-- Logs begin at Mon 2025-03-10 20:05:30 EDT, end at Mon 2025-03-10 22:16:47 EDT. -- Mar 10 22:15:00 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Mar 10 22:15:00 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:00 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:01 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Mar 10 22:15:01 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:01 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:03 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Mar 10 22:15:03 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:03 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:04 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Mar 10 22:15:04 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:04 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:05 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Mar 10 22:15:05 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:05 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:06 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Mar 10 22:15:06 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:06 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:08 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Mar 10 22:15:08 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:08 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:08 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 10 22:15:08 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 10 22:15:08 smsl-n100 volumio[1084]: info: Discovery: Getting this device information Mar 10 22:15:08 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:08 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:08 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 10 22:15:08 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to 10.0.0.122 from 10.0.0.18 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 5 Mar 10 22:15:08 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:08 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:08 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 10 22:15:08 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 10 22:15:08 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Mar 10 22:15:08 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:08 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:10 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Mar 10 22:15:10 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:10 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:11 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Mar 10 22:15:11 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:11 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:12 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 10 22:15:12 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 10 22:15:12 smsl-n100 volumio[1084]: info: Discovery: Getting this device information Mar 10 22:15:12 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:12 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:12 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 10 22:15:12 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Mar 10 22:15:12 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:12 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:13 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Mar 10 22:15:13 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:13 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:14 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Mar 10 22:15:14 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:14 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:14 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to 10.0.0.142 from 10.0.0.18 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 6 Mar 10 22:15:14 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to 10.0.0.142 from 10.0.0.18 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 7 Mar 10 22:15:15 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Mar 10 22:15:15 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:15 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:15 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to 10.0.0.142 from 10.0.0.18 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 8 Mar 10 22:15:15 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:15 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:15 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 10 22:15:15 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 10 22:15:16 smsl-n100 sudo[1802]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 10 22:15:16 smsl-n100 sudo[1802]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 22:15:16 smsl-n100 sudo[1802]: pam_unix(sudo:session): session closed for user root Mar 10 22:15:16 smsl-n100 sudo[1804]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 10 22:15:16 smsl-n100 sudo[1804]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 22:15:16 smsl-n100 sudo[1804]: pam_unix(sudo:session): session closed for user root Mar 10 22:15:16 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Mar 10 22:15:16 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:16 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:16 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to 10.0.0.122 from 10.0.0.18 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 9 Mar 10 22:15:16 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 10 22:15:16 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetVisibleSources Mar 10 22:15:16 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 10 22:15:16 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:16 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:16 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 10 22:15:16 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 10 22:15:16 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 10 22:15:16 smsl-n100 volumio[1084]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Mar 10 22:15:16 smsl-n100 volumio[1084]: info: Received Get System Info Mar 10 22:15:16 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 10 22:15:16 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 10 22:15:16 smsl-n100 volumio[1084]: info: Discovery: Getting this device information Mar 10 22:15:16 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:16 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:16 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 10 22:15:16 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:16 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:17 smsl-n100 volumio[1084]: info: Listing playlists Mar 10 22:15:17 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 10 22:15:17 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 10 22:15:17 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Mar 10 22:15:17 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:17 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:17 smsl-n100 volumio[1084]: info: VolumeController::SetAlsaVolume0 Mar 10 22:15:17 smsl-n100 volumio[1084]: info: CoreStateMachine::pushState Mar 10 22:15:17 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:17 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 22:15:17 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioPushState Mar 10 22:15:17 smsl-n100 volumio[1084]: info: MRS: Pushing multiroomSync output update for this device Mar 10 22:15:17 smsl-n100 volumio[1084]: info: MRS: Pushing multiroomSync output Mar 10 22:15:17 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:17 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:18 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 10 22:15:18 smsl-n100 volumio[1084]: info: Received Get System Info Mar 10 22:15:18 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 10 22:15:18 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 10 22:15:18 smsl-n100 volumio[1084]: info: Discovery: Getting this device information Mar 10 22:15:18 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:18 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:18 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 10 22:15:18 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 10 22:15:18 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Mar 10 22:15:18 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:18 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:18 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Mar 10 22:15:19 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Mar 10 22:15:20 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:20 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:21 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Mar 10 22:15:21 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:21 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:21 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 10 22:15:21 smsl-n100 volumio[1084]: info: Received Get System Info Mar 10 22:15:21 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 10 22:15:21 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 10 22:15:21 smsl-n100 volumio[1084]: info: Discovery: Getting this device information Mar 10 22:15:21 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:21 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:21 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 10 22:15:22 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Mar 10 22:15:22 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:22 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:22 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Mar 10 22:15:22 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:22 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:23 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Mar 10 22:15:23 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:23 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:24 smsl-n100 volumio[1084]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 22:15:24 smsl-n100 volumio[1084]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 22:15:24 smsl-n100 volumio[1084]: info: Retrieving Cloud Streaming UI Mar 10 22:15:24 smsl-n100 volumio[1084]: info: Getting Tidal Cloud Configuration Mar 10 22:15:24 smsl-n100 volumio[1084]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 22:15:24 smsl-n100 volumio[1084]: info: Getting Qobuz Cloud Configuration Mar 10 22:15:24 smsl-n100 volumio[1084]: info: Asking plugin for UI Config Mar 10 22:15:24 smsl-n100 volumio[1084]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 22:15:24 smsl-n100 volumio[1084]: info: Getting Spotify Cloud Configuration Mar 10 22:15:24 smsl-n100 volumio[1084]: info: Asking plugin for UI Config Mar 10 22:15:24 smsl-n100 volumio[1084]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 22:15:24 smsl-n100 volumio[1084]: info: Saving Spotify Acccount Mar 10 22:15:24 smsl-n100 volumio[1084]: info: Got it Mar 10 22:15:24 smsl-n100 volumio[1084]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 10 22:15:24 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Mar 10 22:15:24 smsl-n100 volumio[1084]: info: Got Tidal Cloud Configuration Mar 10 22:15:24 smsl-n100 volumio[1084]: info: Got it Mar 10 22:15:24 smsl-n100 volumio[1084]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 22:15:24 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:24 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:24 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 10 22:15:24 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 10 22:15:24 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 10 22:15:24 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 10 22:15:24 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 10 22:15:24 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 10 22:15:24 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 10 22:15:24 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 10 22:15:24 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetBrowseSources Mar 10 22:15:24 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetBrowseSources Mar 10 22:15:24 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetBrowseSources Mar 10 22:15:25 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 10 22:15:25 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Mar 10 22:15:26 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Mar 10 22:15:26 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:26 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:26 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 10 22:15:27 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Mar 10 22:15:27 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:27 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:29 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Mar 10 22:15:29 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:29 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:29 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 10 22:15:29 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Mar 10 22:15:29 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:29 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:30 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Mar 10 22:15:30 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:30 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:32 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Mar 10 22:15:32 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:32 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:32 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Mar 10 22:15:32 smsl-n100 volumio[1084]: verbose: ControllerMpd::sendMpdCommand update Mar 10 22:15:32 smsl-n100 volumio[1084]: verbose: ControllerMpd::sendMpdCommand status Mar 10 22:15:32 smsl-n100 volumio[1084]: info: Mar 10 22:15:32 smsl-n100 volumio[1084]: ---------------------------- MPD announces state update: update Mar 10 22:15:32 smsl-n100 volumio[1084]: info: sendMpdCommand update took 21 milliseconds Mar 10 22:15:32 smsl-n100 volumio[1084]: info: ControllerMpd::getState Mar 10 22:15:32 smsl-n100 volumio[1084]: verbose: ControllerMpd::sendMpdCommand status Mar 10 22:15:32 smsl-n100 volumio[1084]: verbose: ControllerMpd::sendMpdCommand status Mar 10 22:15:32 smsl-n100 volumio[1084]: info: Mar 10 22:15:32 smsl-n100 volumio[1084]: ---------------------------- MPD announces state update: update Mar 10 22:15:32 smsl-n100 volumio[1084]: info: ControllerMpd::getState Mar 10 22:15:32 smsl-n100 volumio[1084]: verbose: ControllerMpd::sendMpdCommand status Mar 10 22:15:32 smsl-n100 volumio[1084]: verbose: ControllerMpd::sendMpdCommand status Mar 10 22:15:32 smsl-n100 volumio[1084]: info: Mar 10 22:15:32 smsl-n100 volumio[1084]: ---------------------------- MPD announces state update: update Mar 10 22:15:32 smsl-n100 volumio[1084]: info: ControllerMpd::getState Mar 10 22:15:32 smsl-n100 volumio[1084]: verbose: ControllerMpd::sendMpdCommand status Mar 10 22:15:32 smsl-n100 volumio[1084]: info: sendMpdCommand status took 55 milliseconds Mar 10 22:15:32 smsl-n100 volumio[1084]: info: sendMpdCommand status took 35 milliseconds Mar 10 22:15:32 smsl-n100 volumio[1084]: info: sendMpdCommand status took 33 milliseconds Mar 10 22:15:32 smsl-n100 volumio[1084]: info: sendMpdCommand status took 29 milliseconds Mar 10 22:15:32 smsl-n100 volumio[1084]: info: sendMpdCommand status took 27 milliseconds Mar 10 22:15:32 smsl-n100 volumio[1084]: info: sendMpdCommand status took 22 milliseconds Mar 10 22:15:32 smsl-n100 volumio[1084]: verbose: ControllerMpd::parseState Mar 10 22:15:32 smsl-n100 volumio[1084]: info: Command Router : Notfying DB Updatetrue Mar 10 22:15:32 smsl-n100 volumio[1084]: verbose: ControllerMpd::parseState Mar 10 22:15:32 smsl-n100 volumio[1084]: verbose: ControllerMpd::parseState Mar 10 22:15:32 smsl-n100 volumio[1084]: info: Command Router : Notfying DB Updatetrue Mar 10 22:15:32 smsl-n100 volumio[1084]: info: CoreCommandRouter::Close All Modals sent Mar 10 22:15:32 smsl-n100 volumio[1084]: verbose: ControllerMpd::parseState Mar 10 22:15:32 smsl-n100 volumio[1084]: verbose: ControllerMpd::parseState Mar 10 22:15:32 smsl-n100 volumio[1084]: info: Command Router : Notfying DB Updatetrue Mar 10 22:15:32 smsl-n100 volumio[1084]: info: CoreCommandRouter::Close All Modals sent Mar 10 22:15:32 smsl-n100 volumio[1084]: verbose: ControllerMpd::parseState Mar 10 22:15:33 smsl-n100 volumio[1084]: info: ControllerMpd::pushState Mar 10 22:15:33 smsl-n100 volumio[1084]: info: CoreCommandRouter::servicePushState Mar 10 22:15:33 smsl-n100 volumio[1084]: info: CoreStateMachine::pushState Mar 10 22:15:33 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:33 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioPushState Mar 10 22:15:33 smsl-n100 volumio[1084]: info: MRS: Pushing multiroomSync output update for this device Mar 10 22:15:33 smsl-n100 volumio[1084]: info: MRS: Pushing multiroomSync output Mar 10 22:15:33 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:33 smsl-n100 volumio[1084]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 10 22:15:33 smsl-n100 volumio[1084]: verbose: CURRENT POSITION 0 Mar 10 22:15:33 smsl-n100 volumio[1084]: info: CoreStateMachine::syncState stateService stop Mar 10 22:15:33 smsl-n100 volumio[1084]: info: CoreStateMachine::syncState currentStatus stop Mar 10 22:15:33 smsl-n100 volumio[1084]: info: CoreStateMachine::pushState Mar 10 22:15:33 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:33 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 22:15:33 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioPushState Mar 10 22:15:33 smsl-n100 volumio[1084]: info: MRS: Pushing multiroomSync output update for this device Mar 10 22:15:33 smsl-n100 volumio[1084]: info: MRS: Pushing multiroomSync output Mar 10 22:15:33 smsl-n100 volumio[1084]: info: No code Mar 10 22:15:33 smsl-n100 volumio[1084]: info: CoreStateMachine::pushState Mar 10 22:15:33 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:33 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioPushState Mar 10 22:15:33 smsl-n100 volumio[1084]: info: MRS: Pushing multiroomSync output update for this device Mar 10 22:15:33 smsl-n100 volumio[1084]: info: MRS: Pushing multiroomSync output Mar 10 22:15:33 smsl-n100 volumio[1084]: info: ControllerMpd::pushState Mar 10 22:15:33 smsl-n100 volumio[1084]: info: CoreCommandRouter::servicePushState Mar 10 22:15:33 smsl-n100 volumio[1084]: info: CoreStateMachine::pushState Mar 10 22:15:33 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:33 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioPushState Mar 10 22:15:33 smsl-n100 volumio[1084]: info: MRS: Pushing multiroomSync output update for this device Mar 10 22:15:33 smsl-n100 volumio[1084]: info: MRS: Pushing multiroomSync output Mar 10 22:15:33 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:33 smsl-n100 volumio[1084]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 10 22:15:33 smsl-n100 volumio[1084]: verbose: CURRENT POSITION 0 Mar 10 22:15:33 smsl-n100 volumio[1084]: info: CoreStateMachine::syncState stateService stop Mar 10 22:15:33 smsl-n100 volumio[1084]: info: CoreStateMachine::syncState currentStatus stop Mar 10 22:15:33 smsl-n100 volumio[1084]: info: CoreStateMachine::pushState Mar 10 22:15:33 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:33 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioPushState Mar 10 22:15:33 smsl-n100 volumio[1084]: info: MRS: Pushing multiroomSync output update for this device Mar 10 22:15:33 smsl-n100 volumio[1084]: info: MRS: Pushing multiroomSync output Mar 10 22:15:33 smsl-n100 volumio[1084]: info: No code Mar 10 22:15:33 smsl-n100 volumio[1084]: info: CoreStateMachine::pushState Mar 10 22:15:33 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:33 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioPushState Mar 10 22:15:33 smsl-n100 volumio[1084]: info: MRS: Pushing multiroomSync output update for this device Mar 10 22:15:33 smsl-n100 volumio[1084]: info: MRS: Pushing multiroomSync output Mar 10 22:15:33 smsl-n100 volumio[1084]: info: ControllerMpd::pushState Mar 10 22:15:33 smsl-n100 volumio[1084]: info: CoreCommandRouter::servicePushState Mar 10 22:15:33 smsl-n100 volumio[1084]: info: CoreStateMachine::pushState Mar 10 22:15:33 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:33 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioPushState Mar 10 22:15:33 smsl-n100 volumio[1084]: info: MRS: Pushing multiroomSync output update for this device Mar 10 22:15:33 smsl-n100 volumio[1084]: info: MRS: Pushing multiroomSync output Mar 10 22:15:33 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:33 smsl-n100 volumio[1084]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 10 22:15:33 smsl-n100 volumio[1084]: verbose: CURRENT POSITION 0 Mar 10 22:15:33 smsl-n100 volumio[1084]: info: CoreStateMachine::syncState stateService stop Mar 10 22:15:33 smsl-n100 volumio[1084]: info: CoreStateMachine::syncState currentStatus stop Mar 10 22:15:33 smsl-n100 volumio[1084]: info: CoreStateMachine::pushState Mar 10 22:15:33 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:33 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioPushState Mar 10 22:15:33 smsl-n100 volumio[1084]: info: MRS: Pushing multiroomSync output update for this device Mar 10 22:15:33 smsl-n100 volumio[1084]: info: MRS: Pushing multiroomSync output Mar 10 22:15:33 smsl-n100 volumio[1084]: info: No code Mar 10 22:15:33 smsl-n100 volumio[1084]: info: CoreStateMachine::pushState Mar 10 22:15:33 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:33 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioPushState Mar 10 22:15:33 smsl-n100 volumio[1084]: info: MRS: Pushing multiroomSync output update for this device Mar 10 22:15:33 smsl-n100 volumio[1084]: info: MRS: Pushing multiroomSync output Mar 10 22:15:33 smsl-n100 volumio[1084]: info: ------------------------------ 769ms Mar 10 22:15:33 smsl-n100 volumio[1084]: info: ------------------------------ 749ms Mar 10 22:15:33 smsl-n100 volumio[1084]: info: ------------------------------ 744ms Mar 10 22:15:33 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 10 22:15:33 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Mar 10 22:15:33 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:33 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:35 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 10 22:15:35 smsl-n100 volumio[1084]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Mar 10 22:15:35 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Mar 10 22:15:35 smsl-n100 volumio[1084]: info: Received Get System Version Mar 10 22:15:35 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 10 22:15:35 smsl-n100 volumio[1084]: info: Received Get System Info Mar 10 22:15:35 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 10 22:15:35 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 10 22:15:35 smsl-n100 volumio[1084]: info: Discovery: Getting this device information Mar 10 22:15:35 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:35 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:35 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 10 22:15:35 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Mar 10 22:15:35 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:35 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:35 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Mar 10 22:15:36 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:36 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:37 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 10 22:15:37 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Mar 10 22:15:37 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:37 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:38 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Mar 10 22:15:39 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:39 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:40 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Mar 10 22:15:40 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:40 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:40 smsl-n100 volumio[1084]: info: Disabling MyMusic plugin bluetooth Mar 10 22:15:41 smsl-n100 sudo[1866]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumiobt.service Mar 10 22:15:41 smsl-n100 sudo[1866]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 22:15:41 smsl-n100 systemd[1]: Stopping Volumio Bluetooth Module... Mar 10 22:15:41 smsl-n100 volumiobt[1868]: Killing pulse Mar 10 22:15:41 smsl-n100 volumio[1084]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 10 22:15:41 smsl-n100 volumiobt[1868]: Killing BT Pair agent Mar 10 22:15:41 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 10 22:15:41 smsl-n100 systemd[1]: volumiobt.service: Main process exited, code=killed, status=15/TERM Mar 10 22:15:41 smsl-n100 systemd[1]: volumiobt.service: Succeeded. Mar 10 22:15:41 smsl-n100 systemd[1]: Stopped Volumio Bluetooth Module. Mar 10 22:15:41 smsl-n100 sudo[1866]: pam_unix(sudo:session): session closed for user root Mar 10 22:15:41 smsl-n100 volumio[1084]: info: Volumio BT Module successfully stopped Mar 10 22:15:41 smsl-n100 volumio[1084]: info: Disabling plugin bluetooth Mar 10 22:15:41 smsl-n100 volumio[1084]: info: Done. Mar 10 22:15:41 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Mar 10 22:15:41 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:41 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:42 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Mar 10 22:15:42 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:42 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:43 smsl-n100 volumio[1084]: info: Disabling MyMusic plugin multiroom Mar 10 22:15:43 smsl-n100 volumio[1084]: info: Disabling plugin multiroom Mar 10 22:15:43 smsl-n100 volumio[1084]: info: Preparing to generate the ALSA configuration file Mar 10 22:15:43 smsl-n100 volumio[1084]: info: Asound.conf file written Mar 10 22:15:43 smsl-n100 sudo[1872]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Mar 10 22:15:43 smsl-n100 sudo[1872]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 22:15:43 smsl-n100 sudo[1872]: pam_unix(sudo:session): session closed for user root Mar 10 22:15:43 smsl-n100 volumio[1084]: xcb_connection_has_error() returned true Mar 10 22:15:43 smsl-n100 volumio[1084]: info: Output device has changed, restarting MPD Mar 10 22:15:43 smsl-n100 sudo[1877]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 10 22:15:43 smsl-n100 sudo[1877]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 22:15:43 smsl-n100 volumio[1084]: info: Output device has changed, restarting Shairport Sync Mar 10 22:15:43 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:15:43 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 22:15:43 smsl-n100 sudo[1877]: pam_unix(sudo:session): session closed for user root Mar 10 22:15:43 smsl-n100 sudo[1879]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 10 22:15:43 smsl-n100 sudo[1879]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 22:15:43 smsl-n100 systemd[1]: Stopping Music Player Daemon... Mar 10 22:15:43 smsl-n100 volumio[1084]: xcb_connection_has_error() returned true Mar 10 22:15:43 smsl-n100 volumio[1084]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 10 22:15:43 smsl-n100 volumio[1084]: xcb_connection_has_error() returned true Mar 10 22:15:43 smsl-n100 volumio[1084]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 10 22:15:43 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:15:44 smsl-n100 volumio[1084]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Mar 10 22:15:44 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:15:44 smsl-n100 vtcs[1521]: [2025-03-10 22:15:44.015] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Mar 10 22:15:44 smsl-n100 vtcs[1521]: [2025-03-10 22:15:44.017] [tisoc] [error] [SpkconServer.cpp:381] recv error. client fd=7 errorno=104 error=Connection reset by peer Mar 10 22:15:44 smsl-n100 vtcs[1521]: [2025-03-10 22:15:44.017] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected Mar 10 22:15:44 smsl-n100 volumio[1084]: info: Done. Mar 10 22:15:44 smsl-n100 systemd[1]: mpd.service: Succeeded. Mar 10 22:15:44 smsl-n100 systemd[1]: Stopped Music Player Daemon. Mar 10 22:15:44 smsl-n100 sudo[1888]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 10 22:15:44 smsl-n100 sudo[1888]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 22:15:44 smsl-n100 systemd[1]: Starting Music Player Daemon... Mar 10 22:15:44 smsl-n100 volumio[1084]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 10 22:15:44 smsl-n100 volumio[1084]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 10 22:15:44 smsl-n100 sudo[1892]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 10 22:15:44 smsl-n100 sudo[1892]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 22:15:44 smsl-n100 systemd[1]: Stopping Volumio Tidal Connect Service... Mar 10 22:15:44 smsl-n100 volumio[1084]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 10 22:15:44 smsl-n100 systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Mar 10 22:15:44 smsl-n100 systemd[1]: vtcs.service: Succeeded. Mar 10 22:15:44 smsl-n100 systemd[1]: Stopped Volumio Tidal Connect Service. Mar 10 22:15:44 smsl-n100 sudo[1888]: pam_unix(sudo:session): session closed for user root Mar 10 22:15:44 smsl-n100 volumio[1084]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Mar 10 22:15:44 smsl-n100 volumio[1084]: info: MPD Permissions set Mar 10 22:15:44 smsl-n100 sudo[1892]: pam_unix(sudo:session): session closed for user root Mar 10 22:15:44 smsl-n100 volumio[1084]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 10 22:15:44 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:15:44 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:15:44 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:15:44 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:15:44 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:15:44 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:15:44 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:15:44 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:15:44 smsl-n100 sudo[1889]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 10 22:15:44 smsl-n100 sudo[1889]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 22:15:44 smsl-n100 sudo[1889]: pam_unix(sudo:session): session closed for user root Mar 10 22:15:44 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 22:15:44 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 10 22:15:44 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:15:44 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Mar 10 22:15:44 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:15:44 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:15:44 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:15:44 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:15:44 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:15:44 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:15:44 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:15:44 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:15:44 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 10 22:15:44 smsl-n100 volumio[1084]: info: Not Reporting Auto name since its the default one Mar 10 22:15:44 smsl-n100 volumio[1084]: info: Starting Shairport Sync Mar 10 22:15:44 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:44 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:44 smsl-n100 sudo[1909]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 10 22:15:44 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Mar 10 22:15:44 smsl-n100 sudo[1909]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 22:15:44 smsl-n100 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 10 22:15:44 smsl-n100 systemd[1]: shairport-sync.service: Succeeded. Mar 10 22:15:44 smsl-n100 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 10 22:15:44 smsl-n100 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 10 22:15:44 smsl-n100 sudo[1909]: pam_unix(sudo:session): session closed for user root Mar 10 22:15:44 smsl-n100 volumio[1084]: xcb_connection_has_error() returned true Mar 10 22:15:44 smsl-n100 volumio[1084]: info: Configured Audio card not found, not starting RAAT Mar 10 22:15:44 smsl-n100 volumio[1084]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 10 22:15:44 smsl-n100 volumio[1084]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 10 22:15:44 smsl-n100 volumio[1084]: info: Shairport-Sync Started Mar 10 22:15:45 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 10 22:15:45 smsl-n100 volumio[1084]: error: MPD error: Error: This socket has been ended by the other party Mar 10 22:15:45 smsl-n100 volumio[1084]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 10 22:15:45 smsl-n100 volumio[1084]: error: MPD error: Error: This socket has been ended by the other party Mar 10 22:15:45 smsl-n100 volumio[1084]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 10 22:15:45 smsl-n100 volumio[1084]: error: MPD error: Error: This socket has been ended by the other party Mar 10 22:15:45 smsl-n100 volumio[1084]: error: This socket has been ended by the other party {"code":"EPIPE"} Mar 10 22:15:46 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Mar 10 22:15:46 smsl-n100 volumio[1084]: info: Disabling MyMusic plugin upnp Mar 10 22:15:46 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:46 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:46 smsl-n100 sudo[1917]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Mar 10 22:15:46 smsl-n100 sudo[1917]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 22:15:46 smsl-n100 systemd[1]: Stopping UPnP Renderer front-end to MPD... Mar 10 22:15:46 smsl-n100 volumio[1084]: error: Upnp client error: Error: This socket has been ended by the other party Mar 10 22:15:46 smsl-n100 volumio[1084]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 10 22:15:46 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Mar 10 22:15:46 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:46 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:47 smsl-n100 volumio[1084]: info: TidalConnect service stoped! Mar 10 22:15:47 smsl-n100 volumio[1084]: info: TidalConnect service stoped! Mar 10 22:15:47 smsl-n100 volumio[1084]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Mar 10 22:15:47 smsl-n100 volumio[1084]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Mar 10 22:15:47 smsl-n100 sudo[1930]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Mar 10 22:15:47 smsl-n100 sudo[1930]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 22:15:47 smsl-n100 systemd[1]: Started Volumio Tidal Connect Service. Mar 10 22:15:47 smsl-n100 sudo[1930]: pam_unix(sudo:session): session closed for user root Mar 10 22:15:47 smsl-n100 mpd[1901]: Mar 10 22:15 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 10 22:15:47 smsl-n100 systemd[1]: Started Music Player Daemon. Mar 10 22:15:47 smsl-n100 sudo[1879]: pam_unix(sudo:session): session closed for user root Mar 10 22:15:47 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Mar 10 22:15:47 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:47 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:47 smsl-n100 volumio[1084]: error: updateQueue error: null Mar 10 22:15:47 smsl-n100 volumio[1084]: info: RAAT: Requesting Headphone Status Mar 10 22:15:47 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Mar 10 22:15:47 smsl-n100 volumio[1084]: info: Disabling MyMusic plugin metavolumio Mar 10 22:15:47 smsl-n100 volumio[1084]: info: Removing METAVOLUMIO REST API Endpoints Mar 10 22:15:47 smsl-n100 volumio[1084]: info: Removing metavolumio REST Endpoint Mar 10 22:15:47 smsl-n100 volumio[1084]: info: Removing getSimilarArtists REST Endpoint Mar 10 22:15:47 smsl-n100 volumio[1084]: info: Removing getSimilarAlbums REST Endpoint Mar 10 22:15:47 smsl-n100 volumio[1084]: info: Removing getSimilarTracks REST Endpoint Mar 10 22:15:47 smsl-n100 volumio[1084]: info: Disabling plugin metavolumio Mar 10 22:15:47 smsl-n100 volumio[1084]: info: Done. Mar 10 22:15:47 smsl-n100 volumio[1084]: info: CoreStateMachine::pushState Mar 10 22:15:47 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:47 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 22:15:47 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioPushState Mar 10 22:15:47 smsl-n100 volumio[1084]: info: MRS: Pushing multiroomSync output update for this device Mar 10 22:15:47 smsl-n100 volumio[1084]: info: MRS: Pushing multiroomSync output Mar 10 22:15:47 smsl-n100 volumio[1084]: error: Serial API: Failed to decode command: 100, message: undefined Mar 10 22:15:47 smsl-n100 volumio[1084]: error: Serial API: Failed to decode command: MAXVOL, message: Mar 10 22:15:47 smsl-n100 volumio[1084]: error: Serial API: Failed to decode command: 100, message: undefined Mar 10 22:15:47 smsl-n100 volumio[1084]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Mar 10 22:15:47 smsl-n100 volumio[1084]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.TGA7NZXcJUT9yR3kVQ8iPSbdjtm2.86f99ea9add065ca707c80b4d99f1cac.state.mute' Mar 10 22:15:48 smsl-n100 volumio[1084]: info: Executing endpoint tc_getconfig Mar 10 22:15:48 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Mar 10 22:15:48 smsl-n100 vtcs[1932]: STARTING TidalConnect services, version: 1.4.0.34 Mar 10 22:15:48 smsl-n100 volumio[1084]: info: VolumeController::SetAlsaVolume0 Mar 10 22:15:48 smsl-n100 volumio[1084]: info: CoreStateMachine::pushState Mar 10 22:15:48 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:48 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 22:15:48 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioPushState Mar 10 22:15:48 smsl-n100 volumio[1084]: info: MRS: Pushing multiroomSync output update for this device Mar 10 22:15:48 smsl-n100 volumio[1084]: info: MRS: Pushing multiroomSync output Mar 10 22:15:48 smsl-n100 vtcs[1932]: STARTED TidalConnect services. Mar 10 22:15:48 smsl-n100 volumio[1084]: info: Executing endpoint tc_connect Mar 10 22:15:48 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Mar 10 22:15:48 smsl-n100 volumio[1084]: info: Connecting to TidalConnect Mar 10 22:15:48 smsl-n100 volumio[1084]: info: CoreCommandRouter::servicePushState Mar 10 22:15:48 smsl-n100 volumio[1084]: info: CoreStateMachine::pushState Mar 10 22:15:48 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:48 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioPushState Mar 10 22:15:48 smsl-n100 volumio[1084]: info: MRS: Pushing multiroomSync output update for this device Mar 10 22:15:48 smsl-n100 volumio[1084]: info: MRS: Pushing multiroomSync output Mar 10 22:15:48 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:48 smsl-n100 volumio[1084]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect Mar 10 22:15:48 smsl-n100 volumio[1084]: info: CoreCommandRouter::servicePushState Mar 10 22:15:48 smsl-n100 volumio[1084]: info: CoreStateMachine::pushState Mar 10 22:15:48 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:48 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioPushState Mar 10 22:15:48 smsl-n100 volumio[1084]: info: MRS: Pushing multiroomSync output update for this device Mar 10 22:15:48 smsl-n100 volumio[1084]: info: MRS: Pushing multiroomSync output Mar 10 22:15:48 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:48 smsl-n100 volumio[1084]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect Mar 10 22:15:49 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Mar 10 22:15:49 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:49 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:49 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 10 22:15:49 smsl-n100 volumio[1084]: info: Disabling MyMusic plugin airplay_emulation Mar 10 22:15:49 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesShairport-Sync Mar 10 22:15:49 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 10 22:15:49 smsl-n100 volumio[1084]: info: Disabling plugin airplay_emulation Mar 10 22:15:49 smsl-n100 volumio[1084]: info: Done. Mar 10 22:15:49 smsl-n100 sudo[1955]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop shairport-sync Mar 10 22:15:49 smsl-n100 sudo[1955]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 22:15:49 smsl-n100 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 10 22:15:49 smsl-n100 systemd[1]: shairport-sync.service: Succeeded. Mar 10 22:15:49 smsl-n100 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 10 22:15:49 smsl-n100 volumio[1084]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 10 22:15:49 smsl-n100 sudo[1955]: pam_unix(sudo:session): session closed for user root Mar 10 22:15:49 smsl-n100 volumio[1084]: info: Shairport-Sync Stopped Mar 10 22:15:50 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Mar 10 22:15:50 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:50 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:50 smsl-n100 volumio[1084]: info: TidalConnect service started! Mar 10 22:15:51 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Mar 10 22:15:51 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:51 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:51 smsl-n100 volumio[1084]: info: Disabling MyMusic plugin cd_controller Mar 10 22:15:51 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesAudio CD Mar 10 22:15:51 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 10 22:15:51 smsl-n100 volumio[1084]: info: Stopping UDEV Watcher for CD Mar 10 22:15:51 smsl-n100 volumio[1084]: info: Disabling plugin cd_controller Mar 10 22:15:51 smsl-n100 volumio[1084]: info: Done. Mar 10 22:15:52 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Mar 10 22:15:52 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:52 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:53 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 10 22:15:53 smsl-n100 volumio[1084]: info: Disabling MyMusic plugin raat Mar 10 22:15:53 smsl-n100 volumio[1084]: info: Stopping RAAT Plugin Mar 10 22:15:53 smsl-n100 sudo[1972]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop raat-daemon.service Mar 10 22:15:53 smsl-n100 sudo[1972]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 22:15:53 smsl-n100 sudo[1972]: pam_unix(sudo:session): session closed for user root Mar 10 22:15:53 smsl-n100 volumio[1084]: info: Raat Daemon stopped successfully Mar 10 22:15:53 smsl-n100 volumio[1084]: info: Disabling plugin raat Mar 10 22:15:53 smsl-n100 volumio[1084]: info: Done. Mar 10 22:15:53 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Mar 10 22:15:53 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:53 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:54 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Mar 10 22:15:55 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:55 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:56 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Mar 10 22:15:56 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:56 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:57 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 10 22:15:57 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Mar 10 22:15:57 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:57 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:58 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Mar 10 22:15:58 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:58 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:15:59 smsl-n100 volumio[1084]: info: Disabling MyMusic plugin smart_inputs Mar 10 22:15:59 smsl-n100 volumio[1084]: info: Removeing all smart Inputs Mar 10 22:15:59 smsl-n100 volumio[1084]: info: Disabling plugin smart_inputs Mar 10 22:15:59 smsl-n100 volumio[1084]: info: Done. Mar 10 22:15:59 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Mar 10 22:15:59 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:15:59 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:16:00 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Mar 10 22:16:00 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:16:00 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:16:01 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 10 22:16:01 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Mar 10 22:16:01 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:16:01 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:16:02 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Mar 10 22:16:02 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:16:02 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:16:03 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Mar 10 22:16:03 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:16:03 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:16:04 smsl-n100 volumio[1084]: info: Disabling MyMusic plugin tidalconnect Mar 10 22:16:04 smsl-n100 vtcs[1932]: [2025-03-10 22:16:04.023] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Mar 10 22:16:04 smsl-n100 vtcs[1932]: [2025-03-10 22:16:04.024] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected Mar 10 22:16:04 smsl-n100 volumio[1084]: info: Disabling plugin tidalconnect Mar 10 22:16:04 smsl-n100 volumio[1084]: info: Done. Mar 10 22:16:04 smsl-n100 sudo[1993]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 10 22:16:04 smsl-n100 sudo[1993]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 22:16:04 smsl-n100 systemd[1]: Stopping Volumio Tidal Connect Service... Mar 10 22:16:04 smsl-n100 systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Mar 10 22:16:04 smsl-n100 systemd[1]: vtcs.service: Succeeded. Mar 10 22:16:04 smsl-n100 systemd[1]: Stopped Volumio Tidal Connect Service. Mar 10 22:16:04 smsl-n100 volumio[1084]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 10 22:16:04 smsl-n100 sudo[1993]: pam_unix(sudo:session): session closed for user root Mar 10 22:16:05 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Mar 10 22:16:05 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:16:05 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:16:05 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 10 22:16:05 smsl-n100 volumio[1084]: info: Disabling MyMusic plugin upnp_browser Mar 10 22:16:05 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesMedia Servers Mar 10 22:16:05 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 10 22:16:05 smsl-n100 volumio[1084]: info: Disabling plugin upnp_browser Mar 10 22:16:05 smsl-n100 volumio[1084]: info: Done. Mar 10 22:16:06 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Mar 10 22:16:06 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:16:06 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:16:07 smsl-n100 volumio[1084]: info: TidalConnect service stoped! Mar 10 22:16:07 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Mar 10 22:16:07 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:16:07 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:16:08 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Mar 10 22:16:08 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:16:08 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:16:09 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 10 22:16:10 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Mar 10 22:16:10 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:16:10 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:16:11 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Mar 10 22:16:11 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:16:11 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:16:12 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Mar 10 22:16:12 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:16:12 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:16:13 smsl-n100 volumio[1084]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 10 22:16:13 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Mar 10 22:16:13 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:16:13 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:16:14 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Mar 10 22:16:14 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:16:14 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:16:15 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Mar 10 22:16:15 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:16:15 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:16:16 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Mar 10 22:16:16 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:16:16 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:16:17 smsl-n100 volumio[1084]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Mar 10 22:16:17 smsl-n100 volumio[1084]: info: CoreCommandRouter::volumioGetState Mar 10 22:16:17 smsl-n100 volumio[1084]: info: CorePlayQueue::getTrack 0 Mar 10 22:16:17 smsl-n100 volumio[1084]: node: ../deps/uv/src/unix/poll.c:113: uv_poll_stop: Assertion `!uv__is_closing(handle)' failed. Mar 10 22:16:18 smsl-n100 volumio-remote-updater[558]: [2025-03-10 22:16:18] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Mar 10 22:16:18 smsl-n100 volumio-remote-updater[558]: [2025-03-10 22:16:18] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Mar 10 22:16:18 smsl-n100 systemd[1]: volumio.service: Main process exited, code=killed, status=6/ABRT Mar 10 22:16:18 smsl-n100 sudo[1917]: pam_unix(sudo:session): session closed for user root Mar 10 22:16:18 smsl-n100 systemd[1]: media-Music\x2d4TB.mount: Succeeded. Mar 10 22:16:18 smsl-n100 systemd[1]: upmpdcli.service: Succeeded. Mar 10 22:16:18 smsl-n100 systemd[1]: Stopped UPnP Renderer front-end to MPD. Mar 10 22:16:18 smsl-n100 systemd[1]: volumio.service: Failed with result 'signal'. Mar 10 22:16:18 smsl-n100 systemd[1]: Started dynamicswap service. Mar 10 22:16:18 smsl-n100 systemd[1]: dynamicswap.service: Succeeded. Mar 10 22:16:19 smsl-n100 systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Mar 10 22:16:19 smsl-n100 systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. Mar 10 22:16:19 smsl-n100 systemd[1]: Started dynamicswap service. Mar 10 22:16:19 smsl-n100 systemd[1]: Stopped Volumio Backend Module. Mar 10 22:16:19 smsl-n100 systemd[1]: Started Volumio Backend Module. Mar 10 22:16:19 smsl-n100 systemd[1]: dynamicswap.service: Succeeded. Mar 10 22:16:22 smsl-n100 volumio[2063]: info: ------------------------------------------- Mar 10 22:16:22 smsl-n100 volumio[2063]: info: ----- Volumio3 ---- Mar 10 22:16:22 smsl-n100 volumio[2063]: info: ------------------------------------------- Mar 10 22:16:22 smsl-n100 volumio[2063]: info: ----- System startup ---- Mar 10 22:16:22 smsl-n100 volumio[2063]: info: ------------------------------------------- Mar 10 22:16:23 smsl-n100 volumio-remote-updater[558]: [2025-03-10 22:16:23] [connect] Successful connection Mar 10 22:16:23 smsl-n100 volumio[2063]: info: MYVOLUMIO Environment detected Mar 10 22:16:23 smsl-n100 volumio[2063]: info: Plugin folders cleanup Mar 10 22:16:23 smsl-n100 volumio[2063]: info: Scanning into folder /volumio/app/plugins/ Mar 10 22:16:23 smsl-n100 volumio[2063]: info: Scanning category audio_interface Mar 10 22:16:23 smsl-n100 volumio[2063]: info: Scanning category miscellanea Mar 10 22:16:23 smsl-n100 volumio[2063]: info: Scanning category music_service Mar 10 22:16:23 smsl-n100 volumio[2063]: info: Scanning category plugins.json Mar 10 22:16:23 smsl-n100 volumio[2063]: info: Scanning category system_controller Mar 10 22:16:23 smsl-n100 volumio[2063]: info: Scanning category user_interface Mar 10 22:16:23 smsl-n100 volumio[2063]: info: Scanning into folder /data/plugins/ Mar 10 22:16:23 smsl-n100 volumio[2063]: info: Plugin folders cleanup completed Mar 10 22:16:23 smsl-n100 volumio[2063]: info: ------------------------------------------- Mar 10 22:16:23 smsl-n100 volumio[2063]: info: ----- Core plugins startup ---- Mar 10 22:16:23 smsl-n100 volumio[2063]: info: ------------------------------------------- Mar 10 22:16:23 smsl-n100 volumio[2063]: info: Loading plugins from folder /volumio/app/plugins/ Mar 10 22:16:23 smsl-n100 volumio[2063]: info: Adding plugin bluetooth to MyMusic Plugins Mar 10 22:16:23 smsl-n100 volumio[2063]: info: Adding plugin multiroom to MyMusic Plugins Mar 10 22:16:23 smsl-n100 volumio[2063]: info: Adding plugin upnp to MyMusic Plugins Mar 10 22:16:23 smsl-n100 volumio[2063]: info: Adding plugin metavolumio to MyMusic Plugins Mar 10 22:16:23 smsl-n100 volumio[2063]: info: Adding plugin airplay_emulation to MyMusic Plugins Mar 10 22:16:23 smsl-n100 volumio[2063]: info: Adding plugin cd_controller to MyMusic Plugins Mar 10 22:16:23 smsl-n100 volumio[2063]: info: Adding plugin raat to MyMusic Plugins Mar 10 22:16:23 smsl-n100 volumio[2063]: info: Adding plugin smart_inputs to MyMusic Plugins Mar 10 22:16:23 smsl-n100 volumio[2063]: info: Adding plugin tidalconnect to MyMusic Plugins Mar 10 22:16:23 smsl-n100 volumio[2063]: info: Adding plugin upnp_browser to MyMusic Plugins Mar 10 22:16:23 smsl-n100 volumio[2063]: info: Loading plugins from folder /data/plugins/ Mar 10 22:16:23 smsl-n100 volumio[2063]: info: Loading plugin "system"... Mar 10 22:16:23 smsl-n100 volumio[2063]: info: Loading plugin "appearance"... Mar 10 22:16:25 smsl-n100 volumio[2063]: info: Loading plugin "network"... Mar 10 22:16:25 smsl-n100 volumio[2063]: info: Refreshing Cached IP Addresses Mar 10 22:16:25 smsl-n100 sudo[2089]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 10 22:16:25 smsl-n100 sudo[2089]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 22:16:25 smsl-n100 sudo[2089]: pam_unix(sudo:session): session closed for user root Mar 10 22:16:25 smsl-n100 sudo[2091]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 10 22:16:25 smsl-n100 sudo[2091]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 22:16:25 smsl-n100 sudo[2091]: pam_unix(sudo:session): session closed for user root Mar 10 22:16:25 smsl-n100 volumio[2063]: info: Loading plugin "services"... Mar 10 22:16:25 smsl-n100 volumio[2063]: info: Loading plugin "alsa_controller"... Mar 10 22:16:25 smsl-n100 sudo[2100]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Mar 10 22:16:25 smsl-n100 sudo[2100]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 22:16:25 smsl-n100 volumio[2063]: warn: Unable to locate the audio output device SMSL USB AUDIO. Please configure a valid output device. Mar 10 22:16:25 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 10 22:16:25 smsl-n100 volumio[2063]: info: Loading plugin "wizard"... Mar 10 22:16:25 smsl-n100 volumio[2063]: info: Loading plugin "networkfs"... Mar 10 22:16:25 smsl-n100 volumio[2063]: info: Starting Udev Watcher for removable devices Mar 10 22:16:25 smsl-n100 volumio[2063]: info: Ignoring mount for partition: boot Mar 10 22:16:25 smsl-n100 volumio[2063]: info: Ignoring mount for partition: volumio Mar 10 22:16:25 smsl-n100 volumio[2063]: info: Ignoring mount for partition: volumio_data Mar 10 22:16:25 smsl-n100 volumio[2063]: info: Mounting Device Music-4TB Mar 10 22:16:26 smsl-n100 sudo[2118]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/Music-4TB -o noatime Mar 10 22:16:26 smsl-n100 sudo[2118]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 22:16:26 smsl-n100 sudo[2118]: pam_unix(sudo:session): session closed for user root Mar 10 22:16:26 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 10 22:16:26 smsl-n100 volumio[2063]: info: Loading plugin "volumio_command_line_client"... Mar 10 22:16:26 smsl-n100 volumio[2063]: info: Loading plugin "upnp"... Mar 10 22:16:26 smsl-n100 volumio[2063]: info: [1741659386182] Starting Upmpd Daemon Mar 10 22:16:26 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 10 22:16:26 smsl-n100 volumio[2063]: info: Loading plugin "my_music"... Mar 10 22:16:26 smsl-n100 volumio[2063]: info: Loading plugin "mpd"... Mar 10 22:16:26 smsl-n100 volumio[2063]: info: Plugin upnp_browser is not enabled Mar 10 22:16:26 smsl-n100 volumio[2063]: info: Plugin bluetooth is not enabled Mar 10 22:16:26 smsl-n100 volumio[2063]: info: Loading plugin "alarm-clock"... Mar 10 22:16:27 smsl-n100 volumio[2063]: info: Loading plugin "manifestui"... Mar 10 22:16:27 smsl-n100 volumio[2063]: info: Plugin metavolumio is not enabled Mar 10 22:16:27 smsl-n100 volumio[2063]: info: Plugin airplay_emulation is not enabled Mar 10 22:16:27 smsl-n100 volumio[2063]: info: Plugin cd_controller is not enabled Mar 10 22:16:27 smsl-n100 volumio[2063]: info: Loading plugin "last_100"... Mar 10 22:16:27 smsl-n100 volumio[2063]: info: Plugin raat is not enabled Mar 10 22:16:27 smsl-n100 volumio[2063]: info: Loading plugin "streaming_services"... Mar 10 22:16:29 smsl-n100 volumio[2063]: info: Starting Streaming Service Transparent Proxy Mar 10 22:16:29 smsl-n100 volumio[2063]: info: Plugin tidalconnect is not enabled Mar 10 22:16:29 smsl-n100 volumio[2063]: info: Loading plugin "webradio"... Mar 10 22:16:29 smsl-n100 volumio[2063]: info: Loading plugin "i2s_dacs"... Mar 10 22:16:29 smsl-n100 volumio[2063]: info: I2S DAC not set, start Auto-detection Mar 10 22:16:29 smsl-n100 volumio[2063]: info: Loading plugin "volumiodiscovery"... Mar 10 22:16:29 smsl-n100 volumio[2063]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 10 22:16:29 smsl-n100 node[2063]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 10 22:16:29 smsl-n100 node[2063]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 10 22:16:29 smsl-n100 volumio[2063]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 10 22:16:29 smsl-n100 volumio[2063]: *** WARNING *** For more information see Mar 10 22:16:29 smsl-n100 volumio[2063]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 10 22:16:29 smsl-n100 volumio[2063]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 10 22:16:29 smsl-n100 volumio[2063]: *** WARNING *** For more information see Mar 10 22:16:29 smsl-n100 node[2063]: *** WARNING *** For more information see Mar 10 22:16:29 smsl-n100 node[2063]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 10 22:16:29 smsl-n100 node[2063]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 10 22:16:29 smsl-n100 node[2063]: *** WARNING *** For more information see Mar 10 22:16:29 smsl-n100 volumio[2063]: info: Applying required configuration parameters for plugin volumiodiscovery Mar 10 22:16:29 smsl-n100 volumio[2063]: info: Discovery: Started advertising with name: SMSL N100 Mar 10 22:16:29 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 10 22:16:29 smsl-n100 volumio[2063]: info: Plugin multiroom is not enabled Mar 10 22:16:29 smsl-n100 volumio[2063]: info: Loading plugin "outputs"... Mar 10 22:16:29 smsl-n100 volumio[2063]: info: Loading plugin "albumart"... Mar 10 22:16:29 smsl-n100 volumio[2063]: info: Plugin example_plugin is not enabled Mar 10 22:16:29 smsl-n100 volumio[2063]: info: Loading plugin "hi_res_audio"... Mar 10 22:16:30 smsl-n100 sudo[2100]: pam_unix(sudo:session): session closed for user root Mar 10 22:16:30 smsl-n100 volumio[2063]: Forking 3 albumart workers Mar 10 22:16:32 smsl-n100 volumio[2063]: STREAMING PROXY: Starting server on port 3245 Mar 10 22:16:32 smsl-n100 volumio[2063]: Node JS runtime: 14 Mar 10 22:16:33 smsl-n100 volumio[2063]: Starting albumart workers Mar 10 22:16:33 smsl-n100 volumio[2063]: Starting albumart workers Mar 10 22:16:33 smsl-n100 volumio[2063]: info: Applying required configuration parameters for plugin hi_res_audio Mar 10 22:16:33 smsl-n100 volumio[2063]: info: Loading plugin "inputs"... Mar 10 22:16:33 smsl-n100 volumio[2063]: Starting albumart workers Mar 10 22:16:35 smsl-n100 volumio[2063]: info: Loading plugin "qobuz"... Mar 10 22:16:35 smsl-n100 volumio-remote-updater[558]: [2025-03-10 22:16:35] [connect] Successful connection Mar 10 22:16:37 smsl-n100 volumio[2063]: info: Plugin smart_inputs is not enabled Mar 10 22:16:37 smsl-n100 volumio[2063]: info: Loading plugin "tidal"... Mar 10 22:16:38 smsl-n100 volumio[2063]: info: Loading plugin "oem_helper"... Mar 10 22:16:40 smsl-n100 volumio[2063]: info: Applying required configuration parameters for plugin oem_helper Mar 10 22:16:40 smsl-n100 volumio[2063]: info: Loading plugin "smslcontrol"... Mar 10 22:16:40 smsl-n100 volumio[2063]: info: Adding this device properties Mar 10 22:16:40 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties Mar 10 22:16:40 smsl-n100 volumio[2063]: info: Setting Additional Device Volumio Properties: [object Object] Mar 10 22:16:40 smsl-n100 volumio[2063]: info: Loading plugin "updater_comm"... Mar 10 22:16:40 smsl-n100 volumio[2063]: info: Plugin mpdemulation is not enabled Mar 10 22:16:40 smsl-n100 volumio[2063]: info: Loading plugin "rest_api"... Mar 10 22:16:40 smsl-n100 volumio[2063]: info: Loading plugin "websocket"... Mar 10 22:16:40 smsl-n100 volumio[2063]: info: Starting Socket.io Server version 2.3.0 Mar 10 22:16:40 smsl-n100 volumio[2063]: info: Loading i18n strings for locale en Mar 10 22:16:40 smsl-n100 volumio[2063]: Updating browse sources language Mar 10 22:16:40 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 10 22:16:41 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 10 22:16:41 smsl-n100 volumio[2063]: info: CoreCommandRouter::initPlayerControls Mar 10 22:16:41 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:16:41 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:16:41 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:16:41 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:16:41 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:16:41 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:16:41 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:16:41 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:16:41 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 10 22:16:41 smsl-n100 volumio[2063]: Express server listening on port 3000 Mar 10 22:16:41 smsl-n100 volumio[2063]: [Metrics] WebUI: 20s 139.84ms Mar 10 22:16:41 smsl-n100 volumio[2063]: info: CoreStateMachine::resetVolumioState Mar 10 22:16:41 smsl-n100 volumio[2063]: info: CoreStateMachine::getcurrentVolume Mar 10 22:16:41 smsl-n100 volumio[2063]: info: CoreCommandRouter::volumioRetrievevolume Mar 10 22:16:41 smsl-n100 volumio[2063]: info: CoreStateMachine::pushState Mar 10 22:16:41 smsl-n100 volumio[2063]: info: CorePlayQueue::getTrack 0 Mar 10 22:16:41 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 22:16:41 smsl-n100 volumio[2063]: info: CoreCommandRouter::volumioPushState Mar 10 22:16:41 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 22:16:41 smsl-n100 sudo[2216]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 10 22:16:41 smsl-n100 sudo[2216]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 22:16:41 smsl-n100 sudo[2216]: pam_unix(sudo:session): session closed for user root Mar 10 22:16:41 smsl-n100 sudo[2218]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 10 22:16:41 smsl-n100 volumio[2063]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Mar 10 22:16:41 smsl-n100 sudo[2218]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 22:16:41 smsl-n100 volumio[2063]: info: Completed loading Core Plugins Mar 10 22:16:41 smsl-n100 volumio[2063]: info: Preparing to generate the ALSA configuration file Mar 10 22:16:41 smsl-n100 sudo[2218]: pam_unix(sudo:session): session closed for user root Mar 10 22:16:41 smsl-n100 volumio[2063]: info: Volumio Network Manager: Network status updated: 3 Mar 10 22:16:41 smsl-n100 volumio[2063]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Mar 10 22:16:41 smsl-n100 volumio[2063]: verbose: New Socket.io Connection to 10.0.0.122 from 10.0.0.18 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 1 Mar 10 22:16:41 smsl-n100 volumio[2063]: verbose: New Socket.io Connection to 10.0.0.142 from 10.0.0.18 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 2 Mar 10 22:16:41 smsl-n100 volumio[2063]: verbose: New Socket.io Connection to 10.0.0.122 from 10.0.0.18 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 3 Mar 10 22:16:41 smsl-n100 volumio[2063]: verbose: New Socket.io Connection to 10.0.0.122 from 10.0.0.18 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 4 Mar 10 22:16:42 smsl-n100 volumio[2063]: verbose: New Socket.io Connection to 10.0.0.142 from 10.0.0.18 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 5 Mar 10 22:16:42 smsl-n100 volumio[2063]: verbose: New Socket.io Connection to 10.0.0.122 from 10.0.0.18 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 6 Mar 10 22:16:42 smsl-n100 volumio[2063]: verbose: New Socket.io Connection to 10.0.0.122 from 10.0.0.18 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 7 Mar 10 22:16:42 smsl-n100 volumio[2063]: verbose: New Socket.io Connection to 10.0.0.142 from 10.0.0.18 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 8 Mar 10 22:16:42 smsl-n100 volumio[2063]: verbose: New Socket.io Connection to 10.0.0.122 from 10.0.0.18 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 9 Mar 10 22:16:42 smsl-n100 volumio[2063]: verbose: New Socket.io Connection to 10.0.0.122 from 10.0.0.18 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 10 Mar 10 22:16:42 smsl-n100 volumio[2063]: verbose: New Socket.io Connection to 10.0.0.122 from 10.0.0.18 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 11 Mar 10 22:16:42 smsl-n100 volumio[2063]: verbose: New Socket.io Connection to 10.0.0.122 from 10.0.0.18 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 12 Mar 10 22:16:42 smsl-n100 volumio[2063]: verbose: New Socket.io Connection to 10.0.0.142 from 10.0.0.18 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 13 Mar 10 22:16:42 smsl-n100 volumio[2063]: verbose: New Socket.io Connection to 10.0.0.142 from 10.0.0.18 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 14 Mar 10 22:16:42 smsl-n100 volumio[2063]: verbose: New Socket.io Connection to 10.0.0.142 from 10.0.0.18 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 15 Mar 10 22:16:42 smsl-n100 volumio[2063]: verbose: New Socket.io Connection to 10.0.0.122 from 10.0.0.18 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 16 Mar 10 22:16:42 smsl-n100 volumio[2063]: verbose: New Socket.io Connection to 10.0.0.122 from 10.0.0.18 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 17 Mar 10 22:16:42 smsl-n100 volumio[2063]: verbose: New Socket.io Connection to 10.0.0.142 from 10.0.0.18 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 18 Mar 10 22:16:42 smsl-n100 volumio[2063]: verbose: New Socket.io Connection to 10.0.0.122 from 10.0.0.18 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 19 Mar 10 22:16:42 smsl-n100 volumio[2063]: verbose: New Socket.io Connection to 10.0.0.142 from 10.0.0.18 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 20 Mar 10 22:16:42 smsl-n100 volumio[2063]: verbose: New Socket.io Connection to 10.0.0.122 from 10.0.0.18 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 21 Mar 10 22:16:42 smsl-n100 volumio[2063]: verbose: New Socket.io Connection to 10.0.0.142 from 10.0.0.18 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 22 Mar 10 22:16:42 smsl-n100 volumio[2063]: verbose: New Socket.io Connection to 10.0.0.122 from 10.0.0.18 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 23 Mar 10 22:16:42 smsl-n100 volumio[2063]: verbose: New Socket.io Connection to 10.0.0.122 from 10.0.0.18 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 24 Mar 10 22:16:42 smsl-n100 volumio[2063]: verbose: New Socket.io Connection to 10.0.0.142 from 10.0.0.18 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 25 Mar 10 22:16:42 smsl-n100 volumio[2063]: verbose: New Socket.io Connection to 10.0.0.122 from 10.0.0.18 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 26 Mar 10 22:16:42 smsl-n100 volumio[2063]: verbose: New Socket.io Connection to 10.0.0.142 from 10.0.0.18 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 27 Mar 10 22:16:42 smsl-n100 volumio[2063]: verbose: New Socket.io Connection to 10.0.0.122 from 10.0.0.18 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 28 Mar 10 22:16:42 smsl-n100 volumio[2063]: verbose: New Socket.io Connection to 10.0.0.142 from 10.0.0.18 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 29 Mar 10 22:16:42 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 10 22:16:42 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 10 22:16:42 smsl-n100 volumio[2063]: info: Discovery: Getting this device information Mar 10 22:16:42 smsl-n100 volumio[2063]: info: CoreCommandRouter::volumioGetState Mar 10 22:16:42 smsl-n100 volumio[2063]: info: CorePlayQueue::getTrack 0 Mar 10 22:16:42 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 10 22:16:42 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 10 22:16:42 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 10 22:16:42 smsl-n100 volumio[2063]: info: Discovery: Getting this device information Mar 10 22:16:42 smsl-n100 volumio[2063]: info: CoreCommandRouter::volumioGetState Mar 10 22:16:42 smsl-n100 volumio[2063]: info: CorePlayQueue::getTrack 0 Mar 10 22:16:42 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 10 22:16:42 smsl-n100 volumio[2063]: info: Reloading queue from file Mar 10 22:16:42 smsl-n100 volumio[2063]: verbose: New Socket.io Connection to 10.0.0.122 from 10.0.0.18 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 30 Mar 10 22:16:42 smsl-n100 volumio[2063]: info: Asound.conf file unchanged, so no further update is needed Mar 10 22:16:42 smsl-n100 volumio[2063]: info: Output device has changed, restarting MPD Mar 10 22:16:42 smsl-n100 sudo[2226]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 10 22:16:42 smsl-n100 sudo[2226]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 22:16:42 smsl-n100 volumio[2063]: info: ___________ START PLUGINS ___________ Mar 10 22:16:42 smsl-n100 sudo[2226]: pam_unix(sudo:session): session closed for user root Mar 10 22:16:42 smsl-n100 volumio[2063]: info: ControllerMpd::onStart: Initializing MPD Mar 10 22:16:42 smsl-n100 volumio[2063]: info: Creating MPD Configuration file Mar 10 22:16:42 smsl-n100 sudo[2229]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 10 22:16:42 smsl-n100 sudo[2229]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 22:16:42 smsl-n100 systemd[1]: Stopping Music Player Daemon... Mar 10 22:16:42 smsl-n100 sudo[2232]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 10 22:16:42 smsl-n100 sudo[2232]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 22:16:42 smsl-n100 systemd[1]: mpd.service: Succeeded. Mar 10 22:16:42 smsl-n100 volumio[2063]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 10 22:16:42 smsl-n100 sudo[2232]: pam_unix(sudo:session): session closed for user root Mar 10 22:16:42 smsl-n100 volumio[2063]: info: [1741659402852] CoreMusicLibrary::Adding element Last_100 Mar 10 22:16:42 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 10 22:16:42 smsl-n100 systemd[1]: Stopped Music Player Daemon. Mar 10 22:16:42 smsl-n100 systemd[1]: Starting Music Player Daemon... Mar 10 22:16:42 smsl-n100 sudo[2234]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 10 22:16:42 smsl-n100 sudo[2234]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 22:16:42 smsl-n100 systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Mar 10 22:16:42 smsl-n100 systemd[1]: mpd.service: Succeeded. Mar 10 22:16:42 smsl-n100 systemd[1]: Stopped Music Player Daemon. Mar 10 22:16:42 smsl-n100 volumio[2063]: info: Streaming services startup Mar 10 22:16:42 smsl-n100 volumio[2063]: info: Starting Streaming Daemon Mar 10 22:16:42 smsl-n100 systemd[1]: Starting Music Player Daemon... Mar 10 22:16:43 smsl-n100 sudo[2240]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 10 22:16:43 smsl-n100 sudo[2240]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 22:16:43 smsl-n100 sudo[2240]: pam_unix(sudo:session): session closed for user root Mar 10 22:16:43 smsl-n100 volumio[2063]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 10 22:16:43 smsl-n100 volumio[2063]: info: [1741659403103] CoreMusicLibrary::Adding element Webradio Mar 10 22:16:43 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 10 22:16:43 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 10 22:16:43 smsl-n100 volumio[2063]: info: Initializing BBC Radios Mar 10 22:16:43 smsl-n100 sudo[2238]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 10 22:16:43 smsl-n100 sudo[2238]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 22:16:43 smsl-n100 sudo[2238]: pam_unix(sudo:session): session closed for user root Mar 10 22:16:43 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 10 22:16:43 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 22:16:43 smsl-n100 volumio[2063]: error: Hi Res Audio Failed Login: Missing Login Data Mar 10 22:16:43 smsl-n100 volumio[2063]: info: Adding HIGHRESAUDIO REST API Endpoints Mar 10 22:16:43 smsl-n100 volumio[2063]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Mar 10 22:16:43 smsl-n100 volumio[2063]: info: Initializing Serial Communication on port /dev/ttyS1 Mar 10 22:16:43 smsl-n100 volumio[2063]: info: Touch Event Listener Process Starting Mar 10 22:16:43 smsl-n100 sudo[2259]: pam_unix(sudo:auth): conversation failed Mar 10 22:16:43 smsl-n100 sudo[2259]: pam_unix(sudo:auth): auth could not identify password for [volumio] Mar 10 22:16:43 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 10 22:16:43 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 22:16:43 smsl-n100 volumio[2063]: info: Initializing GPIOs Mar 10 22:16:43 smsl-n100 volumio[2063]: info: Starting Button Listener Mar 10 22:16:43 smsl-n100 volumio[2063]: info: Turning off Green LED Mar 10 22:16:43 smsl-n100 volumio[2063]: info: Tuning on Blue LED Mar 10 22:16:43 smsl-n100 volumio[2063]: info: Signaling System Ready Mar 10 22:16:43 smsl-n100 volumio[2063]: info: Volumio Calling Home Mar 10 22:16:43 smsl-n100 volumio[2063]: info: Stopping AccessToken refresher cron for QOBUZ Mar 10 22:16:43 smsl-n100 volumio[2063]: info: AccessToken refresher cron started for QOBUZ Mar 10 22:16:43 smsl-n100 volumio[2063]: info: Stopping AccessToken refresher cron Mar 10 22:16:44 smsl-n100 volumio[2063]: info: AccessToken refresher cron started Mar 10 22:16:44 smsl-n100 volumio[2063]: info: Adding TIDAL REST API Endpoints Mar 10 22:16:44 smsl-n100 volumio[2063]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Mar 10 22:16:44 smsl-n100 volumio[2063]: info: Adding QOBUZ REST API Endpoints Mar 10 22:16:44 smsl-n100 volumio[2063]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Mar 10 22:16:44 smsl-n100 volumio[2063]: info: CoreStateMachine::setRepeat null single undefined Mar 10 22:16:44 smsl-n100 volumio[2063]: info: CoreStateMachine::pushState Mar 10 22:16:44 smsl-n100 volumio[2063]: info: CorePlayQueue::getTrack 0 Mar 10 22:16:44 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 22:16:44 smsl-n100 volumio[2063]: info: CoreCommandRouter::volumioPushState Mar 10 22:16:44 smsl-n100 volumio[2063]: info: CoreStateMachine::setRandom null Mar 10 22:16:44 smsl-n100 volumio[2063]: info: CoreStateMachine::pushState Mar 10 22:16:44 smsl-n100 volumio[2063]: info: CorePlayQueue::getTrack 0 Mar 10 22:16:44 smsl-n100 volumio[2063]: info: CoreCommandRouter::volumioPushState Mar 10 22:16:44 smsl-n100 volumio[2063]: info: Setting Device type: NanoPi NEO 3 Mar 10 22:16:44 smsl-n100 volumio[2063]: info: Serial port opened successfully Mar 10 22:16:44 smsl-n100 volumio[2063]: info: Sending serial start messages Mar 10 22:16:44 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:16:44 smsl-n100 volumio[2063]: info: Reporting MCU Network Status: 3 Mar 10 22:16:44 smsl-n100 volumio[2063]: info: CoreCommandRouter::volumioGetState Mar 10 22:16:44 smsl-n100 volumio[2063]: info: CorePlayQueue::getTrack 0 Mar 10 22:16:44 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 10 22:16:44 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 10 22:16:44 smsl-n100 volumio[2063]: verbose: New Socket.io Connection to 10.0.0.122 from 10.0.0.18 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 31 Mar 10 22:16:44 smsl-n100 volumio[2063]: info: Touch Event Listener Process Closed Mar 10 22:16:44 smsl-n100 volumio[2063]: error: Cannot start Volumio Streaming Daemon Mar 10 22:16:44 smsl-n100 volumio[2063]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 10 22:16:44 smsl-n100 volumio[2063]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 10 22:16:44 smsl-n100 volumio[2063]: info: MPD Permissions set Mar 10 22:16:44 smsl-n100 volumio[2063]: info: MPD Permissions set Mar 10 22:16:44 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setDeviceVolumeOverride Mar 10 22:16:44 smsl-n100 volumio[2063]: info: Setting Device Volume Override Mar 10 22:16:44 smsl-n100 volumio[2063]: info: CoreCommandRouter::volumioUpdateVolumeSettings Mar 10 22:16:44 smsl-n100 volumio[2063]: info: Updating Volume Controller Parameters: Device: 5 Name: SMSL USB AUDIO Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Mar 10 22:16:44 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Mar 10 22:16:44 smsl-n100 volumio[2063]: info: Disabling external Volume Control Mar 10 22:16:44 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:16:44 smsl-n100 volumio[2063]: info: CoreStateMachine::pushState Mar 10 22:16:44 smsl-n100 volumio[2063]: info: CorePlayQueue::getTrack 0 Mar 10 22:16:44 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 22:16:44 smsl-n100 volumio[2063]: info: CoreCommandRouter::volumioPushState Mar 10 22:16:45 smsl-n100 volumio[2063]: error: Serial API: Failed to decode command: 100, message: undefined Mar 10 22:16:45 smsl-n100 volumio[2063]: error: Serial API: Failed to decode command: MAXVOL, message: Mar 10 22:16:45 smsl-n100 volumio[2063]: error: Serial API: Failed to decode command: 100, message: undefined Mar 10 22:16:45 smsl-n100 volumio[2063]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Mar 10 22:16:45 smsl-n100 volumio[2063]: info: CoreStateMachine::pushState Mar 10 22:16:45 smsl-n100 volumio[2063]: info: CorePlayQueue::getTrack 0 Mar 10 22:16:45 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 22:16:45 smsl-n100 volumio[2063]: info: CoreCommandRouter::volumioPushState Mar 10 22:16:45 smsl-n100 sudo[2278]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Mar 10 22:16:45 smsl-n100 volumio[2063]: verbose: New Socket.io Connection to 10.0.0.142 from 10.0.0.18 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 32 Mar 10 22:16:45 smsl-n100 sudo[2278]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 22:16:45 smsl-n100 volumio[2063]: verbose: New Socket.io Connection to 10.0.0.142 from 10.0.0.18 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 33 Mar 10 22:16:45 smsl-n100 volumio[2063]: info: CoreStateMachine::pushState Mar 10 22:16:45 smsl-n100 volumio[2063]: info: CorePlayQueue::getTrack 0 Mar 10 22:16:45 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 22:16:45 smsl-n100 volumio[2063]: info: CoreCommandRouter::volumioPushState Mar 10 22:16:45 smsl-n100 systemd[1]: Started UPnP Renderer front-end to MPD. Mar 10 22:16:45 smsl-n100 sudo[2278]: pam_unix(sudo:session): session closed for user root Mar 10 22:16:45 smsl-n100 volumio[2063]: error: Serial API: Failed to decode command: 100, message: undefined Mar 10 22:16:45 smsl-n100 volumio[2063]: error: Serial API: Failed to decode command: MAXVOL, message: Mar 10 22:16:45 smsl-n100 volumio[2063]: error: Serial API: Failed to decode command: 100, message: undefined Mar 10 22:16:45 smsl-n100 volumio[2063]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Mar 10 22:16:45 smsl-n100 volumio[2063]: info: CoreStateMachine::pushState Mar 10 22:16:45 smsl-n100 volumio[2063]: info: CorePlayQueue::getTrack 0 Mar 10 22:16:45 smsl-n100 volumio[2063]: info: CoreCommandRouter::volumioPushState Mar 10 22:16:45 smsl-n100 volumio[2063]: error: Serial API: Failed to decode command: 100, message: undefined Mar 10 22:16:45 smsl-n100 volumio[2063]: error: Serial API: Failed to decode command: MAXVOL, message: Mar 10 22:16:45 smsl-n100 volumio[2063]: error: Serial API: Failed to decode command: 100, message: undefined Mar 10 22:16:45 smsl-n100 volumio[2063]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Mar 10 22:16:45 smsl-n100 volumio[2063]: error: Serial API: Failed to decode command: 3, message: undefined Mar 10 22:16:45 smsl-n100 volumio[2063]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 34 Mar 10 22:16:45 smsl-n100 volumio[2063]: info: Volumio called home Mar 10 22:16:45 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:16:45 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:16:45 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:16:45 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:16:45 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:16:45 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:16:45 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:16:45 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:16:45 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 22:16:45 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 10 22:16:45 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:16:45 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:16:45 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:16:45 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:16:45 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:16:45 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:16:45 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:16:45 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:16:45 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:16:45 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 22:16:45 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 10 22:16:46 smsl-n100 volumio[2063]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 22:16:46 smsl-n100 volumio[2063]: info: CoreStateMachine::pushState Mar 10 22:16:46 smsl-n100 volumio[2063]: info: CorePlayQueue::getTrack 0 Mar 10 22:16:46 smsl-n100 volumio[2063]: info: CoreCommandRouter::volumioPushState Mar 10 22:16:46 smsl-n100 volumio[2063]: error: Serial API: Failed to decode command: 100, message: undefined Mar 10 22:16:46 smsl-n100 volumio[2063]: error: Serial API: Failed to decode command: MAXVOL, message: Mar 10 22:16:46 smsl-n100 volumio[2063]: error: Serial API: Failed to decode command: 100, message: undefined Mar 10 22:16:46 smsl-n100 volumio[2063]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Mar 10 22:16:46 smsl-n100 volumio[2063]: info: Discovery: adding 4d7e946e-b658-4c02-889b-4ac3bedfa4dd Mar 10 22:16:46 smsl-n100 volumio[2063]: info: Discovery: Found device SMSL N100 Mar 10 22:16:46 smsl-n100 volumio[2063]: info: CoreCommandRouter::volumioGetState Mar 10 22:16:46 smsl-n100 volumio[2063]: info: CorePlayQueue::getTrack 0 Mar 10 22:16:46 smsl-n100 volumio[2063]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 10 22:16:46 smsl-n100 volumio[2063]: Error: The value NaN is not a number Mar 10 22:16:46 smsl-n100 volumio[2063]: at Config.forceToType (/volumio/node_modules/v-conf/index.js:322:20) Mar 10 22:16:46 smsl-n100 volumio[2063]: at Config.set (/volumio/node_modules/v-conf/index.js:153:25) Mar 10 22:16:46 smsl-n100 volumio[2063]: at ControllerVolumioDiscovery.updateMultiroomDevice (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:323:25) Mar 10 22:16:46 smsl-n100 volumio[2063]: at ControllerVolumioDiscovery.connectToRemoteVolumio (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:273:10) Mar 10 22:16:46 smsl-n100 volumio[2063]: at Browser. (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:192:12) Mar 10 22:16:46 smsl-n100 volumio[2063]: at Browser.emit (events.js:400:28) Mar 10 22:16:46 smsl-n100 volumio[2063]: at on_resolver_done (/volumio/node_modules/mdns/lib/browser.js:31:14) Mar 10 22:16:46 smsl-n100 volumio[2063]: at next (/volumio/node_modules/mdns/lib/browser.js:106:7) Mar 10 22:16:46 smsl-n100 volumio[2063]: at Array.makeAddressesUnique (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:177:5) Mar 10 22:16:46 smsl-n100 volumio[2063]: at next (/volumio/node_modules/mdns/lib/browser.js:109:21) Mar 10 22:16:46 smsl-n100 volumio[2063]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 10 22:16:47 smsl-n100 sudo[2316]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-10 22:15 Mar 10 22:16:47 smsl-n100 sudo[2316]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="cc0042a1eab1cb7982711a1347e242f8947b54b6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="723ba1d50268911818ebdca474fb7656df6050cb" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="smsl" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 14 Feb 2025 02:46:15 PM CET" VOLUMIO_VERSION="3.789" VOLUMIO_HARDWARE="nanopineo3" VOLUMIO_DEVICENAME="Nanopi Neo3" VOLUMIO_VENDOR_MODEL="SMSL S100" VOLUMIO_VENDOR="SMSL" VOLUMIO_MODEL="S100" VOLUMIO_HASH="215d731aee688e00fb3cc923952be9a7"