-- Logs begin at Thu 2019-02-14 00:11:59 HST, end at Mon 2025-09-08 18:37:18 HST. -- Sep 08 18:36:01 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 08 18:36:01 smsl-n100 volumio[1268]: info: Received Get System Info Sep 08 18:36:01 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 08 18:36:01 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 08 18:36:01 smsl-n100 volumio[1268]: info: Discovery: Getting this device information Sep 08 18:36:01 smsl-n100 volumio[1268]: info: CoreCommandRouter::volumioGetState Sep 08 18:36:01 smsl-n100 volumio[1268]: info: CorePlayQueue::getTrack 0 Sep 08 18:36:01 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 08 18:36:01 smsl-n100 volumio[1268]: info: Preload queue cleared Sep 08 18:36:01 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Sep 08 18:36:02 smsl-n100 volumio[1268]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Sep 08 18:36:02 smsl-n100 volumio[1268]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Sep 08 18:36:02 smsl-n100 volumio[1268]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Sep 08 18:36:02 smsl-n100 volumio[1268]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Sep 08 18:36:02 smsl-n100 volumio[1268]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Sep 08 18:36:02 smsl-n100 volumio[1268]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Sep 08 18:36:02 smsl-n100 volumio[1268]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Sep 08 18:36:02 smsl-n100 volumio[1268]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Sep 08 18:36:02 smsl-n100 volumio[1268]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Sep 08 18:36:02 smsl-n100 volumio[1268]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Sep 08 18:36:02 smsl-n100 volumio[1268]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Sep 08 18:36:02 smsl-n100 volumio[1268]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Sep 08 18:36:02 smsl-n100 volumio[1268]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Sep 08 18:36:02 smsl-n100 volumio[1268]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Sep 08 18:36:02 smsl-n100 volumio[1268]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Sep 08 18:36:02 smsl-n100 volumio[1268]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Sep 08 18:36:02 smsl-n100 volumio[1268]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Sep 08 18:36:02 smsl-n100 volumio[1268]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Sep 08 18:36:02 smsl-n100 volumio[1268]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Sep 08 18:36:02 smsl-n100 volumio[1268]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Sep 08 18:36:02 smsl-n100 volumio[1268]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Sep 08 18:36:02 smsl-n100 volumio[1268]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Sep 08 18:36:02 smsl-n100 volumio[1268]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Sep 08 18:36:02 smsl-n100 volumio[1268]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Sep 08 18:36:02 smsl-n100 volumio[1268]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Sep 08 18:36:02 smsl-n100 volumio[1268]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Sep 08 18:36:02 smsl-n100 volumio[1268]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Sep 08 18:36:02 smsl-n100 volumio[1268]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Sep 08 18:36:02 smsl-n100 volumio[1268]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Sep 08 18:36:02 smsl-n100 volumio[1519]: .................................................................................................................++++ Sep 08 18:36:04 smsl-n100 volumio[1268]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Sep 08 18:36:04 smsl-n100 volumio[1268]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Sep 08 18:36:04 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 08 18:36:04 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 08 18:36:04 smsl-n100 volumio[1268]: info: Starting MyVolumio Remote Streaming Endpoints Sep 08 18:36:04 smsl-n100 volumio[1268]: info: MyVolumio login type: Token Sep 08 18:36:04 smsl-n100 volumio[1268]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Sep 08 18:36:04 smsl-n100 volumio[1268]: 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' Sep 08 18:36:04 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 08 18:36:04 smsl-n100 volumio[1268]: error: MyVolumio Custom Token format not valid, refreshing it Sep 08 18:36:05 smsl-n100 volumio[1268]: info: MyVolumio login type: Token Sep 08 18:36:06 smsl-n100 volumio[1268]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Sep 08 18:36:07 smsl-n100 volumio[1268]: info: MyVolumio token set successfully Sep 08 18:36:07 smsl-n100 volumio[1268]: info: MYVOLUMIO: Adding device Sep 08 18:36:07 smsl-n100 volumio[1268]: info: MYVOLUMIO: Evaluating Server Sep 08 18:36:07 smsl-n100 volumio[1519]: .......................................................................++++ Sep 08 18:36:07 smsl-n100 volumio[1519]: e is 65537 (0x010001) Sep 08 18:36:07 smsl-n100 volumio[1519]: writing RSA key Sep 08 18:36:07 smsl-n100 volumio[1268]: info: MyVolumio status changed Sep 08 18:36:07 smsl-n100 volumio[1268]: info: Streaming services startup Sep 08 18:36:07 smsl-n100 volumio[1268]: info: Starting Streaming Daemon Sep 08 18:36:07 smsl-n100 volumio[1268]: info: Removing browser output: myVolumio user plan is not superstar Sep 08 18:36:07 smsl-n100 volumio[1268]: info: Removing audio output: Sep 08 18:36:07 smsl-n100 volumio[1268]: info: Stoppping Tunnel 1 Sep 08 18:36:08 smsl-n100 sudo[1779]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Sep 08 18:36:08 smsl-n100 sudo[1779]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 18:36:08 smsl-n100 sudo[1779]: pam_unix(sudo:session): session closed for user root Sep 08 18:36:08 smsl-n100 sudo[1782]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Sep 08 18:36:08 smsl-n100 sudo[1782]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 18:36:08 smsl-n100 volumio[1268]: error: Cannot start Volumio Streaming Daemon Sep 08 18:36:08 smsl-n100 volumio[1268]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Sep 08 18:36:08 smsl-n100 volumio[1268]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Sep 08 18:36:08 smsl-n100 sudo[1782]: pam_unix(sudo:session): session closed for user root Sep 08 18:36:08 smsl-n100 volumio[1268]: info: Remote SSH Stopped Sep 08 18:36:08 smsl-n100 volumio[1268]: info: Setting Geolocation for MyVolumio to us2 Sep 08 18:36:08 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 08 18:36:08 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 08 18:36:08 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 08 18:36:08 smsl-n100 volumio[1268]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Sep 08 18:36:09 smsl-n100 volumio[1268]: info: Updating MyVolumio device info Sep 08 18:36:09 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 08 18:36:09 smsl-n100 volumio[1268]: info: CoreCommandRouter::volumioGetState Sep 08 18:36:09 smsl-n100 volumio[1268]: info: CorePlayQueue::getTrack 0 Sep 08 18:36:09 smsl-n100 volumio[1268]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Sep 08 18:36:11 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 08 18:36:11 smsl-n100 volumio[1268]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Sep 08 18:36:11 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Sep 08 18:36:11 smsl-n100 volumio[1268]: info: Received Get System Version Sep 08 18:36:11 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 08 18:36:11 smsl-n100 volumio[1268]: info: Received Get System Info Sep 08 18:36:11 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 08 18:36:11 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 08 18:36:11 smsl-n100 volumio[1268]: info: Discovery: Getting this device information Sep 08 18:36:11 smsl-n100 volumio[1268]: info: CoreCommandRouter::volumioGetState Sep 08 18:36:11 smsl-n100 volumio[1268]: info: CorePlayQueue::getTrack 0 Sep 08 18:36:11 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 08 18:36:11 smsl-n100 volumio[1268]: error: MyVolumio Plugin failed to start in a timely fashion Sep 08 18:36:11 smsl-n100 volumio[1268]: [Metrics] CommandRouter: 60s 601.34ms Sep 08 18:36:11 smsl-n100 volumio[1268]: info: CoreCommandRouter::volumiosetStartupVolume Sep 08 18:36:11 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 18:36:11 smsl-n100 volumio[1268]: info: VolumeController:: Setting startup Volume 15 Sep 08 18:36:11 smsl-n100 volumio[1268]: info: VolumeController::SetAlsaVolume15 Sep 08 18:36:11 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 08 18:36:11 smsl-n100 volumio[1268]: info: CoreCommandRouter::Close All Modals sent Sep 08 18:36:11 smsl-n100 volumio[1268]: info: CoreCommandRouter::Close All Modals sent Sep 08 18:36:11 smsl-n100 volumio[1268]: info: CoreStateMachine::pushState Sep 08 18:36:11 smsl-n100 volumio[1268]: info: CorePlayQueue::getTrack 0 Sep 08 18:36:11 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 08 18:36:11 smsl-n100 volumio[1268]: info: CoreCommandRouter::volumioPushState Sep 08 18:36:12 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Sep 08 18:36:12 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 08 18:36:12 smsl-n100 volumio[1268]: xcb_connection_has_error() returned true Sep 08 18:36:12 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Sep 08 18:36:12 smsl-n100 volumio[1268]: info: MYVOLUMIO: Adding device Sep 08 18:36:12 smsl-n100 volumio[1268]: info: MYVOLUMIO: Evaluating Server Sep 08 18:36:13 smsl-n100 volumio[1268]: info: Setting Geolocation for MyVolumio to us2 Sep 08 18:36:13 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 08 18:36:13 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 08 18:36:13 smsl-n100 volumio[1268]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 08 18:36:13 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Sep 08 18:36:14 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Sep 08 18:36:14 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Sep 08 18:36:14 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Sep 08 18:36:14 smsl-n100 volumio[1268]: info: Received Get System Version Sep 08 18:36:14 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 08 18:36:14 smsl-n100 volumio[1268]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Sep 08 18:36:14 smsl-n100 volumio[1268]: info: Updating MyVolumio device info Sep 08 18:36:14 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 08 18:36:14 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 08 18:36:14 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 08 18:36:14 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 08 18:36:15 smsl-n100 volumio-remote-updater[565]: No test mode Sep 08 18:36:15 smsl-n100 volumio-remote-updater[565]: No alpha test mode Sep 08 18:36:15 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Sep 08 18:36:15 smsl-n100 volumio[1268]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Sep 08 18:36:15 smsl-n100 volumio[1268]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Sep 08 18:36:15 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Sep 08 18:36:18 smsl-n100 volumio[1268]: info: BOOT COMPLETED Sep 08 18:36:19 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 08 18:36:19 smsl-n100 volumio[1268]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Sep 08 18:36:19 smsl-n100 volumio[1268]: info: CoreCommandRouter::volumioGetState Sep 08 18:36:19 smsl-n100 volumio[1268]: info: CorePlayQueue::getTrack 0 Sep 08 18:36:20 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 18:36:20 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 18:36:20 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 18:36:20 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 18:36:20 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 18:36:20 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 18:36:20 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 18:36:20 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 08 18:36:20 smsl-n100 volumio[1268]: info: Not Reporting Auto name since its the default one Sep 08 18:36:20 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Sep 08 18:36:20 smsl-n100 systemd[1]: systemd-hostnamed.service: Succeeded. Sep 08 18:36:20 smsl-n100 volumio[1268]: xcb_connection_has_error() returned true Sep 08 18:36:20 smsl-n100 sudo[1838]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Sep 08 18:36:20 smsl-n100 sudo[1838]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 18:36:20 smsl-n100 sudo[1838]: pam_unix(sudo:session): session closed for user root Sep 08 18:36:20 smsl-n100 sudo[1840]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Sep 08 18:36:20 smsl-n100 sudo[1840]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 18:36:20 smsl-n100 systemd[1]: Started RAAT DAEMON. Sep 08 18:36:20 smsl-n100 sudo[1840]: pam_unix(sudo:session): session closed for user root Sep 08 18:36:20 smsl-n100 volumio[1268]: info: Raat Daemon started successfully Sep 08 18:36:22 smsl-n100 volumio[1268]: info: Executing endpoint restartRAATSocket Sep 08 18:36:22 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Sep 08 18:36:22 smsl-n100 volumio[1268]: info: CorePlayQueue::getTrack 0 Sep 08 18:36:22 smsl-n100 volumio[1268]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Sep 08 18:36:22 smsl-n100 volumio[1268]: info: CorePlayQueue::getTrack 0 Sep 08 18:36:23 smsl-n100 volumio[1268]: info: RAAT: Requesting Headphone Status Sep 08 18:36:23 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Sep 08 18:36:23 smsl-n100 volumio[1268]: info: CoreStateMachine::pushState Sep 08 18:36:23 smsl-n100 volumio[1268]: info: CorePlayQueue::getTrack 0 Sep 08 18:36:23 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 08 18:36:23 smsl-n100 volumio[1268]: info: CoreCommandRouter::volumioPushState Sep 08 18:36:23 smsl-n100 volumio[1268]: error: Serial API: Failed to decode command: 100, message: undefined Sep 08 18:36:23 smsl-n100 volumio[1268]: error: Serial API: Failed to decode command: MAXVOL, message: Sep 08 18:36:23 smsl-n100 volumio[1268]: error: Serial API: Failed to decode command: 100, message: undefined Sep 08 18:36:23 smsl-n100 volumio[1268]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Sep 08 18:36:24 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 18:36:24 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 18:36:24 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Sep 08 18:36:24 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Sep 08 18:36:24 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Sep 08 18:36:24 smsl-n100 volumio[1268]: info: CoreCommandRouter::volumioGetBrowseSources Sep 08 18:36:24 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 08 18:36:25 smsl-n100 volumio[1268]: info: VolumeController::SetAlsaVolume0 Sep 08 18:36:25 smsl-n100 volumio[1268]: info: CoreStateMachine::pushState Sep 08 18:36:25 smsl-n100 volumio[1268]: info: CorePlayQueue::getTrack 0 Sep 08 18:36:25 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 08 18:36:25 smsl-n100 volumio[1268]: info: CoreCommandRouter::volumioPushState Sep 08 18:36:25 smsl-n100 volumio[1268]: info: Updating RAAT Signal Path Sep 08 18:36:32 smsl-n100 volumio-remote-updater[565]: No test mode Sep 08 18:36:32 smsl-n100 volumio-remote-updater[565]: No alpha test mode Sep 08 18:36:32 smsl-n100 volumio[1268]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Sep 08 18:36:32 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Sep 08 18:36:35 smsl-n100 volumio[1268]: info: CoreCommandRouter::Close All Modals sent Sep 08 18:36:53 smsl-n100 volumio[1268]: info: CoreCommandRouter::volumioGetState Sep 08 18:36:53 smsl-n100 volumio[1268]: info: CorePlayQueue::getTrack 0 Sep 08 18:36:55 smsl-n100 volumio[1268]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 08 18:36:55 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Sep 08 18:36:55 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Sep 08 18:36:56 smsl-n100 sudo[1951]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Sep 08 18:36:56 smsl-n100 sudo[1951]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 18:36:56 smsl-n100 sudo[1957]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Sep 08 18:36:56 smsl-n100 sudo[1957]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 18:36:56 smsl-n100 sudo[1951]: pam_unix(sudo:session): session closed for user root Sep 08 18:36:56 smsl-n100 sudo[1957]: pam_unix(sudo:session): session closed for user root Sep 08 18:36:56 smsl-n100 sudo[1964]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Sep 08 18:36:56 smsl-n100 sudo[1964]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 18:36:56 smsl-n100 sudo[1964]: pam_unix(sudo:session): session closed for user root Sep 08 18:36:56 smsl-n100 sudo[1970]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Sep 08 18:36:56 smsl-n100 sudo[1970]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 18:36:56 smsl-n100 sudo[1970]: pam_unix(sudo:session): session closed for user root Sep 08 18:36:56 smsl-n100 sudo[1976]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 08 18:36:56 smsl-n100 sudo[1976]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 18:36:56 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Sep 08 18:36:56 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Sep 08 18:36:56 smsl-n100 sudo[1976]: pam_unix(sudo:session): session closed for user root Sep 08 18:36:56 smsl-n100 sudo[1979]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 08 18:36:56 smsl-n100 sudo[1979]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 18:36:56 smsl-n100 sudo[1979]: pam_unix(sudo:session): session closed for user root Sep 08 18:36:56 smsl-n100 sudo[1983]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Sep 08 18:36:56 smsl-n100 sudo[1983]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 18:37:00 smsl-n100 sudo[1983]: pam_unix(sudo:session): session closed for user root Sep 08 18:37:11 smsl-n100 volumio[1268]: info: CALLMETHOD: system_controller network saveWirelessNet [object Object] Sep 08 18:37:11 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNet Sep 08 18:37:11 smsl-n100 sudo[2020]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/network/interfaces Sep 08 18:37:11 smsl-n100 sudo[2020]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 18:37:11 smsl-n100 sudo[2020]: pam_unix(sudo:session): session closed for user root Sep 08 18:37:11 smsl-n100 sudo[2022]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/dhcpcd.conf Sep 08 18:37:11 smsl-n100 sudo[2022]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 18:37:11 smsl-n100 sudo[2022]: pam_unix(sudo:session): session closed for user root Sep 08 18:37:11 smsl-n100 volumio[1268]: info: Permissions for /etc/network/interfaces set Sep 08 18:37:11 smsl-n100 volumio[1268]: info: Restarting Wireless Network Sep 08 18:37:11 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Sep 08 18:37:11 smsl-n100 volumio[1268]: info: Discovery: Restarting Advertising due to device name change Sep 08 18:37:11 smsl-n100 sudo[2025]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Sep 08 18:37:11 smsl-n100 sudo[2025]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 18:37:11 smsl-n100 systemd[1]: Stopping Wireless Services... Sep 08 18:37:11 smsl-n100 wpa_supplicant[1022]: wlan0: CTRL-EVENT-DISCONNECTED bssid=4c:ab:f8:9f:c8:de reason=3 locally_generated=1 Sep 08 18:37:11 smsl-n100 dhcpcd[602]: wlan0: carrier lost Sep 08 18:37:11 smsl-n100 volumio[1268]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 08 18:37:11 smsl-n100 wpa_supplicant[1022]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Sep 08 18:37:11 smsl-n100 avahi-daemon[570]: Interface wlan0.IPv4 no longer relevant for mDNS. Sep 08 18:37:11 smsl-n100 avahi-daemon[570]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.99. Sep 08 18:37:11 smsl-n100 wpa_supplicant[1022]: wlan0: CTRL-EVENT-TERMINATING Sep 08 18:37:11 smsl-n100 avahi-daemon[570]: Withdrawing address record for 192.168.1.99 on wlan0. Sep 08 18:37:11 smsl-n100 systemd[1]: wireless.service: Succeeded. Sep 08 18:37:11 smsl-n100 systemd[1]: Stopped Wireless Services. Sep 08 18:37:11 smsl-n100 volumio[1268]: info: Discovery: A device disappeared from network Sep 08 18:37:11 smsl-n100 systemd[1]: Starting Wireless Services... Sep 08 18:37:11 smsl-n100 volumio[1268]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Sep 08 18:37:11 smsl-n100 volumio[1268]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 08 18:37:11 smsl-n100 dhcpcd[602]: wlan0: deleting route to 192.168.1.0/24 Sep 08 18:37:11 smsl-n100 dhcpcd[602]: wlan0: deleting default route via 192.168.1.1 Sep 08 18:37:12 smsl-n100 volumio[1268]: info: Discovery: A device disappeared from network Sep 08 18:37:12 smsl-n100 wireless.js[2038]: Cleaning previous... Sep 08 18:37:12 smsl-n100 sudo[2074]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Sep 08 18:37:12 smsl-n100 sudo[2074]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 18:37:12 smsl-n100 sudo[2074]: pam_unix(sudo:session): session closed for user root Sep 08 18:37:12 smsl-n100 sudo[2076]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Sep 08 18:37:12 smsl-n100 sudo[2076]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 18:37:12 smsl-n100 ntpd[1257]: Deleting interface #4 wlan0, 192.168.1.99#123, interface stats: received=0, sent=0, dropped=0, active_time=127 secs Sep 08 18:37:12 smsl-n100 sudo[2076]: pam_unix(sudo:session): session closed for user root Sep 08 18:37:12 smsl-n100 wireless.js[2038]: Stopped aP Sep 08 18:37:12 smsl-n100 wireless.js[2038]: Wireless Networking DISABLED, not starting wireless flow Sep 08 18:37:12 smsl-n100 iwconfig[2083]: Error for wireless request "Set Power Management" (8B2C) : Sep 08 18:37:12 smsl-n100 iwconfig[2083]: SET failed on device wlan0 ; Operation not permitted. Sep 08 18:37:12 smsl-n100 systemd[1]: wireless.service: Succeeded. Sep 08 18:37:12 smsl-n100 systemd[1]: Started Wireless Services. Sep 08 18:37:12 smsl-n100 sudo[2025]: pam_unix(sudo:session): session closed for user root Sep 08 18:37:16 smsl-n100 volumio[1268]: info: Discovery: Started advertising with name: SMSL N100 Sep 08 18:37:16 smsl-n100 volumio[1268]: info: Reporting MCU Network Status: 1 Sep 08 18:37:16 smsl-n100 volumio[1268]: info: Volumio Network Manager: Network status updated: 1 Sep 08 18:37:16 smsl-n100 volumio[1268]: info: CoreStateMachine::pushState Sep 08 18:37:16 smsl-n100 volumio[1268]: info: CorePlayQueue::getTrack 0 Sep 08 18:37:16 smsl-n100 volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 08 18:37:16 smsl-n100 volumio[1268]: info: CoreCommandRouter::volumioPushState Sep 08 18:37:16 smsl-n100 volumio[1268]: error: Serial API: Failed to decode command: 100, message: undefined Sep 08 18:37:16 smsl-n100 volumio[1268]: error: Serial API: Failed to decode command: MAXVOL, message: Sep 08 18:37:16 smsl-n100 volumio[1268]: error: Serial API: Failed to decode command: 100, message: undefined Sep 08 18:37:16 smsl-n100 volumio[1268]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Sep 08 18:37:16 smsl-n100 volumio[1268]: error: Serial API: Failed to decode command: 1, message: undefined Sep 08 18:37:17 smsl-n100 volumio[1268]: info: Discovery: adding 705c5124-9849-4059-a727-697904c18933 Sep 08 18:37:17 smsl-n100 volumio[1268]: info: Discovery: Found device SMSL N100 Sep 08 18:37:17 smsl-n100 volumio[1268]: info: CoreCommandRouter::volumioGetState Sep 08 18:37:17 smsl-n100 volumio[1268]: info: CorePlayQueue::getTrack 0 Sep 08 18:37:17 smsl-n100 volumio[1268]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 08 18:37:17 smsl-n100 volumio[1268]: Error: The value NaN is not a number Sep 08 18:37:17 smsl-n100 volumio[1268]: at Config.forceToType (/volumio/node_modules/v-conf/index.js:322:20) Sep 08 18:37:17 smsl-n100 volumio[1268]: at Config.set (/volumio/node_modules/v-conf/index.js:153:25) Sep 08 18:37:17 smsl-n100 volumio[1268]: at ControllerVolumioDiscovery.updateMultiroomDevice (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:323:25) Sep 08 18:37:17 smsl-n100 volumio[1268]: at ControllerVolumioDiscovery.connectToRemoteVolumio (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:273:10) Sep 08 18:37:17 smsl-n100 volumio[1268]: at Browser. (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:192:12) Sep 08 18:37:17 smsl-n100 volumio[1268]: at Browser.emit (events.js:400:28) Sep 08 18:37:17 smsl-n100 volumio[1268]: at on_resolver_done (/volumio/node_modules/mdns/lib/browser.js:31:14) Sep 08 18:37:17 smsl-n100 volumio[1268]: at next (/volumio/node_modules/mdns/lib/browser.js:106:7) Sep 08 18:37:17 smsl-n100 volumio[1268]: at Array.makeAddressesUnique (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:177:5) Sep 08 18:37:17 smsl-n100 volumio[1268]: at next (/volumio/node_modules/mdns/lib/browser.js:109:21) Sep 08 18:37:17 smsl-n100 volumio[1268]: at /volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:160:11 Sep 08 18:37:17 smsl-n100 volumio[1268]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:108:7) Sep 08 18:37:17 smsl-n100 volumio[1268]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) Sep 08 18:37:17 smsl-n100 volumio[1268]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 08 18:37:18 smsl-n100 sudo[2109]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-08 18:36 Sep 08 18:37:18 smsl-n100 sudo[2109]: 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"