-- Logs begin at Tue 2024-05-07 15:42:27 CEST, end at Tue 2024-05-07 15:52:43 CEST. --
May 07 15:51:54 minidsp-shd ntpd[778]: receive: Unexpected origin timestamp 0xe9e4ae5c.7f81a200 does not match aorg 0000000000.00000000 from server@217.61.62.224 xmt 0xe9e4b07a.7f05c0e2
May 07 15:51:54 minidsp-shd ntpd[778]: receive: Unexpected origin timestamp 0xe9e4ae5c.7f57f055 does not match aorg 0000000000.00000000 from server@93.94.88.50 xmt 0xe9e4b07a.7f22f299
May 07 15:51:55 minidsp-shd volumio-remote-updater[459]: [2024-05-07 15:51:55] [connect] Successful connection
May 07 15:51:56 minidsp-shd volumio[790]: info: Loading plugin "network"...
May 07 15:51:56 minidsp-shd volumio[790]: info: Refreshing Cached IP Addresses
May 07 15:51:56 minidsp-shd sudo[835]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 07 15:51:56 minidsp-shd sudo[835]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 15:51:56 minidsp-shd volumio[790]: info: Loading plugin "services"...
May 07 15:51:56 minidsp-shd sudo[835]: pam_unix(sudo:session): session closed for user root
May 07 15:51:56 minidsp-shd sudo[837]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 07 15:51:56 minidsp-shd sudo[837]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 15:51:56 minidsp-shd volumio[790]: info: Loading plugin "alsa_controller"...
May 07 15:51:56 minidsp-shd sudo[837]: pam_unix(sudo:session): session closed for user root
May 07 15:51:56 minidsp-shd sudo[840]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
May 07 15:51:56 minidsp-shd sudo[840]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 15:51:56 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 07 15:51:56 minidsp-shd volumio[790]: info: Loading plugin "wizard"...
May 07 15:51:56 minidsp-shd volumio[790]: info: Loading plugin "networkfs"...
May 07 15:51:56 minidsp-shd volumio[790]: info: Starting Udev Watcher for removable devices
May 07 15:51:56 minidsp-shd sudo[846]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.10/Music /mnt/NAS/Musica
May 07 15:51:56 minidsp-shd sudo[846]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 15:51:56 minidsp-shd kernel: FS-Cache: Loaded
May 07 15:51:56 minidsp-shd volumio[790]: info: Ignoring mount for partition: BOOT
May 07 15:51:56 minidsp-shd volumio[790]: info: Ignoring mount for partition: volumio
May 07 15:51:56 minidsp-shd volumio[790]: info: Ignoring mount for partition: volumio_data
May 07 15:51:56 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 07 15:51:56 minidsp-shd volumio[790]: info: Loading plugin "volumio_command_line_client"...
May 07 15:51:56 minidsp-shd volumio[790]: info: Loading plugin "upnp"...
May 07 15:51:56 minidsp-shd volumio[790]: info: [1715089916919] Starting Upmpd Daemon
May 07 15:51:56 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 07 15:51:56 minidsp-shd volumio[790]: info: Loading plugin "my_music"...
May 07 15:51:56 minidsp-shd volumio[790]: info: Loading plugin "mpd"...
May 07 15:51:56 minidsp-shd kernel: FS-Cache: Netfs 'cifs' registered for caching
May 07 15:51:56 minidsp-shd kernel: Key type cifs.spnego registered
May 07 15:51:56 minidsp-shd kernel: Key type cifs.idmap registered
May 07 15:51:56 minidsp-shd kernel: CIFS: Attempting to mount //192.168.0.10/Music
May 07 15:51:56 minidsp-shd kernel: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3 (or SMB2.1) specify vers=1.0 on mount.
May 07 15:51:57 minidsp-shd volumio[790]: info: Loading plugin "upnp_browser"...
May 07 15:51:58 minidsp-shd volumio[790]: info: Loading plugin "bluetooth"...
May 07 15:51:58 minidsp-shd volumio[790]: info: [1715089918897] Starting BluetoothController
May 07 15:51:59 minidsp-shd volumio[790]: info: Loading plugin "alarm-clock"...
May 07 15:51:59 minidsp-shd volumio[790]: info: Loading plugin "manifestui"...
May 07 15:51:59 minidsp-shd volumio[790]: info: Plugin metavolumio is not enabled
May 07 15:51:59 minidsp-shd volumio[790]: info: Loading plugin "airplay_emulation"...
May 07 15:51:59 minidsp-shd volumio[790]: info: Starting Shairport Sync
May 07 15:51:59 minidsp-shd volumio[790]: info: Plugin cd_controller is not enabled
May 07 15:51:59 minidsp-shd volumio[790]: info: Loading plugin "last_100"...
May 07 15:52:00 minidsp-shd volumio[790]: info: Plugin raat is not enabled
May 07 15:52:00 minidsp-shd volumio[790]: info: Loading plugin "streaming_services"...
May 07 15:52:00 minidsp-shd sudo[840]: pam_unix(sudo:session): session closed for user root
May 07 15:52:01 minidsp-shd systemd[1]: systemd-fsckd.service: Succeeded.
May 07 15:52:01 minidsp-shd sh[379]: timed out
May 07 15:52:01 minidsp-shd sh[379]: dhcpcd exited
May 07 15:52:01 minidsp-shd dhcpcd[416]: timed out
May 07 15:52:01 minidsp-shd sh[379]: ifup: failed to bring up eth0
May 07 15:52:01 minidsp-shd dhcpcd[416]: dhcpcd exited
May 07 15:52:01 minidsp-shd systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE
May 07 15:52:01 minidsp-shd systemd[1]: ifup@eth0.service: Failed with result 'exit-code'.
May 07 15:52:02 minidsp-shd volumio[790]: info: Starting Streaming Service Transparent Proxy
May 07 15:52:02 minidsp-shd volumio[790]: info: Loading plugin "tidalconnect"...
May 07 15:52:02 minidsp-shd volumio[790]: info: Loading plugin "webradio"...
May 07 15:52:03 minidsp-shd volumio[790]: info: Loading plugin "i2s_dacs"...
May 07 15:52:03 minidsp-shd volumio[790]: info: I2S DAC not set, start Auto-detection
May 07 15:52:03 minidsp-shd volumio[790]: info: Loading plugin "volumiodiscovery"...
May 07 15:52:03 minidsp-shd volumio[790]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
May 07 15:52:03 minidsp-shd node[790]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
May 07 15:52:03 minidsp-shd node[790]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 07 15:52:03 minidsp-shd volumio[790]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 07 15:52:03 minidsp-shd volumio[790]: *** WARNING *** For more information see
May 07 15:52:03 minidsp-shd volumio[790]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
May 07 15:52:03 minidsp-shd volumio[790]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 07 15:52:03 minidsp-shd volumio[790]: *** WARNING *** For more information see
May 07 15:52:03 minidsp-shd node[790]: *** WARNING *** For more information see
May 07 15:52:03 minidsp-shd node[790]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
May 07 15:52:03 minidsp-shd node[790]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 07 15:52:03 minidsp-shd node[790]: *** WARNING *** For more information see
May 07 15:52:03 minidsp-shd volumio[790]: info: Applying required configuration parameters for plugin volumiodiscovery
May 07 15:52:03 minidsp-shd volumio[790]: info: Discovery: Started advertising with name: miniDSP SHD
May 07 15:52:03 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 07 15:52:03 minidsp-shd volumio[790]: info: Plugin multiroom is not enabled
May 07 15:52:03 minidsp-shd volumio[790]: info: Loading plugin "outputs"...
May 07 15:52:03 minidsp-shd volumio[790]: info: Loading plugin "albumart"...
May 07 15:52:03 minidsp-shd volumio[790]: info: Loading plugin "ms_surface_dial"...
May 07 15:52:04 minidsp-shd volumio[790]: Forking 3 albumart workers
May 07 15:52:04 minidsp-shd volumio[790]: info: Applying required configuration parameters for plugin ms_surface_dial
May 07 15:52:04 minidsp-shd volumio[790]: STREAMING PROXY: Starting server on port 3245
May 07 15:52:04 minidsp-shd volumio[790]: Node JS runtime: 14
May 07 15:52:04 minidsp-shd volumio[790]: info: Plugin example_plugin is not enabled
May 07 15:52:04 minidsp-shd volumio[790]: info: Loading plugin "hi_res_audio"...
May 07 15:52:06 minidsp-shd volumio[790]: Starting albumart workers
May 07 15:52:06 minidsp-shd volumio[790]: Starting albumart workers
May 07 15:52:06 minidsp-shd volumio[790]: Starting albumart workers
May 07 15:52:07 minidsp-shd kernel: CIFS VFS: Error connecting to socket. Aborting operation.
May 07 15:52:07 minidsp-shd kernel: CIFS VFS: cifs_mount failed w/return code = -115
May 07 15:52:07 minidsp-shd sudo[846]: pam_unix(sudo:session): session closed for user root
May 07 15:52:08 minidsp-shd volumio[790]: info: Applying required configuration parameters for plugin hi_res_audio
May 07 15:52:08 minidsp-shd volumio[790]: info: Loading plugin "inputs"...
May 07 15:52:09 minidsp-shd volumio[790]: info: Loading plugin "qobuz"...
May 07 15:52:10 minidsp-shd volumio-remote-updater[459]: [2024-05-07 15:52:10] [connect] Successful connection
May 07 15:52:12 minidsp-shd volumio[790]: info: Loading plugin "tidal"...
May 07 15:52:14 minidsp-shd volumio[790]: info: Loading plugin "oem_helper"...
May 07 15:52:16 minidsp-shd volumio[790]: info: Applying required configuration parameters for plugin oem_helper
May 07 15:52:16 minidsp-shd volumio[790]: info: Loading plugin "updater_comm"...
May 07 15:52:17 minidsp-shd volumio[790]: info: Plugin mpdemulation is not enabled
May 07 15:52:17 minidsp-shd volumio[790]: info: Loading plugin "rest_api"...
May 07 15:52:17 minidsp-shd volumio[790]: info: Loading plugin "websocket"...
May 07 15:52:17 minidsp-shd volumio[790]: info: Loading i18n strings for locale en
May 07 15:52:17 minidsp-shd volumio[790]: Updating browse sources language
May 07 15:52:17 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 07 15:52:17 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 07 15:52:17 minidsp-shd volumio[790]: info: CoreCommandRouter::initPlayerControls
May 07 15:52:17 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 15:52:17 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 15:52:17 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 15:52:17 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 15:52:17 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 15:52:17 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 15:52:17 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 15:52:17 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 15:52:17 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 07 15:52:17 minidsp-shd volumio[790]: Express server listening on port 3000
May 07 15:52:17 minidsp-shd volumio[790]: [Metrics] WebUI: 27s 632.89ms
May 07 15:52:17 minidsp-shd volumio[790]: info: CoreStateMachine::resetVolumioState
May 07 15:52:17 minidsp-shd volumio[790]: info: CoreStateMachine::getcurrentVolume
May 07 15:52:17 minidsp-shd volumio[790]: info: CoreCommandRouter::volumioRetrievevolume
May 07 15:52:17 minidsp-shd volumio[790]: info: CoreStateMachine::pushState
May 07 15:52:17 minidsp-shd volumio[790]: info: CorePlayQueue::getTrack 0
May 07 15:52:17 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 07 15:52:17 minidsp-shd volumio[790]: info: CoreCommandRouter::volumioPushState
May 07 15:52:17 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 07 15:52:17 minidsp-shd sudo[933]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 07 15:52:17 minidsp-shd sudo[933]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 15:52:17 minidsp-shd sudo[933]: pam_unix(sudo:session): session closed for user root
May 07 15:52:17 minidsp-shd sudo[935]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 07 15:52:17 minidsp-shd volumio[790]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
May 07 15:52:17 minidsp-shd sudo[935]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 15:52:17 minidsp-shd volumio[790]: info: Completed loading Core Plugins
May 07 15:52:17 minidsp-shd volumio[790]: info: Preparing to generate the ALSA configuration file
May 07 15:52:17 minidsp-shd sudo[935]: pam_unix(sudo:session): session closed for user root
May 07 15:52:17 minidsp-shd volumio[790]: info: Cannot mount NAS Musica at system boot, trial number 1 ,retrying in 5 seconds
May 07 15:52:18 minidsp-shd volumio[790]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision
May 07 15:52:18 minidsp-shd volumio[790]: verbose: New Socket.io Connection to 192.168.1.110 from 192.168.1.105 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.0.0 Safari/537.36 Total Clients: 1
May 07 15:52:18 minidsp-shd volumio[790]: verbose: New Socket.io Connection to 192.168.1.110 from 192.168.1.105 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.0.0 Safari/537.36 Total Clients: 2
May 07 15:52:18 minidsp-shd volumio[790]: verbose: New Socket.io Connection to 192.168.1.110 from 192.168.1.105 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.0.0 Safari/537.36 Total Clients: 3
May 07 15:52:18 minidsp-shd volumio[790]: verbose: New Socket.io Connection to 192.168.1.110 from 192.168.1.105 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.0.0 Safari/537.36 Total Clients: 4
May 07 15:52:18 minidsp-shd volumio[790]: verbose: New Socket.io Connection to 192.168.1.110 from 192.168.1.105 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.0.0 Safari/537.36 Total Clients: 5
May 07 15:52:18 minidsp-shd volumio[790]: verbose: New Socket.io Connection to 192.168.1.110 from 192.168.1.105 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.0.0 Safari/537.36 Total Clients: 6
May 07 15:52:18 minidsp-shd volumio[790]: verbose: New Socket.io Connection to 192.168.1.110 from 192.168.1.105 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.0.0 Safari/537.36 Total Clients: 7
May 07 15:52:18 minidsp-shd volumio[790]: verbose: New Socket.io Connection to 192.168.1.110 from 192.168.1.105 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.0.0 Safari/537.36 Total Clients: 8
May 07 15:52:18 minidsp-shd volumio[790]: verbose: New Socket.io Connection to 192.168.1.110 from 192.168.1.105 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.0.0 Safari/537.36 Total Clients: 9
May 07 15:52:18 minidsp-shd volumio[790]: verbose: New Socket.io Connection to 192.168.1.110 from 192.168.1.105 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.0.0 Safari/537.36 Total Clients: 10
May 07 15:52:18 minidsp-shd volumio[790]: info: Reloading queue from file
May 07 15:52:18 minidsp-shd volumio[790]: info: Asound.conf file unchanged, so no further update is needed
May 07 15:52:18 minidsp-shd volumio[790]: info: Output device has changed, restarting MPD
May 07 15:52:18 minidsp-shd volumio[790]: info: Output device has changed, restarting Shairport Sync
May 07 15:52:18 minidsp-shd sudo[944]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
May 07 15:52:18 minidsp-shd sudo[944]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 15:52:18 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 15:52:18 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 07 15:52:18 minidsp-shd sudo[944]: pam_unix(sudo:session): session closed for user root
May 07 15:52:18 minidsp-shd sudo[946]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
May 07 15:52:18 minidsp-shd sudo[946]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 15:52:18 minidsp-shd systemd[1]: Listening on mpd.socket.
May 07 15:52:18 minidsp-shd volumio[790]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 07 15:52:18 minidsp-shd systemd[1]: Starting Music Player Daemon...
May 07 15:52:18 minidsp-shd volumio[790]: info: ___________ START PLUGINS ___________
May 07 15:52:18 minidsp-shd volumio[790]: info: ControllerMpd::onStart: Initializing MPD
May 07 15:52:18 minidsp-shd volumio[790]: info: Creating MPD Configuration file
May 07 15:52:18 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 07 15:52:18 minidsp-shd sudo[954]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
May 07 15:52:18 minidsp-shd sudo[954]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 15:52:18 minidsp-shd volumio[790]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 07 15:52:18 minidsp-shd volumio[790]: info: [1715089938782] CoreMusicLibrary::Adding element Media Servers
May 07 15:52:18 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 07 15:52:18 minidsp-shd sudo[954]: pam_unix(sudo:session): session closed for user root
May 07 15:52:18 minidsp-shd sudo[956]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
May 07 15:52:18 minidsp-shd sudo[956]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 15:52:18 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 07 15:52:18 minidsp-shd systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
May 07 15:52:18 minidsp-shd systemd[1]: mpd.service: Succeeded.
May 07 15:52:18 minidsp-shd systemd[1]: Stopped Music Player Daemon.
May 07 15:52:18 minidsp-shd systemd[1]: Starting Music Player Daemon...
May 07 15:52:18 minidsp-shd volumio[790]: info: Adding Manifest REST API Endpoints
May 07 15:52:18 minidsp-shd volumio[790]: info: Adding manifestui REST Endpoint for plugin: miscellanea/manifestui
May 07 15:52:18 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 15:52:18 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 07 15:52:18 minidsp-shd sudo[961]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name miniDSP SHD
May 07 15:52:18 minidsp-shd sudo[961]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 15:52:18 minidsp-shd sudo[961]: pam_unix(sudo:session): session closed for user root
May 07 15:52:18 minidsp-shd volumio[790]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 07 15:52:19 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 15:52:19 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 07 15:52:19 minidsp-shd volumio[790]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 07 15:52:19 minidsp-shd volumio[790]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 07 15:52:19 minidsp-shd volumio[790]: info: [1715089939096] CoreMusicLibrary::Adding element Last_100
May 07 15:52:19 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 07 15:52:19 minidsp-shd volumio[790]: info: Streaming services startup
May 07 15:52:19 minidsp-shd volumio[790]: info: Starting Streaming Daemon
May 07 15:52:19 minidsp-shd sudo[970]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
May 07 15:52:19 minidsp-shd sudo[970]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 15:52:19 minidsp-shd sudo[970]: pam_unix(sudo:session): session closed for user root
May 07 15:52:19 minidsp-shd volumio[790]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 07 15:52:19 minidsp-shd volumio[790]: info: [1715089939281] CoreMusicLibrary::Adding element Webradio
May 07 15:52:19 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 07 15:52:19 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 07 15:52:19 minidsp-shd sudo[977]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
May 07 15:52:19 minidsp-shd sudo[977]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 15:52:19 minidsp-shd dbus-daemon[472]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.8' (uid=1000 pid=790 comm="/usr/bin/node /volumio/index.js ")
May 07 15:52:19 minidsp-shd volumio[790]: error: Hi Res Audio Failed Login: Missing Login Data
May 07 15:52:19 minidsp-shd volumio[790]: info: Adding HIGHRESAUDIO REST API Endpoints
May 07 15:52:19 minidsp-shd volumio[790]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio
May 07 15:52:19 minidsp-shd systemd[1]: Starting Bluetooth service...
May 07 15:52:19 minidsp-shd volumio[790]: info: Refreshing TIDAL token
May 07 15:52:19 minidsp-shd sudo[977]: pam_unix(sudo:session): session closed for user root
May 07 15:52:19 minidsp-shd bluetoothd[979]: Bluetooth daemon 5.23
May 07 15:52:19 minidsp-shd dbus-daemon[472]: [system] Successfully activated service 'org.bluez'
May 07 15:52:19 minidsp-shd systemd[1]: Started Bluetooth service.
May 07 15:52:19 minidsp-shd bluetoothd[979]: Starting SDP server
May 07 15:52:19 minidsp-shd bluetoothd[979]: kernel lacks bnep-protocol support
May 07 15:52:19 minidsp-shd bluetoothd[979]: System does not support network plugin
May 07 15:52:19 minidsp-shd dbus-daemon[472]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.10' (uid=0 pid=979 comm="/usr/local/libexec/bluetooth/bluetoothd ")
May 07 15:52:19 minidsp-shd bluetoothd[979]: Bluetooth management interface 1.14 initialized
May 07 15:52:19 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 07 15:52:19 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 07 15:52:19 minidsp-shd volumio[790]: info: Volumio Calling Home
May 07 15:52:19 minidsp-shd systemd[1]: Starting Hostname Service...
May 07 15:52:19 minidsp-shd volumio[790]: info: Stopping AccessToken refresher cron for QOBUZ
May 07 15:52:19 minidsp-shd dbus-daemon[472]: [system] Successfully activated service 'org.freedesktop.hostname1'
May 07 15:52:19 minidsp-shd systemd[1]: Started Hostname Service.
May 07 15:52:20 minidsp-shd volumio[790]: info: AccessToken refresher cron started for QOBUZ
May 07 15:52:20 minidsp-shd volumio[790]: info: Adding QOBUZ REST API Endpoints
May 07 15:52:20 minidsp-shd volumio[790]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz
May 07 15:52:20 minidsp-shd volumio[790]: info: Setting Device type: NanoPi NEO 3
May 07 15:52:20 minidsp-shd volumio[790]: info: CoreStateMachine::setRepeat true single undefined
May 07 15:52:20 minidsp-shd volumio[790]: info: CoreStateMachine::pushState
May 07 15:52:20 minidsp-shd volumio[790]: info: CorePlayQueue::getTrack 0
May 07 15:52:20 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 07 15:52:20 minidsp-shd volumio[790]: info: CoreCommandRouter::volumioPushState
May 07 15:52:20 minidsp-shd volumio[790]: info: CoreStateMachine::setRandom null
May 07 15:52:20 minidsp-shd volumio[790]: info: CoreStateMachine::pushState
May 07 15:52:20 minidsp-shd volumio[790]: info: CorePlayQueue::getTrack 0
May 07 15:52:20 minidsp-shd volumio[790]: info: CoreCommandRouter::volumioPushState
May 07 15:52:20 minidsp-shd volumio[790]: info: Serial port opened successfully
May 07 15:52:20 minidsp-shd volumio[790]: error: Cannot start Volumio Streaming Daemon
May 07 15:52:20 minidsp-shd volumio[790]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
May 07 15:52:20 minidsp-shd volumio[790]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
May 07 15:52:20 minidsp-shd volumio[790]: error: Cannot set new Bluetooth Name : Error: Command failed: /usr/bin/sudo /bin/hciconfig hci0 name 'miniDSP SHD'
May 07 15:52:20 minidsp-shd volumio[790]: Can't get device info: No such device
May 07 15:52:20 minidsp-shd volumio[790]: info: MPD Permissions set
May 07 15:52:20 minidsp-shd volumio[790]: info: MPD Permissions set
May 07 15:52:20 minidsp-shd volumio[790]: info: msSurfaceDial Managed Objs {"/org/bluez":{"org.freedesktop.DBus.Introspectable":{},"org.bluez.AgentManager1":{},"org.bluez.ProfileManager1":{}}}
May 07 15:52:20 minidsp-shd volumio[790]: info: [msSurfaceDial init()] check /org/bluez
May 07 15:52:20 minidsp-shd sudo[997]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
May 07 15:52:20 minidsp-shd volumio[790]: info: [msSurfaceDial init()] Adapter: null; SurfaceDial: null
May 07 15:52:20 minidsp-shd sudo[997]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 15:52:20 minidsp-shd volumio[790]: info: msSurfaceDial BluetoothSurfaceDial init() - ready!
May 07 15:52:20 minidsp-shd volumio[790]: info: CoreCommandRouter::Reload Ui
May 07 15:52:20 minidsp-shd systemd[1]: Started UPnP Renderer front-end to MPD.
May 07 15:52:20 minidsp-shd sudo[997]: pam_unix(sudo:session): session closed for user root
May 07 15:52:20 minidsp-shd volumio[790]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007
May 07 15:52:20 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 07 15:52:20 minidsp-shd volumio[790]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 11
May 07 15:52:20 minidsp-shd volumio[790]: info: Volumio called home
May 07 15:52:20 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 15:52:20 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 15:52:20 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 15:52:20 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 15:52:20 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 15:52:20 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 15:52:20 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 15:52:20 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 15:52:20 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 07 15:52:20 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: raat , reconfigureAndRestartRaat
May 07 15:52:21 minidsp-shd volumio[790]: info: Adding MINIDSP Inputs
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 07 15:52:21 minidsp-shd volumio[790]: info: [1715089941143] CoreMusicLibrary::Adding element Inputs
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 07 15:52:21 minidsp-shd volumio[790]: info: [1715089941151] CoreMusicLibrary::Adding element Presets
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 07 15:52:21 minidsp-shd volumio[790]: Cannot find translation for source Presets
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::volumioGetState
May 07 15:52:21 minidsp-shd volumio[790]: info: CorePlayQueue::getTrack 0
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::volumioGetVisibleSources
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 07 15:52:21 minidsp-shd volumio[790]: info: Listing playlists
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::volumioGetQueue
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreStateMachine::getQueue
May 07 15:52:21 minidsp-shd volumio[790]: info: CorePlayQueue::getQueue
May 07 15:52:21 minidsp-shd volumio[790]: info: Upmpdcli Daemon Started
May 07 15:52:21 minidsp-shd volumio[790]: info: Starting Shairport Sync
May 07 15:52:21 minidsp-shd volumio[790]: info: Starting Shairport Sync
May 07 15:52:21 minidsp-shd volumio[790]: info: Starting Shairport Sync
May 07 15:52:21 minidsp-shd sudo[1013]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
May 07 15:52:21 minidsp-shd sudo[1013]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 15:52:21 minidsp-shd sudo[1015]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
May 07 15:52:21 minidsp-shd sudo[1015]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::volumiosetSourceActiveno-source
May 07 15:52:21 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 07 15:52:21 minidsp-shd volumio[790]: Cannot find translation for source Presets
May 07 15:52:21 minidsp-shd systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
May 07 15:52:21 minidsp-shd systemd[1]: shairport-sync.service: Succeeded.
May 07 15:52:21 minidsp-shd systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
May 07 15:52:21 minidsp-shd sudo[1019]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
May 07 15:52:21 minidsp-shd sudo[1019]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 15:52:22 minidsp-shd systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
May 07 15:52:22 minidsp-shd sudo[1019]: pam_unix(sudo:session): session closed for user root
May 07 15:52:22 minidsp-shd sudo[1013]: pam_unix(sudo:session): session closed for user root
May 07 15:52:22 minidsp-shd sudo[1015]: pam_unix(sudo:session): session closed for user root
May 07 15:52:22 minidsp-shd sudo[1023]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service
May 07 15:52:22 minidsp-shd sudo[1023]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 15:52:22 minidsp-shd systemd[1]: Started Volumio Bluetooth Module.
May 07 15:52:22 minidsp-shd sudo[1023]: pam_unix(sudo:session): session closed for user root
May 07 15:52:22 minidsp-shd sudo[1028]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/*
May 07 15:52:22 minidsp-shd sudo[1028]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 15:52:22 minidsp-shd volumiobt[1027]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory
May 07 15:52:22 minidsp-shd sudo[1028]: pam_unix(sudo:session): session closed for user root
May 07 15:52:22 minidsp-shd volumio[790]: info: Access Token successfully retrieved
May 07 15:52:22 minidsp-shd volumio[790]: info: Shairport-Sync Started
May 07 15:52:22 minidsp-shd volumio[790]: Error adding Membership: Error: addMembership EINVAL
May 07 15:52:22 minidsp-shd volumio[790]: info: Shairport-Sync Started
May 07 15:52:22 minidsp-shd volumio[790]: info: Shairport-Sync Started
May 07 15:52:22 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
May 07 15:52:22 minidsp-shd volumio[790]: info: Enabling external Volume Control
May 07 15:52:22 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 15:52:22 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 07 15:52:22 minidsp-shd volumio[790]: info: TidalConnect service stoped!
May 07 15:52:22 minidsp-shd volumio[790]: info: Volumio BT Module successfully started
May 07 15:52:22 minidsp-shd volumio[790]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 12
May 07 15:52:22 minidsp-shd volumio[790]: info: CoreCommandRouter::volumioGetState
May 07 15:52:22 minidsp-shd volumio[790]: info: CorePlayQueue::getTrack 0
May 07 15:52:23 minidsp-shd sudo[1040]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.10/Music /mnt/NAS/Musica
May 07 15:52:23 minidsp-shd sudo[1040]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 15:52:23 minidsp-shd kernel: CIFS: Attempting to mount //192.168.0.10/Music
May 07 15:52:23 minidsp-shd kernel: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3 (or SMB2.1) specify vers=1.0 on mount.
May 07 15:52:23 minidsp-shd volumio[790]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect
May 07 15:52:23 minidsp-shd volumio[790]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect
May 07 15:52:23 minidsp-shd sudo[1045]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service
May 07 15:52:23 minidsp-shd sudo[1045]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 15:52:23 minidsp-shd systemd[1]: Started Volumio Tidal Connect Service.
May 07 15:52:23 minidsp-shd sudo[1045]: pam_unix(sudo:session): session closed for user root
May 07 15:52:23 minidsp-shd volumio[790]: info: Successfully retrieved User Session From TIDAL
May 07 15:52:23 minidsp-shd sudo[1050]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio
May 07 15:52:23 minidsp-shd sudo[1050]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 15:52:23 minidsp-shd volumiobt[1027]: pulseaudio: no process found
May 07 15:52:23 minidsp-shd sudo[1050]: pam_unix(sudo:session): session closed for user root
May 07 15:52:23 minidsp-shd dbus-daemon[472]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.15' (uid=1000 pid=1054 comm="/usr/bin/pulseaudio --high-priority=true ")
May 07 15:52:23 minidsp-shd volumio[790]: info: msSurfaceDial volumioupdatevolume callback: {"mute":false,"disableVolumeControl":false}
May 07 15:52:23 minidsp-shd volumio[790]: info: CoreStateMachine::pushState
May 07 15:52:23 minidsp-shd volumio[790]: info: CorePlayQueue::getTrack 0
May 07 15:52:23 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 07 15:52:23 minidsp-shd volumio[790]: info: CoreCommandRouter::volumioPushState
May 07 15:52:23 minidsp-shd systemd[1]: Starting RealtimeKit Scheduling Policy Service...
May 07 15:52:23 minidsp-shd volumio[790]: error: Help! Some callbacks for volumioPushState are crashing!
May 07 15:52:23 minidsp-shd volumio[790]: error: Cannot read property 'sendVolumeMute' of undefined
May 07 15:52:23 minidsp-shd dbus-daemon[472]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1'
May 07 15:52:23 minidsp-shd volumio[790]: ------------------------------------ BT MESSAGE: BT STATUS: running
May 07 15:52:23 minidsp-shd systemd[1]: Started RealtimeKit Scheduling Policy Service.
May 07 15:52:23 minidsp-shd rtkit-daemon[1055]: Successfully called chroot.
May 07 15:52:23 minidsp-shd rtkit-daemon[1055]: Successfully dropped privileges.
May 07 15:52:23 minidsp-shd rtkit-daemon[1055]: Successfully limited resources.
May 07 15:52:23 minidsp-shd rtkit-daemon[1055]: Running.
May 07 15:52:23 minidsp-shd rtkit-daemon[1055]: Canary thread running.
May 07 15:52:23 minidsp-shd dbus-daemon[472]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.16' (uid=0 pid=1055 comm="/usr/lib/rtkit/rtkit-daemon ")
May 07 15:52:23 minidsp-shd rtkit-daemon[1055]: Watchdog thread running.
May 07 15:52:23 minidsp-shd volumio[790]: info: Successfully retrieved User Subscription From TIDAL
May 07 15:52:23 minidsp-shd volumio[790]: info: Adding TIDAL to Browse Sources
May 07 15:52:23 minidsp-shd volumio[790]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 07 15:52:23 minidsp-shd volumio[790]: info: [1715089943823] CoreMusicLibrary::Adding element TIDAL
May 07 15:52:23 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 07 15:52:23 minidsp-shd volumio[790]: Cannot find translation for source Presets
May 07 15:52:23 minidsp-shd volumio[790]: Cannot find translation for source TIDAL
May 07 15:52:23 minidsp-shd systemd[1]: Starting Authorization Manager...
May 07 15:52:23 minidsp-shd volumio[790]: info: Stopping AccessToken refresher cron
May 07 15:52:24 minidsp-shd volumio[790]: info: AccessToken refresher cron started
May 07 15:52:24 minidsp-shd volumio[790]: info: Adding TIDAL REST API Endpoints
May 07 15:52:24 minidsp-shd volumio[790]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal
May 07 15:52:24 minidsp-shd polkitd[1058]: started daemon version 0.105 using authority implementation `local' version `0.105'
May 07 15:52:24 minidsp-shd dbus-daemon[472]: [system] Successfully activated service 'org.freedesktop.PolicyKit1'
May 07 15:52:24 minidsp-shd systemd[1]: Started Authorization Manager.
May 07 15:52:24 minidsp-shd volumio[790]: ------------------------------------ BT MESSAGE: BT STATUS: running
May 07 15:52:24 minidsp-shd volumio[790]: info: Executing endpoint tc_getconfig
May 07 15:52:24 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig
May 07 15:52:24 minidsp-shd vtcs[1047]: STARTING TidalConnect services, version: 1.3.0.19
May 07 15:52:24 minidsp-shd volumio[790]: info: msSurfaceDial volumioupdatevolume callback: {"vol":95,"dbVolume":-6.5,"mute":false,"disableVolumeControl":false}
May 07 15:52:24 minidsp-shd volumio[790]: info: CoreStateMachine::pushState
May 07 15:52:24 minidsp-shd volumio[790]: info: CorePlayQueue::getTrack 0
May 07 15:52:24 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 07 15:52:24 minidsp-shd volumio[790]: info: CoreCommandRouter::volumioPushState
May 07 15:52:24 minidsp-shd volumio[790]: error: Help! Some callbacks for volumioPushState are crashing!
May 07 15:52:24 minidsp-shd volumio[790]: error: Cannot read property 'sendVolumeMute' of undefined
May 07 15:52:24 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: raat , updateRoonVolume
May 07 15:52:24 minidsp-shd vtcs[1047]: STARTED TidalConnect services.
May 07 15:52:24 minidsp-shd volumio[790]: info: Executing endpoint tc_connect
May 07 15:52:24 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect
May 07 15:52:24 minidsp-shd volumio[790]: info: Connecting to TidalConnect
May 07 15:52:24 minidsp-shd volumio[790]: info: CoreCommandRouter::servicePushState
May 07 15:52:24 minidsp-shd volumio[790]: info: CoreStateMachine::pushState
May 07 15:52:24 minidsp-shd volumio[790]: info: CorePlayQueue::getTrack 0
May 07 15:52:24 minidsp-shd volumio[790]: info: CoreCommandRouter::volumioPushState
May 07 15:52:24 minidsp-shd volumio[790]: info: CorePlayQueue::getTrack 0
May 07 15:52:24 minidsp-shd volumio[790]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false}
May 07 15:52:24 minidsp-shd volumio[790]: verbose: CURRENT POSITION 0
May 07 15:52:24 minidsp-shd volumio[790]: info: CoreStateMachine::syncState stateService stop
May 07 15:52:24 minidsp-shd volumio[790]: info: CoreStateMachine::syncState currentStatus stop
May 07 15:52:24 minidsp-shd volumio[790]: info: CoreStateMachine::pushState
May 07 15:52:24 minidsp-shd volumio[790]: info: CorePlayQueue::getTrack 0
May 07 15:52:24 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 07 15:52:24 minidsp-shd volumio[790]: info: CoreCommandRouter::volumioPushState
May 07 15:52:24 minidsp-shd volumio[790]: info: No code
May 07 15:52:24 minidsp-shd volumio[790]: info: CoreStateMachine::pushState
May 07 15:52:24 minidsp-shd volumio[790]: info: CorePlayQueue::getTrack 0
May 07 15:52:24 minidsp-shd volumio[790]: info: CoreCommandRouter::volumioPushState
May 07 15:52:24 minidsp-shd volumio[790]: info: CoreCommandRouter::servicePushState
May 07 15:52:24 minidsp-shd volumio[790]: info: CoreStateMachine::pushState
May 07 15:52:24 minidsp-shd volumio[790]: info: CorePlayQueue::getTrack 0
May 07 15:52:24 minidsp-shd volumio[790]: info: CoreCommandRouter::volumioPushState
May 07 15:52:24 minidsp-shd volumio[790]: info: CorePlayQueue::getTrack 0
May 07 15:52:24 minidsp-shd volumio[790]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false}
May 07 15:52:24 minidsp-shd volumio[790]: verbose: CURRENT POSITION 0
May 07 15:52:24 minidsp-shd volumio[790]: info: CoreStateMachine::syncState stateService stop
May 07 15:52:24 minidsp-shd volumio[790]: info: CoreStateMachine::syncState currentStatus stop
May 07 15:52:24 minidsp-shd volumio[790]: info: CoreStateMachine::pushState
May 07 15:52:24 minidsp-shd volumio[790]: info: CorePlayQueue::getTrack 0
May 07 15:52:24 minidsp-shd volumio[790]: info: CoreCommandRouter::volumioPushState
May 07 15:52:24 minidsp-shd volumio[790]: info: No code
May 07 15:52:24 minidsp-shd volumio[790]: info: CoreStateMachine::pushState
May 07 15:52:24 minidsp-shd volumio[790]: info: CorePlayQueue::getTrack 0
May 07 15:52:24 minidsp-shd volumio[790]: info: CoreCommandRouter::volumioPushState
May 07 15:52:24 minidsp-shd pulseaudio[1054]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11
May 07 15:52:24 minidsp-shd pulseaudio[1054]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11
May 07 15:52:24 minidsp-shd volumiobt[1027]: Applying permissions
May 07 15:52:24 minidsp-shd volumiobt[1027]: Setting BT discoverable and pairable
May 07 15:52:24 minidsp-shd pulseaudio[1054]: 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
May 07 15:52:25 minidsp-shd volumiobt[1027]: [38B blob data]
May 07 15:52:25 minidsp-shd volumiobt[1027]: Invalid command
May 07 15:52:25 minidsp-shd volumiobt[1027]: [bluetooth]# agent on
May 07 15:52:25 minidsp-shd volumiobt[1027]: [bluetooth]# discoverable on
May 07 15:52:25 minidsp-shd volumiobt[1027]: No default controller available
May 07 15:52:25 minidsp-shd volumiobt[1027]: [bluetooth]# pairable on
May 07 15:52:25 minidsp-shd volumiobt[1027]: No default controller available
May 07 15:52:25 minidsp-shd volumiobt[1027]: [bluetooth]# agent NoInputNoOutput
May 07 15:52:25 minidsp-shd volumiobt[1027]: Failed to register agent object
May 07 15:52:25 minidsp-shd volumiobt[1027]: [bluetooth]# default-agent
May 07 15:52:25 minidsp-shd volumiobt[1027]: No agent is registered
May 07 15:52:25 minidsp-shd volumiobt[1027]: [bluetooth]# quit
May 07 15:52:25 minidsp-shd volumiobt[1027]: [61B blob data]
May 07 15:52:25 minidsp-shd volumiobt[1027]: [62B blob data]
May 07 15:52:25 minidsp-shd volumio[790]: verbose: New Socket.io Connection to 192.168.1.110:3000 from 192.168.1.105 UA: node-XMLHttpRequest Total Clients: 13
May 07 15:52:25 minidsp-shd volumio-remote-updater[459]: [2024-05-07 15:52:25] [connect] Successful connection
May 07 15:52:25 minidsp-shd volumio-remote-updater[459]: [2024-05-07 15:52:25] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1715089945 101
May 07 15:52:25 minidsp-shd volumio[790]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 14
May 07 15:52:25 minidsp-shd sudo[1082]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 07 15:52:25 minidsp-shd sudo[1082]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 15:52:25 minidsp-shd sudo[1082]: pam_unix(sudo:session): session closed for user root
May 07 15:52:25 minidsp-shd sudo[1084]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 07 15:52:25 minidsp-shd sudo[1084]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 15:52:25 minidsp-shd sudo[1084]: pam_unix(sudo:session): session closed for user root
May 07 15:52:25 minidsp-shd volumio[790]: verbose: New Socket.io Connection to 192.168.1.110 from 192.168.1.105 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.0.0 Safari/537.36 Total Clients: 15
May 07 15:52:26 minidsp-shd volumio[790]: info: CoreCommandRouter::getUIConfigOnPlugin
May 07 15:52:26 minidsp-shd volumio[790]: info: CoreCommandRouter::getUIConfigOnPlugin
May 07 15:52:26 minidsp-shd volumio[790]: info: Retrieving Cloud Streaming UI
May 07 15:52:26 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
May 07 15:52:26 minidsp-shd volumio[790]: info: CoreCommandRouter::volumioGetState
May 07 15:52:26 minidsp-shd volumio[790]: info: CorePlayQueue::getTrack 0
May 07 15:52:26 minidsp-shd volumio[790]: info: CoreCommandRouter::volumioGetVisibleSources
May 07 15:52:26 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 07 15:52:26 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
May 07 15:52:26 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
May 07 15:52:26 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
May 07 15:52:26 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 07 15:52:26 minidsp-shd volumio[790]: info: Getting Tidal Cloud Configuration
May 07 15:52:26 minidsp-shd volumio[790]: info: CoreCommandRouter::getUIConfigOnPlugin
May 07 15:52:26 minidsp-shd volumio[790]: info: Getting Qobuz Cloud Configuration
May 07 15:52:26 minidsp-shd volumio[790]: info: Asking plugin for UI Config
May 07 15:52:26 minidsp-shd volumio[790]: info: CoreCommandRouter::getUIConfigOnPlugin
May 07 15:52:26 minidsp-shd volumio[790]: info: Getting Spotify Cloud Configuration
May 07 15:52:26 minidsp-shd volumio[790]: info: Asking plugin for UI Config
May 07 15:52:26 minidsp-shd volumio[790]: info: CoreCommandRouter::getUIConfigOnPlugin
May 07 15:52:26 minidsp-shd volumio[790]: info: Saving Spotify Acccount
May 07 15:52:26 minidsp-shd volumio[790]: info: Got it
May 07 15:52:26 minidsp-shd volumio[790]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
May 07 15:52:26 minidsp-shd volumio[790]: info: TidalConnect service started!
May 07 15:52:26 minidsp-shd volumio[790]: info: Got Tidal Cloud Configuration
May 07 15:52:26 minidsp-shd volumio[790]: info: Got it
May 07 15:52:26 minidsp-shd volumio[790]: info: CoreCommandRouter::getUIConfigOnPlugin
May 07 15:52:26 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
May 07 15:52:26 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 07 15:52:26 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 07 15:52:26 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 07 15:52:26 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 07 15:52:26 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 07 15:52:26 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 07 15:52:26 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 07 15:52:26 minidsp-shd volumio[790]: info: CoreCommandRouter::volumioGetBrowseSources
May 07 15:52:26 minidsp-shd volumio[790]: info: CoreCommandRouter::volumioGetBrowseSources
May 07 15:52:26 minidsp-shd volumio[790]: info: CoreCommandRouter::volumioGetBrowseSources
May 07 15:52:27 minidsp-shd mpd[960]: May 07 15:52 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
May 07 15:52:27 minidsp-shd systemd[1]: Started Music Player Daemon.
May 07 15:52:27 minidsp-shd volumio[790]: Upnp client error: Error: This socket has been ended by the other party
May 07 15:52:27 minidsp-shd sudo[946]: pam_unix(sudo:session): session closed for user root
May 07 15:52:27 minidsp-shd sudo[956]: pam_unix(sudo:session): session closed for user root
May 07 15:52:27 minidsp-shd volumio[790]: Upnp client error: Error: This socket has been ended by the other party
May 07 15:52:27 minidsp-shd volumio[790]: info: Completed starting Core Plugins
May 07 15:52:27 minidsp-shd volumio[790]: info: -------------------------------------------
May 07 15:52:27 minidsp-shd volumio[790]: info: ----- MyVolumio plugins startup ----
May 07 15:52:27 minidsp-shd volumio[790]: info: -------------------------------------------
May 07 15:52:27 minidsp-shd volumio[790]: info: [MyVolumio PluginManager] Fetching plans data....
May 07 15:52:27 minidsp-shd volumio[790]: info: MPD running with PID960
May 07 15:52:27 minidsp-shd volumio[790]: ,establishing connection
May 07 15:52:27 minidsp-shd volumio[790]: error: MPD error: The expression evaluated to a falsy value:
May 07 15:52:27 minidsp-shd volumio[790]: assert.ok(self.idling)
May 07 15:52:27 minidsp-shd volumio[790]: error: The expression evaluated to a falsy value:
May 07 15:52:27 minidsp-shd volumio[790]: assert.ok(self.idling)
May 07 15:52:27 minidsp-shd volumio[790]: error: MPD error: The expression evaluated to a falsy value:
May 07 15:52:27 minidsp-shd volumio[790]: assert.ok(self.idling)
May 07 15:52:27 minidsp-shd volumio[790]: error: The expression evaluated to a falsy value:
May 07 15:52:27 minidsp-shd volumio[790]: assert.ok(self.idling)
May 07 15:52:27 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 07 15:52:27 minidsp-shd volumio[790]: error: MPD error: The expression evaluated to a falsy value:
May 07 15:52:27 minidsp-shd volumio[790]: assert.ok(self.idling)
May 07 15:52:27 minidsp-shd volumio[790]: error: The expression evaluated to a falsy value:
May 07 15:52:27 minidsp-shd volumio[790]: assert.ok(self.idling)
May 07 15:52:27 minidsp-shd volumio[790]: error: updateQueue error: null
May 07 15:52:27 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
May 07 15:52:29 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 07 15:52:29 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 07 15:52:29 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: raat , updateDSP
May 07 15:52:29 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken
May 07 15:52:30 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken
May 07 15:52:31 minidsp-shd volumio[999]: Generating RSA private key, 4096 bit long modulus (2 primes)
May 07 15:52:31 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 07 15:52:32 minidsp-shd volumio[790]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory
May 07 15:52:33 minidsp-shd kernel: CIFS VFS: Error connecting to socket. Aborting operation.
May 07 15:52:33 minidsp-shd kernel: CIFS VFS: cifs_mount failed w/return code = -115
May 07 15:52:33 minidsp-shd sudo[1040]: pam_unix(sudo:session): session closed for user root
May 07 15:52:33 minidsp-shd volumio[790]: info: Cannot mount NAS Musica at system boot, trial number 2 ,retrying in 5 seconds
May 07 15:52:35 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 07 15:52:35 minidsp-shd volumio[790]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
May 07 15:52:35 minidsp-shd volumio[790]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
May 07 15:52:35 minidsp-shd volumio[790]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
May 07 15:52:35 minidsp-shd volumio[790]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
May 07 15:52:35 minidsp-shd volumio[790]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
May 07 15:52:35 minidsp-shd volumio[790]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
May 07 15:52:35 minidsp-shd volumio[790]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
May 07 15:52:35 minidsp-shd volumio[790]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
May 07 15:52:35 minidsp-shd volumio[790]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
May 07 15:52:35 minidsp-shd volumio[790]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
May 07 15:52:35 minidsp-shd volumio[790]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
May 07 15:52:35 minidsp-shd volumio[790]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
May 07 15:52:35 minidsp-shd volumio[790]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
May 07 15:52:35 minidsp-shd volumio[790]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
May 07 15:52:35 minidsp-shd volumio[790]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
May 07 15:52:35 minidsp-shd volumio[790]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
May 07 15:52:35 minidsp-shd volumio[790]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
May 07 15:52:35 minidsp-shd volumio[790]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
May 07 15:52:35 minidsp-shd volumio[790]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
May 07 15:52:35 minidsp-shd volumio[790]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
May 07 15:52:35 minidsp-shd volumio[790]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
May 07 15:52:35 minidsp-shd volumio[790]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
May 07 15:52:35 minidsp-shd volumio[790]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
May 07 15:52:35 minidsp-shd volumio[790]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
May 07 15:52:35 minidsp-shd volumio[790]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
May 07 15:52:35 minidsp-shd volumio[790]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
May 07 15:52:35 minidsp-shd volumio[790]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
May 07 15:52:37 minidsp-shd volumio[790]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
May 07 15:52:37 minidsp-shd volumio[790]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
May 07 15:52:37 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 07 15:52:37 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 07 15:52:37 minidsp-shd volumio[790]: info: Starting MyVolumio Remote Streaming Endpoints
May 07 15:52:37 minidsp-shd volumio[790]: info: MyVolumio login type: Token
May 07 15:52:37 minidsp-shd volumio[790]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
May 07 15:52:37 minidsp-shd volumio[790]: error: [MyVolumio PluginManager] Could not read package.json file: Error: /myvolumio/plugins/music_service/streaming_services//package.json: ENOENT: no such file or directory, open '/myvolumio/plugins/music_service/streaming_services//package.json'
May 07 15:52:38 minidsp-shd volumio[999]: .....................................................................................................++++
May 07 15:52:38 minidsp-shd sudo[1149]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.10/Music /mnt/NAS/Musica
May 07 15:52:38 minidsp-shd sudo[1149]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 15:52:38 minidsp-shd kernel: CIFS: Attempting to mount //192.168.0.10/Music
May 07 15:52:38 minidsp-shd kernel: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3 (or SMB2.1) specify vers=1.0 on mount.
May 07 15:52:39 minidsp-shd volumio[790]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
May 07 15:52:39 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 07 15:52:39 minidsp-shd volumio[790]: info: MyVolumio token set successfully
May 07 15:52:39 minidsp-shd volumio[790]: info: MYVOLUMIO: Adding device
May 07 15:52:39 minidsp-shd volumio[790]: info: MYVOLUMIO: Evaluating Server
May 07 15:52:40 minidsp-shd volumio[790]: info: MyVolumio status changed
May 07 15:52:40 minidsp-shd volumio[790]: info: Streaming services startup
May 07 15:52:40 minidsp-shd volumio[790]: info: Starting Streaming Daemon
May 07 15:52:40 minidsp-shd volumio[790]: info: Removing browser output: myVolumio user plan is not superstar
May 07 15:52:40 minidsp-shd volumio[790]: info: Removing audio output:
May 07 15:52:40 minidsp-shd volumio[790]: info: Stoppping Tunnel 1
May 07 15:52:40 minidsp-shd sudo[1171]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
May 07 15:52:40 minidsp-shd sudo[1171]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 15:52:40 minidsp-shd sudo[1171]: pam_unix(sudo:session): session closed for user root
May 07 15:52:40 minidsp-shd sudo[1174]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service
May 07 15:52:40 minidsp-shd sudo[1174]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 07 15:52:40 minidsp-shd volumio[790]: error: Cannot start Volumio Streaming Daemon
May 07 15:52:40 minidsp-shd volumio[790]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
May 07 15:52:40 minidsp-shd volumio[790]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
May 07 15:52:40 minidsp-shd sudo[1174]: pam_unix(sudo:session): session closed for user root
May 07 15:52:40 minidsp-shd volumio[790]: info: Remote SSH Stopped
May 07 15:52:40 minidsp-shd volumio[790]: info: Setting Geolocation for MyVolumio to eu10
May 07 15:52:40 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 07 15:52:40 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 07 15:52:40 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 07 15:52:41 minidsp-shd volumio[790]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"}
May 07 15:52:41 minidsp-shd volumio[790]: info: Updating MyVolumio device info
May 07 15:52:41 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 07 15:52:41 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 07 15:52:41 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 07 15:52:42 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares
May 07 15:52:42 minidsp-shd volumio[790]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService
May 07 15:52:42 minidsp-shd volumio[790]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"}
May 07 15:52:42 minidsp-shd volumio[790]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 07 15:52:42 minidsp-shd volumio[790]: Error: getaddrinfo -3007
May 07 15:52:42 minidsp-shd volumio[790]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11)
May 07 15:52:42 minidsp-shd volumio[790]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10)
May 07 15:52:42 minidsp-shd volumio[790]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) {
May 07 15:52:42 minidsp-shd volumio[790]: code: -3007,
May 07 15:52:42 minidsp-shd volumio[790]: errno: -3007,
May 07 15:52:42 minidsp-shd volumio[790]: syscall: 'getaddrinfo'
May 07 15:52:42 minidsp-shd volumio[790]: }
May 07 15:52:42 minidsp-shd volumio[790]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 07 15:52:43 minidsp-shd volumio[999]: ...............................................................++++
May 07 15:52:43 minidsp-shd volumio[999]: e is 65537 (0x010001)
May 07 15:52:43 minidsp-shd volumio[999]: writing RSA key
May 07 15:52:43 minidsp-shd sudo[1202]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-07 15:51
May 07 15:52:43 minidsp-shd sudo[1202]: 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:13:25 PM CET"
VOLUMIO_VERSION="3.608"
VOLUMIO_HARDWARE="nanopineo3"
VOLUMIO_DEVICENAME="Nanopi Neo3"
VOLUMIO_VENDOR="miniDSP"
VOLUMIO_MODEL="SHD"
VOLUMIO_VENDOR_MODEL="miniDSP SHD"
VOLUMIO_HASH="18533ba33f8f92d7e7e459bb30f70beb"