-- Logs begin at Mon 2025-04-14 22:27:11 CEST, end at Mon 2025-04-14 22:54:53 CEST. -- Apr 14 22:53:09 smsl-n100 volumio[1059]: info: CALLMETHOD: audio_interface alsa_controller saveResamplingOpts [object Object] Apr 14 22:53:09 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveResamplingOpts Apr 14 22:53:09 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: mpd , saveResampleOptions Apr 14 22:53:09 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:09 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:09 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:09 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:09 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:09 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:09 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:09 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:09 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 14 22:53:09 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 14 22:53:09 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:10 smsl-n100 sudo[6304]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 14 22:53:10 smsl-n100 sudo[6306]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 14 22:53:10 smsl-n100 sudo[6306]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:10 smsl-n100 sudo[6304]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:10 smsl-n100 sudo[6304]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:10 smsl-n100 volumio[1059]: info: MPD Permissions set Apr 14 22:53:10 smsl-n100 systemd[1]: Stopping Music Player Daemon... Apr 14 22:53:10 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 14 22:53:10 smsl-n100 systemd[1]: mpd.service: Succeeded. Apr 14 22:53:10 smsl-n100 systemd[1]: Stopped Music Player Daemon. Apr 14 22:53:10 smsl-n100 systemd[1]: Starting Music Player Daemon... Apr 14 22:53:10 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 14 22:53:10 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 14 22:53:10 smsl-n100 sudo[6315]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 14 22:53:10 smsl-n100 sudo[6315]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:10 smsl-n100 sudo[6315]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:13 smsl-n100 volumio[1059]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object] Apr 14 22:53:13 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions Apr 14 22:53:13 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioGetState Apr 14 22:53:13 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:13 smsl-n100 volumio[1059]: info: Restoring Previous Volume level: 100 false false Apr 14 22:53:13 smsl-n100 volumio[1059]: info: Output device has changed, restarting MPD Apr 14 22:53:13 smsl-n100 sudo[6321]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 14 22:53:13 smsl-n100 sudo[6321]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:13 smsl-n100 volumio[1059]: info: Output device has changed, restarting Shairport Sync Apr 14 22:53:13 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:13 smsl-n100 sudo[6321]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:13 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 14 22:53:13 smsl-n100 mpd[6317]: Apr 14 22:53 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 14 22:53:13 smsl-n100 sudo[6324]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 14 22:53:13 smsl-n100 sudo[6306]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:13 smsl-n100 systemd[1]: Started Music Player Daemon. Apr 14 22:53:13 smsl-n100 sudo[6324]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:13 smsl-n100 systemd[1]: Stopping Music Player Daemon... Apr 14 22:53:13 smsl-n100 systemd[1]: mpd.service: Succeeded. Apr 14 22:53:13 smsl-n100 volumio[1059]: xcb_connection_has_error() returned true Apr 14 22:53:13 smsl-n100 systemd[1]: Stopped Music Player Daemon. Apr 14 22:53:13 smsl-n100 volumio[1059]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 14 22:53:13 smsl-n100 volumio[1059]: xcb_connection_has_error() returned true Apr 14 22:53:13 smsl-n100 volumio[1059]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Apr 14 22:53:13 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:13 smsl-n100 systemd[1]: Starting Music Player Daemon... Apr 14 22:53:13 smsl-n100 volumio[1059]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Apr 14 22:53:13 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:13 smsl-n100 vtcs[6135]: [2025-04-14 22:53:13.560] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Apr 14 22:53:13 smsl-n100 vtcs[6135]: [2025-04-14 22:53:13.561] [tisoc] [error] [SpkconServer.cpp:473] socket write error. fd=3 errorno=32 error=Broken pipe Apr 14 22:53:13 smsl-n100 vtcs[6135]: [2025-04-14 22:53:13.561] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected Apr 14 22:53:13 smsl-n100 volumio[1059]: info: Volume configurations have been set Apr 14 22:53:13 smsl-n100 volumio[1059]: info: Reconfiguring and Restarting RAAT Plugin due to audio path changes Apr 14 22:53:13 smsl-n100 sudo[6336]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 14 22:53:13 smsl-n100 sudo[6336]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:13 smsl-n100 sudo[6339]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 14 22:53:13 smsl-n100 sudo[6339]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:13 smsl-n100 sudo[6332]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 14 22:53:13 smsl-n100 systemd[1]: Stopping Volumio Tidal Connect Service... Apr 14 22:53:13 smsl-n100 sudo[6332]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:13 smsl-n100 systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Apr 14 22:53:13 smsl-n100 systemd[1]: vtcs.service: Succeeded. Apr 14 22:53:13 smsl-n100 systemd[1]: Stopped Volumio Tidal Connect Service. Apr 14 22:53:13 smsl-n100 sudo[6332]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:13 smsl-n100 sudo[6336]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:13 smsl-n100 sudo[6339]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:13 smsl-n100 volumio[1059]: xcb_connection_has_error() returned true Apr 14 22:53:13 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 14 22:53:13 smsl-n100 volumio[1059]: info: Updating Volume Controller Parameters: Device: 1 Name: SPDIF Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Apr 14 22:53:13 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 14 22:53:13 smsl-n100 volumio[1059]: info: Disabling external Volume Control Apr 14 22:53:13 smsl-n100 volumio[1059]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 14 22:53:13 smsl-n100 volumio[1059]: info: CoreStateMachine::pushState Apr 14 22:53:13 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:13 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 22:53:13 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioPushState Apr 14 22:53:13 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output update for this device Apr 14 22:53:13 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output Apr 14 22:53:13 smsl-n100 sudo[6348]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 14 22:53:13 smsl-n100 sudo[6348]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:14 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 14 22:53:14 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 14 22:53:14 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 14 22:53:14 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 14 22:53:14 smsl-n100 sudo[6351]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 14 22:53:14 smsl-n100 sudo[6351]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:14 smsl-n100 sudo[6348]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:14 smsl-n100 volumio[1059]: info: Updating RAAT Signal Path Apr 14 22:53:14 smsl-n100 volumio[1059]: info: MPD Permissions set Apr 14 22:53:14 smsl-n100 sudo[6351]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 22:53:14 smsl-n100 volumio[1059]: info: Not Reporting Auto name since its the default one Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 22:53:14 smsl-n100 volumio[1059]: info: Not Reporting Auto name since its the default one Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreStateMachine::pushState Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioPushState Apr 14 22:53:14 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output update for this device Apr 14 22:53:14 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output Apr 14 22:53:14 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: 100, message: undefined Apr 14 22:53:14 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: MAXVOL, message: Apr 14 22:53:14 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: 100, message: undefined Apr 14 22:53:14 smsl-n100 volumio[1059]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreStateMachine::pushState Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioPushState Apr 14 22:53:14 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output update for this device Apr 14 22:53:14 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output Apr 14 22:53:14 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: 100, message: undefined Apr 14 22:53:14 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: MAXVOL, message: Apr 14 22:53:14 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: 100, message: undefined Apr 14 22:53:14 smsl-n100 volumio[1059]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:14 smsl-n100 volumio[1059]: xcb_connection_has_error() returned true Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 14 22:53:14 smsl-n100 volumio[1059]: xcb_connection_has_error() returned true Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: raat , getAdditionalUiSection Apr 14 22:53:14 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Apr 14 22:53:15 smsl-n100 volumio[1059]: xcb_connection_has_error() returned true Apr 14 22:53:15 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Apr 14 22:53:15 smsl-n100 sudo[6376]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Apr 14 22:53:15 smsl-n100 sudo[6376]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:15 smsl-n100 sudo[6376]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:15 smsl-n100 sudo[6380]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Apr 14 22:53:15 smsl-n100 volumio[1059]: xcb_connection_has_error() returned true Apr 14 22:53:15 smsl-n100 sudo[6380]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:15 smsl-n100 systemd[1]: Stopping RAAT DAEMON... Apr 14 22:53:15 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Apr 14 22:53:15 smsl-n100 systemd[1]: raat-daemon.service: Succeeded. Apr 14 22:53:15 smsl-n100 volumio[1059]: info: VolumeController::SetAlsaVolume0 Apr 14 22:53:15 smsl-n100 systemd[1]: Stopped RAAT DAEMON. Apr 14 22:53:15 smsl-n100 volumio[1059]: info: CoreStateMachine::pushState Apr 14 22:53:15 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:15 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 22:53:15 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioPushState Apr 14 22:53:15 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output update for this device Apr 14 22:53:15 smsl-n100 systemd[1]: Started RAAT DAEMON. Apr 14 22:53:15 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output Apr 14 22:53:15 smsl-n100 sudo[6380]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:15 smsl-n100 sudo[6383]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Apr 14 22:53:15 smsl-n100 sudo[6383]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:15 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 14 22:53:15 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 14 22:53:15 smsl-n100 volumio[1059]: info: Updating RAAT Signal Path Apr 14 22:53:15 smsl-n100 sudo[6383]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:15 smsl-n100 volumio[1059]: info: Raat Daemon started successfully Apr 14 22:53:15 smsl-n100 volumio[1059]: info: Starting Shairport Sync Apr 14 22:53:15 smsl-n100 sudo[6390]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Apr 14 22:53:15 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:15 smsl-n100 sudo[6390]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:15 smsl-n100 systemd[1]: Stopping RAAT DAEMON... Apr 14 22:53:15 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Apr 14 22:53:15 smsl-n100 systemd[1]: raat-daemon.service: Succeeded. Apr 14 22:53:15 smsl-n100 systemd[1]: Stopped RAAT DAEMON. Apr 14 22:53:15 smsl-n100 volumio[1059]: info: Executing endpoint restartRAATSocket Apr 14 22:53:15 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Apr 14 22:53:15 smsl-n100 systemd[1]: Started RAAT DAEMON. Apr 14 22:53:15 smsl-n100 sudo[6396]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 14 22:53:15 smsl-n100 sudo[6396]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:15 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 14 22:53:15 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 14 22:53:15 smsl-n100 sudo[6390]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:15 smsl-n100 volumio[1059]: info: Raat Daemon started successfully Apr 14 22:53:15 smsl-n100 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 14 22:53:15 smsl-n100 systemd[1]: shairport-sync.service: Succeeded. Apr 14 22:53:15 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 14 22:53:15 smsl-n100 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 14 22:53:15 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 14 22:53:15 smsl-n100 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 14 22:53:15 smsl-n100 sudo[6396]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:15 smsl-n100 volumio[1059]: info: Executing endpoint restartRAATSocket Apr 14 22:53:15 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Apr 14 22:53:15 smsl-n100 volumio[1059]: info: Shairport-Sync Started Apr 14 22:53:15 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:15 smsl-n100 volumio[1059]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Apr 14 22:53:16 smsl-n100 volumio[1059]: info: TidalConnect service stoped! Apr 14 22:53:16 smsl-n100 volumio[1059]: info: TidalConnect service stoped! Apr 14 22:53:17 smsl-n100 volumio[1059]: info: TidalConnect service stoped! Apr 14 22:53:17 smsl-n100 volumio[1059]: info: TidalConnect service stoped! Apr 14 22:53:17 smsl-n100 volumio[1059]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Apr 14 22:53:17 smsl-n100 volumio[1059]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Apr 14 22:53:17 smsl-n100 volumio[1059]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Apr 14 22:53:17 smsl-n100 volumio[1059]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Apr 14 22:53:17 smsl-n100 sudo[6431]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Apr 14 22:53:17 smsl-n100 sudo[6431]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:17 smsl-n100 sudo[6434]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Apr 14 22:53:17 smsl-n100 sudo[6434]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:17 smsl-n100 systemd[1]: Started Volumio Tidal Connect Service. Apr 14 22:53:17 smsl-n100 sudo[6431]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:17 smsl-n100 sudo[6434]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:17 smsl-n100 volumio[1059]: info: VolumeController::SetAlsaVolume100 Apr 14 22:53:17 smsl-n100 volumio[1059]: info: CoreStateMachine::pushState Apr 14 22:53:17 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:17 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 22:53:17 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioPushState Apr 14 22:53:17 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output update for this device Apr 14 22:53:17 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output Apr 14 22:53:17 smsl-n100 volumio[1059]: info: Updating RAAT Signal Path Apr 14 22:53:17 smsl-n100 mpd[6344]: Apr 14 22:53 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 14 22:53:17 smsl-n100 systemd[1]: Started Music Player Daemon. Apr 14 22:53:17 smsl-n100 volumio[1059]: error: updateQueue error: null Apr 14 22:53:17 smsl-n100 sudo[6324]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:17 smsl-n100 volumio[1059]: error: updateQueue error: null Apr 14 22:53:17 smsl-n100 volumio[1059]: info: Executing endpoint tc_getconfig Apr 14 22:53:17 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Apr 14 22:53:17 smsl-n100 vtcs[6435]: STARTING TidalConnect services, version: 1.4.0.34 Apr 14 22:53:18 smsl-n100 volumio[1059]: info: RAAT: Requesting Headphone Status Apr 14 22:53:18 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Apr 14 22:53:18 smsl-n100 volumio[1059]: info: CoreStateMachine::pushState Apr 14 22:53:18 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:18 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 22:53:18 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioPushState Apr 14 22:53:18 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output update for this device Apr 14 22:53:18 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output Apr 14 22:53:18 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: 100, message: undefined Apr 14 22:53:18 smsl-n100 vtcs[6435]: STARTED TidalConnect services. Apr 14 22:53:18 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: MAXVOL, message: Apr 14 22:53:18 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: 100, message: undefined Apr 14 22:53:18 smsl-n100 volumio[1059]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Apr 14 22:53:18 smsl-n100 volumio[1059]: info: Executing endpoint tc_connect Apr 14 22:53:18 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Apr 14 22:53:18 smsl-n100 volumio[1059]: info: Connecting to TidalConnect Apr 14 22:53:18 smsl-n100 volumio[1059]: info: CoreCommandRouter::servicePushState Apr 14 22:53:18 smsl-n100 volumio[1059]: info: CoreStateMachine::pushState Apr 14 22:53:18 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:18 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioPushState Apr 14 22:53:18 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output update for this device Apr 14 22:53:18 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output Apr 14 22:53:18 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:18 smsl-n100 volumio[1059]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Apr 14 22:53:18 smsl-n100 volumio[1059]: info: CoreCommandRouter::servicePushState Apr 14 22:53:18 smsl-n100 volumio[1059]: info: CoreStateMachine::pushState Apr 14 22:53:18 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:18 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioPushState Apr 14 22:53:18 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output update for this device Apr 14 22:53:18 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output Apr 14 22:53:18 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:18 smsl-n100 volumio[1059]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Apr 14 22:53:18 smsl-n100 volumio[1059]: info: RAAT: Requesting Headphone Status Apr 14 22:53:18 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Apr 14 22:53:18 smsl-n100 volumio[1059]: info: CoreStateMachine::pushState Apr 14 22:53:18 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:18 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 22:53:18 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioPushState Apr 14 22:53:18 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output update for this device Apr 14 22:53:18 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output Apr 14 22:53:18 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: 100, message: undefined Apr 14 22:53:18 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: MAXVOL, message: Apr 14 22:53:18 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: 100, message: undefined Apr 14 22:53:18 smsl-n100 volumio[1059]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Apr 14 22:53:18 smsl-n100 volumio[1059]: info: VolumeController::SetAlsaVolume0 Apr 14 22:53:18 smsl-n100 volumio[1059]: info: CoreStateMachine::pushState Apr 14 22:53:18 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:18 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 22:53:18 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioPushState Apr 14 22:53:18 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output update for this device Apr 14 22:53:18 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output Apr 14 22:53:18 smsl-n100 volumio[1059]: info: Updating RAAT Signal Path Apr 14 22:53:20 smsl-n100 volumio[1059]: info: TidalConnect service started! Apr 14 22:53:20 smsl-n100 volumio[1059]: info: TidalConnect service started! Apr 14 22:53:23 smsl-n100 volumio[1059]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object] Apr 14 22:53:23 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions Apr 14 22:53:23 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioGetState Apr 14 22:53:23 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:23 smsl-n100 volumio[1059]: info: Restoring Previous Volume level: 100 false true Apr 14 22:53:23 smsl-n100 volumio[1059]: info: VolumeController::SetAlsaVolume100 Apr 14 22:53:23 smsl-n100 volumio[1059]: info: Enable softmixer device for audio device number 1 Apr 14 22:53:23 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioStop Apr 14 22:53:23 smsl-n100 volumio[1059]: info: CoreStateMachine::stop Apr 14 22:53:23 smsl-n100 volumio[1059]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 14 22:53:23 smsl-n100 volumio[1059]: info: Enable softmixer device for audio device undefined Apr 14 22:53:23 smsl-n100 volumio[1059]: xcb_connection_has_error() returned true Apr 14 22:53:23 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 14 22:53:23 smsl-n100 volumio[1059]: info: Updating Volume Controller Parameters: Device: 1 Name: SPDIF Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Apr 14 22:53:23 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 14 22:53:23 smsl-n100 volumio[1059]: info: Disabling external Volume Control Apr 14 22:53:23 smsl-n100 volumio[1059]: info: Output device has changed, restarting MPD Apr 14 22:53:24 smsl-n100 sudo[6517]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 14 22:53:24 smsl-n100 sudo[6517]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:24 smsl-n100 volumio[1059]: info: Output device has changed, restarting Shairport Sync Apr 14 22:53:24 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:24 smsl-n100 sudo[6517]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:24 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 14 22:53:24 smsl-n100 sudo[6520]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 14 22:53:24 smsl-n100 sudo[6520]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:24 smsl-n100 systemd[1]: Stopping Music Player Daemon... Apr 14 22:53:24 smsl-n100 systemd[1]: mpd.service: Succeeded. Apr 14 22:53:24 smsl-n100 systemd[1]: Stopped Music Player Daemon. Apr 14 22:53:24 smsl-n100 volumio[1059]: xcb_connection_has_error() returned true Apr 14 22:53:24 smsl-n100 volumio[1059]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 14 22:53:24 smsl-n100 volumio[1059]: xcb_connection_has_error() returned true Apr 14 22:53:24 smsl-n100 volumio[1059]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Apr 14 22:53:24 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:24 smsl-n100 systemd[1]: Starting Music Player Daemon... Apr 14 22:53:24 smsl-n100 volumio[1059]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Apr 14 22:53:24 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:24 smsl-n100 vtcs[6435]: [2025-04-14 22:53:24.214] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Apr 14 22:53:24 smsl-n100 vtcs[6435]: [2025-04-14 22:53:24.217] [tisoc] [error] [SpkconServer.cpp:381] recv error. client fd=8 errorno=104 error=Connection reset by peer Apr 14 22:53:24 smsl-n100 vtcs[6435]: [2025-04-14 22:53:24.217] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected Apr 14 22:53:24 smsl-n100 volumio[1059]: info: Volume configurations have been set Apr 14 22:53:24 smsl-n100 volumio[1059]: info: Reconfiguring and Restarting RAAT Plugin due to audio path changes Apr 14 22:53:24 smsl-n100 sudo[6530]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 14 22:53:24 smsl-n100 sudo[6530]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:24 smsl-n100 sudo[6525]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 14 22:53:24 smsl-n100 sudo[6533]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 14 22:53:24 smsl-n100 sudo[6525]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:24 smsl-n100 systemd[1]: Stopping Volumio Tidal Connect Service... Apr 14 22:53:24 smsl-n100 sudo[6533]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:24 smsl-n100 systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Apr 14 22:53:24 smsl-n100 sudo[6530]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:24 smsl-n100 systemd[1]: vtcs.service: Succeeded. Apr 14 22:53:24 smsl-n100 systemd[1]: Stopped Volumio Tidal Connect Service. Apr 14 22:53:24 smsl-n100 sudo[6525]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:24 smsl-n100 sudo[6533]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:24 smsl-n100 volumio[1059]: xcb_connection_has_error() returned true Apr 14 22:53:24 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 14 22:53:24 smsl-n100 volumio[1059]: info: Updating Volume Controller Parameters: Device: 1 Name: SPDIF Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Apr 14 22:53:24 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 14 22:53:24 smsl-n100 volumio[1059]: info: Disabling external Volume Control Apr 14 22:53:24 smsl-n100 volumio[1059]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 14 22:53:24 smsl-n100 volumio[1059]: info: CoreStateMachine::pushState Apr 14 22:53:24 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:24 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 22:53:24 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioPushState Apr 14 22:53:24 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output update for this device Apr 14 22:53:24 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output Apr 14 22:53:24 smsl-n100 volumio[1059]: info: CoreStateMachine::pushState Apr 14 22:53:24 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:24 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioPushState Apr 14 22:53:24 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output update for this device Apr 14 22:53:24 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output Apr 14 22:53:24 smsl-n100 sudo[6548]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 14 22:53:24 smsl-n100 sudo[6548]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:24 smsl-n100 sudo[6548]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:24 smsl-n100 sudo[6551]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 14 22:53:24 smsl-n100 sudo[6551]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:24 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:24 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:24 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:24 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:24 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:24 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:24 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:24 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:24 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 22:53:24 smsl-n100 volumio[1059]: info: Not Reporting Auto name since its the default one Apr 14 22:53:24 smsl-n100 sudo[6551]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:24 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:24 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:24 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:24 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:24 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:24 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:24 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:24 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:24 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 22:53:24 smsl-n100 volumio[1059]: info: Not Reporting Auto name since its the default one Apr 14 22:53:25 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 14 22:53:25 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 14 22:53:25 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 14 22:53:25 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 14 22:53:25 smsl-n100 volumio[1059]: info: Updating RAAT Signal Path Apr 14 22:53:25 smsl-n100 volumio[1059]: info: Updating RAAT Signal Path Apr 14 22:53:25 smsl-n100 volumio[1059]: info: CoreStateMachine::pushState Apr 14 22:53:25 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:25 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 22:53:25 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioPushState Apr 14 22:53:25 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output update for this device Apr 14 22:53:25 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output Apr 14 22:53:25 smsl-n100 volumio[1059]: info: MPD Permissions set Apr 14 22:53:25 smsl-n100 volumio[1059]: info: CoreStateMachine::pushState Apr 14 22:53:25 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:25 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 22:53:25 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioPushState Apr 14 22:53:25 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output update for this device Apr 14 22:53:25 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output Apr 14 22:53:25 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: 100, message: undefined Apr 14 22:53:25 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: MAXVOL, message: Apr 14 22:53:25 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: 100, message: undefined Apr 14 22:53:25 smsl-n100 volumio[1059]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Apr 14 22:53:25 smsl-n100 volumio[1059]: info: CoreStateMachine::pushState Apr 14 22:53:25 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:25 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioPushState Apr 14 22:53:25 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output update for this device Apr 14 22:53:25 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output Apr 14 22:53:25 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: 100, message: undefined Apr 14 22:53:25 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: MAXVOL, message: Apr 14 22:53:25 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: 100, message: undefined Apr 14 22:53:25 smsl-n100 volumio[1059]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Apr 14 22:53:25 smsl-n100 volumio[1059]: info: Software Volume ALSA configuration written Apr 14 22:53:25 smsl-n100 volumio[1059]: info: Preparing to generate the ALSA configuration file Apr 14 22:53:25 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:25 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:25 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:25 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:25 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 14 22:53:25 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 14 22:53:25 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:25 smsl-n100 volumio[1059]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Apr 14 22:53:25 smsl-n100 volumio[1059]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Apr 14 22:53:25 smsl-n100 volumio[1059]: info: Reading ALSA contributions from plugins. Apr 14 22:53:25 smsl-n100 volumio[1059]: xcb_connection_has_error() returned true Apr 14 22:53:25 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 14 22:53:25 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 14 22:53:25 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 14 22:53:25 smsl-n100 volumio[1059]: xcb_connection_has_error() returned true Apr 14 22:53:25 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 22:53:25 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 22:53:25 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 22:53:25 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 22:53:25 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 22:53:25 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 22:53:25 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 22:53:25 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 14 22:53:25 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 14 22:53:25 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: raat , getAdditionalUiSection Apr 14 22:53:25 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Apr 14 22:53:25 smsl-n100 volumio[1059]: xcb_connection_has_error() returned true Apr 14 22:53:25 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Apr 14 22:53:25 smsl-n100 sudo[6576]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Apr 14 22:53:25 smsl-n100 sudo[6576]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:25 smsl-n100 sudo[6576]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:25 smsl-n100 sudo[6580]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Apr 14 22:53:26 smsl-n100 volumio[1059]: xcb_connection_has_error() returned true Apr 14 22:53:26 smsl-n100 sudo[6580]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:26 smsl-n100 systemd[1]: Stopping RAAT DAEMON... Apr 14 22:53:26 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Apr 14 22:53:26 smsl-n100 systemd[1]: raat-daemon.service: Succeeded. Apr 14 22:53:26 smsl-n100 systemd[1]: Stopped RAAT DAEMON. Apr 14 22:53:26 smsl-n100 volumio[1059]: info: VolumeController::SetAlsaVolume0 Apr 14 22:53:26 smsl-n100 systemd[1]: Started RAAT DAEMON. Apr 14 22:53:26 smsl-n100 sudo[6580]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:26 smsl-n100 sudo[6583]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Apr 14 22:53:26 smsl-n100 sudo[6583]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:26 smsl-n100 volumio[1059]: info: CoreStateMachine::pushState Apr 14 22:53:26 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:26 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 22:53:26 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioPushState Apr 14 22:53:26 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output update for this device Apr 14 22:53:26 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output Apr 14 22:53:26 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 14 22:53:26 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 14 22:53:26 smsl-n100 sudo[6583]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:26 smsl-n100 volumio[1059]: info: Updating RAAT Signal Path Apr 14 22:53:26 smsl-n100 volumio[1059]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: xcb_connection_has_error() returned true Apr 14 22:53:26 smsl-n100 volumio[1059]: amixer: Unable to find simple control '',0 Apr 14 22:53:26 smsl-n100 volumio[1059]: info: Raat Daemon started successfully Apr 14 22:53:26 smsl-n100 volumio[1059]: info: Starting Shairport Sync Apr 14 22:53:26 smsl-n100 sudo[6595]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Apr 14 22:53:26 smsl-n100 sudo[6595]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:26 smsl-n100 volumio[1059]: info: Executing endpoint restartRAATSocket Apr 14 22:53:26 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Apr 14 22:53:26 smsl-n100 systemd[1]: Stopping RAAT DAEMON... Apr 14 22:53:26 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Apr 14 22:53:26 smsl-n100 systemd[1]: raat-daemon.service: Succeeded. Apr 14 22:53:26 smsl-n100 systemd[1]: Stopped RAAT DAEMON. Apr 14 22:53:26 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:26 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:26 smsl-n100 sudo[6599]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 14 22:53:26 smsl-n100 sudo[6599]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:26 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 14 22:53:26 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 14 22:53:26 smsl-n100 systemd[1]: Started RAAT DAEMON. Apr 14 22:53:26 smsl-n100 sudo[6595]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:26 smsl-n100 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 14 22:53:26 smsl-n100 systemd[1]: shairport-sync.service: Succeeded. Apr 14 22:53:26 smsl-n100 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 14 22:53:26 smsl-n100 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 14 22:53:26 smsl-n100 sudo[6599]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:26 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 14 22:53:26 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 14 22:53:26 smsl-n100 volumio[1059]: info: Shairport-Sync Started Apr 14 22:53:26 smsl-n100 volumio[1059]: info: Raat Daemon started successfully Apr 14 22:53:26 smsl-n100 volumio[1059]: info: Executing endpoint restartRAATSocket Apr 14 22:53:26 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Apr 14 22:53:26 smsl-n100 volumio[1059]: info: Asound.conf file written Apr 14 22:53:26 smsl-n100 sudo[6617]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Apr 14 22:53:26 smsl-n100 sudo[6617]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:26 smsl-n100 sudo[6617]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:26 smsl-n100 volumio[1059]: xcb_connection_has_error() returned true Apr 14 22:53:26 smsl-n100 volumio[1059]: info: Output device has changed, restarting MPD Apr 14 22:53:27 smsl-n100 sudo[6622]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 14 22:53:27 smsl-n100 sudo[6622]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:27 smsl-n100 volumio[1059]: info: Output device has changed, restarting Shairport Sync Apr 14 22:53:27 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:27 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 14 22:53:27 smsl-n100 sudo[6622]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:27 smsl-n100 sudo[6625]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 14 22:53:27 smsl-n100 sudo[6625]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:27 smsl-n100 systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Apr 14 22:53:27 smsl-n100 systemd[1]: mpd.service: Succeeded. Apr 14 22:53:27 smsl-n100 systemd[1]: Stopped Music Player Daemon. Apr 14 22:53:27 smsl-n100 systemd[1]: Starting Music Player Daemon... Apr 14 22:53:27 smsl-n100 volumio[1059]: xcb_connection_has_error() returned true Apr 14 22:53:27 smsl-n100 volumio[1059]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 14 22:53:27 smsl-n100 volumio[1059]: xcb_connection_has_error() returned true Apr 14 22:53:27 smsl-n100 volumio[1059]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Apr 14 22:53:27 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:27 smsl-n100 volumio[1059]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Apr 14 22:53:27 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:27 smsl-n100 sudo[6634]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 14 22:53:27 smsl-n100 sudo[6634]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:27 smsl-n100 sudo[6630]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 14 22:53:27 smsl-n100 sudo[6630]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:27 smsl-n100 sudo[6630]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:27 smsl-n100 sudo[6634]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:28 smsl-n100 volumio[1059]: xcb_connection_has_error() returned true Apr 14 22:53:28 smsl-n100 volumio[1059]: Playing WAVE '/volumio/app/silence.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Apr 14 22:53:28 smsl-n100 volumio[1059]: xcb_connection_has_error() returned true Apr 14 22:53:28 smsl-n100 volumio[1059]: info: Reconfiguring and Restarting RAAT Plugin due to audio path changes Apr 14 22:53:28 smsl-n100 volumio[1059]: info: Output device has changed, restarting MPD Apr 14 22:53:28 smsl-n100 sudo[6658]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 14 22:53:28 smsl-n100 sudo[6658]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:28 smsl-n100 sudo[6661]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 14 22:53:28 smsl-n100 volumio[1059]: info: Output device has changed, restarting Shairport Sync Apr 14 22:53:28 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:28 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 14 22:53:28 smsl-n100 sudo[6661]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:28 smsl-n100 sudo[6661]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:28 smsl-n100 sudo[6658]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:28 smsl-n100 sudo[6663]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 14 22:53:28 smsl-n100 sudo[6663]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:28 smsl-n100 systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Apr 14 22:53:28 smsl-n100 systemd[1]: mpd.service: Succeeded. Apr 14 22:53:28 smsl-n100 systemd[1]: Stopped Music Player Daemon. Apr 14 22:53:28 smsl-n100 volumio[1059]: xcb_connection_has_error() returned true Apr 14 22:53:28 smsl-n100 volumio[1059]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 14 22:53:28 smsl-n100 volumio[1059]: xcb_connection_has_error() returned true Apr 14 22:53:28 smsl-n100 volumio[1059]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Apr 14 22:53:28 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:28 smsl-n100 systemd[1]: Starting Music Player Daemon... Apr 14 22:53:28 smsl-n100 volumio[1059]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Apr 14 22:53:28 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:28 smsl-n100 sudo[6674]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 14 22:53:28 smsl-n100 sudo[6674]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:28 smsl-n100 sudo[6670]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 14 22:53:28 smsl-n100 sudo[6670]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:29 smsl-n100 sudo[6674]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:29 smsl-n100 sudo[6670]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:29 smsl-n100 volumio[1059]: xcb_connection_has_error() returned true Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 14 22:53:29 smsl-n100 volumio[1059]: info: Updating Volume Controller Parameters: Device: 1 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 14 22:53:29 smsl-n100 volumio[1059]: info: Disabling external Volume Control Apr 14 22:53:29 smsl-n100 sudo[6689]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 14 22:53:29 smsl-n100 sudo[6689]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:29 smsl-n100 sudo[6692]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 14 22:53:29 smsl-n100 sudo[6692]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:29 smsl-n100 sudo[6689]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:29 smsl-n100 sudo[6695]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 14 22:53:29 smsl-n100 sudo[6695]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:29 smsl-n100 sudo[6692]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 22:53:29 smsl-n100 volumio[1059]: info: Not Reporting Auto name since its the default one Apr 14 22:53:29 smsl-n100 sudo[6695]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 22:53:29 smsl-n100 volumio[1059]: info: Not Reporting Auto name since its the default one Apr 14 22:53:29 smsl-n100 volumio[1059]: info: VolumeController::SetAlsaVolume100 Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CoreStateMachine::pushState Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioPushState Apr 14 22:53:29 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output update for this device Apr 14 22:53:29 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output Apr 14 22:53:29 smsl-n100 volumio[1059]: info: RAAT: Requesting Headphone Status Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Apr 14 22:53:29 smsl-n100 volumio[1059]: info: RAAT: Requesting Headphone Status Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Apr 14 22:53:29 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 14 22:53:29 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 14 22:53:29 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 14 22:53:29 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 14 22:53:29 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 14 22:53:29 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 14 22:53:29 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 14 22:53:29 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CoreStateMachine::pushState Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioPushState Apr 14 22:53:29 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output update for this device Apr 14 22:53:29 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output Apr 14 22:53:29 smsl-n100 volumio[1059]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: xcb_connection_has_error() returned true Apr 14 22:53:29 smsl-n100 volumio[1059]: amixer: Unable to find simple control '',0 Apr 14 22:53:29 smsl-n100 volumio[1059]: info: MPD Permissions set Apr 14 22:53:29 smsl-n100 volumio[1059]: info: MPD Permissions set Apr 14 22:53:29 smsl-n100 volumio[1059]: info: TidalConnect service stoped! Apr 14 22:53:29 smsl-n100 volumio[1059]: info: TidalConnect service stoped! Apr 14 22:53:29 smsl-n100 volumio[1059]: info: TidalConnect service stoped! Apr 14 22:53:29 smsl-n100 volumio[1059]: info: TidalConnect service stoped! Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 22:53:29 smsl-n100 volumio[1059]: info: Not Reporting Auto name since its the default one Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CoreStateMachine::pushState Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioPushState Apr 14 22:53:29 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output update for this device Apr 14 22:53:29 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output Apr 14 22:53:29 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: 100, message: undefined Apr 14 22:53:29 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: MAXVOL, message: Apr 14 22:53:29 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: 100, message: undefined Apr 14 22:53:29 smsl-n100 volumio[1059]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CoreStateMachine::pushState Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioPushState Apr 14 22:53:29 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output update for this device Apr 14 22:53:29 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output Apr 14 22:53:29 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: 100, message: undefined Apr 14 22:53:29 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: MAXVOL, message: Apr 14 22:53:29 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: 100, message: undefined Apr 14 22:53:29 smsl-n100 volumio[1059]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Apr 14 22:53:29 smsl-n100 volumio[1059]: info: CoreStateMachine::pushState Apr 14 22:53:30 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:30 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioPushState Apr 14 22:53:30 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output update for this device Apr 14 22:53:30 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output Apr 14 22:53:30 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: 100, message: undefined Apr 14 22:53:30 smsl-n100 volumio[1059]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Apr 14 22:53:30 smsl-n100 volumio[1059]: info: VolumeController::SetAlsaVolume0 Apr 14 22:53:30 smsl-n100 volumio[1059]: info: CoreStateMachine::pushState Apr 14 22:53:30 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:30 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 22:53:30 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioPushState Apr 14 22:53:30 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output update for this device Apr 14 22:53:30 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output Apr 14 22:53:30 smsl-n100 volumio[1059]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Apr 14 22:53:30 smsl-n100 volumio[1059]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Apr 14 22:53:30 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:30 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:30 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:30 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:30 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:30 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:30 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:30 smsl-n100 sudo[6731]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Apr 14 22:53:30 smsl-n100 sudo[6731]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:30 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 14 22:53:30 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 14 22:53:30 smsl-n100 systemd[1]: Started Volumio Tidal Connect Service. Apr 14 22:53:30 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:30 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:30 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:30 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:30 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:30 smsl-n100 sudo[6731]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:30 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 14 22:53:30 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 14 22:53:30 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:30 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Apr 14 22:53:31 smsl-n100 volumio[1059]: xcb_connection_has_error() returned true Apr 14 22:53:31 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Apr 14 22:53:31 smsl-n100 sudo[6752]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Apr 14 22:53:31 smsl-n100 sudo[6752]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:31 smsl-n100 sudo[6752]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:31 smsl-n100 sudo[6756]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Apr 14 22:53:31 smsl-n100 sudo[6756]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:31 smsl-n100 volumio[1059]: xcb_connection_has_error() returned true Apr 14 22:53:31 smsl-n100 systemd[1]: Stopping RAAT DAEMON... Apr 14 22:53:31 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Apr 14 22:53:31 smsl-n100 systemd[1]: raat-daemon.service: Succeeded. Apr 14 22:53:31 smsl-n100 systemd[1]: Stopped RAAT DAEMON. Apr 14 22:53:31 smsl-n100 systemd[1]: Started RAAT DAEMON. Apr 14 22:53:31 smsl-n100 sudo[6756]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:31 smsl-n100 volumio[1059]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Apr 14 22:53:31 smsl-n100 volumio[1059]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Apr 14 22:53:31 smsl-n100 sudo[6759]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Apr 14 22:53:31 smsl-n100 sudo[6759]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:31 smsl-n100 sudo[6759]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:31 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Apr 14 22:53:32 smsl-n100 sudo[6767]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Apr 14 22:53:32 smsl-n100 sudo[6767]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:32 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Apr 14 22:53:32 smsl-n100 sudo[6768]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Apr 14 22:53:32 smsl-n100 sudo[6768]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:32 smsl-n100 systemd[1]: Stopping RAAT DAEMON... Apr 14 22:53:32 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Apr 14 22:53:32 smsl-n100 systemd[1]: raat-daemon.service: Succeeded. Apr 14 22:53:32 smsl-n100 systemd[1]: Stopped RAAT DAEMON. Apr 14 22:53:32 smsl-n100 sudo[6772]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 14 22:53:32 smsl-n100 sudo[6772]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:32 smsl-n100 volumio[1059]: xcb_connection_has_error() returned true Apr 14 22:53:32 smsl-n100 sudo[6768]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:32 smsl-n100 systemd[1]: Started RAAT DAEMON. Apr 14 22:53:32 smsl-n100 sudo[6767]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:32 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 14 22:53:32 smsl-n100 systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Apr 14 22:53:32 smsl-n100 systemd[1]: mpd.service: Succeeded. Apr 14 22:53:32 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 14 22:53:32 smsl-n100 systemd[1]: Stopped Music Player Daemon. Apr 14 22:53:32 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 14 22:53:32 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 14 22:53:32 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 14 22:53:32 smsl-n100 sudo[6781]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Apr 14 22:53:32 smsl-n100 sudo[6781]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:32 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 14 22:53:32 smsl-n100 systemd[1]: Starting Music Player Daemon... Apr 14 22:53:32 smsl-n100 volumio[1059]: info: Raat Daemon started successfully Apr 14 22:53:32 smsl-n100 volumio[1059]: info: TidalConnect service stoped! Apr 14 22:53:32 smsl-n100 volumio[1059]: info: TidalConnect service stoped! Apr 14 22:53:32 smsl-n100 volumio[1059]: info: TidalConnect service stoped! Apr 14 22:53:32 smsl-n100 sudo[6781]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:32 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 14 22:53:32 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 14 22:53:32 smsl-n100 volumio[1059]: info: Executing endpoint tc_getconfig Apr 14 22:53:32 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Apr 14 22:53:32 smsl-n100 vtcs[6737]: STARTING TidalConnect services, version: 1.4.0.34 Apr 14 22:53:32 smsl-n100 sudo[6786]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Apr 14 22:53:32 smsl-n100 sudo[6786]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:32 smsl-n100 volumio[1059]: info: TidalConnect service stoped! Apr 14 22:53:32 smsl-n100 systemd[1]: Stopping RAAT DAEMON... Apr 14 22:53:32 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Apr 14 22:53:32 smsl-n100 systemd[1]: raat-daemon.service: Succeeded. Apr 14 22:53:32 smsl-n100 volumio[1059]: info: TidalConnect service stoped! Apr 14 22:53:32 smsl-n100 systemd[1]: Stopped RAAT DAEMON. Apr 14 22:53:32 smsl-n100 systemd[1]: Started RAAT DAEMON. Apr 14 22:53:32 smsl-n100 sudo[6786]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:32 smsl-n100 volumio[1059]: info: Raat Daemon started successfully Apr 14 22:53:32 smsl-n100 volumio[1059]: info: Starting Shairport Sync Apr 14 22:53:32 smsl-n100 sudo[6785]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 14 22:53:32 smsl-n100 sudo[6785]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:32 smsl-n100 vtcs[6737]: STARTED TidalConnect services. Apr 14 22:53:32 smsl-n100 sudo[6785]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:32 smsl-n100 volumio[1059]: info: Starting Shairport Sync Apr 14 22:53:32 smsl-n100 sudo[6810]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 14 22:53:32 smsl-n100 sudo[6810]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:32 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 14 22:53:32 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 14 22:53:32 smsl-n100 volumio[1059]: info: Updating RAAT Signal Path Apr 14 22:53:32 smsl-n100 sudo[6814]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 14 22:53:32 smsl-n100 sudo[6814]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:32 smsl-n100 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 14 22:53:32 smsl-n100 systemd[1]: shairport-sync.service: Succeeded. Apr 14 22:53:32 smsl-n100 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 14 22:53:32 smsl-n100 volumio[1059]: info: Raat Daemon started successfully Apr 14 22:53:32 smsl-n100 volumio[1059]: info: TidalConnect service stoped! Apr 14 22:53:33 smsl-n100 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 14 22:53:33 smsl-n100 sudo[6810]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:33 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 14 22:53:33 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 14 22:53:33 smsl-n100 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 14 22:53:33 smsl-n100 volumio[1059]: info: Shairport-Sync Started Apr 14 22:53:33 smsl-n100 systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Apr 14 22:53:33 smsl-n100 systemd[1]: shairport-sync.service: Succeeded. Apr 14 22:53:33 smsl-n100 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 14 22:53:33 smsl-n100 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 14 22:53:33 smsl-n100 sudo[6814]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:33 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 14 22:53:33 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 14 22:53:33 smsl-n100 volumio[1059]: info: Executing endpoint tc_connect Apr 14 22:53:33 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Apr 14 22:53:33 smsl-n100 volumio[1059]: info: Connecting to TidalConnect Apr 14 22:53:33 smsl-n100 volumio[1059]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Apr 14 22:53:33 smsl-n100 volumio[1059]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Apr 14 22:53:33 smsl-n100 sudo[6833]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Apr 14 22:53:33 smsl-n100 sudo[6833]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:33 smsl-n100 volumio[1059]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Apr 14 22:53:33 smsl-n100 volumio[1059]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Apr 14 22:53:33 smsl-n100 volumio[1059]: info: Shairport-Sync Started Apr 14 22:53:33 smsl-n100 sudo[6833]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:33 smsl-n100 volumio[1059]: info: CoreCommandRouter::servicePushState Apr 14 22:53:33 smsl-n100 volumio[1059]: info: CoreStateMachine::pushState Apr 14 22:53:33 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:33 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 22:53:33 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioPushState Apr 14 22:53:33 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output update for this device Apr 14 22:53:33 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output Apr 14 22:53:33 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:33 smsl-n100 volumio[1059]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Apr 14 22:53:33 smsl-n100 volumio[1059]: info: CoreCommandRouter::servicePushState Apr 14 22:53:33 smsl-n100 sudo[6850]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Apr 14 22:53:33 smsl-n100 sudo[6850]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:33 smsl-n100 volumio[1059]: info: CoreStateMachine::pushState Apr 14 22:53:33 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:33 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioPushState Apr 14 22:53:33 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output update for this device Apr 14 22:53:33 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output Apr 14 22:53:33 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:33 smsl-n100 volumio[1059]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Apr 14 22:53:33 smsl-n100 sudo[6850]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:33 smsl-n100 volumio[1059]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Apr 14 22:53:33 smsl-n100 volumio[1059]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Apr 14 22:53:33 smsl-n100 sudo[6855]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Apr 14 22:53:33 smsl-n100 sudo[6855]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:33 smsl-n100 volumio[1059]: info: TidalConnect service started! Apr 14 22:53:33 smsl-n100 volumio[1059]: info: Updating RAAT Signal Path Apr 14 22:53:33 smsl-n100 volumio[1059]: info: Updating RAAT Signal Path Apr 14 22:53:33 smsl-n100 sudo[6855]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:34 smsl-n100 volumio[1059]: info: RAAT: Requesting Headphone Status Apr 14 22:53:34 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Apr 14 22:53:34 smsl-n100 volumio[1059]: info: CoreStateMachine::pushState Apr 14 22:53:34 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:34 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 22:53:34 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioPushState Apr 14 22:53:34 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output update for this device Apr 14 22:53:34 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output Apr 14 22:53:34 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: 100, message: undefined Apr 14 22:53:34 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: MAXVOL, message: Apr 14 22:53:34 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: 100, message: undefined Apr 14 22:53:34 smsl-n100 volumio[1059]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Apr 14 22:53:34 smsl-n100 volumio[1059]: info: Executing endpoint restartRAATSocket Apr 14 22:53:34 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Apr 14 22:53:34 smsl-n100 volumio[1059]: info: RAAT: Requesting Headphone Status Apr 14 22:53:34 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Apr 14 22:53:34 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:34 smsl-n100 volumio[1059]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Apr 14 22:53:34 smsl-n100 volumio[1059]: info: CoreStateMachine::pushState Apr 14 22:53:34 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:34 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 22:53:34 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioPushState Apr 14 22:53:34 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output update for this device Apr 14 22:53:34 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output Apr 14 22:53:34 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: 100, message: undefined Apr 14 22:53:34 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: MAXVOL, message: Apr 14 22:53:34 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: 100, message: undefined Apr 14 22:53:34 smsl-n100 volumio[1059]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Apr 14 22:53:35 smsl-n100 volumio[1059]: info: TidalConnect service started! Apr 14 22:53:35 smsl-n100 volumio[1059]: info: RAAT: Requesting Headphone Status Apr 14 22:53:35 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Apr 14 22:53:35 smsl-n100 volumio[1059]: info: CoreStateMachine::pushState Apr 14 22:53:35 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:35 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 22:53:35 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioPushState Apr 14 22:53:35 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output update for this device Apr 14 22:53:35 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output Apr 14 22:53:35 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: 100, message: undefined Apr 14 22:53:35 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: MAXVOL, message: Apr 14 22:53:35 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: 100, message: undefined Apr 14 22:53:35 smsl-n100 volumio[1059]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Apr 14 22:53:35 smsl-n100 systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Apr 14 22:53:35 smsl-n100 systemd[1]: mpd.service: Failed with result 'protocol'. Apr 14 22:53:35 smsl-n100 systemd[1]: Failed to start Music Player Daemon. Apr 14 22:53:35 smsl-n100 sudo[6663]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:35 smsl-n100 sudo[6625]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:35 smsl-n100 volumio[1059]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Apr 14 22:53:35 smsl-n100 volumio[1059]: Job for mpd.service failed because the service did not take the steps required by its unit configuration. Apr 14 22:53:35 smsl-n100 volumio[1059]: See "systemctl status mpd.service" and "journalctl -xe" for details. Apr 14 22:53:35 smsl-n100 sudo[6772]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:35 smsl-n100 volumio[1059]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Apr 14 22:53:35 smsl-n100 volumio[1059]: Job for mpd.service failed because the service did not take the steps required by its unit configuration. Apr 14 22:53:35 smsl-n100 volumio[1059]: See "systemctl status mpd.service" and "journalctl -xe" for details. Apr 14 22:53:35 smsl-n100 sudo[6520]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:35 smsl-n100 volumio[1059]: error: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Apr 14 22:53:35 smsl-n100 volumio[1059]: Job for mpd.service failed because the service did not take the steps required by its unit configuration. Apr 14 22:53:35 smsl-n100 volumio[1059]: See "systemctl status mpd.service" and "journalctl -xe" for details. Apr 14 22:53:35 smsl-n100 volumio[1059]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Apr 14 22:53:35 smsl-n100 volumio[1059]: Job for mpd.service failed because the service did not take the steps required by its unit configuration. Apr 14 22:53:35 smsl-n100 volumio[1059]: See "systemctl status mpd.service" and "journalctl -xe" for details. Apr 14 22:53:35 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 14 22:53:35 smsl-n100 systemd[1]: Starting Music Player Daemon... Apr 14 22:53:35 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 14 22:53:35 smsl-n100 sudo[6866]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 14 22:53:35 smsl-n100 sudo[6866]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:35 smsl-n100 sudo[6866]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:36 smsl-n100 volumio[1059]: info: TidalConnect service started! Apr 14 22:53:36 smsl-n100 volumio[1059]: info: TidalConnect service started! Apr 14 22:53:36 smsl-n100 volumio[1059]: info: TidalConnect service started! Apr 14 22:53:38 smsl-n100 mpd[6868]: Apr 14 22:53 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 14 22:53:38 smsl-n100 systemd[1]: Started Music Player Daemon. Apr 14 22:53:38 smsl-n100 volumio[1059]: error: MPD error: The expression evaluated to a falsy value: Apr 14 22:53:38 smsl-n100 volumio[1059]: assert.ok(self.idling) Apr 14 22:53:38 smsl-n100 volumio[1059]: error: The expression evaluated to a falsy value: Apr 14 22:53:38 smsl-n100 volumio[1059]: assert.ok(self.idling) Apr 14 22:53:38 smsl-n100 volumio[1059]: error: MPD error: The expression evaluated to a falsy value: Apr 14 22:53:38 smsl-n100 volumio[1059]: assert.ok(self.idling) Apr 14 22:53:38 smsl-n100 volumio[1059]: error: The expression evaluated to a falsy value: Apr 14 22:53:38 smsl-n100 volumio[1059]: assert.ok(self.idling) Apr 14 22:53:38 smsl-n100 mpd_monitor.sh[539]: MPD restarted due to no mpc output. Apr 14 22:53:38 smsl-n100 volumio[1059]: error: updateQueue error: null Apr 14 22:53:54 smsl-n100 volumio[1059]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object] Apr 14 22:53:54 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions Apr 14 22:53:54 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioGetState Apr 14 22:53:54 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:54 smsl-n100 volumio[1059]: info: Restoring Previous Volume level: undefined undefined true Apr 14 22:53:54 smsl-n100 volumio[1059]: info: VolumeController::SetAlsaVolume100 Apr 14 22:53:54 smsl-n100 volumio[1059]: info: Volume configurations have been set Apr 14 22:53:54 smsl-n100 volumio[1059]: info: Reconfiguring and Restarting RAAT Plugin due to audio path changes Apr 14 22:53:54 smsl-n100 vtcs[6737]: [2025-04-14 22:53:54.941] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Apr 14 22:53:54 smsl-n100 vtcs[6737]: [2025-04-14 22:53:54.948] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected Apr 14 22:53:55 smsl-n100 sudo[6906]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 14 22:53:55 smsl-n100 sudo[6906]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:55 smsl-n100 systemd[1]: Stopping Volumio Tidal Connect Service... Apr 14 22:53:55 smsl-n100 systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Apr 14 22:53:55 smsl-n100 systemd[1]: vtcs.service: Succeeded. Apr 14 22:53:55 smsl-n100 systemd[1]: Stopped Volumio Tidal Connect Service. Apr 14 22:53:55 smsl-n100 sudo[6906]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:55 smsl-n100 volumio[1059]: xcb_connection_has_error() returned true Apr 14 22:53:55 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 14 22:53:55 smsl-n100 volumio[1059]: info: Updating Volume Controller Parameters: Device: 1 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Apr 14 22:53:55 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 14 22:53:55 smsl-n100 volumio[1059]: info: Disabling external Volume Control Apr 14 22:53:55 smsl-n100 volumio[1059]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 14 22:53:55 smsl-n100 volumio[1059]: info: CoreStateMachine::pushState Apr 14 22:53:55 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:55 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 22:53:55 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioPushState Apr 14 22:53:55 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output update for this device Apr 14 22:53:55 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output Apr 14 22:53:55 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 14 22:53:55 smsl-n100 sudo[6919]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 14 22:53:55 smsl-n100 sudo[6919]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:55 smsl-n100 volumio[1059]: info: Updating RAAT Signal Path Apr 14 22:53:55 smsl-n100 volumio[1059]: info: CoreStateMachine::pushState Apr 14 22:53:55 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:55 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 22:53:55 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioPushState Apr 14 22:53:55 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output update for this device Apr 14 22:53:55 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output Apr 14 22:53:55 smsl-n100 sudo[6919]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:55 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:55 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:55 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:55 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:55 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:55 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 22:53:55 smsl-n100 volumio[1059]: info: Not Reporting Auto name since its the default one Apr 14 22:53:55 smsl-n100 volumio[1059]: xcb_connection_has_error() returned true Apr 14 22:53:55 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 14 22:53:55 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 14 22:53:55 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 14 22:53:55 smsl-n100 volumio[1059]: xcb_connection_has_error() returned true Apr 14 22:53:55 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 22:53:55 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 22:53:55 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 22:53:55 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 22:53:55 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 22:53:55 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 22:53:55 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 22:53:55 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 14 22:53:55 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 14 22:53:55 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: raat , getAdditionalUiSection Apr 14 22:53:55 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Apr 14 22:53:55 smsl-n100 volumio[1059]: xcb_connection_has_error() returned true Apr 14 22:53:55 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:55 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 22:53:55 smsl-n100 sudo[6933]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Apr 14 22:53:55 smsl-n100 sudo[6933]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:55 smsl-n100 sudo[6933]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:56 smsl-n100 sudo[6935]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Apr 14 22:53:56 smsl-n100 sudo[6935]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:56 smsl-n100 systemd[1]: Stopping RAAT DAEMON... Apr 14 22:53:56 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Apr 14 22:53:56 smsl-n100 systemd[1]: raat-daemon.service: Succeeded. Apr 14 22:53:56 smsl-n100 systemd[1]: Stopped RAAT DAEMON. Apr 14 22:53:56 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 14 22:53:56 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 14 22:53:56 smsl-n100 systemd[1]: Started RAAT DAEMON. Apr 14 22:53:56 smsl-n100 sudo[6935]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:56 smsl-n100 volumio[1059]: info: Raat Daemon started successfully Apr 14 22:53:57 smsl-n100 volumio[1059]: info: Executing endpoint restartRAATSocket Apr 14 22:53:57 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Apr 14 22:53:57 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:57 smsl-n100 volumio[1059]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Apr 14 22:53:58 smsl-n100 volumio[1059]: info: TidalConnect service stoped! Apr 14 22:53:58 smsl-n100 volumio[1059]: info: TidalConnect service stoped! Apr 14 22:53:58 smsl-n100 volumio[1059]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Apr 14 22:53:58 smsl-n100 volumio[1059]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Apr 14 22:53:58 smsl-n100 sudo[6974]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Apr 14 22:53:58 smsl-n100 sudo[6974]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:53:58 smsl-n100 systemd[1]: Started Volumio Tidal Connect Service. Apr 14 22:53:58 smsl-n100 sudo[6974]: pam_unix(sudo:session): session closed for user root Apr 14 22:53:58 smsl-n100 volumio[1059]: info: RAAT: Requesting Headphone Status Apr 14 22:53:58 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Apr 14 22:53:58 smsl-n100 volumio[1059]: info: CoreStateMachine::pushState Apr 14 22:53:58 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:58 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 22:53:58 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioPushState Apr 14 22:53:58 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output update for this device Apr 14 22:53:58 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output Apr 14 22:53:58 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: 100, message: undefined Apr 14 22:53:58 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: MAXVOL, message: Apr 14 22:53:58 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: 100, message: undefined Apr 14 22:53:58 smsl-n100 volumio[1059]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Apr 14 22:53:59 smsl-n100 volumio[1059]: info: Executing endpoint tc_getconfig Apr 14 22:53:59 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Apr 14 22:53:59 smsl-n100 vtcs[6976]: STARTING TidalConnect services, version: 1.4.0.34 Apr 14 22:53:59 smsl-n100 volumio[1059]: info: VolumeController::SetAlsaVolume0 Apr 14 22:53:59 smsl-n100 volumio[1059]: info: CoreStateMachine::pushState Apr 14 22:53:59 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:59 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 22:53:59 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioPushState Apr 14 22:53:59 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output update for this device Apr 14 22:53:59 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output Apr 14 22:53:59 smsl-n100 vtcs[6976]: STARTED TidalConnect services. Apr 14 22:53:59 smsl-n100 volumio[1059]: info: Updating RAAT Signal Path Apr 14 22:53:59 smsl-n100 volumio[1059]: info: Executing endpoint tc_connect Apr 14 22:53:59 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Apr 14 22:53:59 smsl-n100 volumio[1059]: info: Connecting to TidalConnect Apr 14 22:53:59 smsl-n100 volumio[1059]: info: CoreCommandRouter::servicePushState Apr 14 22:53:59 smsl-n100 volumio[1059]: info: CoreStateMachine::pushState Apr 14 22:53:59 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:59 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 22:53:59 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioPushState Apr 14 22:53:59 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output update for this device Apr 14 22:53:59 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output Apr 14 22:53:59 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:59 smsl-n100 volumio[1059]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Apr 14 22:53:59 smsl-n100 volumio[1059]: info: CoreCommandRouter::servicePushState Apr 14 22:53:59 smsl-n100 volumio[1059]: info: CoreStateMachine::pushState Apr 14 22:53:59 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:59 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioPushState Apr 14 22:53:59 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output update for this device Apr 14 22:53:59 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output Apr 14 22:53:59 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:59 smsl-n100 volumio[1059]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Apr 14 22:53:59 smsl-n100 volumio[1059]: info: Updating RAAT Signal Path Apr 14 22:53:59 smsl-n100 volumio[1059]: info: Updating RAAT Signal Path Apr 14 22:53:59 smsl-n100 volumio[1059]: info: VolumeController::SetAlsaVolumeNaN Apr 14 22:53:59 smsl-n100 volumio[1059]: info: CoreStateMachine::pushState Apr 14 22:53:59 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:53:59 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 22:53:59 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioPushState Apr 14 22:53:59 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output update for this device Apr 14 22:53:59 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output Apr 14 22:54:01 smsl-n100 volumio[1059]: info: TidalConnect service started! Apr 14 22:54:25 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioGetState Apr 14 22:54:25 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:54:27 smsl-n100 volumio[1059]: info: Executing endpoint metavolumio Apr 14 22:54:27 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 14 22:54:31 smsl-n100 volumio[1059]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 14 22:54:31 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 14 22:54:31 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Apr 14 22:54:31 smsl-n100 sudo[7091]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Apr 14 22:54:31 smsl-n100 sudo[7091]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:54:31 smsl-n100 sudo[7091]: pam_unix(sudo:session): session closed for user root Apr 14 22:54:31 smsl-n100 sudo[7097]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 14 22:54:31 smsl-n100 sudo[7097]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:54:31 smsl-n100 sudo[7097]: pam_unix(sudo:session): session closed for user root Apr 14 22:54:31 smsl-n100 sudo[7104]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 14 22:54:31 smsl-n100 sudo[7104]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:54:31 smsl-n100 sudo[7104]: pam_unix(sudo:session): session closed for user root Apr 14 22:54:31 smsl-n100 sudo[7111]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 14 22:54:31 smsl-n100 sudo[7111]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:54:31 smsl-n100 sudo[7111]: pam_unix(sudo:session): session closed for user root Apr 14 22:54:31 smsl-n100 sudo[7117]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 14 22:54:31 smsl-n100 sudo[7117]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:54:31 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Apr 14 22:54:31 smsl-n100 sudo[7117]: pam_unix(sudo:session): session closed for user root Apr 14 22:54:31 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Apr 14 22:54:31 smsl-n100 sudo[7120]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 14 22:54:31 smsl-n100 sudo[7120]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:54:31 smsl-n100 sudo[7120]: pam_unix(sudo:session): session closed for user root Apr 14 22:54:31 smsl-n100 sudo[7123]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 14 22:54:31 smsl-n100 sudo[7123]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:54:35 smsl-n100 volumio[1059]: info: CALLMETHOD: system_controller network saveWiredNet [object Object] Apr 14 22:54:35 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: network , saveWiredNet Apr 14 22:54:35 smsl-n100 sudo[7126]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/network/interfaces Apr 14 22:54:35 smsl-n100 sudo[7126]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:54:35 smsl-n100 sudo[7126]: pam_unix(sudo:session): session closed for user root Apr 14 22:54:35 smsl-n100 sudo[7128]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/dhcpcd.conf Apr 14 22:54:35 smsl-n100 sudo[7128]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:54:35 smsl-n100 sudo[7128]: pam_unix(sudo:session): session closed for user root Apr 14 22:54:35 smsl-n100 volumio[1059]: info: Permissions for /etc/network/interfaces set Apr 14 22:54:35 smsl-n100 volumio[1059]: info: Restarting Wired Network Apr 14 22:54:35 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Apr 14 22:54:35 smsl-n100 volumio[1059]: info: Discovery: Restarting Advertising due to device name change Apr 14 22:54:35 smsl-n100 sudo[7131]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ip addr flush dev eth0 Apr 14 22:54:35 smsl-n100 sudo[7131]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:54:35 smsl-n100 avahi-daemon[548]: Withdrawing address record for 192.168.1.223 on eth0. Apr 14 22:54:35 smsl-n100 avahi-daemon[548]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.1.223. Apr 14 22:54:35 smsl-n100 dhcpcd[635]: eth0: pid 7132 deleted IP address 192.168.1.223/24 Apr 14 22:54:35 smsl-n100 dhcpcd[635]: eth0: deleting route to 192.168.1.0/24 Apr 14 22:54:35 smsl-n100 dhcpcd[635]: eth0: deleting default route via 192.168.1.1 Apr 14 22:54:35 smsl-n100 avahi-daemon[548]: Interface eth0.IPv4 no longer relevant for mDNS. Apr 14 22:54:35 smsl-n100 dhcpcd[907]: eth0: pid 7132 deleted IP address 192.168.1.223/24 Apr 14 22:54:35 smsl-n100 dhcpcd[907]: eth0: deleting route to 192.168.1.0/24 Apr 14 22:54:35 smsl-n100 dhcpcd[907]: eth0: deleting default route via 192.168.1.1 Apr 14 22:54:35 smsl-n100 sudo[7131]: pam_unix(sudo:session): session closed for user root Apr 14 22:54:35 smsl-n100 volumio[1059]: info: Discovery: A device disappeared from network Apr 14 22:54:35 smsl-n100 sudo[7135]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 down Apr 14 22:54:35 smsl-n100 sudo[7135]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:54:35 smsl-n100 dhcpcd[907]: eth0: rebinding lease of 192.168.1.223 Apr 14 22:54:35 smsl-n100 dhcpcd[635]: eth0: rebinding lease of 192.168.1.223 Apr 14 22:54:35 smsl-n100 kernel: rk_gmac-dwmac ff540000.ethernet eth0: Link is Down Apr 14 22:54:35 smsl-n100 dhcpcd[907]: eth0: carrier lost Apr 14 22:54:35 smsl-n100 dhcpcd[635]: eth0: carrier lost Apr 14 22:54:35 smsl-n100 sudo[7135]: pam_unix(sudo:session): session closed for user root Apr 14 22:54:35 smsl-n100 sudo[7159]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 up Apr 14 22:54:35 smsl-n100 sudo[7159]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:54:35 smsl-n100 kernel: rk_gmac-dwmac ff540000.ethernet eth0: PHY [stmmac-0:01] driver [Generic PHY] Apr 14 22:54:35 smsl-n100 kernel: rk_gmac-dwmac ff540000.ethernet eth0: No Safety Features support found Apr 14 22:54:35 smsl-n100 kernel: rk_gmac-dwmac ff540000.ethernet eth0: PTP not supported by HW Apr 14 22:54:35 smsl-n100 kernel: rk_gmac-dwmac ff540000.ethernet eth0: configuring for phy/rgmii link mode Apr 14 22:54:35 smsl-n100 sudo[7159]: pam_unix(sudo:session): session closed for user root Apr 14 22:54:36 smsl-n100 ifplugd(eth0)[719]: Link beat lost. Apr 14 22:54:37 smsl-n100 sudo[7123]: pam_unix(sudo:session): session closed for user root Apr 14 22:54:37 smsl-n100 ntpd[991]: Deleting interface #3 eth0, 192.168.1.223#123, interface stats: received=462, sent=462, dropped=2, active_time=1627 secs Apr 14 22:54:37 smsl-n100 ntpd[991]: 116.203.55.65 local addr 192.168.1.223 -> Apr 14 22:54:37 smsl-n100 ntpd[991]: 116.203.244.102 local addr 192.168.1.223 -> Apr 14 22:54:37 smsl-n100 ntpd[991]: 78.46.102.180 local addr 192.168.1.223 -> Apr 14 22:54:37 smsl-n100 ntpd[991]: 88.198.200.96 local addr 192.168.1.223 -> Apr 14 22:54:37 smsl-n100 ntpd[991]: 144.91.126.59 local addr 192.168.1.223 -> Apr 14 22:54:37 smsl-n100 ntpd[991]: 194.59.205.229 local addr 192.168.1.223 -> Apr 14 22:54:37 smsl-n100 ntpd[991]: 5.75.181.179 local addr 192.168.1.223 -> Apr 14 22:54:37 smsl-n100 ntpd[991]: 136.243.177.133 local addr 192.168.1.223 -> Apr 14 22:54:37 smsl-n100 ntpd[991]: 78.47.56.71 local addr 192.168.1.223 -> Apr 14 22:54:37 smsl-n100 ntpd[991]: 116.202.171.176 local addr 192.168.1.223 -> Apr 14 22:54:37 smsl-n100 ntpd[991]: 185.232.69.65 local addr 192.168.1.223 -> Apr 14 22:54:37 smsl-n100 ntpd[991]: 195.201.173.232 local addr 192.168.1.223 -> Apr 14 22:54:37 smsl-n100 ntpd[991]: 167.235.70.245 local addr 192.168.1.223 -> Apr 14 22:54:37 smsl-n100 ntpd[991]: 212.18.3.18 local addr 192.168.1.223 -> Apr 14 22:54:39 smsl-n100 volumio[1059]: info: Reporting MCU Network Status: 0 Apr 14 22:54:39 smsl-n100 volumio[1059]: info: Volumio Network Manager: Network status updated: 0 Apr 14 22:54:39 smsl-n100 volumio[1059]: info: CoreStateMachine::pushState Apr 14 22:54:39 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:54:39 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 22:54:39 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioPushState Apr 14 22:54:39 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output update for this device Apr 14 22:54:39 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output Apr 14 22:54:39 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: 100, message: undefined Apr 14 22:54:39 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: MAXVOL, message: Apr 14 22:54:39 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: 100, message: undefined Apr 14 22:54:39 smsl-n100 volumio[1059]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Apr 14 22:54:40 smsl-n100 volumio[1059]: info: Discovery: Started advertising with name: SMSL N100 Apr 14 22:54:41 smsl-n100 kernel: rk_gmac-dwmac ff540000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx Apr 14 22:54:41 smsl-n100 dhcpcd[635]: eth0: carrier acquired Apr 14 22:54:41 smsl-n100 dhcpcd[907]: eth0: carrier acquired Apr 14 22:54:41 smsl-n100 dhcpcd[635]: eth0: confile file changed, expiring leases Apr 14 22:54:41 smsl-n100 dhcpcd[907]: eth0: confile file changed, expiring leases Apr 14 22:54:41 smsl-n100 dhcpcd[635]: eth0: IAID 65:1f:a5:c8 Apr 14 22:54:41 smsl-n100 dhcpcd[907]: eth0: IAID 65:1f:a5:c8 Apr 14 22:54:41 smsl-n100 dhcpcd[635]: eth0: rebinding lease of 192.168.1.223 Apr 14 22:54:41 smsl-n100 dhcpcd[635]: eth0: probing address 192.168.1.223/24 Apr 14 22:54:41 smsl-n100 ifplugd(eth0)[719]: Link beat detected. Apr 14 22:54:41 smsl-n100 dhcpcd[907]: eth0: soliciting an IPv6 router Apr 14 22:54:41 smsl-n100 dhcpcd[907]: eth0: rebinding lease of 192.168.1.223 Apr 14 22:54:41 smsl-n100 dhcpcd[907]: eth0: probing address 192.168.1.223/24 Apr 14 22:54:41 smsl-n100 dhcpcd[635]: eth0: soliciting an IPv6 router Apr 14 22:54:45 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart Apr 14 22:54:46 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart Apr 14 22:54:46 smsl-n100 volumio[1059]: info: Refreshing Cached IP Addresses Apr 14 22:54:46 smsl-n100 sudo[7209]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Apr 14 22:54:46 smsl-n100 sudo[7209]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:54:46 smsl-n100 sudo[7209]: pam_unix(sudo:session): session closed for user root Apr 14 22:54:46 smsl-n100 sudo[7212]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 14 22:54:46 smsl-n100 sudo[7212]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:54:46 smsl-n100 sudo[7212]: pam_unix(sudo:session): session closed for user root Apr 14 22:54:46 smsl-n100 sudo[7215]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 14 22:54:46 smsl-n100 sudo[7215]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:54:46 smsl-n100 sudo[7215]: pam_unix(sudo:session): session closed for user root Apr 14 22:54:46 smsl-n100 dhcpcd[635]: eth0: leased 192.168.1.223 for 86400 seconds Apr 14 22:54:46 smsl-n100 dhcpcd[635]: eth0: adding route to 192.168.1.0/24 Apr 14 22:54:46 smsl-n100 avahi-daemon[548]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.223. Apr 14 22:54:46 smsl-n100 dhcpcd[635]: eth0: adding default route via 192.168.1.1 Apr 14 22:54:46 smsl-n100 avahi-daemon[548]: New relevant interface eth0.IPv4 for mDNS. Apr 14 22:54:46 smsl-n100 avahi-daemon[548]: Registering new address record for 192.168.1.223 on eth0.IPv4. Apr 14 22:54:46 smsl-n100 dhcpcd[907]: eth0: leased 192.168.1.223 for 86400 seconds Apr 14 22:54:46 smsl-n100 dhcpcd[907]: eth0: adding route to 192.168.1.0/24 Apr 14 22:54:46 smsl-n100 dhcpcd[907]: eth0: adding default route via 192.168.1.1 Apr 14 22:54:46 smsl-n100 ntpd[991]: ntpd exiting on signal 15 (Terminated) Apr 14 22:54:46 smsl-n100 systemd[1]: Stopping Network Time Service... Apr 14 22:54:46 smsl-n100 systemd[1]: ntp.service: Succeeded. Apr 14 22:54:46 smsl-n100 systemd[1]: Stopped Network Time Service. Apr 14 22:54:46 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 14 22:54:46 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 14 22:54:46 smsl-n100 systemd[1]: Starting Network Time Service... Apr 14 22:54:46 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 14 22:54:46 smsl-n100 volumio[1059]: info: CALLMETHOD: system_controller network saveWirelessNet [object Object] Apr 14 22:54:46 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNet Apr 14 22:54:46 smsl-n100 ntpd[7277]: ntpd 4.2.8p12@1.3728-o (1): Starting Apr 14 22:54:46 smsl-n100 ntpd[7277]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Apr 14 22:54:46 smsl-n100 systemd[1]: Started Network Time Service. Apr 14 22:54:46 smsl-n100 ntpd[7286]: proto: precision = 1.166 usec (-20) Apr 14 22:54:46 smsl-n100 ntpd[7286]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Apr 14 22:54:46 smsl-n100 ntpd[7286]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Apr 14 22:54:46 smsl-n100 ntpd[7286]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 839 days ago Apr 14 22:54:46 smsl-n100 ntpd[7286]: Listen and drop on 0 v6wildcard [::]:123 Apr 14 22:54:46 smsl-n100 ntpd[7286]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Apr 14 22:54:46 smsl-n100 ntpd[7286]: Listen normally on 2 lo 127.0.0.1:123 Apr 14 22:54:46 smsl-n100 ntpd[7286]: Listen normally on 3 eth0 192.168.1.223:123 Apr 14 22:54:46 smsl-n100 ntpd[7286]: Listening on routing socket on fd #20 for interface updates Apr 14 22:54:46 smsl-n100 ntpd[7286]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Apr 14 22:54:46 smsl-n100 ntpd[7286]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Apr 14 22:54:46 smsl-n100 ntpd[7286]: ntpd exiting on signal 15 (Terminated) Apr 14 22:54:46 smsl-n100 systemd[1]: Stopping Network Time Service... Apr 14 22:54:46 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioGetState Apr 14 22:54:46 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:54:46 smsl-n100 systemd[1]: ntp.service: Succeeded. Apr 14 22:54:46 smsl-n100 systemd[1]: Stopped Network Time Service. Apr 14 22:54:46 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 14 22:54:46 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 14 22:54:46 smsl-n100 systemd[1]: Starting Network Time Service... Apr 14 22:54:46 smsl-n100 sudo[7289]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/network/interfaces Apr 14 22:54:46 smsl-n100 sudo[7289]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:54:46 smsl-n100 sudo[7289]: pam_unix(sudo:session): session closed for user root Apr 14 22:54:46 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 14 22:54:46 smsl-n100 sudo[7297]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/dhcpcd.conf Apr 14 22:54:46 smsl-n100 ntpd[7292]: ntpd 4.2.8p12@1.3728-o (1): Starting Apr 14 22:54:46 smsl-n100 ntpd[7292]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Apr 14 22:54:46 smsl-n100 systemd[1]: Started Network Time Service. Apr 14 22:54:46 smsl-n100 sudo[7297]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:54:46 smsl-n100 ntpd[7300]: proto: precision = 1.166 usec (-20) Apr 14 22:54:46 smsl-n100 ntpd[7300]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Apr 14 22:54:46 smsl-n100 ntpd[7300]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Apr 14 22:54:46 smsl-n100 ntpd[7300]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 839 days ago Apr 14 22:54:46 smsl-n100 ntpd[7300]: Listen and drop on 0 v6wildcard [::]:123 Apr 14 22:54:46 smsl-n100 ntpd[7300]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Apr 14 22:54:46 smsl-n100 ntpd[7300]: Listen normally on 2 lo 127.0.0.1:123 Apr 14 22:54:46 smsl-n100 ntpd[7300]: Listen normally on 3 eth0 192.168.1.223:123 Apr 14 22:54:46 smsl-n100 ntpd[7300]: Listening on routing socket on fd #20 for interface updates Apr 14 22:54:46 smsl-n100 ntpd[7300]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Apr 14 22:54:46 smsl-n100 ntpd[7300]: kernel reports TIME_ERROR: 0x2041: Clock Unsynchronized Apr 14 22:54:46 smsl-n100 sudo[7297]: pam_unix(sudo:session): session closed for user root Apr 14 22:54:46 smsl-n100 volumio[1059]: info: Permissions for /etc/network/interfaces set Apr 14 22:54:46 smsl-n100 volumio[1059]: info: Restarting Wireless Network Apr 14 22:54:46 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Apr 14 22:54:46 smsl-n100 volumio[1059]: info: Discovery: Restarting Advertising due to device name change Apr 14 22:54:46 smsl-n100 sudo[7304]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Apr 14 22:54:46 smsl-n100 sudo[7304]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:54:46 smsl-n100 systemd[1]: Stopping Wireless Services... Apr 14 22:54:46 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 14 22:54:46 smsl-n100 wpa_supplicant[851]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Apr 14 22:54:46 smsl-n100 dhcpcd[635]: wlan0: carrier acquired Apr 14 22:54:46 smsl-n100 wpa_supplicant[851]: wlan0: CTRL-EVENT-TERMINATING Apr 14 22:54:46 smsl-n100 dhcpcd[635]: wlan0: confile file changed, expiring leases Apr 14 22:54:46 smsl-n100 systemd[1]: wireless.service: Succeeded. Apr 14 22:54:46 smsl-n100 systemd[1]: Stopped Wireless Services. Apr 14 22:54:47 smsl-n100 dhcpcd[635]: wlan0: IAID 2b:ee:c8:55 Apr 14 22:54:47 smsl-n100 dhcpcd[635]: wlan0: carrier lost Apr 14 22:54:47 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 14 22:54:47 smsl-n100 systemd[1]: Starting Wireless Services... Apr 14 22:54:47 smsl-n100 volumio[1059]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 14 22:54:47 smsl-n100 ntpd[7300]: Soliciting pool server 188.245.32.133 Apr 14 22:54:47 smsl-n100 volumio[1059]: info: Discovery: A device disappeared from network Apr 14 22:54:47 smsl-n100 wireless.js[7308]: Cleaning previous... Apr 14 22:54:48 smsl-n100 sudo[7335]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Apr 14 22:54:48 smsl-n100 sudo[7335]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:54:48 smsl-n100 sudo[7335]: pam_unix(sudo:session): session closed for user root Apr 14 22:54:48 smsl-n100 sudo[7337]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Apr 14 22:54:48 smsl-n100 sudo[7337]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:54:48 smsl-n100 sudo[7337]: pam_unix(sudo:session): session closed for user root Apr 14 22:54:48 smsl-n100 wireless.js[7308]: Stopped aP Apr 14 22:54:48 smsl-n100 sudo[7344]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Apr 14 22:54:48 smsl-n100 sudo[7344]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:54:48 smsl-n100 dhcpcd[635]: wlan0: carrier acquired Apr 14 22:54:48 smsl-n100 sudo[7344]: pam_unix(sudo:session): session closed for user root Apr 14 22:54:48 smsl-n100 dhcpcd[635]: wlan0: IAID 2b:ee:c8:55 Apr 14 22:54:48 smsl-n100 sudo[7347]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Apr 14 22:54:48 smsl-n100 sudo[7347]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:54:48 smsl-n100 sudo[7347]: pam_unix(sudo:session): session closed for user root Apr 14 22:54:48 smsl-n100 sudo[7354]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Apr 14 22:54:48 smsl-n100 sudo[7354]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:54:48 smsl-n100 sudo[7354]: pam_unix(sudo:session): session closed for user root Apr 14 22:54:48 smsl-n100 dhcpcd[635]: wlan0: soliciting an IPv6 router Apr 14 22:54:48 smsl-n100 sudo[7356]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Apr 14 22:54:48 smsl-n100 sudo[7356]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:54:48 smsl-n100 volumio[1059]: info: Executing endpoint metavolumio Apr 14 22:54:48 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 14 22:54:48 smsl-n100 ntpd[7300]: Soliciting pool server 167.235.139.237 Apr 14 22:54:49 smsl-n100 dhcpcd[635]: wlan0: soliciting a DHCP lease Apr 14 22:54:49 smsl-n100 ntpd[7300]: Soliciting pool server 128.140.109.119 Apr 14 22:54:49 smsl-n100 volumio[1059]: info: Reporting MCU Network Status: 1 Apr 14 22:54:49 smsl-n100 volumio[1059]: info: Volumio Network Manager: Network status updated: 1 Apr 14 22:54:49 smsl-n100 volumio[1059]: info: CoreStateMachine::pushState Apr 14 22:54:49 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:54:49 smsl-n100 volumio[1059]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 22:54:49 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioPushState Apr 14 22:54:49 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output update for this device Apr 14 22:54:49 smsl-n100 volumio[1059]: info: MRS: Pushing multiroomSync output Apr 14 22:54:49 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: 100, message: undefined Apr 14 22:54:49 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: MAXVOL, message: Apr 14 22:54:49 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: 100, message: undefined Apr 14 22:54:49 smsl-n100 volumio[1059]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Apr 14 22:54:49 smsl-n100 volumio[1059]: error: Serial API: Failed to decode command: 1, message: undefined Apr 14 22:54:49 smsl-n100 ntpd[7300]: Soliciting pool server 129.70.132.34 Apr 14 22:54:49 smsl-n100 ntpd[7300]: Soliciting pool server 185.13.148.71 Apr 14 22:54:49 smsl-n100 ntpd[7300]: Soliciting pool server 194.59.205.229 Apr 14 22:54:50 smsl-n100 ntpd[7300]: Soliciting pool server 217.160.19.219 Apr 14 22:54:50 smsl-n100 ntpd[7300]: Soliciting pool server 144.76.43.40 Apr 14 22:54:50 smsl-n100 ntpd[7300]: Soliciting pool server 94.16.122.152 Apr 14 22:54:50 smsl-n100 ntpd[7300]: Soliciting pool server 130.162.220.39 Apr 14 22:54:51 smsl-n100 volumio[1059]: info: Discovery: Browse raised the following error Error: dns service error: unknown Apr 14 22:54:51 smsl-n100 ntpd[7300]: Soliciting pool server 144.76.76.107 Apr 14 22:54:51 smsl-n100 ntpd[7300]: Soliciting pool server 88.198.7.62 Apr 14 22:54:51 smsl-n100 ntpd[7300]: Soliciting pool server 79.133.44.142 Apr 14 22:54:51 smsl-n100 volumio[1059]: info: Discovery: Started advertising with name: SMSL N100 Apr 14 22:54:52 smsl-n100 ntpd[7300]: Soliciting pool server 85.214.38.116 Apr 14 22:54:52 smsl-n100 ntpd[7300]: Soliciting pool server 116.202.100.11 Apr 14 22:54:52 smsl-n100 volumio[1059]: info: Discovery: adding e2c5ed56-60a3-4ebc-9041-fb4e312aba0d Apr 14 22:54:52 smsl-n100 volumio[1059]: info: Discovery: Found device SMSL N100 Apr 14 22:54:52 smsl-n100 volumio[1059]: info: CoreCommandRouter::volumioGetState Apr 14 22:54:52 smsl-n100 volumio[1059]: info: CorePlayQueue::getTrack 0 Apr 14 22:54:52 smsl-n100 volumio[1059]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 14 22:54:52 smsl-n100 volumio[1059]: Error: The value NaN is not a number Apr 14 22:54:52 smsl-n100 volumio[1059]: at Config.forceToType (/volumio/node_modules/v-conf/index.js:322:20) Apr 14 22:54:52 smsl-n100 volumio[1059]: at Config.set (/volumio/node_modules/v-conf/index.js:153:25) Apr 14 22:54:52 smsl-n100 volumio[1059]: at ControllerVolumioDiscovery.updateMultiroomDevice (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:323:25) Apr 14 22:54:52 smsl-n100 volumio[1059]: at ControllerVolumioDiscovery.connectToRemoteVolumio (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:273:10) Apr 14 22:54:52 smsl-n100 volumio[1059]: at Browser. (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:192:12) Apr 14 22:54:52 smsl-n100 volumio[1059]: at Browser.emit (events.js:400:28) Apr 14 22:54:52 smsl-n100 volumio[1059]: at on_resolver_done (/volumio/node_modules/mdns/lib/browser.js:31:14) Apr 14 22:54:52 smsl-n100 volumio[1059]: at next (/volumio/node_modules/mdns/lib/browser.js:106:7) Apr 14 22:54:52 smsl-n100 volumio[1059]: at Array.makeAddressesUnique (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:177:5) Apr 14 22:54:52 smsl-n100 volumio[1059]: at next (/volumio/node_modules/mdns/lib/browser.js:109:21) Apr 14 22:54:52 smsl-n100 volumio[1059]: at /volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:160:11 Apr 14 22:54:52 smsl-n100 volumio[1059]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:108:7) Apr 14 22:54:52 smsl-n100 volumio[1059]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) Apr 14 22:54:52 smsl-n100 volumio[1059]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 14 22:54:53 smsl-n100 ntpd[7300]: Soliciting pool server 89.58.51.72 Apr 14 22:54:53 smsl-n100 ntpd[7300]: Soliciting pool server 2a0e:b107:27d0:1::6 Apr 14 22:54:53 smsl-n100 sudo[7356]: pam_unix(sudo:session): session closed for user root Apr 14 22:54:53 smsl-n100 wireless.js[7308]: Start wireless flow Apr 14 22:54:53 smsl-n100 wireless.js[7308]: Stopped hotspot (if there).. Apr 14 22:54:53 smsl-n100 sudo[7389]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-14 22:53 Apr 14 22:54:53 smsl-n100 sudo[7390]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Apr 14 22:54:53 smsl-n100 sudo[7389]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:54:53 smsl-n100 sudo[7390]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:54:53 smsl-n100 sudo[7390]: pam_unix(sudo:session): session closed for user root Apr 14 22:54:54 smsl-n100 sudo[7393]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Apr 14 22:54:54 smsl-n100 sudo[7393]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 22:54:54 smsl-n100 dhcpcd[635]: wlan0: carrier lost Apr 14 22:54:54 smsl-n100 sudo[7393]: pam_unix(sudo:session): session closed for user root Apr 14 22:54:54 smsl-n100 wireless.js[7308]: DHCP IP Apr 14 22:54:54 smsl-n100 wireless.js[7308]: Start ap Apr 14 22:54:54 smsl-n100 wpa_supplicant[7399]: Successfully initialized wpa_supplicant 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"