-- Logs begin at Thu 2019-02-14 04:11:58 CST, end at Sun 2025-02-23 16:26:52 CST. --
Feb 23 16:26:18 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 23 16:26:18 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 23 16:26:18 volumio volumio[1063]: info: Discovery: Getting this device information
Feb 23 16:26:18 volumio volumio[1063]: info: CoreCommandRouter::volumioGetState
Feb 23 16:26:18 volumio volumio[1063]: info: CorePlayQueue::getTrack 0
Feb 23 16:26:18 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 23 16:26:18 volumio volumio[1063]: verbose: New Socket.io Connection to 10.27.27.58:3000 from 10.27.27.39 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 10
Feb 23 16:26:18 volumio volumio[1063]: info: CoreCommandRouter::volumioGetState
Feb 23 16:26:18 volumio volumio[1063]: info: CorePlayQueue::getTrack 0
Feb 23 16:26:18 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Feb 23 16:26:18 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Feb 23 16:26:18 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 23 16:26:18 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 23 16:26:18 volumio volumio[1063]: info: Discovery: Getting this device information
Feb 23 16:26:18 volumio volumio[1063]: info: CoreCommandRouter::volumioGetState
Feb 23 16:26:18 volumio volumio[1063]: info: CorePlayQueue::getTrack 0
Feb 23 16:26:18 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 23 16:26:19 volumio sudo[2571]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Feb 23 16:26:19 volumio sudo[2571]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 23 16:26:20 volumio sudo[2571]: pam_unix(sudo:session): session closed for user root
Feb 23 16:26:20 volumio sudo[2574]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Feb 23 16:26:20 volumio sudo[2574]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 23 16:26:20 volumio sudo[2574]: pam_unix(sudo:session): session closed for user root
Feb 23 16:26:20 volumio volumio[1063]: verbose: New Socket.io Connection to 10.27.27.58 from 10.27.27.39 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_3_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 11
Feb 23 16:26:20 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Feb 23 16:26:20 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Feb 23 16:26:20 volumio sudo[2577]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Feb 23 16:26:20 volumio sudo[2577]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 23 16:26:20 volumio sudo[2577]: pam_unix(sudo:session): session closed for user root
Feb 23 16:26:20 volumio sudo[2580]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Feb 23 16:26:20 volumio sudo[2580]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 23 16:26:20 volumio sudo[2580]: pam_unix(sudo:session): session closed for user root
Feb 23 16:26:20 volumio volumio[1063]: verbose: New Socket.io Connection to 10.27.27.58 from 10.27.27.39 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_3_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 12
Feb 23 16:26:20 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Feb 23 16:26:20 volumio volumio[1063]: info: CoreCommandRouter::volumioGetVisibleSources
Feb 23 16:26:20 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 23 16:26:20 volumio volumio[1063]: info: CoreCommandRouter::volumioGetState
Feb 23 16:26:20 volumio volumio[1063]: info: CorePlayQueue::getTrack 0
Feb 23 16:26:20 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Feb 23 16:26:20 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Feb 23 16:26:20 volumio volumio[1063]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Feb 23 16:26:20 volumio volumio[1063]: info: Received Get System Info
Feb 23 16:26:20 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 23 16:26:20 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 23 16:26:20 volumio volumio[1063]: info: Discovery: Getting this device information
Feb 23 16:26:20 volumio volumio[1063]: info: CoreCommandRouter::volumioGetState
Feb 23 16:26:20 volumio volumio[1063]: info: CorePlayQueue::getTrack 0
Feb 23 16:26:20 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 23 16:26:20 volumio volumio[1063]: info: CoreCommandRouter::volumioGetState
Feb 23 16:26:20 volumio volumio[1063]: info: CorePlayQueue::getTrack 0
Feb 23 16:26:20 volumio volumio[1063]: info: Listing playlists
Feb 23 16:26:20 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Feb 23 16:26:20 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Feb 23 16:26:20 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Feb 23 16:26:20 volumio volumio[1063]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 23 16:26:21 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Feb 23 16:26:22 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Feb 23 16:26:22 volumio volumio[1063]: info: Received Get System Info
Feb 23 16:26:22 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 23 16:26:22 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 23 16:26:22 volumio volumio[1063]: info: Discovery: Getting this device information
Feb 23 16:26:22 volumio volumio[1063]: info: CoreCommandRouter::volumioGetState
Feb 23 16:26:22 volumio volumio[1063]: info: CorePlayQueue::getTrack 0
Feb 23 16:26:22 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 23 16:26:22 volumio volumio[1063]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 23 16:26:22 volumio volumio[1063]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 23 16:26:22 volumio volumio[1063]: info: Retrieving Cloud Streaming UI
Feb 23 16:26:22 volumio volumio[1063]: info: Getting Tidal Cloud Configuration
Feb 23 16:26:22 volumio volumio[1063]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 23 16:26:22 volumio volumio[1063]: info: Getting Qobuz Cloud Configuration
Feb 23 16:26:22 volumio volumio[1063]: info: Asking plugin for UI Config
Feb 23 16:26:22 volumio volumio[1063]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 23 16:26:22 volumio volumio[1063]: info: Getting Spotify Cloud Configuration
Feb 23 16:26:22 volumio volumio[1063]: info: Asking plugin for UI Config
Feb 23 16:26:22 volumio volumio[1063]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 23 16:26:22 volumio volumio[1063]: info: Saving Spotify Acccount
Feb 23 16:26:22 volumio volumio[1063]: info: Got it
Feb 23 16:26:22 volumio volumio[1063]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Feb 23 16:26:22 volumio volumio[1063]: info: Got it
Feb 23 16:26:22 volumio volumio[1063]: info: Got Tidal Cloud Configuration
Feb 23 16:26:22 volumio volumio[1063]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 23 16:26:22 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Feb 23 16:26:22 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Feb 23 16:26:22 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Feb 23 16:26:22 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Feb 23 16:26:22 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 23 16:26:22 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 23 16:26:22 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 23 16:26:22 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 23 16:26:22 volumio volumio[1063]: info: CoreCommandRouter::volumioGetBrowseSources
Feb 23 16:26:22 volumio volumio[1063]: info: CoreCommandRouter::volumioGetBrowseSources
Feb 23 16:26:22 volumio volumio[1063]: info: CoreCommandRouter::volumioGetBrowseSources
Feb 23 16:26:22 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 23 16:26:22 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Feb 23 16:26:22 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Feb 23 16:26:22 volumio volumio[1063]: info: Received Get System Info
Feb 23 16:26:22 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 23 16:26:22 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 23 16:26:22 volumio volumio[1063]: info: Discovery: Getting this device information
Feb 23 16:26:22 volumio volumio[1063]: info: CoreCommandRouter::volumioGetState
Feb 23 16:26:22 volumio volumio[1063]: info: CorePlayQueue::getTrack 0
Feb 23 16:26:22 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 23 16:26:22 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 23 16:26:22 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 23 16:26:22 volumio volumio[1063]: info: Discovery: Getting this device information
Feb 23 16:26:22 volumio volumio[1063]: info: CoreCommandRouter::volumioGetState
Feb 23 16:26:22 volumio volumio[1063]: info: CorePlayQueue::getTrack 0
Feb 23 16:26:22 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 23 16:26:22 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 23 16:26:22 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 23 16:26:22 volumio volumio[1063]: info: Discovery: Getting this device information
Feb 23 16:26:22 volumio volumio[1063]: info: CoreCommandRouter::volumioGetState
Feb 23 16:26:22 volumio volumio[1063]: info: CorePlayQueue::getTrack 0
Feb 23 16:26:22 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 23 16:26:25 volumio volumio[1063]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare
Feb 23 16:26:25 volumio sudo[2592]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/NAS/Public
Feb 23 16:26:25 volumio sudo[2592]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 23 16:26:25 volumio sudo[2592]: pam_unix(sudo:session): session closed for user root
Feb 23 16:26:25 volumio volumio[1063]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 23 16:26:25 volumio volumio[1063]: Error: EBUSY: resource busy or locked, rmdir '/mnt/NAS/Public'
Feb 23 16:26:25 volumio volumio[1063]: at Object.rmdirSync (fs.js:890:10)
Feb 23 16:26:25 volumio volumio[1063]: at /volumio/node_modules/linux-mountutils/mountutils.js:178:12
Feb 23 16:26:25 volumio volumio[1063]: at ChildProcess.exithandler (child_process.js:299:7)
Feb 23 16:26:25 volumio volumio[1063]: at ChildProcess.emit (events.js:315:20)
Feb 23 16:26:25 volumio volumio[1063]: at maybeClose (internal/child_process.js:1048:16)
Feb 23 16:26:25 volumio volumio[1063]: at Socket. (internal/child_process.js:439:11)
Feb 23 16:26:25 volumio volumio[1063]: at Socket.emit (events.js:315:20)
Feb 23 16:26:25 volumio volumio[1063]: at Pipe. (net.js:673:12) {
Feb 23 16:26:25 volumio volumio[1063]: errno: -16,
Feb 23 16:26:25 volumio volumio[1063]: syscall: 'rmdir',
Feb 23 16:26:25 volumio volumio[1063]: code: 'EBUSY',
Feb 23 16:26:25 volumio volumio[1063]: path: '/mnt/NAS/Public'
Feb 23 16:26:25 volumio volumio[1063]: }
Feb 23 16:26:25 volumio volumio[1063]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 23 16:26:26 volumio sudo[2604]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-23 16:25
Feb 23 16:26:26 volumio sudo[2604]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 23 16:26:26 volumio sudo[2604]: pam_unix(sudo:session): session closed for user root
Feb 23 16:26:26 volumio vtcs[1965]: [2025-02-23 16:26:26.878] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected
Feb 23 16:26:26 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Feb 23 16:26:26 volumio volumio-remote-updater[575]: [2025-02-23 16:26:26] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Feb 23 16:26:26 volumio volumio-remote-updater[575]: [2025-02-23 16:26:26] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Feb 23 16:26:26 volumio systemd[1]: volumio.service: Failed with result 'exit-code'.
Feb 23 16:26:26 volumio systemd[1]: Started dynamicswap service.
Feb 23 16:26:26 volumio systemd[1]: dynamicswap.service: Succeeded.
Feb 23 16:26:27 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Feb 23 16:26:27 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1.
Feb 23 16:26:27 volumio systemd[1]: Stopped Volumio Backend Module.
Feb 23 16:26:27 volumio systemd[1]: Started Volumio Backend Module.
Feb 23 16:26:27 volumio systemd[1]: Started dynamicswap service.
Feb 23 16:26:27 volumio systemd[1]: dynamicswap.service: Succeeded.
Feb 23 16:26:28 volumio volumio[2632]: info: -------------------------------------------
Feb 23 16:26:28 volumio volumio[2632]: info: ----- Volumio3 ----
Feb 23 16:26:28 volumio volumio[2632]: info: -------------------------------------------
Feb 23 16:26:28 volumio volumio[2632]: info: ----- System startup ----
Feb 23 16:26:28 volumio volumio[2632]: info: -------------------------------------------
Feb 23 16:26:28 volumio volumio[2632]: info: MYVOLUMIO Environment detected
Feb 23 16:26:28 volumio volumio[2632]: info: Plugin folders cleanup
Feb 23 16:26:28 volumio volumio[2632]: info: Scanning into folder /volumio/app/plugins/
Feb 23 16:26:28 volumio volumio[2632]: info: Scanning category audio_interface
Feb 23 16:26:28 volumio volumio[2632]: info: Scanning category miscellanea
Feb 23 16:26:28 volumio volumio[2632]: info: Scanning category music_service
Feb 23 16:26:28 volumio volumio[2632]: info: Scanning category plugins.json
Feb 23 16:26:28 volumio volumio[2632]: info: Scanning category system_controller
Feb 23 16:26:28 volumio volumio[2632]: info: Scanning category user_interface
Feb 23 16:26:28 volumio volumio[2632]: info: Scanning into folder /data/plugins/
Feb 23 16:26:28 volumio volumio[2632]: info: Scanning category audio_interface
Feb 23 16:26:28 volumio volumio[2632]: info: Scanning category music_service
Feb 23 16:26:28 volumio volumio[2632]: info: Scanning category user_interface
Feb 23 16:26:28 volumio volumio[2632]: info: Plugin folders cleanup completed
Feb 23 16:26:28 volumio volumio[2632]: info: -------------------------------------------
Feb 23 16:26:28 volumio volumio[2632]: info: ----- Core plugins startup ----
Feb 23 16:26:28 volumio volumio[2632]: info: -------------------------------------------
Feb 23 16:26:28 volumio volumio[2632]: info: Loading plugins from folder /volumio/app/plugins/
Feb 23 16:26:28 volumio volumio[2632]: info: Adding plugin upnp to MyMusic Plugins
Feb 23 16:26:28 volumio volumio[2632]: info: Adding plugin airplay_emulation to MyMusic Plugins
Feb 23 16:26:28 volumio volumio[2632]: info: Adding plugin upnp_browser to MyMusic Plugins
Feb 23 16:26:28 volumio volumio[2632]: info: Loading plugins from folder /data/plugins/
Feb 23 16:26:28 volumio volumio[2632]: info: Loading plugin "system"...
Feb 23 16:26:28 volumio volumio[2632]: info: Loading plugin "appearance"...
Feb 23 16:26:29 volumio volumio[2632]: info: Loading plugin "network"...
Feb 23 16:26:29 volumio volumio[2632]: info: Refreshing Cached IP Addresses
Feb 23 16:26:29 volumio sudo[2660]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Feb 23 16:26:29 volumio sudo[2660]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 23 16:26:29 volumio sudo[2660]: pam_unix(sudo:session): session closed for user root
Feb 23 16:26:29 volumio sudo[2662]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Feb 23 16:26:29 volumio sudo[2662]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 23 16:26:29 volumio sudo[2662]: pam_unix(sudo:session): session closed for user root
Feb 23 16:26:29 volumio volumio[2632]: info: Loading plugin "services"...
Feb 23 16:26:29 volumio volumio[2632]: info: Loading plugin "alsa_controller"...
Feb 23 16:26:29 volumio sudo[2671]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Feb 23 16:26:29 volumio sudo[2671]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 23 16:26:29 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 23 16:26:29 volumio volumio[2632]: info: Loading plugin "wizard"...
Feb 23 16:26:29 volumio volumio[2632]: info: Loading plugin "networkfs"...
Feb 23 16:26:29 volumio volumio[2632]: info: Cannot mount NAS Public at system boot, trial number 1 ,retrying in 5 seconds
Feb 23 16:26:29 volumio volumio[2632]: info: Cannot mount NAS Public at system boot, trial number 1 ,retrying in 5 seconds
Feb 23 16:26:29 volumio volumio[2632]: info: Starting Udev Watcher for removable devices
Feb 23 16:26:29 volumio volumio[2632]: info: Ignoring mount for partition: boot
Feb 23 16:26:29 volumio volumio[2632]: info: Ignoring mount for partition: volumio
Feb 23 16:26:29 volumio volumio[2632]: info: Ignoring mount for partition: volumio_data
Feb 23 16:26:29 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Feb 23 16:26:29 volumio volumio[2632]: info: Loading plugin "volumio_command_line_client"...
Feb 23 16:26:29 volumio volumio[2632]: info: Plugin upnp is not enabled
Feb 23 16:26:29 volumio volumio[2632]: info: Loading plugin "my_music"...
Feb 23 16:26:29 volumio volumio[2632]: info: Loading plugin "mpd"...
Feb 23 16:26:29 volumio volumio[2632]: info: Loading plugin "upnp_browser"...
Feb 23 16:26:29 volumio volumio[2632]: info: Loading plugin "alarm-clock"...
Feb 23 16:26:30 volumio volumio[2632]: info: Plugin airplay_emulation is not enabled
Feb 23 16:26:30 volumio volumio[2632]: info: Loading plugin "last_100"...
Feb 23 16:26:30 volumio volumio[2632]: info: Loading plugin "webradio"...
Feb 23 16:26:30 volumio volumio[2632]: info: Loading plugin "i2s_dacs"...
Feb 23 16:26:30 volumio volumio[2632]: info: Loading plugin "volumiodiscovery"...
Feb 23 16:26:30 volumio volumio[2632]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Feb 23 16:26:30 volumio volumio[2632]: *** WARNING *** Please fix your application to use the native API of Avahi!
Feb 23 16:26:30 volumio node[2632]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Feb 23 16:26:30 volumio volumio[2632]: *** WARNING *** For more information see
Feb 23 16:26:30 volumio volumio[2632]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Feb 23 16:26:30 volumio volumio[2632]: *** WARNING *** Please fix your application to use the native API of Avahi!
Feb 23 16:26:30 volumio volumio[2632]: *** WARNING *** For more information see
Feb 23 16:26:30 volumio node[2632]: *** WARNING *** Please fix your application to use the native API of Avahi!
Feb 23 16:26:30 volumio node[2632]: *** WARNING *** For more information see
Feb 23 16:26:30 volumio node[2632]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Feb 23 16:26:30 volumio node[2632]: *** WARNING *** Please fix your application to use the native API of Avahi!
Feb 23 16:26:30 volumio node[2632]: *** WARNING *** For more information see
Feb 23 16:26:30 volumio volumio[2632]: info: Applying required configuration parameters for plugin volumiodiscovery
Feb 23 16:26:30 volumio volumio[2632]: info: Discovery: Started advertising with name: Volumio
Feb 23 16:26:30 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Feb 23 16:26:30 volumio volumio[2632]: info: Loading plugin "now_playing"...
Feb 23 16:26:30 volumio volumio[2632]: info: Loading plugin "outputs"...
Feb 23 16:26:30 volumio volumio[2632]: info: Loading plugin "albumart"...
Feb 23 16:26:30 volumio volumio[2632]: info: Plugin example_plugin is not enabled
Feb 23 16:26:30 volumio volumio[2632]: info: Loading plugin "inputs"...
Feb 23 16:26:30 volumio volumio[2632]: info: Loading plugin "updater_comm"...
Feb 23 16:26:31 volumio volumio[2632]: info: Plugin mpdemulation is not enabled
Feb 23 16:26:31 volumio volumio[2632]: info: Loading plugin "rest_api"...
Feb 23 16:26:31 volumio volumio[2632]: info: Loading plugin "websocket"...
Feb 23 16:26:31 volumio volumio[2632]: info: Starting Socket.io Server version 2.3.0
Feb 23 16:26:31 volumio volumio[2632]: info: Loading plugin "fusiondsp"...
Feb 23 16:26:31 volumio volumio[2632]: Forking 3 albumart workers
Feb 23 16:26:31 volumio volumio[2632]: info: Applying required configuration parameters for plugin fusiondsp
Feb 23 16:26:31 volumio volumio[2632]: info: Loading plugin "volusonic"...
Feb 23 16:26:31 volumio volumio[2632]: Starting albumart workers
Feb 23 16:26:31 volumio volumio-remote-updater[575]: [2025-02-23 16:26:31] [connect] Successful connection
Feb 23 16:26:31 volumio volumio[2632]: Starting albumart workers
Feb 23 16:26:31 volumio volumio[2632]: Starting albumart workers
Feb 23 16:26:31 volumio volumio[2632]: info: Applying required configuration parameters for plugin volusonic
Feb 23 16:26:32 volumio volumio[2632]: info: Loading plugin "lastfm"...
Feb 23 16:26:32 volumio volumio[2632]: info: Plugin peppymeterbasic is not enabled
Feb 23 16:26:32 volumio volumio[2632]: info: Loading plugin "peppyspectrum"...
Feb 23 16:26:32 volumio volumio[2632]: info: Loading plugin "touch_display"...
Feb 23 16:26:32 volumio volumio[2632]: info: Applying required configuration parameters for plugin touch_display
Feb 23 16:26:32 volumio volumio[2632]: info: Loading i18n strings for locale en
Feb 23 16:26:32 volumio volumio[2632]: info: Plugin volusonic has duplicated i18n key SAVE. It is ignored.
Feb 23 16:26:32 volumio volumio[2632]: info: Plugin peppyspectrum has duplicated i18n key APPLY. It is ignored.
Feb 23 16:26:32 volumio volumio[2632]: info: Plugin peppyspectrum has duplicated i18n key SAVE. It is ignored.
Feb 23 16:26:32 volumio volumio[2632]: info: Plugin peppyspectrum has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored.
Feb 23 16:26:32 volumio volumio[2632]: info: Plugin peppyspectrum has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored.
Feb 23 16:26:32 volumio volumio[2632]: Updating browse sources language
Feb 23 16:26:32 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::initPlayerControls
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 23 16:26:33 volumio volumio[2632]: Express server listening on port 3000
Feb 23 16:26:33 volumio volumio[2632]: [Metrics] WebUI: 5s 153.60ms
Feb 23 16:26:33 volumio volumio[2632]: info: CoreStateMachine::resetVolumioState
Feb 23 16:26:33 volumio volumio[2632]: info: CoreStateMachine::getcurrentVolume
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::volumioRetrievevolume
Feb 23 16:26:33 volumio volumio[2632]: info: Volumio Network Manager: Network status updated: 3
Feb 23 16:26:33 volumio volumio[2632]: verbose: New Socket.io Connection to 10.27.27.59 from 10.27.27.39 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_3_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 1
Feb 23 16:26:33 volumio volumio[2632]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2
Feb 23 16:26:33 volumio volumio[2632]: verbose: New Socket.io Connection to 10.27.27.58 from 10.27.27.39 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_3_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 3
Feb 23 16:26:33 volumio volumio[2632]: verbose: New Socket.io Connection to 10.27.27.59 from 10.27.27.39 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_3_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 4
Feb 23 16:26:33 volumio volumio[2632]: verbose: New Socket.io Connection to 10.27.27.58 from 10.27.27.39 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_3_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 5
Feb 23 16:26:33 volumio volumio[2632]: verbose: New Socket.io Connection to 10.27.27.59 from 10.27.27.39 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_3_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 6
Feb 23 16:26:33 volumio volumio[2632]: verbose: New Socket.io Connection to 10.27.27.59 from 10.27.27.39 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_3_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 7
Feb 23 16:26:33 volumio volumio-remote-updater[575]: [2025-02-23 16:26:33] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1740349591 101
Feb 23 16:26:33 volumio volumio[2632]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 8
Feb 23 16:26:33 volumio volumio[2632]: verbose: New Socket.io Connection to 10.27.27.59 from 10.27.27.39 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_3_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 9
Feb 23 16:26:33 volumio volumio[2632]: verbose: New Socket.io Connection to 10.27.27.59 from 10.27.27.39 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_3_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 10
Feb 23 16:26:33 volumio volumio[2632]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo
Feb 23 16:26:33 volumio volumio[2632]: error: Failed callmethod call: TypeError: Cannot read property 'has' of undefined
Feb 23 16:26:33 volumio volumio[2632]: verbose: New Socket.io Connection to 10.27.27.58 from 10.27.27.39 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_3_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 11
Feb 23 16:26:33 volumio volumio[2632]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12
Feb 23 16:26:33 volumio volumio[2632]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 13
Feb 23 16:26:33 volumio volumio[2632]: info: Reloading queue from file
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 23 16:26:33 volumio volumio[2632]: info: Listing playlists
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::volumioGetQueue
Feb 23 16:26:33 volumio volumio[2632]: info: CoreStateMachine::getQueue
Feb 23 16:26:33 volumio volumio[2632]: info: CorePlayQueue::getQueue
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::volumioGetVisibleSources
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::volumioGetState
Feb 23 16:26:33 volumio volumio[2632]: info: CorePlayQueue::getTrack 0
Feb 23 16:26:33 volumio volumio[2632]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo
Feb 23 16:26:33 volumio volumio[2632]: error: Failed callmethod call: TypeError: Cannot read property 'has' of undefined
Feb 23 16:26:33 volumio volumio[2632]: info: Listing playlists
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::volumioGetQueue
Feb 23 16:26:33 volumio volumio[2632]: info: CoreStateMachine::getQueue
Feb 23 16:26:33 volumio volumio[2632]: info: CorePlayQueue::getQueue
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::volumioGetVisibleSources
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::volumioGetState
Feb 23 16:26:33 volumio volumio[2632]: info: CorePlayQueue::getTrack 0
Feb 23 16:26:33 volumio sudo[2671]: pam_unix(sudo:session): session closed for user root
Feb 23 16:26:33 volumio volumio[2632]: info: VolumeController:: Volume=96 Mute =false
Feb 23 16:26:33 volumio volumio[2632]: info: CoreStateMachine::pushState
Feb 23 16:26:33 volumio volumio[2632]: info: CorePlayQueue::getTrack 0
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::volumioPushState
Feb 23 16:26:33 volumio volumio[2632]: info: CoreStateMachine::updateTrackBlock
Feb 23 16:26:33 volumio volumio[2632]: info: CorePlayQueue::getTrackBlock
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::volumioRetrievevolume
Feb 23 16:26:33 volumio volumio[2632]: info: CoreStateMachine::setRepeat undefined single undefined
Feb 23 16:26:33 volumio volumio[2632]: info: CoreStateMachine::pushState
Feb 23 16:26:33 volumio volumio[2632]: info: CorePlayQueue::getTrack 0
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::volumioPushState
Feb 23 16:26:33 volumio volumio[2632]: info: CoreStateMachine::setRandom true
Feb 23 16:26:33 volumio volumio[2632]: info: CoreStateMachine::pushState
Feb 23 16:26:33 volumio volumio[2632]: info: CorePlayQueue::getTrack 0
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::volumioPushState
Feb 23 16:26:33 volumio volumio[2632]: info: Setting Device type: Raspberry PI
Feb 23 16:26:33 volumio volumio[2632]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb
Feb 23 16:26:33 volumio volumio[2632]: info: USB Boot Capable - System SBC Revision found in cpuinfo: b03115
Feb 23 16:26:33 volumio volumio[2632]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI
Feb 23 16:26:33 volumio volumio[2632]: verbose: New Socket.io Connection to 10.27.27.58 from 10.27.27.39 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_3_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 14
Feb 23 16:26:33 volumio volumio[2632]: verbose: New Socket.io Connection to 10.27.27.58 from 10.27.27.39 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_3_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 15
Feb 23 16:26:33 volumio volumio[2632]: info: Completed loading Core Plugins
Feb 23 16:26:33 volumio volumio[2632]: info: Preparing to generate the ALSA configuration file
Feb 23 16:26:33 volumio volumio[2632]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Feb 23 16:26:33 volumio volumio[2632]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf
Feb 23 16:26:33 volumio volumio[2632]: info: Reading ALSA contributions from plugins.
Feb 23 16:26:33 volumio volumio[2632]: info: Received Get System Info
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 23 16:26:33 volumio volumio[2632]: info: Discovery: Getting this device information
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::volumioGetState
Feb 23 16:26:33 volumio volumio[2632]: info: CorePlayQueue::getTrack 0
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::volumioGetState
Feb 23 16:26:33 volumio volumio[2632]: info: CorePlayQueue::getTrack 0
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::volumioGetVisibleSources
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::volumioGetState
Feb 23 16:26:33 volumio volumio[2632]: info: CorePlayQueue::getTrack 0
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Feb 23 16:26:33 volumio volumio[2632]: info: Received Get System Info
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 23 16:26:33 volumio volumio[2632]: info: Discovery: Getting this device information
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::volumioGetState
Feb 23 16:26:33 volumio volumio[2632]: info: CorePlayQueue::getTrack 0
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::volumioGetState
Feb 23 16:26:33 volumio volumio[2632]: info: CorePlayQueue::getTrack 0
Feb 23 16:26:33 volumio volumio[2632]: info: Listing playlists
Feb 23 16:26:33 volumio volumio[2632]: info: VolumeController:: Volume=96 Mute =false
Feb 23 16:26:33 volumio volumio[2632]: info: CoreStateMachine::pushState
Feb 23 16:26:33 volumio volumio[2632]: info: CorePlayQueue::getTrack 0
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::volumioPushState
Feb 23 16:26:33 volumio volumio[2632]: info: Discovery: adding a3f0c9a3-a52e-408e-8238-7a5c4dccaeb4
Feb 23 16:26:33 volumio volumio[2632]: info: Discovery: Found device Volumio
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::volumioGetState
Feb 23 16:26:33 volumio volumio[2632]: info: CorePlayQueue::getTrack 0
Feb 23 16:26:33 volumio volumio[2632]: info: Discovery: this is already registered, a3f0c9a3-a52e-408e-8238-7a5c4dccaeb4
Feb 23 16:26:33 volumio volumio[2632]: info: Discovery: Found device Volumio
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::volumioGetState
Feb 23 16:26:33 volumio volumio[2632]: info: CorePlayQueue::getTrack 0
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 23 16:26:33 volumio volumio[2632]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 23 16:26:34 volumio volumio[2632]: info: Asound.conf file written
Feb 23 16:26:34 volumio sudo[2756]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Feb 23 16:26:34 volumio sudo[2756]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 23 16:26:34 volumio sudo[2756]: pam_unix(sudo:session): session closed for user root
Feb 23 16:26:34 volumio volumio[2632]: info: Output device has changed, restarting MPD
Feb 23 16:26:34 volumio sudo[2762]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 23 16:26:34 volumio sudo[2762]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 23 16:26:34 volumio sudo[2762]: pam_unix(sudo:session): session closed for user root
Feb 23 16:26:34 volumio volumio[2632]: info: ___________ START PLUGINS ___________
Feb 23 16:26:34 volumio volumio[2632]: info: ControllerMpd::onStart: Initializing MPD
Feb 23 16:26:34 volumio volumio[2632]: info: Creating MPD Configuration file
Feb 23 16:26:34 volumio sudo[2765]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 23 16:26:34 volumio sudo[2765]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 23 16:26:34 volumio systemd[1]: Stopping Music Player Daemon...
Feb 23 16:26:34 volumio sudo[2768]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 23 16:26:34 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 23 16:26:34 volumio volumio[2632]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Feb 23 16:26:34 volumio volumio[2632]: info: [1740349594537] CoreMusicLibrary::Adding element Media Servers
Feb 23 16:26:34 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 23 16:26:34 volumio sudo[2768]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 23 16:26:34 volumio systemd[1]: mpd.service: Succeeded.
Feb 23 16:26:34 volumio systemd[1]: Stopped Music Player Daemon.
Feb 23 16:26:34 volumio sudo[2768]: pam_unix(sudo:session): session closed for user root
Feb 23 16:26:34 volumio sudo[2770]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 23 16:26:34 volumio sudo[2770]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 23 16:26:34 volumio volumio[2632]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Feb 23 16:26:34 volumio volumio[2632]: info: [1740349594558] CoreMusicLibrary::Adding element Last_100
Feb 23 16:26:34 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 23 16:26:34 volumio volumio[2632]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Feb 23 16:26:34 volumio volumio[2632]: info: [1740349594560] CoreMusicLibrary::Adding element Webradio
Feb 23 16:26:34 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 23 16:26:34 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 23 16:26:34 volumio volumio[2632]: info: Initializing BBC Radios
Feb 23 16:26:34 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 23 16:26:34 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 23 16:26:34 volumio volumio[2632]: info: [now-playing] ConfigUpdater: config is up to date.
Feb 23 16:26:34 volumio volumio[2632]: info: Loading i18n strings for locale en
Feb 23 16:26:34 volumio volumio[2632]: info: Plugin volusonic has duplicated i18n key SAVE. It is ignored.
Feb 23 16:26:34 volumio volumio[2632]: info: Plugin peppyspectrum has duplicated i18n key APPLY. It is ignored.
Feb 23 16:26:34 volumio volumio[2632]: info: Plugin peppyspectrum has duplicated i18n key SAVE. It is ignored.
Feb 23 16:26:34 volumio volumio[2632]: info: Plugin peppyspectrum has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored.
Feb 23 16:26:34 volumio volumio[2632]: info: Plugin peppyspectrum has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored.
Feb 23 16:26:34 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Feb 23 16:26:34 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 23 16:26:34 volumio volumio[2632]: info: FusionDsp - mixtype--------------------- Hardware
Feb 23 16:26:34 volumio systemd[1]: Starting Music Player Daemon...
Feb 23 16:26:34 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM
Feb 23 16:26:34 volumio systemd[1]: mpd.service: Succeeded.
Feb 23 16:26:34 volumio systemd[1]: Stopped Music Player Daemon.
Feb 23 16:26:34 volumio systemd[1]: Starting Music Player Daemon...
Feb 23 16:26:34 volumio volumio[2632]: info: Loading i18n strings for locale en
Feb 23 16:26:34 volumio volumio[2632]: info: Plugin volusonic has duplicated i18n key SAVE. It is ignored.
Feb 23 16:26:34 volumio volumio[2632]: info: Plugin peppyspectrum has duplicated i18n key APPLY. It is ignored.
Feb 23 16:26:34 volumio volumio[2632]: info: Plugin peppyspectrum has duplicated i18n key SAVE. It is ignored.
Feb 23 16:26:34 volumio volumio[2632]: info: Plugin peppyspectrum has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored.
Feb 23 16:26:34 volumio volumio[2632]: info: Plugin peppyspectrum has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored.
Feb 23 16:26:34 volumio volumio[2632]: Updating browse sources language
Feb 23 16:26:34 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 23 16:26:34 volumio volumio[2632]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Feb 23 16:26:34 volumio volumio[2632]: info: [1740349594693] CoreMusicLibrary::Adding element Volusonic
Feb 23 16:26:34 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 23 16:26:34 volumio volumio[2632]: Cannot find translation for source Volusonic
Feb 23 16:26:34 volumio volumio[2632]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Feb 23 16:26:34 volumio volumio[2632]: info: [1740349594695] CoreMusicLibrary::Adding element LastFM
Feb 23 16:26:34 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 23 16:26:34 volumio volumio[2632]: Cannot find translation for source Volusonic
Feb 23 16:26:34 volumio volumio[2632]: Cannot find translation for source LastFM
Feb 23 16:26:34 volumio volumio[2632]: info: [LastFM] scrobbler initiated!
Feb 23 16:26:34 volumio volumio[2632]: info: [LastFM] extended logging: false
Feb 23 16:26:34 volumio volumio[2632]: info: [LastFM] try scrobble stream/radio plays: true
Feb 23 16:26:34 volumio volumio[2632]: info: [LastFM] Left init routine
Feb 23 16:26:34 volumio volumio[2632]: info: [LastFM] Socket already connected: true
Feb 23 16:26:34 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Feb 23 16:26:34 volumio volumio[2632]: info: Loading i18n strings for locale en
Feb 23 16:26:34 volumio volumio[2632]: info: Plugin volusonic has duplicated i18n key SAVE. It is ignored.
Feb 23 16:26:34 volumio volumio[2632]: info: Plugin peppyspectrum has duplicated i18n key APPLY. It is ignored.
Feb 23 16:26:34 volumio volumio[2632]: info: Plugin peppyspectrum has duplicated i18n key SAVE. It is ignored.
Feb 23 16:26:34 volumio volumio[2632]: info: Plugin peppyspectrum has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored.
Feb 23 16:26:34 volumio volumio[2632]: info: Plugin peppyspectrum has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored.
Feb 23 16:26:34 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 23 16:26:34 volumio sudo[2784]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Feb 23 16:26:34 volumio volumio[2632]: info: Volumio Calling Home
Feb 23 16:26:34 volumio sudo[2784]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 23 16:26:34 volumio sudo[2784]: pam_unix(sudo:session): session closed for user root
Feb 23 16:26:34 volumio volumio[2632]: info: Preparing to generate the ALSA configuration file
Feb 23 16:26:34 volumio sudo[2791]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service
Feb 23 16:26:34 volumio sudo[2791]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 23 16:26:34 volumio sudo[2794]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service
Feb 23 16:26:34 volumio sudo[2794]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 23 16:26:35 volumio sudo[2791]: pam_unix(sudo:session): session closed for user root
Feb 23 16:26:35 volumio systemd[1]: Reloading.
Feb 23 16:26:35 volumio sudo[2797]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload
Feb 23 16:26:35 volumio sudo[2797]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 23 16:26:35 volumio volumio[2632]: info: [now-playing] Fetching API key...
Feb 23 16:26:35 volumio volumio[2632]: info: [now-playing] App is listening on port 4004.
Feb 23 16:26:35 volumio volumio[2632]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds
Feb 23 16:26:35 volumio volumio[2632]: info: Cannot mount NAS Public at system boot, trial number 2 ,retrying in 5 seconds
Feb 23 16:26:35 volumio volumio[2632]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Feb 23 16:26:35 volumio volumio[2632]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf
Feb 23 16:26:35 volumio volumio[2632]: info: Reading ALSA contributions from plugins.
Feb 23 16:26:35 volumio volumio[2632]: error: touch_display: Error detecting backlight interface: Error: ENOENT: no such file or directory, scandir '/sys/class/backlight/'
Feb 23 16:26:35 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 23 16:26:35 volumio volumio[2632]: info: touch_display: systemctl stop getty@tty1.service succeeded.
Feb 23 16:26:35 volumio volumio[2632]: info: MPD Permissions set
Feb 23 16:26:35 volumio volumio[2632]: info: MPD Permissions set
Feb 23 16:26:35 volumio volumio[2632]: info: Volumio called home
Feb 23 16:26:35 volumio volumio[2632]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 16
Feb 23 16:26:35 volumio volumio[2632]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 17
Feb 23 16:26:35 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 23 16:26:35 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 23 16:26:35 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 23 16:26:35 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 23 16:26:35 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 23 16:26:35 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 23 16:26:35 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 23 16:26:35 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 23 16:26:35 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 23 16:26:35 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 23 16:26:35 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 23 16:26:35 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 23 16:26:35 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 23 16:26:35 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly.
Feb 23 16:26:35 volumio volumio[2632]: info: [LastFM] finished init: Authenticated successfully!
Feb 23 16:26:35 volumio volumio[2632]: info: touch_display: No Raspberry Pi Foundation touch screen detected.
Feb 23 16:26:35 volumio sudo[2823]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf
Feb 23 16:26:35 volumio sudo[2823]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 23 16:26:35 volumio sudo[2823]: pam_unix(sudo:session): session closed for user root
Feb 23 16:26:35 volumio volumio[2632]: info: CoreCommandRouter::volumioGetState
Feb 23 16:26:35 volumio volumio[2632]: info: CorePlayQueue::getTrack 0
Feb 23 16:26:35 volumio volumio[2632]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set.
Feb 23 16:26:35 volumio volumio[2632]: info: Asound.conf file unchanged, so no further update is needed
Feb 23 16:26:35 volumio volumio[2632]: info: Output device has changed, restarting MPD
Feb 23 16:26:36 volumio sudo[2794]: pam_unix(sudo:session): session closed for user root
Feb 23 16:26:36 volumio systemd[1]: Reloading.
Feb 23 16:26:36 volumio mpd[2787]: Feb 23 16:26 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Feb 23 16:26:36 volumio sudo[2826]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 23 16:26:36 volumio sudo[2826]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 23 16:26:36 volumio sudo[2826]: pam_unix(sudo:session): session closed for user root
Feb 23 16:26:36 volumio volumio[2632]: info: Preparing to generate the ALSA configuration file
Feb 23 16:26:36 volumio sudo[2831]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 23 16:26:36 volumio sudo[2831]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 23 16:26:36 volumio volumio[2632]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Feb 23 16:26:36 volumio volumio[2632]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf
Feb 23 16:26:36 volumio volumio[2632]: info: Reading ALSA contributions from plugins.
Feb 23 16:26:36 volumio volumio[2632]: info: MPD Permissions set
Feb 23 16:26:36 volumio volumio[2632]: info: touch_display: systemctl disable getty@tty1.service succeeded.
Feb 23 16:26:36 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly.
Feb 23 16:26:36 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 23 16:26:36 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 23 16:26:36 volumio volumio[2632]: info: Discovery: Getting this device information
Feb 23 16:26:36 volumio volumio[2632]: info: CoreCommandRouter::volumioGetState
Feb 23 16:26:36 volumio volumio[2632]: info: CorePlayQueue::getTrack 0
Feb 23 16:26:36 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 23 16:26:36 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 23 16:26:36 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 23 16:26:36 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 23 16:26:36 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 23 16:26:36 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 23 16:26:36 volumio volumio[2632]: info: Discovery: Getting this device information
Feb 23 16:26:36 volumio volumio[2632]: info: CoreCommandRouter::volumioGetState
Feb 23 16:26:36 volumio volumio[2632]: info: CorePlayQueue::getTrack 0
Feb 23 16:26:36 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 23 16:26:36 volumio volumio[2632]: verbose: New Socket.io Connection to 10.27.27.58:3000 from 10.27.27.39 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 18
Feb 23 16:26:36 volumio volumio[2632]: info: Asound.conf file unchanged, so no further update is needed
Feb 23 16:26:36 volumio volumio[2632]: info: Output device has changed, restarting MPD
Feb 23 16:26:36 volumio sudo[2853]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 23 16:26:36 volumio sudo[2853]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 23 16:26:36 volumio sudo[2853]: pam_unix(sudo:session): session closed for user root
Feb 23 16:26:36 volumio sudo[2856]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 23 16:26:36 volumio sudo[2856]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 23 16:26:36 volumio volumio[2632]: info: CoreCommandRouter::volumioGetState
Feb 23 16:26:36 volumio volumio[2632]: info: CorePlayQueue::getTrack 0
Feb 23 16:26:36 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Feb 23 16:26:36 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Feb 23 16:26:36 volumio volumio[2632]: info: MPD Permissions set
Feb 23 16:26:36 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 23 16:26:36 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 23 16:26:36 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 23 16:26:36 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 23 16:26:36 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 23 16:26:36 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 23 16:26:36 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 23 16:26:36 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 23 16:26:36 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 23 16:26:36 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 23 16:26:36 volumio volumio[2632]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists
Feb 23 16:26:36 volumio volumio[2632]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo
Feb 23 16:26:36 volumio volumio[2632]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists
Feb 23 16:26:36 volumio volumio[2632]: info: camilladsp spawned new process with pid 2871, instance 1, run: true
Feb 23 16:26:36 volumio volumio[2632]: info: camilladsp service started and running in background, instance 1
Feb 23 16:26:36 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 23 16:26:36 volumio systemd[1]: Started Music Player Daemon.
Feb 23 16:26:36 volumio sudo[2797]: pam_unix(sudo:session): session closed for user root
Feb 23 16:26:36 volumio sudo[2770]: pam_unix(sudo:session): session closed for user root
Feb 23 16:26:36 volumio sudo[2765]: pam_unix(sudo:session): session closed for user root
Feb 23 16:26:36 volumio volumio[2632]: cannot open device 'volumioHw': Device or resource busy
Feb 23 16:26:36 volumio volumio[2632]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json
Feb 23 16:26:36 volumio volumio[2632]: cannot open device 'volumioHw': Device or resource busy
Feb 23 16:26:36 volumio systemd[1]: Stopping Music Player Daemon...
Feb 23 16:26:36 volumio volumio[2632]: info: FusionDsp loaded
Feb 23 16:26:36 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 23 16:26:36 volumio systemd[1]: mpd.service: Succeeded.
Feb 23 16:26:36 volumio systemd[1]: Stopped Music Player Daemon.
Feb 23 16:26:36 volumio sudo[2882]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service
Feb 23 16:26:36 volumio volumio[2632]: info: FusionDsp - Reporting Fusion DSP Enabled
Feb 23 16:26:36 volumio volumio[2632]: info: Adding Signal Path Element [object Object]
Feb 23 16:26:36 volumio volumio[2632]: info: Adding fusiondspeq DSP Signal Path Element
Feb 23 16:26:36 volumio volumio[2632]: info: FusionDsp - ---- installed callbackRead
Feb 23 16:26:36 volumio volumio[2632]: info: touch_display: systemctl daemon-reload succeeded.
Feb 23 16:26:36 volumio volumio[2632]: info: FusionDsp - If filter freq >samplerate/2 then disable it
Feb 23 16:26:36 volumio systemd[1]: Starting Music Player Daemon...
Feb 23 16:26:36 volumio sudo[2882]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 23 16:26:36 volumio volumio[2632]: error: Cannot initialize MPD Connection: MPD is not running
Feb 23 16:26:36 volumio sudo[2888]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service
Feb 23 16:26:36 volumio sudo[2888]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 23 16:26:36 volumio volumio[2632]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 19
Feb 23 16:26:36 volumio sudo[2882]: pam_unix(sudo:session): session closed for user root
Feb 23 16:26:36 volumio sudo[2888]: pam_unix(sudo:session): session closed for user root
Feb 23 16:26:36 volumio volumio[2632]: info: FusionDsp - {"Reload":{"result":"Ok"}}
Feb 23 16:26:36 volumio volumio[2632]: info: touch_display: systemctl start volumio-kiosk.service succeeded.
Feb 23 16:26:36 volumio volumio[2632]: info: touch_display: Volumio Kiosk started.
Feb 23 16:26:36 volumio volumio[2632]: info: CoreCommandRouter::volumioGetState
Feb 23 16:26:36 volumio volumio[2632]: info: CorePlayQueue::getTrack 0
Feb 23 16:26:36 volumio volumio[2632]: info: Completed starting Core Plugins
Feb 23 16:26:36 volumio volumio[2632]: info: -------------------------------------------
Feb 23 16:26:36 volumio volumio[2632]: info: ----- MyVolumio plugins startup ----
Feb 23 16:26:36 volumio volumio[2632]: info: -------------------------------------------
Feb 23 16:26:36 volumio volumio[2632]: info: [MyVolumio PluginManager] Fetching plans data....
Feb 23 16:26:36 volumio volumio[2632]: info: CoreCommandRouter::volumioGetState
Feb 23 16:26:36 volumio volumio[2632]: info: CorePlayQueue::getTrack 0
Feb 23 16:26:36 volumio sudo[2883]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Feb 23 16:26:36 volumio sudo[2883]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 23 16:26:36 volumio sudo[2883]: pam_unix(sudo:session): session closed for user root
Feb 23 16:26:36 volumio volumio[2632]: info: touch_display: X display number found: 0
Feb 23 16:26:37 volumio volumio[2632]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Feb 23 16:26:37 volumio volumio[2632]: info: touch_display: X display number found: 0
Feb 23 16:26:37 volumio volumio[2632]: info: CoreCommandRouter::volumioGetState
Feb 23 16:26:37 volumio volumio[2632]: info: CorePlayQueue::getTrack 0
Feb 23 16:26:37 volumio volumio[2632]: info: touch_display: Setting screensaver timeout to 0 seconds.
Feb 23 16:26:37 volumio volumio[2632]: info: [now-playing] OpenWeatherMap API key obtained.
Feb 23 16:26:37 volumio mpd[2894]: Feb 23 16:26 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Feb 23 16:26:37 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Feb 23 16:26:37 volumio systemd[1]: Started Music Player Daemon.
Feb 23 16:26:37 volumio sudo[2856]: pam_unix(sudo:session): session closed for user root
Feb 23 16:26:37 volumio sudo[2831]: pam_unix(sudo:session): session closed for user root
Feb 23 16:26:37 volumio volumio[2632]: error: MPD error: The expression evaluated to a falsy value:
Feb 23 16:26:37 volumio volumio[2632]: assert.ok(self.idling)
Feb 23 16:26:37 volumio volumio[2632]: error: The expression evaluated to a falsy value:
Feb 23 16:26:37 volumio volumio[2632]: assert.ok(self.idling)
Feb 23 16:26:38 volumio volumio[2632]: error: updateQueue error: null
Feb 23 16:26:38 volumio volumio[2632]: error: MPD error: The expression evaluated to a falsy value:
Feb 23 16:26:38 volumio volumio[2632]: assert.ok(self.idling)
Feb 23 16:26:38 volumio volumio[2632]: error: The expression evaluated to a falsy value:
Feb 23 16:26:38 volumio volumio[2632]: assert.ok(self.idling)
Feb 23 16:26:38 volumio volumio[2632]: error: updateQueue error: null
Feb 23 16:26:38 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 23 16:26:38 volumio volumio[2632]: info: Discovery: Getting this device information
Feb 23 16:26:38 volumio volumio[2632]: info: CoreCommandRouter::volumioGetState
Feb 23 16:26:38 volumio volumio[2632]: info: CorePlayQueue::getTrack 0
Feb 23 16:26:38 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 23 16:26:38 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Feb 23 16:26:38 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 23 16:26:38 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Feb 23 16:26:38 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Feb 23 16:26:38 volumio volumio[2632]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Feb 23 16:26:38 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Feb 23 16:26:38 volumio volumio[2632]: info: Received Get System Version
Feb 23 16:26:38 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 23 16:26:38 volumio volumio[2632]: info: Received Get System Info
Feb 23 16:26:38 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 23 16:26:38 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 23 16:26:38 volumio volumio[2632]: info: Discovery: Getting this device information
Feb 23 16:26:38 volumio volumio[2632]: info: CoreCommandRouter::volumioGetState
Feb 23 16:26:38 volumio volumio[2632]: info: CorePlayQueue::getTrack 0
Feb 23 16:26:38 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 23 16:26:39 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Feb 23 16:26:39 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Feb 23 16:26:40 volumio volumio[2632]: info: Cannot mount NAS Public at system boot, trial number 3 ,retrying in 5 seconds
Feb 23 16:26:40 volumio volumio[2632]: info: Cannot mount NAS Public at system boot, trial number 3 ,retrying in 5 seconds
Feb 23 16:26:40 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Feb 23 16:26:40 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Feb 23 16:26:41 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Feb 23 16:26:41 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Feb 23 16:26:42 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Feb 23 16:26:42 volumio volumio[2632]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 23 16:26:42 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Feb 23 16:26:42 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Feb 23 16:26:42 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Feb 23 16:26:42 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Feb 23 16:26:42 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 23 16:26:42 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 23 16:26:42 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 23 16:26:42 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 23 16:26:42 volumio volumio[2632]: info: CoreCommandRouter::volumioGetBrowseSources
Feb 23 16:26:42 volumio volumio[2632]: info: CoreCommandRouter::volumioGetBrowseSources
Feb 23 16:26:42 volumio volumio[2632]: info: CoreCommandRouter::volumioGetBrowseSources
Feb 23 16:26:42 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 23 16:26:42 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Feb 23 16:26:42 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Feb 23 16:26:42 volumio volumio[2632]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory
Feb 23 16:26:45 volumio volumio[2632]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
Feb 23 16:26:45 volumio volumio[2632]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
Feb 23 16:26:45 volumio volumio[2632]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
Feb 23 16:26:45 volumio volumio[2632]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
Feb 23 16:26:45 volumio volumio[2632]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
Feb 23 16:26:45 volumio volumio[2632]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
Feb 23 16:26:45 volumio volumio[2632]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
Feb 23 16:26:45 volumio volumio[2632]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
Feb 23 16:26:45 volumio volumio[2632]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
Feb 23 16:26:45 volumio volumio[2632]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
Feb 23 16:26:45 volumio volumio[2632]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Feb 23 16:26:45 volumio volumio[2632]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Feb 23 16:26:45 volumio volumio[2632]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Feb 23 16:26:45 volumio volumio[2632]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
Feb 23 16:26:45 volumio volumio[2632]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Feb 23 16:26:45 volumio volumio[2632]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Feb 23 16:26:45 volumio volumio[2632]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Feb 23 16:26:45 volumio volumio[2632]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Feb 23 16:26:45 volumio volumio[2632]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Feb 23 16:26:45 volumio volumio[2632]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Feb 23 16:26:45 volumio volumio[2632]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Feb 23 16:26:45 volumio volumio[2632]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
Feb 23 16:26:45 volumio volumio[2632]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Feb 23 16:26:45 volumio volumio[2632]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Feb 23 16:26:45 volumio volumio[2632]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Feb 23 16:26:45 volumio volumio[2632]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Feb 23 16:26:45 volumio volumio[2632]: info: Adding plugin bluetooth to MyMusic Plugins
Feb 23 16:26:45 volumio volumio[2632]: info: Adding plugin multiroom to MyMusic Plugins
Feb 23 16:26:45 volumio volumio[2632]: info: Adding plugin metavolumio to MyMusic Plugins
Feb 23 16:26:45 volumio volumio[2632]: info: Adding plugin cd_controller to MyMusic Plugins
Feb 23 16:26:45 volumio volumio[2632]: info: Adding plugin smart_inputs to MyMusic Plugins
Feb 23 16:26:45 volumio volumio[2632]: info: Adding plugin tidalconnect to MyMusic Plugins
Feb 23 16:26:45 volumio volumio[2632]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
Feb 23 16:26:45 volumio volumio[2632]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Feb 23 16:26:45 volumio volumio[2632]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Feb 23 16:26:45 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 23 16:26:45 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 23 16:26:45 volumio volumio[2632]: info: Starting MyVolumio Remote Streaming Endpoints
Feb 23 16:26:45 volumio volumio[2632]: info: MyVolumio login type: Token
Feb 23 16:26:45 volumio volumio[2632]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Feb 23 16:26:45 volumio volumio[2632]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
Feb 23 16:26:46 volumio volumio[2632]: info: Starting Streaming Service Transparent Proxy
Feb 23 16:26:46 volumio volumio[2632]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Feb 23 16:26:46 volumio volumio[2632]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Feb 23 16:26:46 volumio volumio[2632]: info: Streaming services startup
Feb 23 16:26:46 volumio volumio[2632]: info: Starting Streaming Daemon
Feb 23 16:26:46 volumio sudo[2935]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Feb 23 16:26:46 volumio sudo[2935]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 23 16:26:46 volumio sudo[2935]: pam_unix(sudo:session): session closed for user root
Feb 23 16:26:46 volumio volumio[2632]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
Feb 23 16:26:46 volumio volumio[2632]: info: Cannot mount NAS Public at system boot, trial number 4 ,retrying in 5 seconds
Feb 23 16:26:46 volumio volumio[2632]: info: Cannot mount NAS Public at system boot, trial number 4 ,retrying in 5 seconds
Feb 23 16:26:46 volumio volumio[2632]: error: Cannot start Volumio Streaming Daemon
Feb 23 16:26:46 volumio volumio[2632]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Feb 23 16:26:46 volumio volumio[2632]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Feb 23 16:26:46 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 23 16:26:47 volumio volumio[2632]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
Feb 23 16:26:47 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare
Feb 23 16:26:47 volumio volumio[2632]: STREAMING PROXY: Starting server on port 3245
Feb 23 16:26:47 volumio volumio[2632]: Node JS runtime: 14
Feb 23 16:26:47 volumio sudo[2944]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/NAS/Public
Feb 23 16:26:47 volumio sudo[2944]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 23 16:26:47 volumio sudo[2944]: pam_unix(sudo:session): session closed for user root
Feb 23 16:26:47 volumio systemd[1]: mnt-NAS-Public.mount: Succeeded.
Feb 23 16:26:47 volumio volumio[2632]: info: Share Public successfully unmounted
Feb 23 16:26:47 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 23 16:26:47 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 23 16:26:47 volumio volumio[2632]: info: Discovery: Getting this device information
Feb 23 16:26:47 volumio volumio[2632]: info: CoreCommandRouter::volumioGetState
Feb 23 16:26:47 volumio volumio[2632]: info: CorePlayQueue::getTrack 0
Feb 23 16:26:47 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 23 16:26:47 volumio volumio[2632]: info: MyVolumio token set successfully
Feb 23 16:26:47 volumio volumio[2632]: info: MYVOLUMIO: Adding device
Feb 23 16:26:47 volumio volumio[2632]: info: MYVOLUMIO: Evaluating Server
Feb 23 16:26:47 volumio volumio[2632]: info: MyVolumio Plan changed: premium
Feb 23 16:26:47 volumio volumio[2632]: info: [MyVolumio PluginManager] Subscribed plan changed to premium
Feb 23 16:26:47 volumio volumio[2632]: info: Removing browser output: myVolumio user plan is not superstar
Feb 23 16:26:47 volumio volumio[2632]: info: Removing audio output:
Feb 23 16:26:47 volumio volumio[2632]: info: MYVOLUMIO: Adding device
Feb 23 16:26:47 volumio volumio[2632]: info: MYVOLUMIO: Evaluating Server
Feb 23 16:26:47 volumio volumio[2632]: info: Remote config written successfully
Feb 23 16:26:47 volumio volumio[2632]: info: Starting Tunnel 1
Feb 23 16:26:47 volumio volumio[2632]: info: Starting Tunnel Connection Checker
Feb 23 16:26:47 volumio volumio[2632]: info: Completed starting MyVolumio Plugin
Feb 23 16:26:48 volumio volumio[2632]: info: MYVolumio Device enabled
Feb 23 16:26:48 volumio volumio[2632]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins...
Feb 23 16:26:48 volumio volumio[2632]: info: MyVolumio status changed
Feb 23 16:26:48 volumio volumio[2632]: info: Streaming services startup
Feb 23 16:26:48 volumio volumio[2632]: info: Starting Streaming Daemon
Feb 23 16:26:48 volumio volumio[2632]: info: Setting Geolocation for MyVolumio to us3
Feb 23 16:26:48 volumio sudo[2980]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Feb 23 16:26:48 volumio sudo[2980]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 23 16:26:48 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 23 16:26:48 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 23 16:26:48 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 23 16:26:48 volumio sudo[2980]: pam_unix(sudo:session): session closed for user root
Feb 23 16:26:48 volumio volumio[2632]: error: Cannot start Volumio Streaming Daemon
Feb 23 16:26:48 volumio volumio[2632]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Feb 23 16:26:48 volumio volumio[2632]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Feb 23 16:26:48 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid
Feb 23 16:26:48 volumio volumio[2632]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"...
Feb 23 16:26:48 volumio volumio[2632]: info: [1740349608554] Starting BluetoothController
Feb 23 16:26:48 volumio volumio[2632]: info: [MyVolumio PluginManager] Loading plugin "multiroom"...
Feb 23 16:26:49 volumio volumio[2632]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom
Feb 23 16:26:49 volumio sudo[2997]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom
Feb 23 16:26:49 volumio sudo[2997]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 23 16:26:49 volumio sudo[2997]: pam_unix(sudo:session): session closed for user root
Feb 23 16:26:49 volumio volumio[2632]: /bin/mkdir: cannot create directory ‘/tmp/hls’: File exists
Feb 23 16:26:49 volumio volumio[2632]: info: MRS: MultiRoom plugin initialized
Feb 23 16:26:49 volumio volumio[2632]: info: MRS: STOPPING SNAPCLIENT
Feb 23 16:26:49 volumio volumio[2632]: info: MRS: Snap server stop
Feb 23 16:26:49 volumio sudo[3013]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient
Feb 23 16:26:49 volumio sudo[3013]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 23 16:26:49 volumio volumio[2632]: info: MRS: STOPPING volumioStreaming
Feb 23 16:26:49 volumio sudo[3016]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver
Feb 23 16:26:49 volumio sudo[3013]: pam_unix(sudo:session): session closed for user root
Feb 23 16:26:49 volumio sudo[3016]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 23 16:26:49 volumio sudo[3018]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming
Feb 23 16:26:49 volumio sudo[3018]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 23 16:26:49 volumio volumio[2632]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"...
Feb 23 16:26:49 volumio sudo[3022]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/*
Feb 23 16:26:49 volumio sudo[3022]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 23 16:26:49 volumio volumio[2632]: info: [MyVolumio PluginManager] Loading plugin "manifestui"...
Feb 23 16:26:49 volumio sudo[3022]: pam_unix(sudo:session): session closed for user root
Feb 23 16:26:49 volumio sudo[3018]: pam_unix(sudo:session): session closed for user root
Feb 23 16:26:49 volumio sudo[3016]: pam_unix(sudo:session): session closed for user root
Feb 23 16:26:49 volumio volumio[2632]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"...
Feb 23 16:26:49 volumio volumio[2632]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"...
Feb 23 16:26:49 volumio volumio[2632]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"...
Feb 23 16:26:49 volumio volumio[2632]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio
Feb 23 16:26:49 volumio volumio[2632]: info: [MyVolumio PluginManager] Loading plugin "tidal"...
Feb 23 16:26:49 volumio volumio[2632]: info: [MyVolumio PluginManager] Loading plugin "qobuz"...
Feb 23 16:26:49 volumio volumio[2632]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"...
Feb 23 16:26:49 volumio volumio[2632]: info: Preparing to generate the ALSA configuration file
Feb 23 16:26:49 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Feb 23 16:26:50 volumio volumio[2632]: info: Updating MyVolumio device info
Feb 23 16:26:50 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 23 16:26:50 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 23 16:26:50 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 23 16:26:50 volumio volumio[2632]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Feb 23 16:26:50 volumio volumio[2632]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Feb 23 16:26:50 volumio volumio[2632]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf
Feb 23 16:26:50 volumio volumio[2632]: info: Reading ALSA contributions from plugins.
Feb 23 16:26:50 volumio volumio[2632]: info: Setting Geolocation for MyVolumio to us3
Feb 23 16:26:50 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 23 16:26:50 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 23 16:26:50 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 23 16:26:50 volumio volumio[2632]: info: MRS: Removed streaming files
Feb 23 16:26:50 volumio volumio[2632]: info: MRS: volumioStreaming STOPPED
Feb 23 16:26:50 volumio volumio[2632]: info: MRS: SNAPSERVER STOPPED
Feb 23 16:26:50 volumio volumio[2632]: info: MRS: SNAPCLIENT STOPPED
Feb 23 16:26:50 volumio volumio[2632]: info: Asound.conf file written
Feb 23 16:26:50 volumio sudo[3028]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Feb 23 16:26:50 volumio sudo[3028]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 23 16:26:50 volumio sudo[3028]: pam_unix(sudo:session): session closed for user root
Feb 23 16:26:50 volumio volumio[2632]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Max Overclock PLL:0' : Device or resource busy
Feb 23 16:26:50 volumio volumio[2632]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Max Overclock DSP:0' : Device or resource busy
Feb 23 16:26:50 volumio volumio[2632]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Max Overclock DAC:0' : Device or resource busy
Feb 23 16:26:50 volumio volumio[2632]: info: Output device has changed, restarting MPD
Feb 23 16:26:50 volumio sudo[3033]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 23 16:26:50 volumio sudo[3033]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 23 16:26:50 volumio sudo[3033]: pam_unix(sudo:session): session closed for user root
Feb 23 16:26:50 volumio volumio[2632]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Feb 23 16:26:50 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 23 16:26:50 volumio sudo[3036]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 23 16:26:50 volumio sudo[3036]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 23 16:26:50 volumio volumio[2632]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth
Feb 23 16:26:50 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Feb 23 16:26:50 volumio systemd[1]: Stopping Music Player Daemon...
Feb 23 16:26:50 volumio volumio[2632]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom
Feb 23 16:26:50 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus
Feb 23 16:26:50 volumio volumio[2632]: info: MRS: Pushing multiroomSync output for this device
Feb 23 16:26:50 volumio volumio[2632]: info: MRS: Pushing multiroomSync output
Feb 23 16:26:50 volumio sudo[3041]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name Volumio
Feb 23 16:26:50 volumio sudo[3041]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 23 16:26:50 volumio volumio[2632]: info: Adding audio output:
Feb 23 16:26:50 volumio volumio[2632]: info: Adding audio output:
Feb 23 16:26:50 volumio sudo[3041]: pam_unix(sudo:session): session closed for user root
Feb 23 16:26:50 volumio systemd[1]: mpd.service: Succeeded.
Feb 23 16:26:50 volumio systemd[1]: Stopped Music Player Daemon.
Feb 23 16:26:50 volumio volumio[2632]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Feb 23 16:26:50 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 23 16:26:50 volumio volumio[2632]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio
Feb 23 16:26:50 volumio volumio[2632]: info: Adding METAVOLUMIO REST API Endpoints
Feb 23 16:26:50 volumio volumio[2632]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio
Feb 23 16:26:50 volumio volumio[2632]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio
Feb 23 16:26:50 volumio volumio[2632]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio
Feb 23 16:26:50 volumio volumio[2632]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio
Feb 23 16:26:50 volumio volumio[2632]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui
Feb 23 16:26:50 volumio volumio[2632]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller
Feb 23 16:26:50 volumio volumio[2632]: info: Preparing CD Folders
Feb 23 16:26:50 volumio volumio[2632]: info: Adding CD REST API Endpoints
Feb 23 16:26:50 volumio volumio[2632]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller
Feb 23 16:26:50 volumio volumio[2632]: info: Starting UDEV Watcher for CD
Feb 23 16:26:50 volumio volumio[2632]: info: Detecting CD presence with UDEV
Feb 23 16:26:50 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices
Feb 23 16:26:50 volumio systemd[1]: Starting Music Player Daemon...
Feb 23 16:26:50 volumio volumio[2632]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs
Feb 23 16:26:50 volumio volumio[2632]: info: Adding inputs REST Endpoints
Feb 23 16:26:50 volumio volumio[2632]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs
Feb 23 16:26:50 volumio volumio[2632]: info: Scanning Audio Inputs
Feb 23 16:26:50 volumio volumio[2632]: info: Checking against Known Cards name
Feb 23 16:26:50 volumio volumio[2632]: info: Adding Server instance for streaming
Feb 23 16:26:50 volumio sudo[3043]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Feb 23 16:26:50 volumio volumio[2632]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio
Feb 23 16:26:50 volumio sudo[3043]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 23 16:26:50 volumio volumio[2632]: error: Hi Res Audio Failed Login: Missing Login Data
Feb 23 16:26:50 volumio volumio[2632]: info: Adding HIGHRESAUDIO REST API Endpoints
Feb 23 16:26:50 volumio volumio[2632]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio
Feb 23 16:26:50 volumio volumio[2632]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal
Feb 23 16:26:50 volumio volumio[2632]: info: Refreshing TIDAL token
Feb 23 16:26:50 volumio sudo[3043]: pam_unix(sudo:session): session closed for user root
Feb 23 16:26:50 volumio volumio[2632]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz
Feb 23 16:26:50 volumio volumio[2632]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect
Feb 23 16:26:50 volumio sudo[3052]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Feb 23 16:26:50 volumio sudo[3052]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 23 16:26:50 volumio volumio[2632]: info: Stopping AccessToken refresher cron for QOBUZ
Feb 23 16:26:50 volumio systemd[1]: Stopping Volumio Tidal Connect Service...
Feb 23 16:26:50 volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM
Feb 23 16:26:50 volumio systemd[1]: vtcs.service: Succeeded.
Feb 23 16:26:50 volumio systemd[1]: Stopped Volumio Tidal Connect Service.
Feb 23 16:26:50 volumio sudo[3052]: pam_unix(sudo:session): session closed for user root
Feb 23 16:26:50 volumio volumio[2632]: info: AccessToken refresher cron started for QOBUZ
Feb 23 16:26:50 volumio volumio[2632]: info: Adding QOBUZ REST API Endpoints
Feb 23 16:26:50 volumio volumio[2632]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz
Feb 23 16:26:50 volumio volumio[2632]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined
Feb 23 16:26:50 volumio volumio[2632]: info: Bluetooth name changed to Volumio
Feb 23 16:26:50 volumio volumio[2632]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined
Feb 23 16:26:50 volumio volumio[2632]: info: MPD Permissions set
Feb 23 16:26:50 volumio volumio[2632]: info: Successfully Added MyVolumio device
Feb 23 16:26:50 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 23 16:26:50 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 23 16:26:50 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 23 16:26:50 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 23 16:26:50 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 23 16:26:50 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 23 16:26:50 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 23 16:26:50 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 23 16:26:50 volumio volumio[2632]: error: MPD error: Error: This socket has been ended by the other party
Feb 23 16:26:50 volumio volumio[2632]: error: This socket has been ended by the other party {"code":"EPIPE"}
Feb 23 16:26:50 volumio volumio[2632]: error: MPD error: Error: This socket has been ended by the other party
Feb 23 16:26:50 volumio volumio[2632]: error: This socket has been ended by the other party {"code":"EPIPE"}
Feb 23 16:26:50 volumio volumio[2632]: error: MPD error: Error: This socket has been ended by the other party
Feb 23 16:26:50 volumio volumio[2632]: error: This socket has been ended by the other party {"code":"EPIPE"}
Feb 23 16:26:50 volumio volumio[2632]: info: MRS: Found cast device: V405-G9-83bd08435794400d5d935ac65f05a174
Feb 23 16:26:50 volumio volumio[2632]: info: Adding audio output:
Feb 23 16:26:50 volumio volumio[2632]: info: MRS: Found cast device: V405-G9-83bd08435794400d5d935ac65f05a174
Feb 23 16:26:50 volumio volumio[2632]: info: Successfully Added MyVolumio device
Feb 23 16:26:50 volumio volumio[2632]: info: Access Token successfully retrieved
Feb 23 16:26:51 volumio volumio[2632]: info: Updating MyVolumio device info
Feb 23 16:26:51 volumio volumio[2632]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 23 16:26:51 volumio volumio[2632]: info: Successfully Updated MyVolumio device
Feb 23 16:26:51 volumio volumio[2632]: info: Successfully retrieved User Session From TIDAL
Feb 23 16:26:51 volumio volumio[2632]: info: Successfully Updated MyVolumio device
Feb 23 16:26:51 volumio mpd[3050]: Feb 23 16:26 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Feb 23 16:26:51 volumio systemd[1]: Started Music Player Daemon.
Feb 23 16:26:51 volumio sudo[3036]: pam_unix(sudo:session): session closed for user root
Feb 23 16:26:51 volumio volumio[2632]: info: [1740349611489] Database update started
Feb 23 16:26:51 volumio volumio[2632]: error: updateQueue error: null
Feb 23 16:26:51 volumio volumio[2632]: info: MPD Database updated - AlbumList cache refreshed
Feb 23 16:26:51 volumio volumio[2632]: info:
Feb 23 16:26:51 volumio volumio[2632]: ---------------------------- MPD announces state update: database
Feb 23 16:26:51 volumio volumio[2632]: verbose: ControllerMpd::sendMpdCommand status
Feb 23 16:26:51 volumio volumio[2632]: info:
Feb 23 16:26:51 volumio volumio[2632]: ---------------------------- MPD announces state update: update
Feb 23 16:26:51 volumio volumio[2632]: info: ControllerMpd::getState
Feb 23 16:26:51 volumio volumio[2632]: verbose: ControllerMpd::sendMpdCommand status
Feb 23 16:26:51 volumio volumio[2632]: info: ControllerMpd::getState
Feb 23 16:26:51 volumio volumio[2632]: verbose: ControllerMpd::sendMpdCommand status
Feb 23 16:26:51 volumio volumio[2632]: info: sendMpdCommand status took 10 milliseconds
Feb 23 16:26:51 volumio volumio[2632]: info: sendMpdCommand status took 9 milliseconds
Feb 23 16:26:51 volumio volumio[2632]: info: sendMpdCommand status took 8 milliseconds
Feb 23 16:26:51 volumio volumio[2632]: verbose: ControllerMpd::parseState
Feb 23 16:26:51 volumio volumio[2632]: info: Command Router : Notfying DB Updatefalse
Feb 23 16:26:51 volumio volumio[2632]: info: CoreCommandRouter::Close All Modals sent
Feb 23 16:26:51 volumio volumio[2632]: verbose: ControllerMpd::parseState
Feb 23 16:26:51 volumio volumio[2632]: verbose: ControllerMpd::parseState
Feb 23 16:26:51 volumio volumio[2632]: info: ControllerMpd::pushState
Feb 23 16:26:51 volumio volumio[2632]: info: CoreCommandRouter::servicePushState
Feb 23 16:26:51 volumio volumio[2632]: info: CoreStateMachine::pushState
Feb 23 16:26:51 volumio volumio[2632]: info: CorePlayQueue::getTrack 0
Feb 23 16:26:51 volumio volumio[2632]: info: CoreCommandRouter::volumioPushState
Feb 23 16:26:51 volumio volumio[2632]: info: MRS: Pushing multiroomSync output update for this device
Feb 23 16:26:51 volumio volumio[2632]: info: MRS: Pushing multiroomSync output
Feb 23 16:26:51 volumio volumio[2632]: info: CorePlayQueue::getTrack 0
Feb 23 16:26:51 volumio volumio[2632]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Feb 23 16:26:51 volumio volumio[2632]: verbose: CURRENT POSITION 0
Feb 23 16:26:51 volumio volumio[2632]: info: CoreStateMachine::syncState stateService stop
Feb 23 16:26:51 volumio volumio[2632]: info: CoreStateMachine::syncState currentStatus stop
Feb 23 16:26:51 volumio volumio[2632]: info: CoreStateMachine::pushState
Feb 23 16:26:51 volumio volumio[2632]: info: CorePlayQueue::getTrack 0
Feb 23 16:26:51 volumio volumio[2632]: info: CoreCommandRouter::volumioPushState
Feb 23 16:26:51 volumio volumio[2632]: info: MRS: Pushing multiroomSync output update for this device
Feb 23 16:26:51 volumio volumio[2632]: info: MRS: Pushing multiroomSync output
Feb 23 16:26:51 volumio volumio[2632]: info: No code
Feb 23 16:26:51 volumio volumio[2632]: info: CoreStateMachine::pushState
Feb 23 16:26:51 volumio volumio[2632]: info: CorePlayQueue::getTrack 0
Feb 23 16:26:51 volumio volumio[2632]: info: CoreCommandRouter::volumioPushState
Feb 23 16:26:51 volumio volumio[2632]: info: MRS: Pushing multiroomSync output update for this device
Feb 23 16:26:51 volumio volumio[2632]: info: MRS: Pushing multiroomSync output
Feb 23 16:26:51 volumio volumio[2632]: info: ControllerMpd::pushState
Feb 23 16:26:51 volumio volumio[2632]: info: CoreCommandRouter::servicePushState
Feb 23 16:26:51 volumio volumio[2632]: info: CoreStateMachine::pushState
Feb 23 16:26:51 volumio volumio[2632]: info: CorePlayQueue::getTrack 0
Feb 23 16:26:51 volumio volumio[2632]: info: CoreCommandRouter::volumioPushState
Feb 23 16:26:51 volumio volumio[2632]: info: MRS: Pushing multiroomSync output update for this device
Feb 23 16:26:51 volumio volumio[2632]: info: MRS: Pushing multiroomSync output
Feb 23 16:26:51 volumio volumio[2632]: info: CorePlayQueue::getTrack 0
Feb 23 16:26:51 volumio volumio[2632]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Feb 23 16:26:51 volumio volumio[2632]: verbose: CURRENT POSITION 0
Feb 23 16:26:51 volumio volumio[2632]: info: CoreStateMachine::syncState stateService stop
Feb 23 16:26:51 volumio volumio[2632]: info: CoreStateMachine::syncState currentStatus stop
Feb 23 16:26:51 volumio volumio[2632]: info: CoreStateMachine::pushState
Feb 23 16:26:51 volumio volumio[2632]: info: CorePlayQueue::getTrack 0
Feb 23 16:26:51 volumio volumio[2632]: info: CoreCommandRouter::volumioPushState
Feb 23 16:26:51 volumio volumio[2632]: info: MRS: Pushing multiroomSync output update for this device
Feb 23 16:26:51 volumio volumio[2632]: info: MRS: Pushing multiroomSync output
Feb 23 16:26:51 volumio volumio[2632]: info: No code
Feb 23 16:26:51 volumio volumio[2632]: info: CoreStateMachine::pushState
Feb 23 16:26:51 volumio volumio[2632]: info: CorePlayQueue::getTrack 0
Feb 23 16:26:51 volumio volumio[2632]: info: CoreCommandRouter::volumioPushState
Feb 23 16:26:51 volumio volumio[2632]: info: MRS: Pushing multiroomSync output update for this device
Feb 23 16:26:51 volumio volumio[2632]: info: MRS: Pushing multiroomSync output
Feb 23 16:26:51 volumio volumio[2632]: info: ------------------------------ 296ms
Feb 23 16:26:51 volumio volumio[2632]: info: ------------------------------ 296ms
Feb 23 16:26:51 volumio volumio[2632]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 23 16:26:51 volumio volumio[2632]: TypeError: Cannot read property 'replace' of undefined
Feb 23 16:26:51 volumio volumio[2632]: at ControllerNetworkfs.mountShare (/volumio/app/plugins/system_controller/networkfs/index.js:202:28)
Feb 23 16:26:51 volumio volumio[2632]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/networkfs/index.js:255:20)
Feb 23 16:26:51 volumio volumio[2632]: at listOnTimeout (internal/timers.js:554:17)
Feb 23 16:26:51 volumio volumio[2632]: at processTimers (internal/timers.js:497:7)
Feb 23 16:26:51 volumio volumio[2632]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 23 16:26:52 volumio sudo[3077]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-23 16:25
Feb 23 16:26:52 volumio sudo[3077]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="f6610a1100d2380eef33bd3004af43153c786f96"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET"
VOLUMIO_VERSION="3.785"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"