-- Logs begin at Fri 2025-02-21 23:43:57 CST, end at Sun 2025-02-23 23:36:30 CST. -- Feb 23 23:35:00 smsl-n100 volumio[956]: info: Reloading queue from file Feb 23 23:35:00 smsl-n100 volumio[956]: info: CoreStateMachine::setRepeat null single undefined Feb 23 23:35:00 smsl-n100 volumio[956]: info: CoreStateMachine::pushState Feb 23 23:35:00 smsl-n100 volumio[956]: info: CorePlayQueue::getTrack 0 Feb 23 23:35:00 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 23:35:00 smsl-n100 volumio[956]: info: CoreCommandRouter::volumioPushState Feb 23 23:35:00 smsl-n100 volumio[956]: info: CoreStateMachine::setRandom null Feb 23 23:35:00 smsl-n100 volumio[956]: info: CoreStateMachine::pushState Feb 23 23:35:00 smsl-n100 volumio[956]: info: CorePlayQueue::getTrack 0 Feb 23 23:35:00 smsl-n100 volumio[956]: info: CoreCommandRouter::volumioPushState Feb 23 23:35:00 smsl-n100 volumio[956]: info: Setting Device type: NanoPi NEO 3 Feb 23 23:35:00 smsl-n100 volumio[956]: info: Asound.conf file unchanged, so no further update is needed Feb 23 23:35:00 smsl-n100 volumio[956]: info: Output device has changed, restarting MPD Feb 23 23:35:00 smsl-n100 sudo[1326]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Feb 23 23:35:00 smsl-n100 sudo[1326]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 23:35:00 smsl-n100 systemd[1]: Started UPnP Renderer front-end to MPD. Feb 23 23:35:00 smsl-n100 sudo[1329]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 23 23:35:00 smsl-n100 sudo[1329]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 23:35:00 smsl-n100 volumio[956]: info: Output device has changed, restarting Shairport Sync Feb 23 23:35:00 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:35:00 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 23:35:00 smsl-n100 sudo[1329]: pam_unix(sudo:session): session closed for user root Feb 23 23:35:00 smsl-n100 sudo[1326]: pam_unix(sudo:session): session closed for user root Feb 23 23:35:00 smsl-n100 sudo[1333]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 23 23:35:00 smsl-n100 sudo[1333]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 23:35:00 smsl-n100 systemd[1]: Stopping Music Player Daemon... Feb 23 23:35:00 smsl-n100 volumio[956]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 23 23:35:00 smsl-n100 volumio[956]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Feb 23 23:35:00 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:35:00 smsl-n100 volumio[956]: info: ___________ START PLUGINS ___________ Feb 23 23:35:00 smsl-n100 volumio[956]: info: ControllerMpd::onStart: Initializing MPD Feb 23 23:35:00 smsl-n100 volumio[956]: info: Creating MPD Configuration file Feb 23 23:35:00 smsl-n100 sudo[1341]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 23 23:35:00 smsl-n100 sudo[1341]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 23:35:00 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 23:35:00 smsl-n100 volumio[956]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 23 23:35:00 smsl-n100 sudo[1341]: pam_unix(sudo:session): session closed for user root Feb 23 23:35:00 smsl-n100 volumio[956]: info: [1740324900704] CoreMusicLibrary::Adding element 媒体服务器 Feb 23 23:35:00 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 23 23:35:00 smsl-n100 sudo[1343]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 23 23:35:00 smsl-n100 sudo[1343]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 23:35:00 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 23 23:35:00 smsl-n100 systemd[1]: mpd.service: Succeeded. Feb 23 23:35:00 smsl-n100 systemd[1]: Stopped Music Player Daemon. Feb 23 23:35:00 smsl-n100 systemd[1]: Starting Music Player Daemon... Feb 23 23:35:00 smsl-n100 systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Feb 23 23:35:00 smsl-n100 systemd[1]: mpd.service: Succeeded. Feb 23 23:35:00 smsl-n100 systemd[1]: Stopped Music Player Daemon. Feb 23 23:35:00 smsl-n100 volumio[956]: info: Adding METAVOLUMIO REST API Endpoints Feb 23 23:35:00 smsl-n100 volumio[956]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Feb 23 23:35:00 smsl-n100 volumio[956]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Feb 23 23:35:00 smsl-n100 volumio[956]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Feb 23 23:35:00 smsl-n100 systemd[1]: Starting Music Player Daemon... Feb 23 23:35:00 smsl-n100 volumio[956]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Feb 23 23:35:00 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:35:00 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 23:35:00 smsl-n100 sudo[1348]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name SMSL N100 Feb 23 23:35:00 smsl-n100 sudo[1348]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 23:35:00 smsl-n100 sudo[1348]: pam_unix(sudo:session): session closed for user root Feb 23 23:35:00 smsl-n100 volumio[956]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 23 23:35:00 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:35:00 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 23:35:01 smsl-n100 sudo[1349]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 23 23:35:01 smsl-n100 sudo[1349]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 23:35:01 smsl-n100 sudo[1349]: pam_unix(sudo:session): session closed for user root Feb 23 23:35:01 smsl-n100 volumio[956]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 23 23:35:01 smsl-n100 volumio[956]: info: Preparing CD Folders Feb 23 23:35:01 smsl-n100 volumio[956]: info: Adding CD REST API Endpoints Feb 23 23:35:01 smsl-n100 volumio[956]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Feb 23 23:35:01 smsl-n100 volumio[956]: info: Starting UDEV Watcher for CD Feb 23 23:35:01 smsl-n100 volumio[956]: info: Detecting CD presence with UDEV Feb 23 23:35:01 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Feb 23 23:35:01 smsl-n100 volumio[956]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 23 23:35:01 smsl-n100 volumio[956]: info: [1740324901106] CoreMusicLibrary::Adding element Last_100 Feb 23 23:35:01 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 23 23:35:01 smsl-n100 volumio[956]: info: Starting RAAT Plugin Feb 23 23:35:01 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Feb 23 23:35:01 smsl-n100 volumio[956]: info: Additional UI Settings Added for plugin music_service/raat Feb 23 23:35:01 smsl-n100 volumio[956]: info: Registering DSP Elements listener and retrieving current ones Feb 23 23:35:01 smsl-n100 volumio[956]: info: Additional DSP elements updated Feb 23 23:35:01 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:35:01 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:35:01 smsl-n100 volumio[956]: info: Updating RAAT Signal Path Feb 23 23:35:01 smsl-n100 volumio[956]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Feb 23 23:35:01 smsl-n100 volumio[956]: info: Streaming services startup Feb 23 23:35:01 smsl-n100 volumio[956]: info: Starting Streaming Daemon Feb 23 23:35:01 smsl-n100 sudo[1362]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Feb 23 23:35:01 smsl-n100 sudo[1362]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 23:35:01 smsl-n100 sudo[1362]: pam_unix(sudo:session): session closed for user root Feb 23 23:35:01 smsl-n100 volumio[956]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 23 23:35:01 smsl-n100 volumio[956]: info: [1740324901369] CoreMusicLibrary::Adding element Webradio Feb 23 23:35:01 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 23 23:35:01 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 23 23:35:01 smsl-n100 volumio[956]: info: Initializing BBC Radios Feb 23 23:35:01 smsl-n100 sudo[1369]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 23 23:35:01 smsl-n100 sudo[1369]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 23:35:01 smsl-n100 sudo[1369]: pam_unix(sudo:session): session closed for user root Feb 23 23:35:01 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 23 23:35:01 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 23:35:01 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Feb 23 23:35:01 smsl-n100 volumio[956]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Feb 23 23:35:01 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:35:01 smsl-n100 volumio[956]: error: Hi Res Audio Failed Login: Missing Login Data Feb 23 23:35:01 smsl-n100 volumio[956]: info: Adding HIGHRESAUDIO REST API Endpoints Feb 23 23:35:01 smsl-n100 volumio[956]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Feb 23 23:35:01 smsl-n100 volumio[956]: info: Initializing Serial Communication on port /dev/ttyS1 Feb 23 23:35:01 smsl-n100 volumio[956]: info: Touch Event Listener Process Starting Feb 23 23:35:01 smsl-n100 volumio[956]: info: Refreshing QOBUZ token Feb 23 23:35:01 smsl-n100 sudo[1400]: pam_unix(sudo:auth): conversation failed Feb 23 23:35:01 smsl-n100 sudo[1400]: pam_unix(sudo:auth): auth could not identify password for [volumio] Feb 23 23:35:01 smsl-n100 volumio[956]: info: Adding inputs REST Endpoints Feb 23 23:35:01 smsl-n100 volumio[956]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Feb 23 23:35:01 smsl-n100 volumio[956]: info: Scanning Audio Inputs Feb 23 23:35:01 smsl-n100 volumio[956]: info: Checking against Known Cards name Feb 23 23:35:01 smsl-n100 volumio[956]: info: Adding Server instance for streaming Feb 23 23:35:02 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 23 23:35:02 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 23:35:02 smsl-n100 volumio[956]: info: Initializing GPIOs Feb 23 23:35:02 smsl-n100 kernel: gpio gpiochip3: Persistence not supported for GPIO 1 Feb 23 23:35:02 smsl-n100 kernel: gpio gpiochip2: Persistence not supported for GPIO 15 Feb 23 23:35:02 smsl-n100 kernel: gpio gpiochip3: Persistence not supported for GPIO 0 Feb 23 23:35:02 smsl-n100 kernel: gpio gpiochip2: Persistence not supported for GPIO 2 Feb 23 23:35:02 smsl-n100 volumio[956]: info: Starting Button Listener Feb 23 23:35:02 smsl-n100 volumio[956]: info: Turning off Green LED Feb 23 23:35:02 smsl-n100 volumio[956]: info: Tuning on Blue LED Feb 23 23:35:02 smsl-n100 volumio[956]: info: Signaling System Ready Feb 23 23:35:02 smsl-n100 volumio[956]: info: Volumio Calling Home Feb 23 23:35:02 smsl-n100 volumio[956]: (node:956) [DEP0005] DeprecationWarning: Buffer() is deprecated due to security and usability issues. Please use the Buffer.alloc(), Buffer.allocUnsafe(), or Buffer.from() methods instead. Feb 23 23:35:02 smsl-n100 volumio[956]: (Use `node --trace-deprecation ...` to show where the warning was created) Feb 23 23:35:02 smsl-n100 volumio[956]: info: Stopping AccessToken refresher cron Feb 23 23:35:02 smsl-n100 volumio[956]: info: AccessToken refresher cron started Feb 23 23:35:02 smsl-n100 volumio[956]: info: Adding TIDAL REST API Endpoints Feb 23 23:35:02 smsl-n100 volumio[956]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Feb 23 23:35:02 smsl-n100 volumio[956]: info: Discovery: adding 8ff320e5-ba40-4f99-8d40-e51473ce7e45 Feb 23 23:35:02 smsl-n100 volumio[956]: info: Discovery: Found device SMSL N100 Feb 23 23:35:02 smsl-n100 volumio[956]: info: CoreCommandRouter::volumioGetState Feb 23 23:35:02 smsl-n100 volumio[956]: info: CorePlayQueue::getTrack 0 Feb 23 23:35:02 smsl-n100 volumio[956]: info: MRS: Pushing multiroomSync output for this device Feb 23 23:35:02 smsl-n100 volumio[956]: info: MRS: Pushing multiroomSync output Feb 23 23:35:02 smsl-n100 volumio[956]: info: Adding audio output: Feb 23 23:35:02 smsl-n100 volumio[956]: info: Adding audio output: Feb 23 23:35:02 smsl-n100 volumio[956]: info: Serial port opened successfully Feb 23 23:35:02 smsl-n100 volumio[956]: info: Sending serial start messages Feb 23 23:35:02 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:35:02 smsl-n100 volumio[956]: info: Reporting MCU Network Status: 2 Feb 23 23:35:03 smsl-n100 volumio-remote-updater[539]: [2025-02-23 23:35:03] [connect] Successful connection Feb 23 23:35:03 smsl-n100 volumio[956]: info: Touch Event Listener Process Closed Feb 23 23:35:03 smsl-n100 volumio[956]: error: Cannot start Volumio Streaming Daemon Feb 23 23:35:03 smsl-n100 volumio[956]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Feb 23 23:35:03 smsl-n100 volumio[956]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Feb 23 23:35:03 smsl-n100 volumio[956]: info: RAAT Albumart path created successfully Feb 23 23:35:03 smsl-n100 volumio[956]: error: Cannot set new Bluetooth Name : Error: Command failed: /usr/bin/sudo /bin/hciconfig hci0 name 'SMSL N100' Feb 23 23:35:03 smsl-n100 volumio[956]: Can't get device info: No such device Feb 23 23:35:03 smsl-n100 volumio[956]: info: MPD Permissions set Feb 23 23:35:03 smsl-n100 volumio[956]: info: MPD Permissions set Feb 23 23:35:03 smsl-n100 volumio[956]: info: Upmpdcli Daemon Started Feb 23 23:35:03 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setDeviceVolumeOverride Feb 23 23:35:03 smsl-n100 volumio[956]: info: Setting Device Volume Override Feb 23 23:35:03 smsl-n100 volumio[956]: info: CoreCommandRouter::volumioUpdateVolumeSettings Feb 23 23:35:03 smsl-n100 volumio[956]: info: Updating Volume Controller Parameters: Device: 1 Name: SPDIF Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Feb 23 23:35:03 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Feb 23 23:35:03 smsl-n100 volumio[956]: info: Disabling external Volume Control Feb 23 23:35:03 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:35:03 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:35:03 smsl-n100 volumio[956]: info: CoreStateMachine::pushState Feb 23 23:35:03 smsl-n100 volumio[956]: info: CorePlayQueue::getTrack 0 Feb 23 23:35:03 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 23:35:03 smsl-n100 volumio[956]: info: CoreCommandRouter::volumioPushState Feb 23 23:35:03 smsl-n100 volumio[956]: info: MRS: Pushing multiroomSync output update for this device Feb 23 23:35:03 smsl-n100 volumio[956]: info: MRS: Pushing multiroomSync output Feb 23 23:35:03 smsl-n100 volumio[956]: error: Serial API: Failed to decode command: 100, message: undefined Feb 23 23:35:03 smsl-n100 volumio[956]: error: Serial API: Failed to decode command: MAXVOL, message: Feb 23 23:35:03 smsl-n100 volumio[956]: error: Serial API: Failed to decode command: 100, message: undefined Feb 23 23:35:03 smsl-n100 volumio[956]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Feb 23 23:35:03 smsl-n100 volumio[956]: info: CoreStateMachine::pushState Feb 23 23:35:03 smsl-n100 volumio[956]: info: CorePlayQueue::getTrack 0 Feb 23 23:35:03 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 23:35:03 smsl-n100 volumio[956]: info: CoreCommandRouter::volumioPushState Feb 23 23:35:03 smsl-n100 volumio[956]: info: MRS: Pushing multiroomSync output update for this device Feb 23 23:35:03 smsl-n100 volumio[956]: info: MRS: Pushing multiroomSync output Feb 23 23:35:03 smsl-n100 volumio[956]: info: CoreStateMachine::pushState Feb 23 23:35:03 smsl-n100 volumio[956]: info: CorePlayQueue::getTrack 0 Feb 23 23:35:03 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 23:35:03 smsl-n100 volumio[956]: info: CoreCommandRouter::volumioPushState Feb 23 23:35:03 smsl-n100 volumio[956]: info: MRS: Pushing multiroomSync output update for this device Feb 23 23:35:03 smsl-n100 volumio[956]: info: MRS: Pushing multiroomSync output Feb 23 23:35:03 smsl-n100 volumio[956]: error: Serial API: Failed to decode command: 100, message: undefined Feb 23 23:35:03 smsl-n100 volumio[956]: error: Serial API: Failed to decode command: MAXVOL, message: Feb 23 23:35:03 smsl-n100 volumio[956]: error: Serial API: Failed to decode command: 100, message: undefined Feb 23 23:35:03 smsl-n100 volumio[956]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Feb 23 23:35:03 smsl-n100 volumio[956]: info: CoreStateMachine::pushState Feb 23 23:35:03 smsl-n100 volumio[956]: info: CorePlayQueue::getTrack 0 Feb 23 23:35:03 smsl-n100 volumio[956]: info: CoreCommandRouter::volumioPushState Feb 23 23:35:03 smsl-n100 volumio[956]: info: MRS: Pushing multiroomSync output update for this device Feb 23 23:35:03 smsl-n100 volumio[956]: info: MRS: Pushing multiroomSync output Feb 23 23:35:03 smsl-n100 volumio[956]: error: Serial API: Failed to decode command: 100, message: undefined Feb 23 23:35:03 smsl-n100 volumio[956]: error: Serial API: Failed to decode command: MAXVOL, message: Feb 23 23:35:03 smsl-n100 volumio[956]: error: Serial API: Failed to decode command: 100, message: undefined Feb 23 23:35:03 smsl-n100 volumio[956]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Feb 23 23:35:03 smsl-n100 volumio[956]: error: Serial API: Failed to decode command: 2, message: undefined Feb 23 23:35:03 smsl-n100 volumio[956]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Feb 23 23:35:03 smsl-n100 volumio-remote-updater[539]: [2025-02-23 23:35:03] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1740324902 101 Feb 23 23:35:03 smsl-n100 volumio[956]: 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: 2 Feb 23 23:35:03 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:35:03 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:35:03 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:35:03 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:35:03 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:35:03 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:35:03 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:35:03 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:35:03 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 23:35:03 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 23 23:35:03 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:35:03 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:35:03 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:35:03 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:35:03 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:35:03 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:35:03 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:35:03 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:35:03 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:35:03 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 23:35:03 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 23 23:35:03 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:35:03 smsl-n100 volumio[956]: info: CoreStateMachine::pushState Feb 23 23:35:03 smsl-n100 volumio[956]: info: CorePlayQueue::getTrack 0 Feb 23 23:35:03 smsl-n100 volumio[956]: info: CoreCommandRouter::volumioPushState Feb 23 23:35:03 smsl-n100 volumio[956]: info: MRS: Pushing multiroomSync output update for this device Feb 23 23:35:03 smsl-n100 volumio[956]: info: MRS: Pushing multiroomSync output Feb 23 23:35:03 smsl-n100 volumio[956]: error: Serial API: Failed to decode command: 100, message: undefined Feb 23 23:35:03 smsl-n100 volumio[956]: error: Serial API: Failed to decode command: MAXVOL, message: Feb 23 23:35:03 smsl-n100 volumio[956]: error: Serial API: Failed to decode command: 100, message: undefined Feb 23 23:35:03 smsl-n100 volumio[956]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Feb 23 23:35:04 smsl-n100 sudo[1444]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Feb 23 23:35:04 smsl-n100 sudo[1444]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 23:35:04 smsl-n100 systemd[1]: Started Volumio Bluetooth Module. Feb 23 23:35:04 smsl-n100 volumio[956]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Feb 23 23:35:04 smsl-n100 volumio[956]: info: Volumio called home Feb 23 23:35:04 smsl-n100 sudo[1444]: pam_unix(sudo:session): session closed for user root Feb 23 23:35:04 smsl-n100 sudo[1447]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* Feb 23 23:35:04 smsl-n100 sudo[1447]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 23:35:04 smsl-n100 volumiobt[1446]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory Feb 23 23:35:04 smsl-n100 sudo[1447]: pam_unix(sudo:session): session closed for user root Feb 23 23:35:04 smsl-n100 volumio[956]: info: Starting Shairport Sync Feb 23 23:35:04 smsl-n100 volumio[956]: info: Starting Shairport Sync Feb 23 23:35:04 smsl-n100 sudo[1451]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 23 23:35:04 smsl-n100 sudo[1451]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 23:35:04 smsl-n100 volumio[956]: info: Starting Shairport Sync Feb 23 23:35:04 smsl-n100 sudo[1453]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 23 23:35:04 smsl-n100 sudo[1453]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 23:35:04 smsl-n100 volumio[956]: info: CoreStateMachine::pushState Feb 23 23:35:04 smsl-n100 volumio[956]: info: CorePlayQueue::getTrack 0 Feb 23 23:35:04 smsl-n100 volumio[956]: info: CoreCommandRouter::volumioPushState Feb 23 23:35:04 smsl-n100 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 23 23:35:04 smsl-n100 volumio[956]: info: MRS: Pushing multiroomSync output update for this device Feb 23 23:35:04 smsl-n100 systemd[1]: shairport-sync.service: Succeeded. Feb 23 23:35:04 smsl-n100 volumio[956]: info: MRS: Pushing multiroomSync output Feb 23 23:35:04 smsl-n100 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 23 23:35:04 smsl-n100 volumio[956]: error: Serial API: Failed to decode command: 100, message: undefined Feb 23 23:35:04 smsl-n100 volumio[956]: error: Serial API: Failed to decode command: MAXVOL, message: Feb 23 23:35:04 smsl-n100 volumio[956]: error: Serial API: Failed to decode command: 100, message: undefined Feb 23 23:35:04 smsl-n100 volumio[956]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Feb 23 23:35:04 smsl-n100 volumio[956]: info: CoreStateMachine::pushState Feb 23 23:35:04 smsl-n100 volumio[956]: info: CorePlayQueue::getTrack 0 Feb 23 23:35:04 smsl-n100 volumio[956]: info: CoreCommandRouter::volumioPushState Feb 23 23:35:04 smsl-n100 sudo[1457]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 23 23:35:04 smsl-n100 sudo[1457]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 23:35:04 smsl-n100 volumio[956]: info: MRS: Pushing multiroomSync output update for this device Feb 23 23:35:04 smsl-n100 volumio[956]: info: MRS: Pushing multiroomSync output Feb 23 23:35:04 smsl-n100 volumio[956]: error: Serial API: Failed to decode command: 100, message: undefined Feb 23 23:35:04 smsl-n100 volumio[956]: error: Serial API: Failed to decode command: MAXVOL, message: Feb 23 23:35:04 smsl-n100 volumio[956]: error: Serial API: Failed to decode command: 100, message: undefined Feb 23 23:35:04 smsl-n100 volumio[956]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Feb 23 23:35:04 smsl-n100 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 23 23:35:04 smsl-n100 sudo[1451]: pam_unix(sudo:session): session closed for user root Feb 23 23:35:04 smsl-n100 sudo[1453]: pam_unix(sudo:session): session closed for user root Feb 23 23:35:04 smsl-n100 volumio[956]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 23 23:35:04 smsl-n100 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 23 23:35:04 smsl-n100 volumio[956]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 23 23:35:04 smsl-n100 volumio[956]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 23 23:35:04 smsl-n100 systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Feb 23 23:35:04 smsl-n100 systemd[1]: shairport-sync.service: Succeeded. Feb 23 23:35:04 smsl-n100 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 23 23:35:04 smsl-n100 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 23 23:35:04 smsl-n100 sudo[1457]: pam_unix(sudo:session): session closed for user root Feb 23 23:35:04 smsl-n100 volumio[956]: info: CoreCommandRouter::volumioGetState Feb 23 23:35:04 smsl-n100 volumio[956]: info: CorePlayQueue::getTrack 0 Feb 23 23:35:04 smsl-n100 volumio[956]: info: Volumio BT Module successfully started Feb 23 23:35:04 smsl-n100 volumio[956]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 23 23:35:04 smsl-n100 volumio[956]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 23 23:35:05 smsl-n100 volumio[956]: info: Access Token successfully retrieved Feb 23 23:35:05 smsl-n100 volumio[956]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 23 23:35:05 smsl-n100 volumio[956]: info: [1740324905033] CoreMusicLibrary::Adding element QOBUZ Feb 23 23:35:05 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 23 23:35:05 smsl-n100 volumio[956]: Cannot find translation for source QOBUZ Feb 23 23:35:05 smsl-n100 volumio[956]: info: Stopping AccessToken refresher cron for QOBUZ Feb 23 23:35:05 smsl-n100 volumio[956]: info: AccessToken refresher cron started for QOBUZ Feb 23 23:35:05 smsl-n100 volumio[956]: info: Adding QOBUZ REST API Endpoints Feb 23 23:35:05 smsl-n100 volumio[956]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Feb 23 23:35:05 smsl-n100 volumio[956]: info: Shairport-Sync Started Feb 23 23:35:05 smsl-n100 sudo[1464]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio Feb 23 23:35:05 smsl-n100 sudo[1464]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 23:35:05 smsl-n100 volumio[956]: Error adding Membership: Error: addMembership EINVAL Feb 23 23:35:05 smsl-n100 volumio[956]: info: Shairport-Sync Started Feb 23 23:35:05 smsl-n100 volumio[956]: info: Shairport-Sync Started Feb 23 23:35:05 smsl-n100 volumio[956]: info: TidalConnect service stoped! Feb 23 23:35:05 smsl-n100 volumiobt[1446]: pulseaudio: no process found Feb 23 23:35:05 smsl-n100 sudo[1464]: pam_unix(sudo:session): session closed for user root Feb 23 23:35:05 smsl-n100 volumio[956]: info: CoreCommandRouter::volumioGetState Feb 23 23:35:05 smsl-n100 volumio[956]: info: CorePlayQueue::getTrack 0 Feb 23 23:35:05 smsl-n100 dbus-daemon[576]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.15' (uid=1000 pid=1472 comm="/usr/bin/pulseaudio --high-priority=true ") Feb 23 23:35:05 smsl-n100 systemd[1]: Starting RealtimeKit Scheduling Policy Service... Feb 23 23:35:05 smsl-n100 dbus-daemon[576]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' Feb 23 23:35:05 smsl-n100 systemd[1]: Started RealtimeKit Scheduling Policy Service. Feb 23 23:35:05 smsl-n100 rtkit-daemon[1473]: Successfully called chroot. Feb 23 23:35:05 smsl-n100 rtkit-daemon[1473]: Successfully dropped privileges. Feb 23 23:35:05 smsl-n100 rtkit-daemon[1473]: Successfully limited resources. Feb 23 23:35:05 smsl-n100 rtkit-daemon[1473]: Running. Feb 23 23:35:05 smsl-n100 rtkit-daemon[1473]: Watchdog thread running. Feb 23 23:35:05 smsl-n100 dbus-daemon[576]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.16' (uid=0 pid=1473 comm="/usr/lib/rtkit/rtkit-daemon ") Feb 23 23:35:05 smsl-n100 rtkit-daemon[1473]: Canary thread running. Feb 23 23:35:05 smsl-n100 systemd[1]: Starting Authorization Manager... Feb 23 23:35:05 smsl-n100 volumio[956]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 23 23:35:05 smsl-n100 volumio[956]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 23 23:35:05 smsl-n100 polkitd[1476]: started daemon version 0.105 using authority implementation `local' version `0.105' Feb 23 23:35:05 smsl-n100 dbus-daemon[576]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Feb 23 23:35:05 smsl-n100 systemd[1]: Started Authorization Manager. Feb 23 23:35:05 smsl-n100 volumio[956]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Feb 23 23:35:05 smsl-n100 volumio[956]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect Feb 23 23:35:05 smsl-n100 volumio[956]: info: CoreStateMachine::pushState Feb 23 23:35:05 smsl-n100 volumio[956]: info: CorePlayQueue::getTrack 0 Feb 23 23:35:05 smsl-n100 volumio[956]: info: CoreCommandRouter::volumioPushState Feb 23 23:35:05 smsl-n100 volumio[956]: info: MRS: Pushing multiroomSync output update for this device Feb 23 23:35:05 smsl-n100 volumio[956]: info: MRS: Pushing multiroomSync output Feb 23 23:35:05 smsl-n100 volumio[956]: error: Help! Some callbacks for volumioPushState are crashing! Feb 23 23:35:05 smsl-n100 volumio[956]: error: Cannot read property 'sendVolumeMute' of undefined Feb 23 23:35:05 smsl-n100 volumio[956]: error: Serial API: Failed to decode command: 100, message: undefined Feb 23 23:35:05 smsl-n100 volumio[956]: error: Serial API: Failed to decode command: MAXVOL, message: Feb 23 23:35:05 smsl-n100 volumio[956]: error: Serial API: Failed to decode command: 100, message: undefined Feb 23 23:35:05 smsl-n100 volumio[956]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Feb 23 23:35:05 smsl-n100 sudo[1485]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Feb 23 23:35:05 smsl-n100 sudo[1485]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 23:35:06 smsl-n100 systemd[1]: Started Volumio Tidal Connect Service. Feb 23 23:35:06 smsl-n100 sudo[1485]: pam_unix(sudo:session): session closed for user root Feb 23 23:35:06 smsl-n100 mpd[1358]: Feb 23 23:35 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 23 23:35:06 smsl-n100 systemd[1]: Started Music Player Daemon. Feb 23 23:35:06 smsl-n100 sudo[1343]: pam_unix(sudo:session): session closed for user root Feb 23 23:35:06 smsl-n100 sudo[1333]: pam_unix(sudo:session): session closed for user root Feb 23 23:35:06 smsl-n100 volumio[956]: Upnp client error: Error: This socket has been ended by the other party Feb 23 23:35:06 smsl-n100 volumio[956]: error: MPD error: The expression evaluated to a falsy value: Feb 23 23:35:06 smsl-n100 volumio[956]: assert.ok(self.idling) Feb 23 23:35:06 smsl-n100 volumio[956]: error: The expression evaluated to a falsy value: Feb 23 23:35:06 smsl-n100 volumio[956]: assert.ok(self.idling) Feb 23 23:35:06 smsl-n100 volumio[956]: error: updateQueue error: null Feb 23 23:35:06 smsl-n100 dbus-daemon[576]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.36' (uid=1000 pid=1472 comm="/usr/bin/pulseaudio --high-priority=true ") Feb 23 23:35:06 smsl-n100 volumio[956]: info: MPD running with PID1358 Feb 23 23:35:06 smsl-n100 volumio[956]: ,establishing connection Feb 23 23:35:06 smsl-n100 volumio[956]: info: MRS: Getting audio outputs on start Feb 23 23:35:06 smsl-n100 systemd[1]: Starting Bluetooth service... Feb 23 23:35:06 smsl-n100 volumio[956]: info: MRS: Requesting all other devices output Feb 23 23:35:06 smsl-n100 volumio[956]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 23 23:35:06 smsl-n100 volumio[956]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Feb 23 23:35:06 smsl-n100 volumio[956]: error: updateQueue error: null Feb 23 23:35:06 smsl-n100 pulseaudio[1472]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Feb 23 23:35:06 smsl-n100 pulseaudio[1472]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Feb 23 23:35:06 smsl-n100 volumiobt[1446]: Applying permissions Feb 23 23:35:06 smsl-n100 volumiobt[1446]: Setting BT discoverable and pairable Feb 23 23:35:06 smsl-n100 volumio[956]: info: CoreCommandRouter::volumioGetState Feb 23 23:35:06 smsl-n100 volumio[956]: info: CorePlayQueue::getTrack 0 Feb 23 23:35:06 smsl-n100 bluetoothd[1499]: Bluetooth daemon 5.50 Feb 23 23:35:06 smsl-n100 bluetoothd[1499]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Feb 23 23:35:06 smsl-n100 dbus-daemon[576]: [system] Successfully activated service 'org.bluez' Feb 23 23:35:06 smsl-n100 systemd[1]: Started Bluetooth service. Feb 23 23:35:06 smsl-n100 bluetoothd[1499]: Starting SDP server Feb 23 23:35:06 smsl-n100 bluetoothd[1499]: Excluding (cli) sap Feb 23 23:35:06 smsl-n100 bluetoothd[1499]: kernel lacks bnep-protocol support Feb 23 23:35:06 smsl-n100 bluetoothd[1499]: System does not support network plugin Feb 23 23:35:06 smsl-n100 dbus-daemon[576]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.38' (uid=0 pid=1499 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") Feb 23 23:35:06 smsl-n100 bluetoothd[1499]: Bluetooth management interface 1.14 initialized Feb 23 23:35:07 smsl-n100 volumiobt[1446]: [bluetooth]# -e power on Feb 23 23:35:07 smsl-n100 volumiobt[1446]: Invalid command in menu main: -e Feb 23 23:35:07 smsl-n100 volumiobt[1446]: Feb 23 23:35:07 smsl-n100 volumiobt[1446]: Use "help" for a list of available commands in a menu. Feb 23 23:35:07 smsl-n100 volumiobt[1446]: Use "menu " if you want to enter any submenu. Feb 23 23:35:07 smsl-n100 volumiobt[1446]: Use "back" if you want to return to menu main. Feb 23 23:35:07 smsl-n100 volumiobt[1446]: [bluetooth]# agent on Feb 23 23:35:07 smsl-n100 volumiobt[1446]: Failed to register agent object Feb 23 23:35:07 smsl-n100 volumiobt[1446]: [bluetooth]# discoverable on Feb 23 23:35:07 smsl-n100 volumiobt[1446]: No default controller available Feb 23 23:35:07 smsl-n100 volumiobt[1446]: [bluetooth]# pairable on Feb 23 23:35:07 smsl-n100 volumiobt[1446]: No default controller available Feb 23 23:35:07 smsl-n100 volumiobt[1446]: [bluetooth]# agent NoInputNoOutput Feb 23 23:35:07 smsl-n100 volumiobt[1446]: Failed to register agent object Feb 23 23:35:07 smsl-n100 volumiobt[1446]: [bluetooth]# default-agent Feb 23 23:35:07 smsl-n100 volumiobt[1446]: No agent is registered Feb 23 23:35:07 smsl-n100 volumiobt[1446]: [bluetooth]# quit Feb 23 23:35:07 smsl-n100 volumio[1331]: Generating RSA private key, 4096 bit long modulus (2 primes) Feb 23 23:35:07 smsl-n100 pulseaudio[1472]: 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 Feb 23 23:35:07 smsl-n100 volumiobt[1446]: [59B blob data] Feb 23 23:35:07 smsl-n100 systemd[1]: Starting Hostname Service... Feb 23 23:35:07 smsl-n100 volumio[956]: info: Executing endpoint tc_getconfig Feb 23 23:35:07 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Feb 23 23:35:07 smsl-n100 vtcs[1487]: STARTING TidalConnect services, version: 1.4.0.34 Feb 23 23:35:07 smsl-n100 volumio[956]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 23 23:35:07 smsl-n100 dbus-daemon[576]: [system] Successfully activated service 'org.freedesktop.hostname1' Feb 23 23:35:07 smsl-n100 systemd[1]: Started Hostname Service. Feb 23 23:35:07 smsl-n100 vtcs[1487]: STARTED TidalConnect services. Feb 23 23:35:07 smsl-n100 volumio[956]: info: Executing endpoint tc_connect Feb 23 23:35:07 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Feb 23 23:35:07 smsl-n100 volumio[956]: info: Connecting to TidalConnect Feb 23 23:35:07 smsl-n100 volumio[956]: info: CoreCommandRouter::servicePushState Feb 23 23:35:07 smsl-n100 volumio[956]: info: CoreStateMachine::pushState Feb 23 23:35:07 smsl-n100 volumio[956]: info: CorePlayQueue::getTrack 0 Feb 23 23:35:07 smsl-n100 volumio[956]: info: CoreCommandRouter::volumioPushState Feb 23 23:35:07 smsl-n100 volumio[956]: info: MRS: Pushing multiroomSync output update for this device Feb 23 23:35:07 smsl-n100 volumio[956]: info: MRS: Pushing multiroomSync output Feb 23 23:35:07 smsl-n100 volumio[956]: info: CorePlayQueue::getTrack 0 Feb 23 23:35:07 smsl-n100 volumio[956]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received tidalconnect Feb 23 23:35:07 smsl-n100 volumio[956]: info: CoreCommandRouter::servicePushState Feb 23 23:35:07 smsl-n100 volumio[956]: info: CoreStateMachine::pushState Feb 23 23:35:07 smsl-n100 volumio[956]: info: CorePlayQueue::getTrack 0 Feb 23 23:35:07 smsl-n100 volumio[956]: info: CoreCommandRouter::volumioPushState Feb 23 23:35:07 smsl-n100 volumio[956]: info: MRS: Pushing multiroomSync output update for this device Feb 23 23:35:07 smsl-n100 volumio[956]: info: MRS: Pushing multiroomSync output Feb 23 23:35:07 smsl-n100 volumio[956]: info: CorePlayQueue::getTrack 0 Feb 23 23:35:07 smsl-n100 volumio[956]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received tidalconnect Feb 23 23:35:09 smsl-n100 volumio[956]: info: TidalConnect service started! Feb 23 23:35:09 smsl-n100 volumio[956]: info: Completed starting Core Plugins Feb 23 23:35:09 smsl-n100 volumio[956]: info: ------------------------------------------- Feb 23 23:35:09 smsl-n100 volumio[956]: info: ----- MyVolumio plugins startup ---- Feb 23 23:35:09 smsl-n100 volumio[956]: info: ------------------------------------------- Feb 23 23:35:09 smsl-n100 volumio[956]: info: [MyVolumio PluginManager] Fetching plans data.... Feb 23 23:35:11 smsl-n100 volumio[956]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Feb 23 23:35:14 smsl-n100 volumio[1331]: ..................................................................................................++++ Feb 23 23:35:21 smsl-n100 volumio[1331]: ..................................................................................................++++ Feb 23 23:35:21 smsl-n100 volumio[1331]: e is 65537 (0x010001) Feb 23 23:35:21 smsl-n100 volumio[1331]: writing RSA key Feb 23 23:35:28 smsl-n100 volumio[956]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Feb 23 23:35:28 smsl-n100 volumio[956]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Feb 23 23:35:28 smsl-n100 volumio[956]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Feb 23 23:35:28 smsl-n100 volumio[956]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Feb 23 23:35:28 smsl-n100 volumio[956]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Feb 23 23:35:28 smsl-n100 volumio[956]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Feb 23 23:35:28 smsl-n100 volumio[956]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Feb 23 23:35:28 smsl-n100 volumio[956]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Feb 23 23:35:28 smsl-n100 volumio[956]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Feb 23 23:35:28 smsl-n100 volumio[956]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Feb 23 23:35:28 smsl-n100 volumio[956]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Feb 23 23:35:28 smsl-n100 volumio[956]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Feb 23 23:35:28 smsl-n100 volumio[956]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Feb 23 23:35:28 smsl-n100 volumio[956]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Feb 23 23:35:28 smsl-n100 volumio[956]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Feb 23 23:35:28 smsl-n100 volumio[956]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Feb 23 23:35:28 smsl-n100 volumio[956]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Feb 23 23:35:28 smsl-n100 volumio[956]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Feb 23 23:35:28 smsl-n100 volumio[956]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Feb 23 23:35:28 smsl-n100 volumio[956]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Feb 23 23:35:28 smsl-n100 volumio[956]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Feb 23 23:35:28 smsl-n100 volumio[956]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Feb 23 23:35:28 smsl-n100 volumio[956]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Feb 23 23:35:28 smsl-n100 volumio[956]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Feb 23 23:35:28 smsl-n100 volumio[956]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Feb 23 23:35:28 smsl-n100 volumio[956]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Feb 23 23:35:28 smsl-n100 volumio[956]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Feb 23 23:35:30 smsl-n100 volumio[956]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Feb 23 23:35:30 smsl-n100 volumio[956]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Feb 23 23:35:30 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 23:35:30 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 23:35:30 smsl-n100 volumio[956]: info: Starting MyVolumio Remote Streaming Endpoints Feb 23 23:35:30 smsl-n100 volumio[956]: info: MyVolumio login type: Token Feb 23 23:35:30 smsl-n100 volumio[956]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Feb 23 23:35:30 smsl-n100 volumio[956]: 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' Feb 23 23:35:30 smsl-n100 volumio[956]: error: MyVolumio Plugin failed to start in a timely fashion Feb 23 23:35:30 smsl-n100 volumio[956]: [Metrics] CommandRouter: 64s 704.01ms Feb 23 23:35:30 smsl-n100 volumio[956]: info: CoreCommandRouter::volumiosetStartupVolume Feb 23 23:35:30 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:35:30 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 23:35:30 smsl-n100 volumio[956]: info: CoreCommandRouter::Close All Modals sent Feb 23 23:35:30 smsl-n100 volumio[956]: info: CoreCommandRouter::Close All Modals sent Feb 23 23:35:31 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Feb 23 23:35:31 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 23 23:35:31 smsl-n100 volumio[956]: xcb_connection_has_error() returned true Feb 23 23:35:31 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Feb 23 23:35:32 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 23 23:35:32 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 23:35:32 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 23 23:35:37 smsl-n100 systemd[1]: systemd-hostnamed.service: Succeeded. Feb 23 23:35:37 smsl-n100 volumio[956]: info: BOOT COMPLETED Feb 23 23:35:38 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:35:38 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:35:38 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:35:38 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:35:38 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:35:38 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:35:38 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:35:38 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 23:35:38 smsl-n100 volumio[956]: info: Not Reporting Auto name since its the default one Feb 23 23:35:38 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Feb 23 23:35:38 smsl-n100 volumio[956]: xcb_connection_has_error() returned true Feb 23 23:35:38 smsl-n100 sudo[1617]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Feb 23 23:35:38 smsl-n100 sudo[1617]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 23:35:38 smsl-n100 sudo[1617]: pam_unix(sudo:session): session closed for user root Feb 23 23:35:38 smsl-n100 sudo[1619]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Feb 23 23:35:38 smsl-n100 sudo[1619]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 23:35:38 smsl-n100 systemd[1]: Started RAAT DAEMON. Feb 23 23:35:38 smsl-n100 sudo[1619]: pam_unix(sudo:session): session closed for user root Feb 23 23:35:38 smsl-n100 volumio[956]: info: Raat Daemon started successfully Feb 23 23:35:39 smsl-n100 volumio[956]: info: Executing endpoint restartRAATSocket Feb 23 23:35:39 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Feb 23 23:35:39 smsl-n100 volumio[956]: info: CorePlayQueue::getTrack 0 Feb 23 23:35:39 smsl-n100 volumio[956]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Feb 23 23:35:41 smsl-n100 volumio[956]: info: RAAT: Requesting Headphone Status Feb 23 23:35:41 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Feb 23 23:35:41 smsl-n100 volumio[956]: info: CoreStateMachine::pushState Feb 23 23:35:41 smsl-n100 volumio[956]: info: CorePlayQueue::getTrack 0 Feb 23 23:35:41 smsl-n100 volumio[956]: info: CoreCommandRouter::volumioPushState Feb 23 23:35:41 smsl-n100 volumio[956]: info: MRS: Pushing multiroomSync output update for this device Feb 23 23:35:41 smsl-n100 volumio[956]: info: MRS: Pushing multiroomSync output Feb 23 23:35:41 smsl-n100 volumio[956]: error: Serial API: Failed to decode command: 100, message: undefined Feb 23 23:35:41 smsl-n100 volumio[956]: error: Serial API: Failed to decode command: MAXVOL, message: Feb 23 23:35:41 smsl-n100 volumio[956]: error: Serial API: Failed to decode command: 100, message: undefined Feb 23 23:35:41 smsl-n100 volumio[956]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Feb 23 23:35:45 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 23 23:35:45 smsl-n100 volumio[956]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Feb 23 23:35:45 smsl-n100 volumio[956]: info: CoreCommandRouter::volumioGetState Feb 23 23:35:45 smsl-n100 volumio[956]: info: CorePlayQueue::getTrack 0 Feb 23 23:35:50 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:35:50 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:35:50 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Feb 23 23:35:50 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Feb 23 23:35:50 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 23 23:35:50 smsl-n100 volumio[956]: info: CoreCommandRouter::volumioGetBrowseSources Feb 23 23:35:50 smsl-n100 volumio[956]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 23 23:36:00 smsl-n100 volumio[956]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Feb 23 23:36:00 smsl-n100 volumio[956]: info: Retrying Login Due to Network Error Feb 23 23:36:10 smsl-n100 volumio[956]: info: MyVolumio login type: Token Feb 23 23:36:23 smsl-n100 kernel: rk_gmac-dwmac ff540000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx Feb 23 23:36:23 smsl-n100 dhcpcd[945]: eth0: carrier acquired Feb 23 23:36:23 smsl-n100 dhcpcd[945]: eth0: IAID 09:32:f0:68 Feb 23 23:36:23 smsl-n100 dhcpcd[945]: eth0: adding address fe80::31c9:6134:9a18:95d0 Feb 23 23:36:23 smsl-n100 dhcpcd[945]: ipv6_addaddr1: Permission denied Feb 23 23:36:24 smsl-n100 dhcpcd[945]: eth0: soliciting an IPv6 router Feb 23 23:36:24 smsl-n100 ifplugd(eth0)[685]: Link beat detected. Feb 23 23:36:24 smsl-n100 ifplugd(eth0)[685]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Feb 23 23:36:24 smsl-n100 dhcpcd[945]: eth0: soliciting a DHCP lease Feb 23 23:36:24 smsl-n100 dhcpcd[945]: eth0: offered 192.168.31.10 from 192.168.31.1 Feb 23 23:36:24 smsl-n100 dhcpcd[945]: eth0: probing address 192.168.31.10/24 Feb 23 23:36:24 smsl-n100 ifplugd(eth0)[685]: client: sending commands to master dhcpcd process Feb 23 23:36:24 smsl-n100 dhcpcd[1773]: sending commands to master dhcpcd process Feb 23 23:36:24 smsl-n100 dhcpcd[945]: control command: /sbin/dhcpcd eth0 Feb 23 23:36:24 smsl-n100 ifplugd(eth0)[685]: Program executed successfully. Feb 23 23:36:29 smsl-n100 dhcpcd[945]: eth0: leased 192.168.31.10 for 43200 seconds Feb 23 23:36:29 smsl-n100 avahi-daemon[552]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.31.10. Feb 23 23:36:29 smsl-n100 avahi-daemon[552]: New relevant interface eth0.IPv4 for mDNS. Feb 23 23:36:29 smsl-n100 dhcpcd[945]: eth0: adding route to 192.168.31.0/24 Feb 23 23:36:29 smsl-n100 avahi-daemon[552]: Registering new address record for 192.168.31.10 on eth0.IPv4. Feb 23 23:36:29 smsl-n100 dhcpcd[945]: eth0: adding default route via 192.168.31.1 Feb 23 23:36:29 smsl-n100 ntpd[944]: ntpd exiting on signal 15 (Terminated) Feb 23 23:36:29 smsl-n100 ntpd[944]: 193.182.111.142 local addr 192.168.31.99 -> Feb 23 23:36:29 smsl-n100 systemd[1]: Stopping Network Time Service... Feb 23 23:36:29 smsl-n100 ntpd[944]: 202.112.31.197 local addr 192.168.31.99 -> Feb 23 23:36:29 smsl-n100 ntpd[944]: 193.182.111.141 local addr 192.168.31.99 -> Feb 23 23:36:29 smsl-n100 ntpd[944]: 202.112.29.82 local addr 192.168.31.99 -> Feb 23 23:36:29 smsl-n100 ntpd[944]: 116.203.151.74 local addr 192.168.31.99 -> Feb 23 23:36:29 smsl-n100 systemd[1]: ntp.service: Succeeded. Feb 23 23:36:29 smsl-n100 ntpd[944]: 193.182.111.12 local addr 192.168.31.99 -> Feb 23 23:36:29 smsl-n100 ntpd[944]: 113.207.49.85 local addr 192.168.31.99 -> Feb 23 23:36:29 smsl-n100 ntpd[944]: 47.115.137.18 local addr 192.168.31.99 -> Feb 23 23:36:29 smsl-n100 ntpd[944]: 119.28.183.184 local addr 192.168.31.99 -> Feb 23 23:36:29 smsl-n100 ntpd[944]: 162.159.200.1 local addr 192.168.31.99 -> Feb 23 23:36:29 smsl-n100 systemd[1]: Stopped Network Time Service. Feb 23 23:36:29 smsl-n100 ntpd[944]: 119.28.206.193 local addr 192.168.31.99 -> Feb 23 23:36:29 smsl-n100 ntpd[944]: 95.111.202.5 local addr 192.168.31.99 -> Feb 23 23:36:29 smsl-n100 ntpd[944]: 78.46.102.180 local addr 192.168.31.99 -> Feb 23 23:36:29 smsl-n100 ntpd[944]: 202.118.1.81 local addr 192.168.31.99 -> Feb 23 23:36:29 smsl-n100 ntpd[944]: 108.59.2.24 local addr 192.168.31.99 -> Feb 23 23:36:29 smsl-n100 volumio[956]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 23 23:36:29 smsl-n100 ntpd[944]: 162.159.200.123 local addr 192.168.31.99 -> Feb 23 23:36:29 smsl-n100 ntpd[944]: 5.79.108.34 local addr 192.168.31.99 -> Feb 23 23:36:29 smsl-n100 volumio[956]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 23 23:36:29 smsl-n100 systemd[1]: Starting Network Time Service... Feb 23 23:36:29 smsl-n100 volumio[956]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 23 23:36:29 smsl-n100 ntpd[1835]: ntpd 4.2.8p12@1.3728-o (1): Starting Feb 23 23:36:29 smsl-n100 ntpd[1835]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Feb 23 23:36:29 smsl-n100 systemd[1]: Started Network Time Service. Feb 23 23:36:29 smsl-n100 ntpd[1841]: proto: precision = 0.875 usec (-20) Feb 23 23:36:29 smsl-n100 ntpd[1841]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Feb 23 23:36:29 smsl-n100 ntpd[1841]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Feb 23 23:36:29 smsl-n100 ntpd[1841]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 789 days ago Feb 23 23:36:29 smsl-n100 ntpd[1841]: Listen and drop on 0 v6wildcard [::]:123 Feb 23 23:36:29 smsl-n100 ntpd[1841]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Feb 23 23:36:29 smsl-n100 ntpd[1841]: Listen normally on 2 lo 127.0.0.1:123 Feb 23 23:36:29 smsl-n100 ntpd[1841]: Listen normally on 3 eth0 192.168.31.10:123 Feb 23 23:36:29 smsl-n100 ntpd[1841]: Listen normally on 4 wlan0 192.168.31.99:123 Feb 23 23:36:29 smsl-n100 ntpd[1841]: Listening on routing socket on fd #21 for interface updates Feb 23 23:36:29 smsl-n100 ntpd[1841]: kernel reports TIME_ERROR: 0x4041: Clock Unsynchronized Feb 23 23:36:29 smsl-n100 ntpd[1841]: kernel reports TIME_ERROR: 0x4041: Clock Unsynchronized Feb 23 23:36:29 smsl-n100 volumio[956]: info: Discovery: this is already registered, 8ff320e5-ba40-4f99-8d40-e51473ce7e45 Feb 23 23:36:29 smsl-n100 volumio[956]: info: Discovery: Found device SMSL N100 Feb 23 23:36:29 smsl-n100 volumio[956]: info: CoreCommandRouter::volumioGetState Feb 23 23:36:29 smsl-n100 volumio[956]: info: CorePlayQueue::getTrack 0 Feb 23 23:36:29 smsl-n100 volumio[956]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 23 23:36:29 smsl-n100 volumio[956]: Error: The value NaN is not a number Feb 23 23:36:29 smsl-n100 volumio[956]: at Config.forceToType (/volumio/node_modules/v-conf/index.js:322:20) Feb 23 23:36:29 smsl-n100 volumio[956]: at Config.set (/volumio/node_modules/v-conf/index.js:153:25) Feb 23 23:36:29 smsl-n100 volumio[956]: at ControllerVolumioDiscovery.updateMultiroomDevice (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:323:25) Feb 23 23:36:29 smsl-n100 volumio[956]: at ControllerVolumioDiscovery.connectToRemoteVolumio (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:273:10) Feb 23 23:36:29 smsl-n100 volumio[956]: at Browser. (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:192:12) Feb 23 23:36:29 smsl-n100 volumio[956]: at Browser.emit (events.js:400:28) Feb 23 23:36:29 smsl-n100 volumio[956]: at on_resolver_done (/volumio/node_modules/mdns/lib/browser.js:31:14) Feb 23 23:36:29 smsl-n100 volumio[956]: at next (/volumio/node_modules/mdns/lib/browser.js:106:7) Feb 23 23:36:29 smsl-n100 volumio[956]: at Array.makeAddressesUnique (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:177:5) Feb 23 23:36:29 smsl-n100 volumio[956]: at next (/volumio/node_modules/mdns/lib/browser.js:109:21) Feb 23 23:36:29 smsl-n100 volumio[956]: at /volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:160:11 Feb 23 23:36:29 smsl-n100 volumio[956]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:108:7) Feb 23 23:36:29 smsl-n100 volumio[956]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) Feb 23 23:36:29 smsl-n100 volumio[956]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 23 23:36:30 smsl-n100 ntpd[1841]: Soliciting pool server 193.182.111.143 Feb 23 23:36:30 smsl-n100 sudo[1853]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-23 23:35 Feb 23 23:36:30 smsl-n100 sudo[1853]: 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"