-- Logs begin at Thu 2019-02-14 13:11:59 MSK, end at Fri 2025-06-20 15:21:45 MSK. -- Jun 20 15:20:00 smsl-n100 volumio[1065]: info: Loading plugin "qobuz"... Jun 20 15:20:02 smsl-n100 volumio[1065]: info: Loading plugin "smart_inputs"... Jun 20 15:20:03 smsl-n100 volumio[1065]: info: Loading plugin "tidal"... Jun 20 15:20:05 smsl-n100 volumio[1065]: info: Loading plugin "oem_helper"... Jun 20 15:20:08 smsl-n100 volumio[1065]: info: Applying required configuration parameters for plugin oem_helper Jun 20 15:20:08 smsl-n100 volumio[1065]: info: Loading plugin "smslcontrol"... Jun 20 15:20:08 smsl-n100 kernel: gpio gpiochip0: Persistence not supported for GPIO 5 Jun 20 15:20:08 smsl-n100 volumio[1065]: info: Adding this device properties Jun 20 15:20:08 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties Jun 20 15:20:08 smsl-n100 volumio[1065]: info: Setting Additional Device Volumio Properties: [object Object] Jun 20 15:20:08 smsl-n100 volumio[1065]: info: Loading plugin "updater_comm"... Jun 20 15:20:08 smsl-n100 volumio[1065]: info: Plugin mpdemulation is not enabled Jun 20 15:20:08 smsl-n100 volumio[1065]: info: Loading plugin "rest_api"... Jun 20 15:20:08 smsl-n100 volumio[1065]: info: Loading plugin "websocket"... Jun 20 15:20:08 smsl-n100 volumio[1065]: info: Starting Socket.io Server version 2.3.0 Jun 20 15:20:08 smsl-n100 volumio[1065]: info: Loading i18n strings for locale ru Jun 20 15:20:08 smsl-n100 volumio[1065]: Updating browse sources language Jun 20 15:20:08 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 20 15:20:09 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 20 15:20:09 smsl-n100 volumio[1065]: info: CoreCommandRouter::initPlayerControls Jun 20 15:20:09 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:09 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:09 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:09 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:09 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:09 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:09 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:09 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:09 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 20 15:20:09 smsl-n100 volumio[1065]: Express server listening on port 3000 Jun 20 15:20:09 smsl-n100 volumio[1065]: [Metrics] WebUI: 35s 215.02ms Jun 20 15:20:09 smsl-n100 volumio[1065]: info: CoreStateMachine::resetVolumioState Jun 20 15:20:09 smsl-n100 volumio[1065]: info: CoreStateMachine::getcurrentVolume Jun 20 15:20:09 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumioRetrievevolume Jun 20 15:20:09 smsl-n100 volumio[1065]: info: CoreStateMachine::pushState Jun 20 15:20:09 smsl-n100 volumio[1065]: info: CorePlayQueue::getTrack 0 Jun 20 15:20:09 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 15:20:09 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumioPushState Jun 20 15:20:09 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 20 15:20:09 smsl-n100 sudo[1306]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 20 15:20:09 smsl-n100 sudo[1306]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 15:20:09 smsl-n100 sudo[1306]: pam_unix(sudo:session): session closed for user root Jun 20 15:20:09 smsl-n100 sudo[1308]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 15:20:09 smsl-n100 sudo[1308]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 15:20:09 smsl-n100 volumio[1065]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jun 20 15:20:09 smsl-n100 volumio[1065]: info: Completed loading Core Plugins Jun 20 15:20:09 smsl-n100 sudo[1308]: pam_unix(sudo:session): session closed for user root Jun 20 15:20:09 smsl-n100 volumio[1065]: info: Preparing to generate the ALSA configuration file Jun 20 15:20:09 smsl-n100 volumio[1065]: info: Volumio Network Manager: Network status updated: 1 Jun 20 15:20:09 smsl-n100 volumio[1065]: info: MRS: Removed streaming files Jun 20 15:20:09 smsl-n100 volumio[1065]: info: MRS: volumioStreaming STOPPED Jun 20 15:20:09 smsl-n100 volumio[1065]: info: MRS: SNAPSERVER STOPPED Jun 20 15:20:09 smsl-n100 volumio[1065]: info: MRS: SNAPCLIENT STOPPED Jun 20 15:20:09 smsl-n100 volumio[1065]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Jun 20 15:20:09 smsl-n100 volumio[1065]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jun 20 15:20:09 smsl-n100 volumio[1065]: info: Reading ALSA contributions from plugins. Jun 20 15:20:10 smsl-n100 volumio[1065]: info: Reloading queue from file Jun 20 15:20:10 smsl-n100 volumio[1065]: info: CoreStateMachine::setRepeat false single undefined Jun 20 15:20:10 smsl-n100 volumio[1065]: info: CoreStateMachine::pushState Jun 20 15:20:10 smsl-n100 volumio[1065]: info: CorePlayQueue::getTrack 0 Jun 20 15:20:10 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 15:20:10 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumioPushState Jun 20 15:20:10 smsl-n100 volumio[1065]: info: CoreStateMachine::setRandom false Jun 20 15:20:10 smsl-n100 volumio[1065]: info: CoreStateMachine::pushState Jun 20 15:20:10 smsl-n100 volumio[1065]: info: CorePlayQueue::getTrack 0 Jun 20 15:20:10 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 15:20:10 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumioPushState Jun 20 15:20:10 smsl-n100 volumio[1065]: info: Setting Device type: NanoPi NEO 3 Jun 20 15:20:10 smsl-n100 volumio[1065]: info: Asound.conf file unchanged, so no further update is needed Jun 20 15:20:10 smsl-n100 volumio[1065]: info: Output device has changed, restarting MPD Jun 20 15:20:10 smsl-n100 sudo[1317]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jun 20 15:20:10 smsl-n100 sudo[1317]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 15:20:10 smsl-n100 systemd[1]: Started UPnP Renderer front-end to MPD. Jun 20 15:20:10 smsl-n100 sudo[1320]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 20 15:20:10 smsl-n100 sudo[1320]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 15:20:10 smsl-n100 sudo[1320]: pam_unix(sudo:session): session closed for user root Jun 20 15:20:10 smsl-n100 volumio[1065]: info: Output device has changed, restarting Shairport Sync Jun 20 15:20:10 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:10 smsl-n100 sudo[1317]: pam_unix(sudo:session): session closed for user root Jun 20 15:20:10 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 20 15:20:10 smsl-n100 sudo[1324]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 20 15:20:10 smsl-n100 sudo[1324]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 15:20:10 smsl-n100 systemd[1]: Stopping Music Player Daemon... Jun 20 15:20:10 smsl-n100 volumio[1065]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 20 15:20:10 smsl-n100 volumio[1065]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jun 20 15:20:10 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:10 smsl-n100 volumio[1065]: info: ___________ START PLUGINS ___________ Jun 20 15:20:10 smsl-n100 volumio[1065]: info: ControllerMpd::onStart: Initializing MPD Jun 20 15:20:10 smsl-n100 volumio[1065]: info: Creating MPD Configuration file Jun 20 15:20:10 smsl-n100 sudo[1346]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 20 15:20:10 smsl-n100 sudo[1346]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 15:20:10 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 20 15:20:10 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 20 15:20:10 smsl-n100 volumio[1065]: info: [1750422010869] CoreMusicLibrary::Adding element Медиа-серверы Jun 20 15:20:10 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 20 15:20:10 smsl-n100 sudo[1346]: pam_unix(sudo:session): session closed for user root Jun 20 15:20:10 smsl-n100 systemd[1]: mpd.service: Succeeded. Jun 20 15:20:10 smsl-n100 systemd[1]: Stopped Music Player Daemon. Jun 20 15:20:10 smsl-n100 sudo[1348]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 20 15:20:10 smsl-n100 sudo[1348]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 15:20:10 smsl-n100 systemd[1]: Starting Music Player Daemon... Jun 20 15:20:10 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 20 15:20:10 smsl-n100 systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jun 20 15:20:10 smsl-n100 systemd[1]: mpd.service: Succeeded. Jun 20 15:20:10 smsl-n100 systemd[1]: Stopped Music Player Daemon. Jun 20 15:20:10 smsl-n100 systemd[1]: Starting Music Player Daemon... Jun 20 15:20:11 smsl-n100 volumio[1065]: info: Adding METAVOLUMIO REST API Endpoints Jun 20 15:20:11 smsl-n100 volumio[1065]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Jun 20 15:20:11 smsl-n100 volumio[1065]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Jun 20 15:20:11 smsl-n100 volumio[1065]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Jun 20 15:20:11 smsl-n100 volumio[1065]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Jun 20 15:20:11 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:11 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 20 15:20:11 smsl-n100 sudo[1354]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name SMSL N100 Jun 20 15:20:11 smsl-n100 sudo[1354]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 15:20:11 smsl-n100 sudo[1354]: pam_unix(sudo:session): session closed for user root Jun 20 15:20:11 smsl-n100 volumio[1065]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 20 15:20:11 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:11 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 20 15:20:11 smsl-n100 sudo[1353]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 20 15:20:11 smsl-n100 sudo[1353]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 15:20:11 smsl-n100 sudo[1353]: pam_unix(sudo:session): session closed for user root Jun 20 15:20:11 smsl-n100 volumio[1065]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 20 15:20:11 smsl-n100 volumio[1065]: info: Preparing CD Folders Jun 20 15:20:11 smsl-n100 volumio[1065]: info: Adding CD REST API Endpoints Jun 20 15:20:11 smsl-n100 volumio[1065]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Jun 20 15:20:11 smsl-n100 volumio[1065]: info: Starting UDEV Watcher for CD Jun 20 15:20:11 smsl-n100 volumio[1065]: info: Detecting CD presence with UDEV Jun 20 15:20:11 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Jun 20 15:20:11 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 20 15:20:11 smsl-n100 volumio[1065]: info: [1750422011273] CoreMusicLibrary::Adding element Last_100 Jun 20 15:20:11 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 20 15:20:11 smsl-n100 volumio[1065]: info: Starting RAAT Plugin Jun 20 15:20:11 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Jun 20 15:20:11 smsl-n100 volumio[1065]: info: Additional UI Settings Added for plugin music_service/raat Jun 20 15:20:11 smsl-n100 volumio[1065]: info: Registering DSP Elements listener and retrieving current ones Jun 20 15:20:11 smsl-n100 volumio[1065]: info: Additional DSP elements updated Jun 20 15:20:11 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:11 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:11 smsl-n100 volumio[1065]: info: Updating RAAT Signal Path Jun 20 15:20:11 smsl-n100 volumio[1065]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Jun 20 15:20:11 smsl-n100 volumio[1065]: info: Streaming services startup Jun 20 15:20:11 smsl-n100 volumio[1065]: info: Starting Streaming Daemon Jun 20 15:20:11 smsl-n100 sudo[1367]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jun 20 15:20:11 smsl-n100 sudo[1367]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 15:20:11 smsl-n100 sudo[1367]: pam_unix(sudo:session): session closed for user root Jun 20 15:20:11 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 20 15:20:11 smsl-n100 volumio[1065]: info: [1750422011543] CoreMusicLibrary::Adding element Webradio Jun 20 15:20:11 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 20 15:20:11 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 20 15:20:11 smsl-n100 volumio[1065]: info: Initializing BBC Radios Jun 20 15:20:11 smsl-n100 sudo[1374]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 20 15:20:11 smsl-n100 sudo[1374]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 15:20:11 smsl-n100 sudo[1374]: pam_unix(sudo:session): session closed for user root Jun 20 15:20:11 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 20 15:20:11 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 20 15:20:11 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Jun 20 15:20:11 smsl-n100 volumio[1065]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jun 20 15:20:11 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:11 smsl-n100 volumio[1065]: error: Hi Res Audio Failed Login: Missing Login Data Jun 20 15:20:11 smsl-n100 volumio[1065]: info: Adding HIGHRESAUDIO REST API Endpoints Jun 20 15:20:11 smsl-n100 volumio[1065]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Jun 20 15:20:11 smsl-n100 volumio[1065]: info: Initializing Serial Communication on port /dev/ttyS1 Jun 20 15:20:11 smsl-n100 volumio[1065]: info: Touch Event Listener Process Starting Jun 20 15:20:11 smsl-n100 volumio[1065]: info: Refreshing QOBUZ token Jun 20 15:20:11 smsl-n100 sudo[1391]: pam_unix(sudo:auth): conversation failed Jun 20 15:20:11 smsl-n100 sudo[1391]: pam_unix(sudo:auth): auth could not identify password for [volumio] Jun 20 15:20:11 smsl-n100 volumio[1065]: info: Adding inputs REST Endpoints Jun 20 15:20:11 smsl-n100 volumio[1065]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Jun 20 15:20:11 smsl-n100 volumio[1065]: info: Scanning Audio Inputs Jun 20 15:20:12 smsl-n100 volumio[1065]: info: Checking against Known Cards name Jun 20 15:20:12 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 20 15:20:12 smsl-n100 volumio[1065]: info: [1750422012109] CoreMusicLibrary::Adding element USB HIFI Audio Jun 20 15:20:12 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 20 15:20:12 smsl-n100 volumio[1065]: Cannot find translation for source USB HIFI Audio Jun 20 15:20:12 smsl-n100 volumio[1065]: info: Checking against Known Cards name Jun 20 15:20:12 smsl-n100 volumio[1065]: info: Adding Server instance for streaming Jun 20 15:20:12 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 20 15:20:12 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 20 15:20:12 smsl-n100 volumio[1065]: info: Initializing GPIOs Jun 20 15:20:12 smsl-n100 kernel: gpio gpiochip3: Persistence not supported for GPIO 1 Jun 20 15:20:12 smsl-n100 kernel: gpio gpiochip2: Persistence not supported for GPIO 15 Jun 20 15:20:12 smsl-n100 kernel: gpio gpiochip3: Persistence not supported for GPIO 0 Jun 20 15:20:12 smsl-n100 kernel: gpio gpiochip2: Persistence not supported for GPIO 2 Jun 20 15:20:12 smsl-n100 volumio[1065]: info: Starting Button Listener Jun 20 15:20:12 smsl-n100 volumio[1065]: info: Turning off Green LED Jun 20 15:20:12 smsl-n100 volumio[1065]: info: Tuning on Blue LED Jun 20 15:20:12 smsl-n100 volumio[1065]: info: Signaling System Ready Jun 20 15:20:12 smsl-n100 volumio[1065]: info: Volumio Calling Home Jun 20 15:20:12 smsl-n100 volumio[1065]: (node:1065) [DEP0005] DeprecationWarning: Buffer() is deprecated due to security and usability issues. Please use the Buffer.alloc(), Buffer.allocUnsafe(), or Buffer.from() methods instead. Jun 20 15:20:12 smsl-n100 volumio[1065]: (Use `node --trace-deprecation ...` to show where the warning was created) Jun 20 15:20:12 smsl-n100 volumio[1065]: info: Stopping AccessToken refresher cron Jun 20 15:20:12 smsl-n100 volumio[1065]: info: AccessToken refresher cron started Jun 20 15:20:12 smsl-n100 volumio[1065]: info: Adding TIDAL REST API Endpoints Jun 20 15:20:12 smsl-n100 volumio[1065]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Jun 20 15:20:13 smsl-n100 volumio[1065]: info: Discovery: adding 1df7577f-2dd9-4e13-90a4-2547ecf91573 Jun 20 15:20:13 smsl-n100 volumio[1065]: info: Discovery: Found device SMSL N100 Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumioGetState Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CorePlayQueue::getTrack 0 Jun 20 15:20:13 smsl-n100 volumio[1065]: info: MRS: Pushing multiroomSync output for this device Jun 20 15:20:13 smsl-n100 volumio[1065]: info: MRS: Pushing multiroomSync output Jun 20 15:20:13 smsl-n100 volumio[1065]: info: Adding audio output: Jun 20 15:20:13 smsl-n100 volumio[1065]: info: Adding audio output: Jun 20 15:20:13 smsl-n100 volumio[1065]: info: Serial port opened successfully Jun 20 15:20:13 smsl-n100 volumio[1065]: info: Sending serial start messages Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:13 smsl-n100 volumio[1065]: info: Reporting MCU Network Status: 1 Jun 20 15:20:13 smsl-n100 volumio[1065]: info: Touch Event Listener Process Closed Jun 20 15:20:13 smsl-n100 volumio[1065]: error: Cannot start Volumio Streaming Daemon Jun 20 15:20:13 smsl-n100 volumio[1065]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jun 20 15:20:13 smsl-n100 volumio[1065]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jun 20 15:20:13 smsl-n100 volumio[1065]: info: RAAT Albumart path created successfully Jun 20 15:20:13 smsl-n100 volumio[1065]: error: Cannot set new Bluetooth Name : Error: Command failed: /usr/bin/sudo /bin/hciconfig hci0 name 'SMSL N100' Jun 20 15:20:13 smsl-n100 volumio[1065]: Can't get device info: No such device Jun 20 15:20:13 smsl-n100 volumio[1065]: info: MPD Permissions set Jun 20 15:20:13 smsl-n100 volumio[1065]: info: MPD Permissions set Jun 20 15:20:13 smsl-n100 volumio[1065]: info: Upmpdcli Daemon Started Jun 20 15:20:13 smsl-n100 volumio[1065]: info: Volumio called home Jun 20 15:20:13 smsl-n100 volumio[1065]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 20 15:20:13 smsl-n100 volumio-remote-updater[563]: [2025-06-20 15:20:13] [connect] Successful connection Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setDeviceVolumeOverride Jun 20 15:20:13 smsl-n100 volumio[1065]: info: Setting Device Volume Override Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jun 20 15:20:13 smsl-n100 volumio[1065]: info: Updating Volume Controller Parameters: Device: 5 Name: USB HIFI Audio Mixer: Max Vol: 100 Vol Curve; linear Vol Steps: 20 Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jun 20 15:20:13 smsl-n100 volumio[1065]: info: Disabling external Volume Control Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CoreStateMachine::pushState Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CorePlayQueue::getTrack 0 Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumioPushState Jun 20 15:20:13 smsl-n100 volumio[1065]: info: MRS: Pushing multiroomSync output update for this device Jun 20 15:20:13 smsl-n100 volumio[1065]: info: MRS: Pushing multiroomSync output Jun 20 15:20:13 smsl-n100 volumio[1065]: error: Serial API: Failed to decode command: 100, message: undefined Jun 20 15:20:13 smsl-n100 volumio[1065]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 20 15:20:13 smsl-n100 volumio[1065]: error: Serial API: Failed to decode command: 100, message: undefined Jun 20 15:20:13 smsl-n100 volumio[1065]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CoreStateMachine::pushState Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CorePlayQueue::getTrack 0 Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumioPushState Jun 20 15:20:13 smsl-n100 volumio[1065]: info: MRS: Pushing multiroomSync output update for this device Jun 20 15:20:13 smsl-n100 volumio[1065]: info: MRS: Pushing multiroomSync output Jun 20 15:20:13 smsl-n100 volumio[1065]: error: Serial API: Failed to decode command: 100, message: undefined Jun 20 15:20:13 smsl-n100 volumio[1065]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 20 15:20:13 smsl-n100 volumio[1065]: error: Serial API: Failed to decode command: 100, message: undefined Jun 20 15:20:13 smsl-n100 volumio[1065]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CoreStateMachine::pushState Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CorePlayQueue::getTrack 0 Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumioPushState Jun 20 15:20:13 smsl-n100 volumio[1065]: info: MRS: Pushing multiroomSync output update for this device Jun 20 15:20:13 smsl-n100 volumio[1065]: info: MRS: Pushing multiroomSync output Jun 20 15:20:13 smsl-n100 volumio[1065]: error: Serial API: Failed to decode command: 100, message: undefined Jun 20 15:20:13 smsl-n100 volumio[1065]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 20 15:20:13 smsl-n100 volumio[1065]: error: Serial API: Failed to decode command: 100, message: undefined Jun 20 15:20:13 smsl-n100 volumio[1065]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CoreStateMachine::pushState Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CorePlayQueue::getTrack 0 Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 15:20:13 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumioPushState Jun 20 15:20:13 smsl-n100 volumio[1065]: info: MRS: Pushing multiroomSync output update for this device Jun 20 15:20:13 smsl-n100 volumio[1065]: info: MRS: Pushing multiroomSync output Jun 20 15:20:13 smsl-n100 volumio[1065]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Jun 20 15:20:14 smsl-n100 volumio[1065]: info: CoreStateMachine::pushState Jun 20 15:20:14 smsl-n100 volumio[1065]: info: CorePlayQueue::getTrack 0 Jun 20 15:20:14 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 15:20:14 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumioPushState Jun 20 15:20:14 smsl-n100 sudo[1436]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Jun 20 15:20:14 smsl-n100 volumio[1065]: info: MRS: Pushing multiroomSync output update for this device Jun 20 15:20:14 smsl-n100 sudo[1436]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 15:20:14 smsl-n100 volumio[1065]: info: MRS: Pushing multiroomSync output Jun 20 15:20:14 smsl-n100 volumio[1065]: error: Serial API: Failed to decode command: 100, message: undefined Jun 20 15:20:14 smsl-n100 volumio[1065]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 20 15:20:14 smsl-n100 volumio[1065]: error: Serial API: Failed to decode command: 100, message: undefined Jun 20 15:20:14 smsl-n100 volumio[1065]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 20 15:20:14 smsl-n100 systemd[1]: Started Volumio Bluetooth Module. Jun 20 15:20:14 smsl-n100 sudo[1436]: pam_unix(sudo:session): session closed for user root Jun 20 15:20:14 smsl-n100 sudo[1439]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* Jun 20 15:20:14 smsl-n100 sudo[1439]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 15:20:14 smsl-n100 volumiobt[1438]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory Jun 20 15:20:14 smsl-n100 sudo[1439]: pam_unix(sudo:session): session closed for user root Jun 20 15:20:14 smsl-n100 volumio[1065]: info: Access Token successfully retrieved Jun 20 15:20:14 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 20 15:20:14 smsl-n100 volumio[1065]: info: [1750422014468] CoreMusicLibrary::Adding element QOBUZ Jun 20 15:20:14 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 20 15:20:14 smsl-n100 volumio[1065]: Cannot find translation for source USB HIFI Audio Jun 20 15:20:14 smsl-n100 volumio[1065]: Cannot find translation for source QOBUZ Jun 20 15:20:14 smsl-n100 volumio[1065]: info: Stopping AccessToken refresher cron for QOBUZ Jun 20 15:20:14 smsl-n100 volumio[1065]: info: AccessToken refresher cron started for QOBUZ Jun 20 15:20:14 smsl-n100 volumio[1065]: info: Adding QOBUZ REST API Endpoints Jun 20 15:20:14 smsl-n100 volumio[1065]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Jun 20 15:20:14 smsl-n100 volumio-remote-updater[563]: [2025-06-20 15:20:14] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1750422013 101 Jun 20 15:20:14 smsl-n100 volumio[1065]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 3 Jun 20 15:20:14 smsl-n100 volumio[1065]: info: Volumio BT Module successfully started Jun 20 15:20:14 smsl-n100 volumio[1065]: info: Starting Shairport Sync Jun 20 15:20:14 smsl-n100 volumio[1065]: info: Starting Shairport Sync Jun 20 15:20:14 smsl-n100 sudo[1444]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 20 15:20:14 smsl-n100 sudo[1444]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 15:20:14 smsl-n100 volumio[1065]: info: Starting Shairport Sync Jun 20 15:20:14 smsl-n100 sudo[1446]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 20 15:20:14 smsl-n100 sudo[1446]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 15:20:14 smsl-n100 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 20 15:20:14 smsl-n100 sudo[1449]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 20 15:20:14 smsl-n100 sudo[1449]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 15:20:14 smsl-n100 systemd[1]: shairport-sync.service: Succeeded. Jun 20 15:20:14 smsl-n100 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 20 15:20:14 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumioGetState Jun 20 15:20:14 smsl-n100 volumio[1065]: info: CorePlayQueue::getTrack 0 Jun 20 15:20:15 smsl-n100 volumio[1065]: info: TidalConnect service stoped! Jun 20 15:20:15 smsl-n100 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 20 15:20:15 smsl-n100 sudo[1446]: pam_unix(sudo:session): session closed for user root Jun 20 15:20:15 smsl-n100 sudo[1444]: pam_unix(sudo:session): session closed for user root Jun 20 15:20:15 smsl-n100 volumio[1065]: info: CoreStateMachine::pushState Jun 20 15:20:15 smsl-n100 volumio[1065]: info: CorePlayQueue::getTrack 0 Jun 20 15:20:15 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumioPushState Jun 20 15:20:15 smsl-n100 volumio[1065]: info: MRS: Pushing multiroomSync output update for this device Jun 20 15:20:15 smsl-n100 volumio[1065]: info: MRS: Pushing multiroomSync output Jun 20 15:20:15 smsl-n100 volumio[1065]: error: Serial API: Failed to decode command: 100, message: undefined Jun 20 15:20:15 smsl-n100 volumio[1065]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 20 15:20:15 smsl-n100 volumio[1065]: error: Serial API: Failed to decode command: 100, message: undefined Jun 20 15:20:15 smsl-n100 volumio[1065]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 20 15:20:15 smsl-n100 sudo[1449]: pam_unix(sudo:session): session closed for user root Jun 20 15:20:15 smsl-n100 volumio[1065]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 20 15:20:15 smsl-n100 volumio[1065]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 20 15:20:15 smsl-n100 volumio[1065]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 20 15:20:15 smsl-n100 volumio[1065]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 20 15:20:15 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumioGetState Jun 20 15:20:15 smsl-n100 volumio[1065]: info: CorePlayQueue::getTrack 0 Jun 20 15:20:15 smsl-n100 volumio[1065]: info: Shairport-Sync Started Jun 20 15:20:15 smsl-n100 volumio[1065]: Error adding Membership: Error: addMembership EINVAL Jun 20 15:20:15 smsl-n100 volumio[1065]: info: Shairport-Sync Started Jun 20 15:20:15 smsl-n100 sudo[1459]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio Jun 20 15:20:15 smsl-n100 sudo[1459]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 15:20:15 smsl-n100 volumiobt[1438]: pulseaudio: no process found Jun 20 15:20:15 smsl-n100 sudo[1459]: pam_unix(sudo:session): session closed for user root Jun 20 15:20:15 smsl-n100 volumio[1065]: info: Shairport-Sync Started Jun 20 15:20:15 smsl-n100 dbus-daemon[560]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.15' (uid=1000 pid=1467 comm="/usr/bin/pulseaudio --high-priority=true ") Jun 20 15:20:15 smsl-n100 systemd[1]: Starting RealtimeKit Scheduling Policy Service... Jun 20 15:20:15 smsl-n100 dbus-daemon[560]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' Jun 20 15:20:15 smsl-n100 systemd[1]: Started RealtimeKit Scheduling Policy Service. Jun 20 15:20:15 smsl-n100 rtkit-daemon[1468]: Successfully called chroot. Jun 20 15:20:15 smsl-n100 rtkit-daemon[1468]: Successfully dropped privileges. Jun 20 15:20:15 smsl-n100 volumio[1065]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jun 20 15:20:15 smsl-n100 volumio[1065]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect Jun 20 15:20:15 smsl-n100 rtkit-daemon[1468]: Successfully limited resources. Jun 20 15:20:15 smsl-n100 rtkit-daemon[1468]: Running. Jun 20 15:20:15 smsl-n100 rtkit-daemon[1468]: Watchdog thread running. Jun 20 15:20:15 smsl-n100 rtkit-daemon[1468]: Canary thread running. Jun 20 15:20:15 smsl-n100 dbus-daemon[560]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.16' (uid=0 pid=1468 comm="/usr/lib/rtkit/rtkit-daemon ") Jun 20 15:20:15 smsl-n100 systemd[1]: Starting Authorization Manager... Jun 20 15:20:15 smsl-n100 volumio[1065]: info: CoreStateMachine::pushState Jun 20 15:20:15 smsl-n100 volumio[1065]: info: CorePlayQueue::getTrack 0 Jun 20 15:20:15 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumioPushState Jun 20 15:20:15 smsl-n100 volumio[1065]: info: MRS: Pushing multiroomSync output update for this device Jun 20 15:20:15 smsl-n100 volumio[1065]: info: MRS: Pushing multiroomSync output Jun 20 15:20:15 smsl-n100 volumio[1065]: error: Help! Some callbacks for volumioPushState are crashing! Jun 20 15:20:15 smsl-n100 volumio[1065]: error: Cannot read property 'sendVolumeMute' of undefined Jun 20 15:20:15 smsl-n100 volumio[1065]: error: Serial API: Failed to decode command: 100, message: undefined Jun 20 15:20:15 smsl-n100 volumio[1065]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 20 15:20:15 smsl-n100 volumio[1065]: error: Serial API: Failed to decode command: 100, message: undefined Jun 20 15:20:15 smsl-n100 volumio[1065]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 20 15:20:15 smsl-n100 sudo[1473]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jun 20 15:20:15 smsl-n100 sudo[1473]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 15:20:15 smsl-n100 volumio[1065]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 20 15:20:15 smsl-n100 volumio[1065]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 20 15:20:15 smsl-n100 systemd[1]: Started Volumio Tidal Connect Service. Jun 20 15:20:15 smsl-n100 sudo[1473]: pam_unix(sudo:session): session closed for user root Jun 20 15:20:15 smsl-n100 polkitd[1472]: started daemon version 0.105 using authority implementation `local' version `0.105' Jun 20 15:20:15 smsl-n100 dbus-daemon[560]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Jun 20 15:20:15 smsl-n100 systemd[1]: Started Authorization Manager. Jun 20 15:20:16 smsl-n100 mpd[1363]: Jun 20 15:20 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 20 15:20:16 smsl-n100 systemd[1]: Started Music Player Daemon. Jun 20 15:20:16 smsl-n100 sudo[1348]: pam_unix(sudo:session): session closed for user root Jun 20 15:20:16 smsl-n100 sudo[1324]: pam_unix(sudo:session): session closed for user root Jun 20 15:20:16 smsl-n100 dbus-daemon[560]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.36' (uid=1000 pid=1467 comm="/usr/bin/pulseaudio --high-priority=true ") Jun 20 15:20:16 smsl-n100 volumio[1065]: info: Executing endpoint tc_getconfig Jun 20 15:20:16 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Jun 20 15:20:16 smsl-n100 vtcs[1476]: STARTING TidalConnect services, version: 1.4.0.34 Jun 20 15:20:16 smsl-n100 systemd[1]: Starting Bluetooth service... Jun 20 15:20:16 smsl-n100 volumio[1065]: Upnp client error: Error: This socket has been ended by the other party Jun 20 15:20:16 smsl-n100 volumio[1065]: Upnp client error: Error: This socket has been ended by the other party Jun 20 15:20:16 smsl-n100 volumio[1065]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 20 15:20:16 smsl-n100 pulseaudio[1467]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Jun 20 15:20:16 smsl-n100 pulseaudio[1467]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Jun 20 15:20:16 smsl-n100 volumiobt[1438]: Applying permissions Jun 20 15:20:16 smsl-n100 volumiobt[1438]: Setting BT discoverable and pairable Jun 20 15:20:16 smsl-n100 bluetoothd[1485]: Bluetooth daemon 5.50 Jun 20 15:20:16 smsl-n100 bluetoothd[1485]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Jun 20 15:20:16 smsl-n100 volumio[1065]: info: MRS: Getting audio outputs on start Jun 20 15:20:16 smsl-n100 dbus-daemon[560]: [system] Successfully activated service 'org.bluez' Jun 20 15:20:16 smsl-n100 systemd[1]: Started Bluetooth service. Jun 20 15:20:16 smsl-n100 volumio[1065]: info: MRS: Requesting all other devices output Jun 20 15:20:16 smsl-n100 bluetoothd[1485]: Starting SDP server Jun 20 15:20:16 smsl-n100 bluetoothd[1485]: Excluding (cli) sap Jun 20 15:20:16 smsl-n100 bluetoothd[1485]: kernel lacks bnep-protocol support Jun 20 15:20:16 smsl-n100 bluetoothd[1485]: System does not support network plugin Jun 20 15:20:16 smsl-n100 bluetoothd[1485]: Bluetooth management interface 1.14 initialized Jun 20 15:20:16 smsl-n100 dbus-daemon[560]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.37' (uid=0 pid=1485 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") Jun 20 15:20:16 smsl-n100 volumiobt[1438]: [bluetooth]# -e power on Jun 20 15:20:16 smsl-n100 volumiobt[1438]: Invalid command in menu main: -e Jun 20 15:20:16 smsl-n100 volumiobt[1438]: Jun 20 15:20:16 smsl-n100 volumiobt[1438]: Use "help" for a list of available commands in a menu. Jun 20 15:20:16 smsl-n100 volumiobt[1438]: Use "menu " if you want to enter any submenu. Jun 20 15:20:16 smsl-n100 volumiobt[1438]: Use "back" if you want to return to menu main. Jun 20 15:20:16 smsl-n100 volumiobt[1438]: [bluetooth]# agent on Jun 20 15:20:16 smsl-n100 volumiobt[1438]: Failed to register agent object Jun 20 15:20:16 smsl-n100 volumiobt[1438]: [bluetooth]# discoverable on Jun 20 15:20:16 smsl-n100 volumiobt[1438]: No default controller available Jun 20 15:20:16 smsl-n100 volumiobt[1438]: [bluetooth]# pairable on Jun 20 15:20:16 smsl-n100 volumiobt[1438]: No default controller available Jun 20 15:20:16 smsl-n100 volumiobt[1438]: [bluetooth]# agent NoInputNoOutput Jun 20 15:20:16 smsl-n100 volumiobt[1438]: Failed to register agent object Jun 20 15:20:16 smsl-n100 volumiobt[1438]: [bluetooth]# default-agent Jun 20 15:20:16 smsl-n100 volumiobt[1438]: No agent is registered Jun 20 15:20:16 smsl-n100 pulseaudio[1467]: Failed to register as a handsfree audio agent with ofono: org.freedesktop.DBus.Error.ServiceUnknown: The name org.ofono was not provided by any .service files Jun 20 15:20:16 smsl-n100 volumiobt[1438]: [bluetooth]# quit Jun 20 15:20:16 smsl-n100 volumiobt[1438]: [59B blob data] Jun 20 15:20:17 smsl-n100 systemd[1]: Starting Hostname Service... Jun 20 15:20:17 smsl-n100 vtcs[1476]: STARTED TidalConnect services. Jun 20 15:20:17 smsl-n100 volumio[1065]: error: MPD error: The expression evaluated to a falsy value: Jun 20 15:20:17 smsl-n100 volumio[1065]: assert.ok(self.idling) Jun 20 15:20:17 smsl-n100 volumio[1065]: error: The expression evaluated to a falsy value: Jun 20 15:20:17 smsl-n100 volumio[1065]: assert.ok(self.idling) Jun 20 15:20:17 smsl-n100 volumio[1065]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 20 15:20:17 smsl-n100 volumio[1065]: info: MPD running with PID1363 Jun 20 15:20:17 smsl-n100 volumio[1065]: ,establishing connection Jun 20 15:20:17 smsl-n100 volumio[1065]: error: updateQueue error: null Jun 20 15:20:17 smsl-n100 volumio[1065]: info: Executing endpoint tc_connect Jun 20 15:20:17 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Jun 20 15:20:17 smsl-n100 volumio[1065]: info: Connecting to TidalConnect Jun 20 15:20:17 smsl-n100 volumio[1065]: error: updateQueue error: null Jun 20 15:20:17 smsl-n100 volumio[1065]: info: CoreCommandRouter::servicePushState Jun 20 15:20:17 smsl-n100 volumio[1065]: info: CoreStateMachine::pushState Jun 20 15:20:17 smsl-n100 volumio[1065]: info: CorePlayQueue::getTrack 0 Jun 20 15:20:17 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumioPushState Jun 20 15:20:17 smsl-n100 volumio[1065]: info: MRS: Pushing multiroomSync output update for this device Jun 20 15:20:17 smsl-n100 volumio[1065]: info: MRS: Pushing multiroomSync output Jun 20 15:20:17 smsl-n100 volumio[1065]: info: CorePlayQueue::getTrack 0 Jun 20 15:20:17 smsl-n100 volumio[1065]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received tidalconnect Jun 20 15:20:17 smsl-n100 volumio[1065]: info: CoreCommandRouter::servicePushState Jun 20 15:20:17 smsl-n100 volumio[1065]: info: CoreStateMachine::pushState Jun 20 15:20:17 smsl-n100 volumio[1065]: info: CorePlayQueue::getTrack 0 Jun 20 15:20:17 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumioPushState Jun 20 15:20:17 smsl-n100 volumio[1065]: info: MRS: Pushing multiroomSync output update for this device Jun 20 15:20:17 smsl-n100 dbus-daemon[560]: [system] Successfully activated service 'org.freedesktop.hostname1' Jun 20 15:20:17 smsl-n100 volumio[1065]: info: MRS: Pushing multiroomSync output Jun 20 15:20:17 smsl-n100 systemd[1]: Started Hostname Service. Jun 20 15:20:17 smsl-n100 volumio[1065]: info: CorePlayQueue::getTrack 0 Jun 20 15:20:17 smsl-n100 volumio[1065]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received tidalconnect Jun 20 15:20:18 smsl-n100 volumio[1065]: info: TidalConnect service started! Jun 20 15:20:18 smsl-n100 volumio[1065]: info: Completed starting Core Plugins Jun 20 15:20:18 smsl-n100 volumio[1065]: info: ------------------------------------------- Jun 20 15:20:18 smsl-n100 volumio[1065]: info: ----- MyVolumio plugins startup ---- Jun 20 15:20:18 smsl-n100 volumio[1065]: info: ------------------------------------------- Jun 20 15:20:18 smsl-n100 volumio[1065]: info: [MyVolumio PluginManager] Fetching plans data.... Jun 20 15:20:20 smsl-n100 volumio[1322]: Generating RSA private key, 4096 bit long modulus (2 primes) Jun 20 15:20:21 smsl-n100 volumio[1065]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Jun 20 15:20:27 smsl-n100 volumio[1065]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jun 20 15:20:27 smsl-n100 volumio[1065]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jun 20 15:20:27 smsl-n100 volumio[1065]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jun 20 15:20:27 smsl-n100 volumio[1065]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jun 20 15:20:27 smsl-n100 volumio[1065]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jun 20 15:20:27 smsl-n100 volumio[1065]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jun 20 15:20:27 smsl-n100 volumio[1065]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jun 20 15:20:27 smsl-n100 volumio[1065]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jun 20 15:20:27 smsl-n100 volumio[1065]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jun 20 15:20:27 smsl-n100 volumio[1065]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jun 20 15:20:27 smsl-n100 volumio[1065]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Jun 20 15:20:27 smsl-n100 volumio[1065]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jun 20 15:20:27 smsl-n100 volumio[1065]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jun 20 15:20:27 smsl-n100 volumio[1065]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jun 20 15:20:27 smsl-n100 volumio[1065]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jun 20 15:20:27 smsl-n100 volumio[1065]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jun 20 15:20:27 smsl-n100 volumio[1065]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jun 20 15:20:27 smsl-n100 volumio[1065]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jun 20 15:20:27 smsl-n100 volumio[1065]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jun 20 15:20:27 smsl-n100 volumio[1065]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jun 20 15:20:27 smsl-n100 volumio[1065]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jun 20 15:20:27 smsl-n100 volumio[1065]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Jun 20 15:20:27 smsl-n100 volumio[1065]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jun 20 15:20:27 smsl-n100 volumio[1065]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jun 20 15:20:27 smsl-n100 volumio[1065]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jun 20 15:20:27 smsl-n100 volumio[1065]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jun 20 15:20:27 smsl-n100 volumio[1065]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jun 20 15:20:27 smsl-n100 volumio[1065]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jun 20 15:20:27 smsl-n100 volumio[1065]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jun 20 15:20:29 smsl-n100 volumio[1065]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jun 20 15:20:29 smsl-n100 volumio[1065]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jun 20 15:20:29 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 20 15:20:29 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 20 15:20:29 smsl-n100 volumio[1065]: info: Starting MyVolumio Remote Streaming Endpoints Jun 20 15:20:29 smsl-n100 volumio[1065]: info: MyVolumio login type: Token Jun 20 15:20:29 smsl-n100 volumio[1065]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jun 20 15:20:29 smsl-n100 volumio[1065]: error: [MyVolumio PluginManager] Could not read package.json file: Error: /myvolumio/plugins/music_service/streaming_services//package.json: ENOENT: no such file or directory, open '/myvolumio/plugins/music_service/streaming_services//package.json' Jun 20 15:20:30 smsl-n100 volumio[1065]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Jun 20 15:20:31 smsl-n100 volumio[1065]: info: MyVolumio token set successfully Jun 20 15:20:31 smsl-n100 volumio[1065]: info: MYVOLUMIO: Adding device Jun 20 15:20:31 smsl-n100 volumio[1065]: info: MYVOLUMIO: Evaluating Server Jun 20 15:20:32 smsl-n100 volumio[1065]: info: MyVolumio status changed Jun 20 15:20:32 smsl-n100 volumio[1065]: info: Streaming services startup Jun 20 15:20:32 smsl-n100 volumio[1065]: info: Starting Streaming Daemon Jun 20 15:20:32 smsl-n100 volumio[1065]: info: Removing browser output: myVolumio user plan is not superstar Jun 20 15:20:32 smsl-n100 volumio[1065]: info: Removing audio output: Jun 20 15:20:32 smsl-n100 volumio[1065]: info: Stoppping Tunnel 1 Jun 20 15:20:32 smsl-n100 sudo[1576]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jun 20 15:20:32 smsl-n100 sudo[1576]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 15:20:32 smsl-n100 sudo[1576]: pam_unix(sudo:session): session closed for user root Jun 20 15:20:32 smsl-n100 sudo[1579]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Jun 20 15:20:32 smsl-n100 sudo[1579]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 15:20:32 smsl-n100 volumio[1065]: error: Cannot start Volumio Streaming Daemon Jun 20 15:20:32 smsl-n100 volumio[1065]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jun 20 15:20:32 smsl-n100 volumio[1065]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jun 20 15:20:32 smsl-n100 volumio[1322]: ...............................................................................................................................................................++++ Jun 20 15:20:32 smsl-n100 sudo[1579]: pam_unix(sudo:session): session closed for user root Jun 20 15:20:32 smsl-n100 volumio[1065]: info: Remote SSH Stopped Jun 20 15:20:34 smsl-n100 volumio[1322]: .........................++++ Jun 20 15:20:34 smsl-n100 volumio[1322]: e is 65537 (0x010001) Jun 20 15:20:34 smsl-n100 volumio[1322]: writing RSA key Jun 20 15:20:34 smsl-n100 volumio[1065]: info: Setting Geolocation for MyVolumio to eu7 Jun 20 15:20:34 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 20 15:20:34 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 20 15:20:34 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 20 15:20:34 smsl-n100 volumio[1065]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Jun 20 15:20:35 smsl-n100 volumio[1065]: info: Updating MyVolumio device info Jun 20 15:20:35 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 20 15:20:35 smsl-n100 volumio[1065]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Jun 20 15:20:37 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 20 15:20:37 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 20 15:20:37 smsl-n100 volumio[1065]: info: Discovery: Getting this device information Jun 20 15:20:37 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumioGetState Jun 20 15:20:37 smsl-n100 volumio[1065]: info: CorePlayQueue::getTrack 0 Jun 20 15:20:37 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 20 15:20:37 smsl-n100 volumio[1065]: verbose: New Socket.io Connection to 192.168.40.219:3000 from 192.168.40.225 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 4 Jun 20 15:20:37 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumioGetState Jun 20 15:20:37 smsl-n100 volumio[1065]: info: CorePlayQueue::getTrack 0 Jun 20 15:20:37 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 20 15:20:37 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 20 15:20:38 smsl-n100 volumio[1065]: info: MYVOLUMIO: Adding device Jun 20 15:20:38 smsl-n100 volumio[1065]: info: MYVOLUMIO: Evaluating Server Jun 20 15:20:38 smsl-n100 volumio[1065]: error: MyVolumio Plugin failed to start in a timely fashion Jun 20 15:20:38 smsl-n100 volumio[1065]: [Metrics] CommandRouter: 63s 401.37ms Jun 20 15:20:38 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumiosetStartupVolume Jun 20 15:20:38 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:38 smsl-n100 volumio[1065]: info: VolumeController:: Setting startup Volume 100 Jun 20 15:20:38 smsl-n100 volumio[1065]: info: VolumeController::SetAlsaVolume100 Jun 20 15:20:38 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 20 15:20:38 smsl-n100 volumio[1065]: info: CoreCommandRouter::Close All Modals sent Jun 20 15:20:38 smsl-n100 volumio[1065]: info: CoreCommandRouter::Close All Modals sent Jun 20 15:20:38 smsl-n100 volumio[1065]: info: CoreStateMachine::pushState Jun 20 15:20:38 smsl-n100 volumio[1065]: info: CorePlayQueue::getTrack 0 Jun 20 15:20:38 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 15:20:38 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumioPushState Jun 20 15:20:38 smsl-n100 volumio[1065]: info: MRS: Pushing multiroomSync output update for this device Jun 20 15:20:38 smsl-n100 volumio[1065]: info: MRS: Pushing multiroomSync output Jun 20 15:20:39 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jun 20 15:20:39 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 20 15:20:40 smsl-n100 volumio[1065]: xcb_connection_has_error() returned true Jun 20 15:20:40 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jun 20 15:20:40 smsl-n100 volumio[1065]: info: Setting Geolocation for MyVolumio to eu6 Jun 20 15:20:40 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 20 15:20:40 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 20 15:20:40 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 20 15:20:41 smsl-n100 volumio[1065]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Jun 20 15:20:41 smsl-n100 volumio[1065]: info: Updating MyVolumio device info Jun 20 15:20:41 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 20 15:20:41 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 20 15:20:41 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 20 15:20:42 smsl-n100 volumio[1065]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Jun 20 15:20:42 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 20 15:20:42 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 20 15:20:42 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 20 15:20:42 smsl-n100 volumio-remote-updater[563]: No test mode Jun 20 15:20:42 smsl-n100 volumio-remote-updater[563]: No alpha test mode Jun 20 15:20:42 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jun 20 15:20:42 smsl-n100 volumio[1065]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Jun 20 15:20:42 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jun 20 15:20:43 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumioGetState Jun 20 15:20:43 smsl-n100 volumio[1065]: info: CorePlayQueue::getTrack 0 Jun 20 15:20:43 smsl-n100 volumio[1065]: verbose: New Socket.io Connection to 192.168.40.219:3000 from 192.168.40.225 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Jun 20 15:20:43 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumioGetState Jun 20 15:20:43 smsl-n100 volumio[1065]: info: CorePlayQueue::getTrack 0 Jun 20 15:20:44 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 20 15:20:44 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 20 15:20:44 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumioGetState Jun 20 15:20:44 smsl-n100 volumio[1065]: info: CorePlayQueue::getTrack 0 Jun 20 15:20:44 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 20 15:20:44 smsl-n100 volumio[1065]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Jun 20 15:20:44 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumioGetState Jun 20 15:20:44 smsl-n100 volumio[1065]: info: CorePlayQueue::getTrack 0 Jun 20 15:20:45 smsl-n100 sudo[1636]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 20 15:20:45 smsl-n100 sudo[1636]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 15:20:45 smsl-n100 sudo[1636]: pam_unix(sudo:session): session closed for user root Jun 20 15:20:45 smsl-n100 sudo[1638]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 15:20:45 smsl-n100 sudo[1638]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 15:20:45 smsl-n100 sudo[1638]: pam_unix(sudo:session): session closed for user root Jun 20 15:20:45 smsl-n100 volumio[1065]: verbose: New Socket.io Connection to 192.168.40.219 from 192.168.40.225 UA: Mozilla/5.0 (Linux; Android 12; 21091116UG Build/SP1A.210812.016; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/137.0.7151.89 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Jun 20 15:20:45 smsl-n100 volumio[1065]: info: BOOT COMPLETED Jun 20 15:20:46 smsl-n100 sudo[1642]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 20 15:20:46 smsl-n100 sudo[1642]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 15:20:46 smsl-n100 sudo[1642]: pam_unix(sudo:session): session closed for user root Jun 20 15:20:46 smsl-n100 sudo[1644]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 15:20:46 smsl-n100 sudo[1644]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 15:20:46 smsl-n100 sudo[1644]: pam_unix(sudo:session): session closed for user root Jun 20 15:20:46 smsl-n100 volumio[1065]: verbose: New Socket.io Connection to 192.168.40.219 from 192.168.40.225 UA: Mozilla/5.0 (Linux; Android 12; 21091116UG Build/SP1A.210812.016; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/137.0.7151.89 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Jun 20 15:20:46 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 20 15:20:46 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumioGetVisibleSources Jun 20 15:20:46 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 20 15:20:46 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumioGetState Jun 20 15:20:46 smsl-n100 volumio[1065]: info: CorePlayQueue::getTrack 0 Jun 20 15:20:46 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 20 15:20:46 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 20 15:20:46 smsl-n100 volumio[1065]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jun 20 15:20:46 smsl-n100 volumio[1065]: info: Received Get System Info Jun 20 15:20:46 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 20 15:20:46 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 20 15:20:46 smsl-n100 volumio[1065]: info: Discovery: Getting this device information Jun 20 15:20:46 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumioGetState Jun 20 15:20:46 smsl-n100 volumio[1065]: info: CorePlayQueue::getTrack 0 Jun 20 15:20:46 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 20 15:20:46 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumioGetState Jun 20 15:20:46 smsl-n100 volumio[1065]: info: CorePlayQueue::getTrack 0 Jun 20 15:20:47 smsl-n100 volumio[1065]: info: Listing playlists Jun 20 15:20:47 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 20 15:20:47 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 20 15:20:47 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jun 20 15:20:47 smsl-n100 systemd[1]: systemd-hostnamed.service: Succeeded. Jun 20 15:20:47 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:47 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:47 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:47 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:47 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:47 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:47 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:47 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:47 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 20 15:20:47 smsl-n100 volumio[1065]: info: Not Reporting Auto name since its the default one Jun 20 15:20:47 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jun 20 15:20:47 smsl-n100 volumio[1065]: xcb_connection_has_error() returned true Jun 20 15:20:48 smsl-n100 sudo[1659]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Jun 20 15:20:48 smsl-n100 sudo[1659]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 15:20:48 smsl-n100 sudo[1659]: pam_unix(sudo:session): session closed for user root Jun 20 15:20:48 smsl-n100 sudo[1661]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jun 20 15:20:48 smsl-n100 sudo[1661]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 15:20:48 smsl-n100 systemd[1]: Started RAAT DAEMON. Jun 20 15:20:48 smsl-n100 sudo[1661]: pam_unix(sudo:session): session closed for user root Jun 20 15:20:48 smsl-n100 volumio[1065]: info: Raat Daemon started successfully Jun 20 15:20:48 smsl-n100 volumio[1065]: info: Executing endpoint restartRAATSocket Jun 20 15:20:48 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jun 20 15:20:48 smsl-n100 volumio[1065]: info: CorePlayQueue::getTrack 0 Jun 20 15:20:48 smsl-n100 volumio[1065]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Jun 20 15:20:48 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 20 15:20:48 smsl-n100 volumio[1065]: info: Received Get System Info Jun 20 15:20:48 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 20 15:20:48 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 20 15:20:48 smsl-n100 volumio[1065]: info: Discovery: Getting this device information Jun 20 15:20:48 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumioGetState Jun 20 15:20:48 smsl-n100 volumio[1065]: info: CorePlayQueue::getTrack 0 Jun 20 15:20:48 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 20 15:20:48 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jun 20 15:20:49 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:49 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 15:20:49 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jun 20 15:20:49 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jun 20 15:20:49 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jun 20 15:20:49 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumioGetBrowseSources Jun 20 15:20:49 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 20 15:20:49 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 20 15:20:49 smsl-n100 volumio[1065]: info: Received Get System Info Jun 20 15:20:49 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 20 15:20:49 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 20 15:20:49 smsl-n100 volumio[1065]: info: Discovery: Getting this device information Jun 20 15:20:49 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumioGetState Jun 20 15:20:49 smsl-n100 volumio[1065]: info: CorePlayQueue::getTrack 0 Jun 20 15:20:49 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 20 15:20:50 smsl-n100 volumio[1065]: info: RAAT: Requesting Headphone Status Jun 20 15:20:51 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Jun 20 15:20:51 smsl-n100 volumio[1065]: info: CoreStateMachine::pushState Jun 20 15:20:51 smsl-n100 volumio[1065]: info: CorePlayQueue::getTrack 0 Jun 20 15:20:51 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 15:20:51 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumioPushState Jun 20 15:20:51 smsl-n100 volumio[1065]: info: MRS: Pushing multiroomSync output update for this device Jun 20 15:20:51 smsl-n100 volumio[1065]: info: MRS: Pushing multiroomSync output Jun 20 15:20:51 smsl-n100 volumio[1065]: error: Serial API: Failed to decode command: 100, message: undefined Jun 20 15:20:51 smsl-n100 volumio[1065]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 20 15:20:51 smsl-n100 volumio[1065]: error: Serial API: Failed to decode command: 100, message: undefined Jun 20 15:20:51 smsl-n100 volumio[1065]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 20 15:20:51 smsl-n100 volumio[1065]: info: VolumeController::SetAlsaVolume0 Jun 20 15:20:51 smsl-n100 volumio[1065]: info: CoreStateMachine::pushState Jun 20 15:20:51 smsl-n100 volumio[1065]: info: CorePlayQueue::getTrack 0 Jun 20 15:20:51 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 15:20:51 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumioPushState Jun 20 15:20:51 smsl-n100 volumio[1065]: info: MRS: Pushing multiroomSync output update for this device Jun 20 15:20:51 smsl-n100 volumio[1065]: info: MRS: Pushing multiroomSync output Jun 20 15:20:51 smsl-n100 volumio[1065]: info: Updating RAAT Signal Path Jun 20 15:20:56 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 20 15:20:56 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 20 15:20:56 smsl-n100 volumio[1065]: info: Discovery: Getting this device information Jun 20 15:20:56 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumioGetState Jun 20 15:20:56 smsl-n100 volumio[1065]: info: CorePlayQueue::getTrack 0 Jun 20 15:20:56 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 20 15:20:56 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 20 15:21:04 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 20 15:21:04 smsl-n100 volumio[1065]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jun 20 15:21:04 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jun 20 15:21:04 smsl-n100 volumio[1065]: info: Received Get System Version Jun 20 15:21:05 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 20 15:21:05 smsl-n100 volumio[1065]: info: Received Get System Info Jun 20 15:21:05 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 20 15:21:05 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 20 15:21:05 smsl-n100 volumio[1065]: info: Discovery: Getting this device information Jun 20 15:21:05 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumioGetState Jun 20 15:21:05 smsl-n100 volumio[1065]: info: CorePlayQueue::getTrack 0 Jun 20 15:21:05 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 20 15:21:26 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 20 15:21:26 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 20 15:21:26 smsl-n100 volumio[1065]: info: Discovery: Getting this device information Jun 20 15:21:26 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumioGetState Jun 20 15:21:26 smsl-n100 volumio[1065]: info: CorePlayQueue::getTrack 0 Jun 20 15:21:26 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 20 15:21:31 smsl-n100 dhcpcd[916]: eth0: carrier lost Jun 20 15:21:31 smsl-n100 kernel: rk_gmac-dwmac ff540000.ethernet eth0: Link is Down Jun 20 15:21:31 smsl-n100 dhcpcd[960]: eth0: carrier lost Jun 20 15:21:32 smsl-n100 ifplugd(eth0)[758]: Link beat lost. Jun 20 15:21:32 smsl-n100 avahi-daemon[553]: Withdrawing address record for 192.168.40.219 on eth0. Jun 20 15:21:32 smsl-n100 avahi-daemon[553]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.40.219. Jun 20 15:21:32 smsl-n100 avahi-daemon[553]: Interface eth0.IPv4 no longer relevant for mDNS. Jun 20 15:21:32 smsl-n100 dhcpcd[916]: eth0: deleting route to 192.168.40.0/24 Jun 20 15:21:32 smsl-n100 dhcpcd[916]: eth0: deleting default route via 192.168.40.1 Jun 20 15:21:32 smsl-n100 volumio[1065]: info: Discovery: A device disappeared from network Jun 20 15:21:32 smsl-n100 dhcpcd[960]: eth0: deleting route to 192.168.40.0/24 Jun 20 15:21:32 smsl-n100 dhcpcd[960]: eth0: deleting default route via 192.168.40.1 Jun 20 15:21:32 smsl-n100 volumio[1065]: info: Reporting MCU Network Status: 0 Jun 20 15:21:32 smsl-n100 volumio[1065]: info: Volumio Network Manager: Network status updated: 0 Jun 20 15:21:32 smsl-n100 volumio[1065]: error: Serial API: Failed to decode command: 0, message: undefined Jun 20 15:21:33 smsl-n100 nmbd[736]: [2025/06/20 15:21:33.532075, 0] ../source3/nmbd/nmbd.c:361(reload_interfaces) Jun 20 15:21:33 smsl-n100 nmbd[736]: reload_interfaces: No subnets to listen to. Waiting.. Jun 20 15:21:33 smsl-n100 kernel: rk_gmac-dwmac ff540000.ethernet eth0: Link is Up - 100Mbps/Full - flow control off Jun 20 15:21:33 smsl-n100 dhcpcd[916]: eth0: carrier acquired Jun 20 15:21:33 smsl-n100 dhcpcd[960]: eth0: carrier acquired Jun 20 15:21:33 smsl-n100 dhcpcd[916]: eth0: IAID d8:a0:49:60 Jun 20 15:21:33 smsl-n100 dhcpcd[960]: eth0: IAID d8:a0:49:60 Jun 20 15:21:33 smsl-n100 ifplugd(eth0)[758]: Link beat detected. Jun 20 15:21:34 smsl-n100 dhcpcd[960]: eth0: soliciting an IPv6 router Jun 20 15:21:34 smsl-n100 dhcpcd[916]: eth0: soliciting an IPv6 router Jun 20 15:21:34 smsl-n100 dhcpcd[960]: eth0: rebinding lease of 192.168.40.219 Jun 20 15:21:34 smsl-n100 dhcpcd[916]: eth0: rebinding lease of 192.168.40.219 Jun 20 15:21:35 smsl-n100 ntpd[959]: Deleting interface #3 eth0, 192.168.40.219#123, interface stats: received=110, sent=112, dropped=2, active_time=141 secs Jun 20 15:21:35 smsl-n100 ntpd[959]: 51.250.53.172 local addr 192.168.40.219 -> Jun 20 15:21:35 smsl-n100 ntpd[959]: 79.164.218.223 local addr 192.168.40.219 -> Jun 20 15:21:35 smsl-n100 ntpd[959]: 93.183.81.140 local addr 192.168.40.219 -> Jun 20 15:21:35 smsl-n100 ntpd[959]: 51.250.110.169 local addr 192.168.40.219 -> Jun 20 15:21:35 smsl-n100 ntpd[959]: 89.109.251.23 local addr 192.168.40.219 -> Jun 20 15:21:35 smsl-n100 ntpd[959]: 192.36.143.130 local addr 192.168.40.219 -> Jun 20 15:21:35 smsl-n100 ntpd[959]: 51.250.68.198 local addr 192.168.40.219 -> Jun 20 15:21:35 smsl-n100 ntpd[959]: 51.250.35.68 local addr 192.168.40.219 -> Jun 20 15:21:35 smsl-n100 ntpd[959]: 85.193.65.152 local addr 192.168.40.219 -> Jun 20 15:21:35 smsl-n100 ntpd[959]: 46.148.143.150 local addr 192.168.40.219 -> Jun 20 15:21:35 smsl-n100 ntpd[959]: 185.228.113.220 local addr 192.168.40.219 -> Jun 20 15:21:38 smsl-n100 dhcpcd[916]: eth0: probing address 192.168.40.219/24 Jun 20 15:21:38 smsl-n100 dhcpcd[960]: eth0: probing address 192.168.40.219/24 Jun 20 15:21:43 smsl-n100 dhcpcd[916]: eth0: leased 192.168.40.219 for 600 seconds Jun 20 15:21:43 smsl-n100 avahi-daemon[553]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.40.219. Jun 20 15:21:43 smsl-n100 avahi-daemon[553]: New relevant interface eth0.IPv4 for mDNS. Jun 20 15:21:43 smsl-n100 dhcpcd[916]: eth0: adding route to 192.168.40.0/24 Jun 20 15:21:43 smsl-n100 avahi-daemon[553]: Registering new address record for 192.168.40.219 on eth0.IPv4. Jun 20 15:21:43 smsl-n100 dhcpcd[916]: eth0: adding default route via 192.168.40.1 Jun 20 15:21:43 smsl-n100 volumio[1065]: info: Reporting MCU Network Status: 1 Jun 20 15:21:43 smsl-n100 volumio[1065]: info: Volumio Network Manager: Network status updated: 1 Jun 20 15:21:43 smsl-n100 volumio[1065]: info: CoreStateMachine::pushState Jun 20 15:21:43 smsl-n100 volumio[1065]: info: CorePlayQueue::getTrack 0 Jun 20 15:21:43 smsl-n100 volumio[1065]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 15:21:43 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumioPushState Jun 20 15:21:43 smsl-n100 volumio[1065]: info: MRS: Pushing multiroomSync output update for this device Jun 20 15:21:43 smsl-n100 volumio[1065]: info: MRS: Pushing multiroomSync output Jun 20 15:21:43 smsl-n100 volumio[1065]: error: Serial API: Failed to decode command: 100, message: undefined Jun 20 15:21:43 smsl-n100 volumio[1065]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 20 15:21:43 smsl-n100 volumio[1065]: error: Serial API: Failed to decode command: 100, message: undefined Jun 20 15:21:43 smsl-n100 volumio[1065]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 20 15:21:43 smsl-n100 volumio[1065]: error: Serial API: Failed to decode command: 1, message: undefined Jun 20 15:21:43 smsl-n100 ntpd[959]: ntpd exiting on signal 15 (Terminated) Jun 20 15:21:43 smsl-n100 systemd[1]: Stopping Network Time Service... Jun 20 15:21:43 smsl-n100 systemd[1]: ntp.service: Succeeded. Jun 20 15:21:43 smsl-n100 systemd[1]: Stopped Network Time Service. Jun 20 15:21:43 smsl-n100 volumio[1065]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 20 15:21:43 smsl-n100 volumio[1065]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 20 15:21:43 smsl-n100 systemd[1]: Starting Network Time Service... Jun 20 15:21:43 smsl-n100 volumio[1065]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 20 15:21:43 smsl-n100 ntpd[1900]: ntpd 4.2.8p12@1.3728-o (1): Starting Jun 20 15:21:43 smsl-n100 ntpd[1900]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Jun 20 15:21:43 smsl-n100 systemd[1]: Started Network Time Service. Jun 20 15:21:43 smsl-n100 ntpd[1906]: proto: precision = 1.166 usec (-20) Jun 20 15:21:43 smsl-n100 ntpd[1906]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Jun 20 15:21:43 smsl-n100 ntpd[1906]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Jun 20 15:21:43 smsl-n100 ntpd[1906]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 906 days ago Jun 20 15:21:43 smsl-n100 ntpd[1906]: Listen and drop on 0 v6wildcard [::]:123 Jun 20 15:21:43 smsl-n100 ntpd[1906]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Jun 20 15:21:43 smsl-n100 ntpd[1906]: Listen normally on 2 lo 127.0.0.1:123 Jun 20 15:21:43 smsl-n100 ntpd[1906]: Listen normally on 3 eth0 192.168.40.219:123 Jun 20 15:21:43 smsl-n100 ntpd[1906]: Listening on routing socket on fd #20 for interface updates Jun 20 15:21:43 smsl-n100 ntpd[1906]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Jun 20 15:21:43 smsl-n100 ntpd[1906]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Jun 20 15:21:44 smsl-n100 dhcpcd[960]: eth0: leased 192.168.40.219 for 600 seconds Jun 20 15:21:44 smsl-n100 dhcpcd[960]: eth0: adding route to 192.168.40.0/24 Jun 20 15:21:44 smsl-n100 dhcpcd[960]: eth0: adding default route via 192.168.40.1 Jun 20 15:21:44 smsl-n100 volumio[1065]: info: Discovery: adding 1df7577f-2dd9-4e13-90a4-2547ecf91573 Jun 20 15:21:44 smsl-n100 volumio[1065]: info: Discovery: Found device SMSL N100 Jun 20 15:21:44 smsl-n100 volumio[1065]: info: CoreCommandRouter::volumioGetState Jun 20 15:21:44 smsl-n100 volumio[1065]: info: CorePlayQueue::getTrack 0 Jun 20 15:21:44 smsl-n100 volumio[1065]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 20 15:21:44 smsl-n100 volumio[1065]: Error: The value NaN is not a number Jun 20 15:21:44 smsl-n100 volumio[1065]: at Config.forceToType (/volumio/node_modules/v-conf/index.js:322:20) Jun 20 15:21:44 smsl-n100 volumio[1065]: at Config.set (/volumio/node_modules/v-conf/index.js:153:25) Jun 20 15:21:44 smsl-n100 volumio[1065]: at ControllerVolumioDiscovery.updateMultiroomDevice (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:323:25) Jun 20 15:21:44 smsl-n100 volumio[1065]: at ControllerVolumioDiscovery.connectToRemoteVolumio (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:273:10) Jun 20 15:21:44 smsl-n100 volumio[1065]: at Browser. (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:192:12) Jun 20 15:21:44 smsl-n100 volumio[1065]: at Browser.emit (events.js:400:28) Jun 20 15:21:44 smsl-n100 volumio[1065]: at on_resolver_done (/volumio/node_modules/mdns/lib/browser.js:31:14) Jun 20 15:21:44 smsl-n100 volumio[1065]: at next (/volumio/node_modules/mdns/lib/browser.js:106:7) Jun 20 15:21:44 smsl-n100 volumio[1065]: at Array.makeAddressesUnique (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:177:5) Jun 20 15:21:44 smsl-n100 volumio[1065]: at next (/volumio/node_modules/mdns/lib/browser.js:109:21) Jun 20 15:21:44 smsl-n100 volumio[1065]: at /volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:160:11 Jun 20 15:21:44 smsl-n100 volumio[1065]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:108:7) Jun 20 15:21:44 smsl-n100 volumio[1065]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) Jun 20 15:21:44 smsl-n100 volumio[1065]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 20 15:21:44 smsl-n100 ntpd[1906]: ntpd exiting on signal 15 (Terminated) Jun 20 15:21:44 smsl-n100 systemd[1]: Stopping Network Time Service... Jun 20 15:21:44 smsl-n100 systemd[1]: ntp.service: Succeeded. Jun 20 15:21:44 smsl-n100 systemd[1]: Stopped Network Time Service. Jun 20 15:21:44 smsl-n100 systemd[1]: Starting Network Time Service... Jun 20 15:21:44 smsl-n100 ntpd[1946]: ntpd 4.2.8p12@1.3728-o (1): Starting Jun 20 15:21:44 smsl-n100 ntpd[1946]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Jun 20 15:21:44 smsl-n100 systemd[1]: Started Network Time Service. Jun 20 15:21:44 smsl-n100 ntpd[1952]: proto: precision = 1.166 usec (-20) Jun 20 15:21:44 smsl-n100 ntpd[1952]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Jun 20 15:21:44 smsl-n100 ntpd[1952]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Jun 20 15:21:44 smsl-n100 ntpd[1952]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 906 days ago Jun 20 15:21:44 smsl-n100 ntpd[1952]: Listen and drop on 0 v6wildcard [::]:123 Jun 20 15:21:44 smsl-n100 ntpd[1952]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Jun 20 15:21:44 smsl-n100 ntpd[1952]: Listen normally on 2 lo 127.0.0.1:123 Jun 20 15:21:44 smsl-n100 ntpd[1952]: Listen normally on 3 eth0 192.168.40.219:123 Jun 20 15:21:44 smsl-n100 ntpd[1952]: Listening on routing socket on fd #20 for interface updates Jun 20 15:21:44 smsl-n100 ntpd[1952]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Jun 20 15:21:44 smsl-n100 ntpd[1952]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Jun 20 15:21:45 smsl-n100 sudo[1956]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-20 15:20 Jun 20 15:21:45 smsl-n100 sudo[1956]: 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"