-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Sat 2026-05-30 19:27:48 CST. -- May 30 19:26:19 smsl-n100 kernel: usb 4-1: new high-speed USB device number 3 using xhci-hcd May 30 19:26:19 smsl-n100 kernel: usb 4-1: New USB device found, idVendor=0499, idProduct=3111, bcdDevice= 1.00 May 30 19:26:19 smsl-n100 kernel: usb 4-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 May 30 19:26:19 smsl-n100 kernel: usb 4-1: Product: Yamaha USB DAC May 30 19:26:19 smsl-n100 kernel: usb 4-1: Manufacturer: Yamaha Corporation May 30 19:26:19 smsl-n100 kernel: hid-generic 0003:0499:3111.0002: hiddev96,hidraw0: USB HID v1.10 Device [Yamaha Corporation Yamaha USB DAC] on usb-xhci-hcd.0.auto-1/input3 May 30 19:26:19 smsl-n100 volumio[985]: info: May 30 19:26:19 smsl-n100 volumio[985]: ---------------------------- USB Audio Device Attached May 30 19:26:19 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach May 30 19:26:19 smsl-n100 volumio[985]: xcb_connection_has_error() returned true May 30 19:26:19 smsl-n100 volumio[985]: info: CoreCommandRouter::Close All Modals sent May 30 19:26:19 smsl-n100 volumio[985]: info: Preparing to save Alsa Options, stopping services first May 30 19:26:19 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioGetState May 30 19:26:19 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPause May 30 19:26:19 smsl-n100 volumio[985]: info: CoreStateMachine::pause May 30 19:26:19 smsl-n100 volumio[985]: info: CoreStateMachine::stPlaybackTimer May 30 19:26:19 smsl-n100 volumio[985]: info: CoreStateMachine::servicePause May 30 19:26:19 smsl-n100 volumio[985]: info: CoreCommandRouter::servicePause May 30 19:26:19 smsl-n100 volumio[985]: info: Airplay Pause with DBUS Call May 30 19:26:19 smsl-n100 volumio[985]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"Yamaha USB DAC","alsacard":"DAC"},"i2s":false} May 30 19:26:19 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 30 19:26:19 smsl-n100 volumio[985]: xcb_connection_has_error() returned true May 30 19:26:20 smsl-n100 volumio[985]: xcb_connection_has_error() returned true May 30 19:26:20 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 30 19:26:20 smsl-n100 volumio[985]: xcb_connection_has_error() returned true May 30 19:26:20 smsl-n100 volumio[985]: info: Setting mixer PCM for card Yamaha USB DAC May 30 19:26:20 smsl-n100 volumio[985]: info: Reconfiguring and Restarting RAAT Plugin due to audio path changes May 30 19:26:20 smsl-n100 vtcs[1446]: [2026-05-30 19:26:20.190] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE May 30 19:26:20 smsl-n100 vtcs[1446]: [2026-05-30 19:26:20.193] [tisoc] [error] [SpkconServer.cpp:381] recv error. client fd=8 errorno=104 error=Connection reset by peer May 30 19:26:20 smsl-n100 vtcs[1446]: [2026-05-30 19:26:20.194] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected May 30 19:26:20 smsl-n100 sudo[1808]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 30 19:26:20 smsl-n100 sudo[1808]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 19:26:20 smsl-n100 systemd[1]: Stopping Volumio Tidal Connect Service... May 30 19:26:20 smsl-n100 systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM May 30 19:26:20 smsl-n100 systemd[1]: vtcs.service: Succeeded. May 30 19:26:20 smsl-n100 systemd[1]: Stopped Volumio Tidal Connect Service. May 30 19:26:20 smsl-n100 sudo[1808]: pam_unix(sudo:session): session closed for user root May 30 19:26:20 smsl-n100 volumio[985]: xcb_connection_has_error() returned true May 30 19:26:20 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioUpdateVolumeSettings May 30 19:26:20 smsl-n100 volumio[985]: info: Updating Volume Controller Parameters: Device: 5 Name: Yamaha USB DAC Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 May 30 19:26:20 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume May 30 19:26:20 smsl-n100 volumio[985]: info: Disabling external Volume Control May 30 19:26:20 smsl-n100 volumio[985]: info: CoreCommandRouter::getUIConfigOnPlugin May 30 19:26:20 smsl-n100 volumio[985]: info: Preparing to generate the ALSA configuration file May 30 19:26:20 smsl-n100 volumio[985]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf May 30 19:26:20 smsl-n100 volumio[985]: info: Reading ALSA contributions from plugins. May 30 19:26:20 smsl-n100 sudo[1815]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 30 19:26:20 smsl-n100 sudo[1815]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 19:26:20 smsl-n100 volumio[985]: ------------------------------------ BT MESSAGE: BT STATUS: running May 30 19:26:20 smsl-n100 sudo[1815]: pam_unix(sudo:session): session closed for user root May 30 19:26:20 smsl-n100 volumio[985]: info: Error Airplay DBUS Call Pause: Error: Command failed: /usr/bin/dbus-send --system --print-reply --type=method_call --dest=org.gnome.ShairportSync '/org/gnome/ShairportSync' org.gnome.ShairportSync.RemoteControl.Pause May 30 19:26:20 smsl-n100 volumio[985]: Error org.freedesktop.DBus.Error.ServiceUnknown: The name org.gnome.ShairportSync was not provided by any .service files May 30 19:26:20 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:26:20 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:26:20 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:26:20 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:26:20 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:26:20 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:26:20 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:26:20 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 30 19:26:20 smsl-n100 volumio[985]: info: Not Reporting Auto name since its the default one May 30 19:26:20 smsl-n100 volumio[985]: info: Executing endpoint scanAudioInputs May 30 19:26:20 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: smart_inputs , scanAudioInputs May 30 19:26:20 smsl-n100 volumio[985]: info: Scanning Audio Inputs May 30 19:26:20 smsl-n100 volumio[985]: xcb_connection_has_error() returned true May 30 19:26:20 smsl-n100 volumio[985]: info: Checking against Known Cards name May 30 19:26:20 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 30 19:26:20 smsl-n100 volumio[985]: info: [1780140380881] CoreMusicLibrary::Adding element Yamaha USB DAC May 30 19:26:20 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 30 19:26:20 smsl-n100 volumio[985]: Cannot find translation for source Yamaha USB DAC May 30 19:26:20 smsl-n100 volumio[985]: info: Checking against Known Cards name May 30 19:26:20 smsl-n100 volumio[985]: info: VolumeController:: Volume=0 Mute =false May 30 19:26:20 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:26:20 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 19:26:20 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:26:20 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:26:20 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:26:20 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat May 30 19:26:21 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:26:21 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:26:21 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:26:21 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:26:21 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:26:21 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:26:21 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:26:21 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:26:21 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 30 19:26:21 smsl-n100 volumio[985]: info: Not Reporting Auto name since its the default one May 30 19:26:21 smsl-n100 volumio[985]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined May 30 19:26:21 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:26:21 smsl-n100 volumio[985]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined May 30 19:26:21 smsl-n100 volumio[985]: xcb_connection_has_error() returned true May 30 19:26:21 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 30 19:26:21 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 30 19:26:21 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 30 19:26:21 smsl-n100 volumio[985]: xcb_connection_has_error() returned true May 30 19:26:21 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 30 19:26:21 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 30 19:26:21 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 30 19:26:21 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 30 19:26:21 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 30 19:26:21 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 30 19:26:21 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 30 19:26:21 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode May 30 19:26:21 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 30 19:26:21 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: raat , getAdditionalUiSection May 30 19:26:21 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable May 30 19:26:21 smsl-n100 volumio[985]: xcb_connection_has_error() returned true May 30 19:26:21 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable May 30 19:26:21 smsl-n100 sudo[1836]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service May 30 19:26:21 smsl-n100 sudo[1836]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 19:26:21 smsl-n100 sudo[1836]: pam_unix(sudo:session): session closed for user root May 30 19:26:21 smsl-n100 sudo[1840]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service May 30 19:26:21 smsl-n100 sudo[1840]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 19:26:21 smsl-n100 volumio[985]: xcb_connection_has_error() returned true May 30 19:26:21 smsl-n100 systemd[1]: Started RAAT DAEMON. May 30 19:26:21 smsl-n100 sudo[1840]: pam_unix(sudo:session): session closed for user root May 30 19:26:21 smsl-n100 sudo[1844]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service May 30 19:26:21 smsl-n100 sudo[1844]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 19:26:21 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:26:21 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:26:21 smsl-n100 volumio[985]: info: Raat Daemon started successfully May 30 19:26:21 smsl-n100 volumio[985]: info: Asound.conf file unchanged, so no further update is needed May 30 19:26:21 smsl-n100 volumio[985]: info: Output device has changed, restarting MPD May 30 19:26:21 smsl-n100 sudo[1844]: pam_unix(sudo:session): session closed for user root May 30 19:26:21 smsl-n100 sudo[1850]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service May 30 19:26:21 smsl-n100 sudo[1850]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 19:26:21 smsl-n100 sudo[1852]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 30 19:26:21 smsl-n100 sudo[1852]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 19:26:21 smsl-n100 systemd[1]: Stopping RAAT DAEMON... May 30 19:26:21 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM May 30 19:26:21 smsl-n100 systemd[1]: raat-daemon.service: Succeeded. May 30 19:26:21 smsl-n100 sudo[1852]: pam_unix(sudo:session): session closed for user root May 30 19:26:21 smsl-n100 systemd[1]: Stopped RAAT DAEMON. May 30 19:26:21 smsl-n100 systemd[1]: Started RAAT DAEMON. May 30 19:26:21 smsl-n100 volumio[985]: info: Output device has changed, restarting Shairport Sync May 30 19:26:21 smsl-n100 sudo[1850]: pam_unix(sudo:session): session closed for user root May 30 19:26:21 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:26:21 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 30 19:26:21 smsl-n100 sudo[1861]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 30 19:26:21 smsl-n100 sudo[1861]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 19:26:22 smsl-n100 systemd[1]: Stopping Music Player Daemon... May 30 19:26:22 smsl-n100 volumio[985]: xcb_connection_has_error() returned true May 30 19:26:22 smsl-n100 volumio[985]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 30 19:26:22 smsl-n100 volumio[985]: xcb_connection_has_error() returned true May 30 19:26:22 smsl-n100 volumio[985]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration May 30 19:26:22 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:26:22 smsl-n100 systemd[1]: mpd.service: Succeeded. May 30 19:26:22 smsl-n100 systemd[1]: Stopped Music Player Daemon. May 30 19:26:22 smsl-n100 volumio[985]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes May 30 19:26:22 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:26:22 smsl-n100 systemd[1]: Starting Music Player Daemon... May 30 19:26:22 smsl-n100 sudo[1879]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 30 19:26:22 smsl-n100 sudo[1879]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 19:26:22 smsl-n100 volumio[985]: ------------------------------------ BT MESSAGE: BT STATUS: running May 30 19:26:22 smsl-n100 volumio[985]: ------------------------------------ BT MESSAGE: BT STATUS: waiting May 30 19:26:22 smsl-n100 sudo[1882]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 30 19:26:22 smsl-n100 sudo[1882]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 19:26:22 smsl-n100 volumio[985]: ------------------------------------ BT MESSAGE: BT STATUS: running May 30 19:26:22 smsl-n100 sudo[1879]: pam_unix(sudo:session): session closed for user root May 30 19:26:22 smsl-n100 volumio[985]: ------------------------------------ BT MESSAGE: BT STATUS: waiting May 30 19:26:22 smsl-n100 volumio[985]: ------------------------------------ BT MESSAGE: BT STATUS: running May 30 19:26:22 smsl-n100 sudo[1877]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 30 19:26:22 smsl-n100 sudo[1877]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 19:26:22 smsl-n100 sudo[1877]: pam_unix(sudo:session): session closed for user root May 30 19:26:22 smsl-n100 volumio[985]: info: MPD Permissions set May 30 19:26:22 smsl-n100 volumio[985]: info: Raat Daemon started successfully May 30 19:26:22 smsl-n100 sudo[1882]: pam_unix(sudo:session): session closed for user root May 30 19:26:22 smsl-n100 volumio[985]: info: Executing endpoint restartRAATSocket May 30 19:26:22 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection May 30 19:26:22 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:26:22 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:26:22 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:26:22 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:26:22 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:26:22 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:26:22 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:26:22 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:26:22 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 30 19:26:22 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber May 30 19:26:22 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:26:22 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:26:22 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:26:22 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:26:22 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:26:22 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:26:22 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:26:22 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:26:22 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:26:22 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 30 19:26:22 smsl-n100 volumio[985]: info: Not Reporting Auto name since its the default one May 30 19:26:22 smsl-n100 volumio[985]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 May 30 19:26:22 smsl-n100 volumio[985]: info: Starting Shairport Sync May 30 19:26:22 smsl-n100 sudo[1902]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 30 19:26:22 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable May 30 19:26:22 smsl-n100 sudo[1902]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 19:26:22 smsl-n100 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 30 19:26:22 smsl-n100 systemd[1]: shairport-sync.service: Succeeded. May 30 19:26:22 smsl-n100 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 30 19:26:23 smsl-n100 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 30 19:26:23 smsl-n100 sudo[1902]: pam_unix(sudo:session): session closed for user root May 30 19:26:23 smsl-n100 volumio[985]: xcb_connection_has_error() returned true May 30 19:26:23 smsl-n100 volumio[985]: ------------------------------------ BT MESSAGE: BT STATUS: running May 30 19:26:23 smsl-n100 volumio[985]: ------------------------------------ BT MESSAGE: BT STATUS: waiting May 30 19:26:23 smsl-n100 sudo[1908]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service May 30 19:26:23 smsl-n100 sudo[1908]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 19:26:23 smsl-n100 volumio[985]: info: Shairport-Sync Started May 30 19:26:23 smsl-n100 sudo[1908]: pam_unix(sudo:session): session closed for user root May 30 19:26:23 smsl-n100 sudo[1912]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service May 30 19:26:23 smsl-n100 sudo[1912]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 19:26:23 smsl-n100 systemd[1]: Stopping RAAT DAEMON... May 30 19:26:23 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM May 30 19:26:23 smsl-n100 systemd[1]: raat-daemon.service: Succeeded. May 30 19:26:23 smsl-n100 systemd[1]: Stopped RAAT DAEMON. May 30 19:26:23 smsl-n100 volumio[985]: ------------------------------------ BT MESSAGE: BT STATUS: running May 30 19:26:23 smsl-n100 volumio[985]: ------------------------------------ BT MESSAGE: BT STATUS: waiting May 30 19:26:23 smsl-n100 systemd[1]: Started RAAT DAEMON. May 30 19:26:23 smsl-n100 volumio[985]: info: TidalConnect service stoped! May 30 19:26:23 smsl-n100 sudo[1912]: pam_unix(sudo:session): session closed for user root May 30 19:26:23 smsl-n100 volumio[985]: info: Raat Daemon started successfully May 30 19:26:23 smsl-n100 volumio[985]: info: Executing endpoint restartRAATSocket May 30 19:26:23 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection May 30 19:26:23 smsl-n100 volumio[985]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 May 30 19:26:23 smsl-n100 volumio[985]: info: TidalConnect service stoped! May 30 19:26:23 smsl-n100 volumio[985]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect May 30 19:26:23 smsl-n100 volumio[985]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect May 30 19:26:23 smsl-n100 sudo[1935]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service May 30 19:26:23 smsl-n100 sudo[1935]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 19:26:23 smsl-n100 systemd[1]: Started Volumio Tidal Connect Service. May 30 19:26:23 smsl-n100 sudo[1935]: pam_unix(sudo:session): session closed for user root May 30 19:26:24 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioRetrieveVolumeLevels May 30 19:26:24 smsl-n100 volumio[985]: info: CoreStateMachine::getcurrentVolume May 30 19:26:24 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioRetrievevolume May 30 19:26:24 smsl-n100 volumio[985]: info: Executing endpoint tc_getconfig May 30 19:26:24 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig May 30 19:26:24 smsl-n100 vtcs[1937]: STARTING TidalConnect services, version: 1.4.0.34 May 30 19:26:24 smsl-n100 volumio[985]: info: RAAT: Requesting Headphone Status May 30 19:26:24 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus May 30 19:26:24 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:26:24 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 19:26:24 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:26:24 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:26:24 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:26:24 smsl-n100 volumio[985]: error: Serial API: Failed to decode command: 100, message: undefined May 30 19:26:24 smsl-n100 volumio[985]: error: Serial API: Failed to decode command: MAXVOL, message: May 30 19:26:24 smsl-n100 volumio[985]: error: Serial API: Failed to decode command: 100, message: undefined May 30 19:26:24 smsl-n100 volumio[985]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff May 30 19:26:24 smsl-n100 volumio[985]: info: RAAT: Requesting Headphone Status May 30 19:26:24 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus May 30 19:26:24 smsl-n100 vtcs[1937]: STARTED TidalConnect services. May 30 19:26:24 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:26:24 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 19:26:24 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:26:24 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:26:24 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:26:24 smsl-n100 volumio[985]: error: Serial API: Failed to decode command: 100, message: undefined May 30 19:26:24 smsl-n100 volumio[985]: error: Serial API: Failed to decode command: MAXVOL, message: May 30 19:26:24 smsl-n100 volumio[985]: error: Serial API: Failed to decode command: 100, message: undefined May 30 19:26:24 smsl-n100 volumio[985]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff May 30 19:26:24 smsl-n100 volumio[985]: info: Executing endpoint tc_connect May 30 19:26:24 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect May 30 19:26:24 smsl-n100 systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM May 30 19:26:24 smsl-n100 systemd[1]: mpd.service: Failed with result 'protocol'. May 30 19:26:24 smsl-n100 volumio[985]: info: Connecting to TidalConnect May 30 19:26:24 smsl-n100 systemd[1]: Failed to start Music Player Daemon. May 30 19:26:24 smsl-n100 sudo[1861]: pam_unix(sudo:session): session closed for user root May 30 19:26:24 smsl-n100 systemd[1]: Starting Music Player Daemon... May 30 19:26:24 smsl-n100 volumio[985]: ------------------------------------ BT MESSAGE: BT STATUS: waiting May 30 19:26:24 smsl-n100 volumio[985]: info: VolumeController:: Volume=0 Mute =false May 30 19:26:24 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:26:24 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 19:26:24 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:26:24 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:26:24 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:26:25 smsl-n100 volumio[985]: info: CoreStateMachine::updateTrackBlock May 30 19:26:25 smsl-n100 volumio[985]: info: CorePlayQueue::getTrackBlock May 30 19:26:25 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioRetrievevolume May 30 19:26:25 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:26:25 smsl-n100 volumio[985]: ------------------------------------ BT MESSAGE: BT STATUS: running May 30 19:26:25 smsl-n100 volumio[985]: info: CoreCommandRouter::servicePushState May 30 19:26:25 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:26:25 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:26:25 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:26:25 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:26:25 smsl-n100 volumio[985]: info: CorePlayQueue::getTrack 0 May 30 19:26:25 smsl-n100 volumio[985]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect May 30 19:26:25 smsl-n100 volumio[985]: info: CoreCommandRouter::servicePushState May 30 19:26:25 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:26:25 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:26:25 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:26:25 smsl-n100 sudo[1952]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 30 19:26:25 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:26:25 smsl-n100 sudo[1952]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 19:26:25 smsl-n100 volumio[985]: info: CorePlayQueue::getTrack 0 May 30 19:26:25 smsl-n100 volumio[985]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect May 30 19:26:25 smsl-n100 sudo[1952]: pam_unix(sudo:session): session closed for user root May 30 19:26:25 smsl-n100 volumio[985]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service May 30 19:26:25 smsl-n100 volumio[985]: Job for mpd.service failed because the service did not take the steps required by its unit configuration. May 30 19:26:25 smsl-n100 volumio[985]: See "systemctl status mpd.service" and "journalctl -xe" for details. May 30 19:26:25 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:26:25 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:26:25 smsl-n100 volumio[985]: info: VolumeController:: Volume=0 Mute =false May 30 19:26:25 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:26:25 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:26:25 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:26:25 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:26:25 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:26:25 smsl-n100 volumio[985]: info: TidalConnect service stoped! May 30 19:26:25 smsl-n100 volumio[985]: info: TidalConnect service stoped! May 30 19:26:25 smsl-n100 volumio[985]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect May 30 19:26:25 smsl-n100 volumio[985]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect May 30 19:26:25 smsl-n100 sudo[1974]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service May 30 19:26:25 smsl-n100 sudo[1974]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 19:26:25 smsl-n100 sudo[1974]: pam_unix(sudo:session): session closed for user root May 30 19:26:26 smsl-n100 volumio[985]: info: RAAT: Requesting Headphone Status May 30 19:26:26 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus May 30 19:26:26 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:26:26 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 19:26:26 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:26:26 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:26:26 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:26:26 smsl-n100 volumio[985]: error: Serial API: Failed to decode command: 100, message: undefined May 30 19:26:26 smsl-n100 volumio[985]: error: Serial API: Failed to decode command: MAXVOL, message: May 30 19:26:26 smsl-n100 volumio[985]: error: Serial API: Failed to decode command: 100, message: undefined May 30 19:26:26 smsl-n100 volumio[985]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff May 30 19:26:26 smsl-n100 volumio[985]: info: TidalConnect service started! May 30 19:26:28 smsl-n100 mpd[1963]: May 30 19:26 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 30 19:26:28 smsl-n100 systemd[1]: Started Music Player Daemon. May 30 19:26:28 smsl-n100 mpd_monitor.sh[494]: MPD restarted due to no mpc output. May 30 19:26:28 smsl-n100 volumio[985]: error: updateQueue error: null May 30 19:26:28 smsl-n100 volumio[985]: info: TidalConnect service started! May 30 19:26:50 smsl-n100 kernel: usb 4-1: USB disconnect, device number 3 May 30 19:26:50 smsl-n100 volumio[985]: info: Executing endpoint scanAudioInputs May 30 19:26:50 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: smart_inputs , scanAudioInputs May 30 19:26:50 smsl-n100 volumio[985]: info: Scanning Audio Inputs May 30 19:26:50 smsl-n100 volumio[985]: xcb_connection_has_error() returned true May 30 19:26:50 smsl-n100 volumio[985]: info: Checking against Known Cards name May 30 19:26:50 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesYamaha USB DAC May 30 19:26:50 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 30 19:26:50 smsl-n100 volumio[985]: info: May 30 19:26:50 smsl-n100 volumio[985]: ---------------------------- USB Audio Device Detached May 30 19:26:50 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach May 30 19:26:50 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 30 19:26:50 smsl-n100 volumio[985]: xcb_connection_has_error() returned true May 30 19:26:50 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: raat , onStop May 30 19:26:50 smsl-n100 volumio[985]: info: Stopping RAAT Plugin May 30 19:26:50 smsl-n100 sudo[2081]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop raat-daemon.service May 30 19:26:50 smsl-n100 sudo[2081]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 19:26:50 smsl-n100 systemd[1]: Stopping RAAT DAEMON... May 30 19:26:50 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM May 30 19:26:50 smsl-n100 systemd[1]: raat-daemon.service: Succeeded. May 30 19:26:50 smsl-n100 systemd[1]: Stopped RAAT DAEMON. May 30 19:26:50 smsl-n100 volumio[985]: ------------------------------------ BT MESSAGE: BT STATUS: running May 30 19:26:50 smsl-n100 sudo[2081]: pam_unix(sudo:session): session closed for user root May 30 19:26:50 smsl-n100 volumio[985]: info: Raat Daemon stopped successfully May 30 19:26:59 smsl-n100 kernel: usb 4-1: new high-speed USB device number 4 using xhci-hcd May 30 19:26:59 smsl-n100 kernel: usb 4-1: New USB device found, idVendor=0499, idProduct=3111, bcdDevice= 1.00 May 30 19:26:59 smsl-n100 kernel: usb 4-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0 May 30 19:26:59 smsl-n100 kernel: usb 4-1: Product: Yamaha USB DAC May 30 19:26:59 smsl-n100 kernel: usb 4-1: Manufacturer: Yamaha Corporation May 30 19:27:00 smsl-n100 kernel: hid-generic 0003:0499:3111.0003: hiddev96,hidraw0: USB HID v1.10 Device [Yamaha Corporation Yamaha USB DAC] on usb-xhci-hcd.0.auto-1/input3 May 30 19:27:00 smsl-n100 volumio[985]: info: May 30 19:27:00 smsl-n100 volumio[985]: ---------------------------- USB Audio Device Attached May 30 19:27:00 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach May 30 19:27:00 smsl-n100 volumio[985]: xcb_connection_has_error() returned true May 30 19:27:00 smsl-n100 volumio[985]: info: CoreCommandRouter::Close All Modals sent May 30 19:27:00 smsl-n100 volumio[985]: info: Preparing to save Alsa Options, stopping services first May 30 19:27:00 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioGetState May 30 19:27:00 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPause May 30 19:27:00 smsl-n100 volumio[985]: info: CoreStateMachine::pause May 30 19:27:00 smsl-n100 volumio[985]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"Yamaha USB DAC","alsacard":"DAC"},"i2s":false} May 30 19:27:00 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 30 19:27:00 smsl-n100 volumio[985]: xcb_connection_has_error() returned true May 30 19:27:00 smsl-n100 volumio[985]: xcb_connection_has_error() returned true May 30 19:27:00 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 30 19:27:00 smsl-n100 volumio[985]: xcb_connection_has_error() returned true May 30 19:27:00 smsl-n100 volumio[985]: info: Setting mixer PCM for card Yamaha USB DAC May 30 19:27:00 smsl-n100 volumio[985]: info: Reconfiguring and Restarting RAAT Plugin due to audio path changes May 30 19:27:00 smsl-n100 vtcs[1937]: [2026-05-30 19:27:00.737] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE May 30 19:27:00 smsl-n100 vtcs[1937]: [2026-05-30 19:27:00.738] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected May 30 19:27:00 smsl-n100 sudo[2121]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 30 19:27:00 smsl-n100 sudo[2121]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 19:27:00 smsl-n100 systemd[1]: Stopping Volumio Tidal Connect Service... May 30 19:27:00 smsl-n100 systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM May 30 19:27:00 smsl-n100 systemd[1]: vtcs.service: Succeeded. May 30 19:27:00 smsl-n100 systemd[1]: Stopped Volumio Tidal Connect Service. May 30 19:27:00 smsl-n100 sudo[2121]: pam_unix(sudo:session): session closed for user root May 30 19:27:00 smsl-n100 volumio[985]: xcb_connection_has_error() returned true May 30 19:27:00 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioUpdateVolumeSettings May 30 19:27:00 smsl-n100 volumio[985]: info: Updating Volume Controller Parameters: Device: 5 Name: Yamaha USB DAC Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 May 30 19:27:00 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume May 30 19:27:00 smsl-n100 volumio[985]: info: Disabling external Volume Control May 30 19:27:00 smsl-n100 volumio[985]: info: CoreCommandRouter::getUIConfigOnPlugin May 30 19:27:00 smsl-n100 volumio[985]: info: Preparing to generate the ALSA configuration file May 30 19:27:01 smsl-n100 volumio[985]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf May 30 19:27:01 smsl-n100 volumio[985]: info: Reading ALSA contributions from plugins. May 30 19:27:01 smsl-n100 volumio[985]: ------------------------------------ BT MESSAGE: BT STATUS: running May 30 19:27:01 smsl-n100 sudo[2128]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 30 19:27:01 smsl-n100 sudo[2128]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 19:27:01 smsl-n100 sudo[2128]: pam_unix(sudo:session): session closed for user root May 30 19:27:01 smsl-n100 volumio[985]: info: Executing endpoint scanAudioInputs May 30 19:27:01 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: smart_inputs , scanAudioInputs May 30 19:27:01 smsl-n100 volumio[985]: info: Scanning Audio Inputs May 30 19:27:01 smsl-n100 volumio[985]: xcb_connection_has_error() returned true May 30 19:27:01 smsl-n100 volumio[985]: info: Checking against Known Cards name May 30 19:27:01 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 30 19:27:01 smsl-n100 volumio[985]: info: [1780140421276] CoreMusicLibrary::Adding element Yamaha USB DAC May 30 19:27:01 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 30 19:27:01 smsl-n100 volumio[985]: Cannot find translation for source Yamaha USB DAC May 30 19:27:01 smsl-n100 volumio[985]: info: Checking against Known Cards name May 30 19:27:01 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:27:01 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:27:01 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:27:01 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:27:01 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:27:01 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:27:01 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:27:01 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 30 19:27:01 smsl-n100 volumio[985]: info: Not Reporting Auto name since its the default one May 30 19:27:01 smsl-n100 volumio[985]: xcb_connection_has_error() returned true May 30 19:27:01 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 30 19:27:01 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 30 19:27:01 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 30 19:27:01 smsl-n100 volumio[985]: xcb_connection_has_error() returned true May 30 19:27:01 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 30 19:27:01 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 30 19:27:01 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 30 19:27:01 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 30 19:27:01 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 30 19:27:01 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 30 19:27:01 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 30 19:27:01 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode May 30 19:27:01 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 30 19:27:01 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: raat , getAdditionalUiSection May 30 19:27:01 smsl-n100 volumio[985]: info: VolumeController:: Volume=0 Mute =false May 30 19:27:01 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:27:01 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 19:27:01 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:27:01 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:27:01 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:27:01 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat May 30 19:27:01 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:27:01 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:27:01 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:27:01 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:27:01 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:27:01 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:27:01 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:27:01 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:27:01 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 30 19:27:01 smsl-n100 volumio[985]: info: Not Reporting Auto name since its the default one May 30 19:27:01 smsl-n100 volumio[985]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined May 30 19:27:01 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:27:01 smsl-n100 volumio[985]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined May 30 19:27:01 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable May 30 19:27:01 smsl-n100 volumio[985]: xcb_connection_has_error() returned true May 30 19:27:01 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:27:01 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:27:01 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable May 30 19:27:01 smsl-n100 sudo[2149]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service May 30 19:27:01 smsl-n100 sudo[2149]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 19:27:01 smsl-n100 sudo[2149]: pam_unix(sudo:session): session closed for user root May 30 19:27:02 smsl-n100 sudo[2153]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service May 30 19:27:02 smsl-n100 sudo[2153]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 19:27:02 smsl-n100 volumio[985]: xcb_connection_has_error() returned true May 30 19:27:02 smsl-n100 systemd[1]: Started RAAT DAEMON. May 30 19:27:02 smsl-n100 sudo[2153]: pam_unix(sudo:session): session closed for user root May 30 19:27:02 smsl-n100 volumio[985]: info: Asound.conf file unchanged, so no further update is needed May 30 19:27:02 smsl-n100 volumio[985]: info: Output device has changed, restarting MPD May 30 19:27:02 smsl-n100 sudo[2157]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service May 30 19:27:02 smsl-n100 sudo[2157]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 19:27:02 smsl-n100 sudo[2157]: pam_unix(sudo:session): session closed for user root May 30 19:27:02 smsl-n100 sudo[2164]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 30 19:27:02 smsl-n100 sudo[2164]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 19:27:02 smsl-n100 volumio[985]: info: Output device has changed, restarting Shairport Sync May 30 19:27:02 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:27:02 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 30 19:27:02 smsl-n100 sudo[2164]: pam_unix(sudo:session): session closed for user root May 30 19:27:02 smsl-n100 sudo[2166]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service May 30 19:27:02 smsl-n100 sudo[2171]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 30 19:27:02 smsl-n100 sudo[2171]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 19:27:02 smsl-n100 sudo[2166]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 19:27:02 smsl-n100 systemd[1]: Stopping Music Player Daemon... May 30 19:27:02 smsl-n100 systemd[1]: Stopping RAAT DAEMON... May 30 19:27:02 smsl-n100 volumio[985]: xcb_connection_has_error() returned true May 30 19:27:02 smsl-n100 volumio[985]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 30 19:27:02 smsl-n100 volumio[985]: xcb_connection_has_error() returned true May 30 19:27:02 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM May 30 19:27:02 smsl-n100 systemd[1]: raat-daemon.service: Succeeded. May 30 19:27:02 smsl-n100 systemd[1]: Stopped RAAT DAEMON. May 30 19:27:02 smsl-n100 volumio[985]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration May 30 19:27:02 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:27:02 smsl-n100 systemd[1]: Started RAAT DAEMON. May 30 19:27:02 smsl-n100 sudo[2166]: pam_unix(sudo:session): session closed for user root May 30 19:27:02 smsl-n100 systemd[1]: mpd.service: Succeeded. May 30 19:27:02 smsl-n100 systemd[1]: Stopped Music Player Daemon. May 30 19:27:02 smsl-n100 volumio[985]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes May 30 19:27:02 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:27:02 smsl-n100 systemd[1]: Starting Music Player Daemon... May 30 19:27:02 smsl-n100 sudo[2188]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 30 19:27:02 smsl-n100 sudo[2188]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 19:27:02 smsl-n100 volumio[985]: ------------------------------------ BT MESSAGE: BT STATUS: running May 30 19:27:02 smsl-n100 volumio[985]: ------------------------------------ BT MESSAGE: BT STATUS: running May 30 19:27:02 smsl-n100 volumio[985]: ------------------------------------ BT MESSAGE: BT STATUS: waiting May 30 19:27:02 smsl-n100 volumio[985]: ------------------------------------ BT MESSAGE: BT STATUS: waiting May 30 19:27:02 smsl-n100 volumio[985]: ------------------------------------ BT MESSAGE: BT STATUS: running May 30 19:27:02 smsl-n100 sudo[2195]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 30 19:27:02 smsl-n100 sudo[2195]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 19:27:02 smsl-n100 volumio[985]: info: MPD Permissions set May 30 19:27:02 smsl-n100 volumio[985]: info: Raat Daemon started successfully May 30 19:27:02 smsl-n100 volumio[985]: info: Raat Daemon started successfully May 30 19:27:02 smsl-n100 volumio[985]: info: Executing endpoint restartRAATSocket May 30 19:27:02 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection May 30 19:27:02 smsl-n100 sudo[2184]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 30 19:27:02 smsl-n100 sudo[2184]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 19:27:02 smsl-n100 volumio[985]: info: Executing endpoint restartRAATSocket May 30 19:27:02 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection May 30 19:27:02 smsl-n100 sudo[2184]: pam_unix(sudo:session): session closed for user root May 30 19:27:02 smsl-n100 volumio[985]: ------------------------------------ BT MESSAGE: BT STATUS: waiting May 30 19:27:02 smsl-n100 sudo[2195]: pam_unix(sudo:session): session closed for user root May 30 19:27:02 smsl-n100 sudo[2188]: pam_unix(sudo:session): session closed for user root May 30 19:27:02 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:27:02 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:27:02 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:27:02 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:27:02 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:27:02 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:27:02 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:27:02 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:27:02 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 30 19:27:02 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber May 30 19:27:02 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:27:03 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:27:03 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:27:03 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:27:03 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:27:03 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:27:03 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:27:03 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:27:03 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 19:27:03 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 30 19:27:03 smsl-n100 volumio[985]: info: Not Reporting Auto name since its the default one May 30 19:27:03 smsl-n100 volumio[985]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 May 30 19:27:03 smsl-n100 volumio[985]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 May 30 19:27:03 smsl-n100 volumio[985]: info: Starting Shairport Sync May 30 19:27:03 smsl-n100 sudo[2214]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 30 19:27:03 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable May 30 19:27:03 smsl-n100 sudo[2214]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 19:27:03 smsl-n100 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 30 19:27:03 smsl-n100 systemd[1]: shairport-sync.service: Succeeded. May 30 19:27:03 smsl-n100 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 30 19:27:03 smsl-n100 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 30 19:27:03 smsl-n100 sudo[2214]: pam_unix(sudo:session): session closed for user root May 30 19:27:03 smsl-n100 volumio[985]: xcb_connection_has_error() returned true May 30 19:27:03 smsl-n100 volumio[985]: ------------------------------------ BT MESSAGE: BT STATUS: running May 30 19:27:03 smsl-n100 volumio[985]: ------------------------------------ BT MESSAGE: BT STATUS: waiting May 30 19:27:03 smsl-n100 volumio[985]: info: Shairport-Sync Started May 30 19:27:03 smsl-n100 sudo[2220]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service May 30 19:27:03 smsl-n100 sudo[2220]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 19:27:03 smsl-n100 sudo[2220]: pam_unix(sudo:session): session closed for user root May 30 19:27:03 smsl-n100 sudo[2224]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service May 30 19:27:03 smsl-n100 sudo[2224]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 19:27:03 smsl-n100 systemd[1]: Stopping RAAT DAEMON... May 30 19:27:03 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM May 30 19:27:03 smsl-n100 systemd[1]: raat-daemon.service: Succeeded. May 30 19:27:03 smsl-n100 volumio[985]: ------------------------------------ BT MESSAGE: BT STATUS: running May 30 19:27:03 smsl-n100 systemd[1]: Stopped RAAT DAEMON. May 30 19:27:03 smsl-n100 volumio[985]: ------------------------------------ BT MESSAGE: BT STATUS: waiting May 30 19:27:03 smsl-n100 systemd[1]: Started RAAT DAEMON. May 30 19:27:03 smsl-n100 sudo[2224]: pam_unix(sudo:session): session closed for user root May 30 19:27:03 smsl-n100 volumio[985]: info: Raat Daemon started successfully May 30 19:27:03 smsl-n100 volumio[985]: info: Executing endpoint restartRAATSocket May 30 19:27:03 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection May 30 19:27:03 smsl-n100 volumio[985]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 May 30 19:27:03 smsl-n100 volumio[985]: info: TidalConnect service stoped! May 30 19:27:04 smsl-n100 volumio[985]: info: TidalConnect service stoped! May 30 19:27:04 smsl-n100 volumio[985]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect May 30 19:27:04 smsl-n100 volumio[985]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect May 30 19:27:04 smsl-n100 sudo[2246]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service May 30 19:27:04 smsl-n100 sudo[2246]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 19:27:04 smsl-n100 systemd[1]: Started Volumio Tidal Connect Service. May 30 19:27:04 smsl-n100 sudo[2246]: pam_unix(sudo:session): session closed for user root May 30 19:27:04 smsl-n100 volumio[985]: info: Executing endpoint tc_getconfig May 30 19:27:04 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig May 30 19:27:04 smsl-n100 volumio[985]: info: RAAT: Requesting Headphone Status May 30 19:27:04 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus May 30 19:27:04 smsl-n100 vtcs[2248]: STARTING TidalConnect services, version: 1.4.0.34 May 30 19:27:04 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:27:04 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 19:27:04 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:27:04 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:27:04 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:27:04 smsl-n100 volumio[985]: error: Serial API: Failed to decode command: 100, message: undefined May 30 19:27:04 smsl-n100 volumio[985]: error: Serial API: Failed to decode command: MAXVOL, message: May 30 19:27:04 smsl-n100 volumio[985]: error: Serial API: Failed to decode command: 100, message: undefined May 30 19:27:04 smsl-n100 volumio[985]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff May 30 19:27:04 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioRetrieveVolumeLevels May 30 19:27:04 smsl-n100 volumio[985]: info: CoreStateMachine::getcurrentVolume May 30 19:27:04 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioRetrievevolume May 30 19:27:05 smsl-n100 volumio[985]: info: RAAT: Requesting Headphone Status May 30 19:27:05 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus May 30 19:27:05 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:27:05 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 19:27:05 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:27:05 smsl-n100 vtcs[2248]: STARTED TidalConnect services. May 30 19:27:05 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:27:05 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:27:05 smsl-n100 volumio[985]: error: Serial API: Failed to decode command: 100, message: undefined May 30 19:27:05 smsl-n100 volumio[985]: error: Serial API: Failed to decode command: MAXVOL, message: May 30 19:27:05 smsl-n100 volumio[985]: error: Serial API: Failed to decode command: 100, message: undefined May 30 19:27:05 smsl-n100 volumio[985]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff May 30 19:27:05 smsl-n100 volumio[985]: info: Executing endpoint tc_connect May 30 19:27:05 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect May 30 19:27:05 smsl-n100 volumio[985]: info: Connecting to TidalConnect May 30 19:27:05 smsl-n100 volumio[985]: info: VolumeController:: Volume=0 Mute =false May 30 19:27:05 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:27:05 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 19:27:05 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:27:05 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:27:05 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:27:05 smsl-n100 volumio[985]: info: CoreStateMachine::updateTrackBlock May 30 19:27:05 smsl-n100 volumio[985]: info: CorePlayQueue::getTrackBlock May 30 19:27:05 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioRetrievevolume May 30 19:27:05 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:27:05 smsl-n100 volumio[985]: info: CoreCommandRouter::servicePushState May 30 19:27:05 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:27:05 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:27:05 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:27:05 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:27:05 smsl-n100 volumio[985]: info: CorePlayQueue::getTrack 0 May 30 19:27:05 smsl-n100 volumio[985]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect May 30 19:27:05 smsl-n100 volumio[985]: info: CoreCommandRouter::servicePushState May 30 19:27:05 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:27:05 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:27:05 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:27:05 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:27:05 smsl-n100 volumio[985]: info: CorePlayQueue::getTrack 0 May 30 19:27:05 smsl-n100 volumio[985]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect May 30 19:27:05 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:27:05 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:27:05 smsl-n100 volumio[985]: info: VolumeController:: Volume=0 Mute =false May 30 19:27:05 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:27:05 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:27:05 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:27:05 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:27:05 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:27:05 smsl-n100 volumio[985]: info: TidalConnect service stoped! May 30 19:27:05 smsl-n100 volumio[985]: info: TidalConnect service stoped! May 30 19:27:05 smsl-n100 volumio[985]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect May 30 19:27:05 smsl-n100 volumio[985]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect May 30 19:27:05 smsl-n100 sudo[2280]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service May 30 19:27:05 smsl-n100 sudo[2280]: pam_unix(sudo:session): session opened for user root by (uid=0) May 30 19:27:06 smsl-n100 sudo[2280]: pam_unix(sudo:session): session closed for user root May 30 19:27:06 smsl-n100 volumio[985]: info: RAAT: Requesting Headphone Status May 30 19:27:06 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus May 30 19:27:06 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:27:06 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 19:27:06 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:27:06 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:27:06 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:27:06 smsl-n100 volumio[985]: error: Serial API: Failed to decode command: 100, message: undefined May 30 19:27:06 smsl-n100 volumio[985]: error: Serial API: Failed to decode command: MAXVOL, message: May 30 19:27:06 smsl-n100 volumio[985]: error: Serial API: Failed to decode command: 100, message: undefined May 30 19:27:06 smsl-n100 volumio[985]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff May 30 19:27:06 smsl-n100 mpd[2199]: May 30 19:27 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 30 19:27:06 smsl-n100 systemd[1]: Started Music Player Daemon. May 30 19:27:06 smsl-n100 sudo[2171]: pam_unix(sudo:session): session closed for user root May 30 19:27:06 smsl-n100 volumio[985]: error: updateQueue error: null May 30 19:27:07 smsl-n100 volumio[985]: info: TidalConnect service started! May 30 19:27:09 smsl-n100 volumio[985]: info: TidalConnect service started! May 30 19:27:20 smsl-n100 volumio[985]: info: Airplay started streaming, receiving metadatas May 30 19:27:20 smsl-n100 volumio[985]: info: Airplay started streaming, receiving metadatas May 30 19:27:20 smsl-n100 volumio[985]: info: Airplay started streaming, receiving metadatas May 30 19:27:20 smsl-n100 volumio[985]: info: Airplay started streaming, receiving metadatas May 30 19:27:20 smsl-n100 volumio[985]: info: Airplay started streaming, receiving metadatas May 30 19:27:20 smsl-n100 shairport-sync[2218]: % Total % Received % Xferd Average Speed Time Time Time Current May 30 19:27:20 smsl-n100 shairport-sync[2218]: Dload Upload Total Spent Left Speed May 30 19:27:20 smsl-n100 volumio[985]: info: Updating volume from AirPlay: -20; 33% May 30 19:27:20 smsl-n100 volumio[985]: info: VolumeController::SetAlsaVolume33 May 30 19:27:20 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:27:20 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 19:27:20 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:27:20 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:27:20 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:27:20 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:27:20 smsl-n100 volumio[985]: info: May 30 19:27:20 smsl-n100 volumio[985]: ---------------------------- Client requests Start Airplay PlaybackRoutine May 30 19:27:20 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback May 30 19:27:20 smsl-n100 volumio[985]: info: Airplay playback start May 30 19:27:20 smsl-n100 shairport-sync[2218]: [237B blob data] May 30 19:27:21 smsl-n100 volumio[985]: info: CoreCommandRouter::servicePushState May 30 19:27:21 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:27:21 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 19:27:21 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:27:21 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:27:21 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:27:21 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:27:21 smsl-n100 volumio[985]: info: CoreCommandRouter::servicePushState May 30 19:27:21 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:27:21 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:27:21 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:27:21 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:27:21 smsl-n100 volumio[985]: info: CoreCommandRouter::servicePushState May 30 19:27:21 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:27:21 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:27:21 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:27:21 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:27:21 smsl-n100 volumio[985]: info: CoreCommandRouter::servicePushState May 30 19:27:21 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:27:21 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:27:21 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:27:21 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:27:21 smsl-n100 volumio[985]: info: CoreCommandRouter::servicePushState May 30 19:27:21 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:27:21 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:27:21 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:27:21 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:27:21 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:27:21 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:27:21 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:27:21 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:27:21 smsl-n100 volumio[985]: info: CoreCommandRouter::servicePushState May 30 19:27:21 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:27:21 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:27:21 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:27:21 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:27:21 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:27:22 smsl-n100 volumio[985]: info: CoreCommandRouter::servicePushState May 30 19:27:22 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:27:22 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 19:27:22 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:27:22 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:27:22 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:27:22 smsl-n100 volumio[985]: info: CoreCommandRouter::servicePushState May 30 19:27:22 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:27:22 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:27:22 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:27:22 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:27:22 smsl-n100 volumio[985]: info: CoreCommandRouter::servicePushState May 30 19:27:22 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:27:22 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:27:22 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:27:22 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:27:22 smsl-n100 volumio[985]: info: CoreCommandRouter::servicePushState May 30 19:27:22 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:27:22 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:27:22 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:27:22 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:27:22 smsl-n100 volumio[985]: info: CoreCommandRouter::servicePushState May 30 19:27:22 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:27:22 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:27:22 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:27:22 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:27:22 smsl-n100 volumio[985]: info: CoreCommandRouter::servicePushState May 30 19:27:22 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:27:22 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 19:27:22 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:27:22 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:27:22 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:27:22 smsl-n100 volumio[985]: info: CoreCommandRouter::servicePushState May 30 19:27:22 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:27:22 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:27:22 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:27:22 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:27:22 smsl-n100 volumio[985]: info: CoreCommandRouter::servicePushState May 30 19:27:22 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:27:22 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:27:22 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:27:22 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:27:22 smsl-n100 volumio[985]: info: CoreCommandRouter::servicePushState May 30 19:27:22 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:27:22 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:27:22 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:27:22 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:27:22 smsl-n100 volumio[985]: info: CoreCommandRouter::servicePushState May 30 19:27:22 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:27:22 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:27:22 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:27:22 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:27:22 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:27:22 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:27:22 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:27:22 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:27:22 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:27:22 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:27:22 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:27:22 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:27:22 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:27:22 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:27:24 smsl-n100 volumio[985]: info: Updating volume from AirPlay: -18.12; 40% May 30 19:27:24 smsl-n100 volumio[985]: info: VolumeController::SetAlsaVolume40 May 30 19:27:24 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:27:24 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 19:27:24 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:27:24 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:27:24 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:27:24 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:27:24 smsl-n100 volumio[985]: info: Updating volume from AirPlay: -16.25; 46% May 30 19:27:24 smsl-n100 volumio[985]: info: VolumeController::SetAlsaVolume46 May 30 19:27:24 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:27:24 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 19:27:24 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:27:24 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:27:24 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:27:25 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:27:25 smsl-n100 volumio[985]: info: Updating volume from AirPlay: -12.5; 58% May 30 19:27:25 smsl-n100 volumio[985]: info: VolumeController::SetAlsaVolume58 May 30 19:27:25 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:27:25 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 19:27:25 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:27:25 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:27:25 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:27:25 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:27:25 smsl-n100 volumio[985]: info: CoreCommandRouter::servicePushState May 30 19:27:25 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:27:25 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 19:27:25 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:27:25 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:27:25 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:27:25 smsl-n100 volumio[985]: info: CoreCommandRouter::servicePushState May 30 19:27:25 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:27:25 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:27:25 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:27:25 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:27:25 smsl-n100 volumio[985]: info: CoreCommandRouter::servicePushState May 30 19:27:25 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:27:25 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:27:25 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:27:25 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:27:25 smsl-n100 volumio[985]: info: CoreCommandRouter::servicePushState May 30 19:27:25 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:27:25 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:27:25 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:27:25 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:27:25 smsl-n100 volumio[985]: info: CoreCommandRouter::servicePushState May 30 19:27:25 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:27:25 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:27:25 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:27:25 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:27:25 smsl-n100 volumio[985]: info: CoreCommandRouter::servicePushState May 30 19:27:25 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:27:25 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 19:27:25 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:27:25 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:27:25 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:27:25 smsl-n100 volumio[985]: info: CoreCommandRouter::servicePushState May 30 19:27:25 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:27:25 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:27:25 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:27:25 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:27:25 smsl-n100 volumio[985]: info: CoreCommandRouter::servicePushState May 30 19:27:25 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:27:25 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:27:25 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:27:25 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:27:25 smsl-n100 volumio[985]: info: CoreCommandRouter::servicePushState May 30 19:27:25 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:27:25 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:27:25 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:27:25 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:27:25 smsl-n100 volumio[985]: info: CoreCommandRouter::servicePushState May 30 19:27:25 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:27:25 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:27:25 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:27:25 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:27:25 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:27:25 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:27:25 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:27:25 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:27:25 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:27:25 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:27:25 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:27:25 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:27:25 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:27:25 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:27:27 smsl-n100 volumio[985]: info: Updating volume from AirPlay: -14.37; 52% May 30 19:27:27 smsl-n100 volumio[985]: info: VolumeController::SetAlsaVolume52 May 30 19:27:27 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:27:27 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 19:27:27 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:27:27 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:27:27 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:27:28 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:27:28 smsl-n100 volumio[985]: info: Updating volume from AirPlay: -16.25; 46% May 30 19:27:28 smsl-n100 volumio[985]: info: VolumeController::SetAlsaVolume46 May 30 19:27:28 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:27:28 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 19:27:28 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:27:28 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:27:28 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:27:28 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:27:29 smsl-n100 volumio[985]: info: Updating volume from AirPlay: -18.12; 40% May 30 19:27:29 smsl-n100 volumio[985]: info: VolumeController::SetAlsaVolume40 May 30 19:27:29 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:27:29 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 19:27:29 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:27:29 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:27:29 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:27:29 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:27:29 smsl-n100 volumio[985]: info: Updating volume from AirPlay: -20; 33% May 30 19:27:29 smsl-n100 volumio[985]: info: VolumeController::SetAlsaVolume33 May 30 19:27:29 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:27:29 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 19:27:29 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:27:29 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:27:29 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:27:29 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:27:29 smsl-n100 volumio[985]: info: Updating volume from AirPlay: -21.88; 27% May 30 19:27:29 smsl-n100 volumio[985]: info: VolumeController::SetAlsaVolume27 May 30 19:27:29 smsl-n100 volumio[985]: info: CoreStateMachine::pushState May 30 19:27:29 smsl-n100 volumio[985]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 30 19:27:29 smsl-n100 volumio[985]: info: CoreCommandRouter::volumioPushState May 30 19:27:29 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output update for this device May 30 19:27:29 smsl-n100 volumio[985]: info: MRS: Pushing multiroomSync output May 30 19:27:29 smsl-n100 volumio[985]: info: Updating RAAT Signal Path May 30 19:27:47 smsl-n100 volumio[985]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 30 19:27:47 smsl-n100 volumio[985]: Error: connect ETIMEDOUT 173.255.209.47:443 May 30 19:27:47 smsl-n100 volumio[985]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { May 30 19:27:47 smsl-n100 volumio[985]: errno: -110, May 30 19:27:47 smsl-n100 volumio[985]: code: 'ETIMEDOUT', May 30 19:27:47 smsl-n100 volumio[985]: syscall: 'connect', May 30 19:27:47 smsl-n100 volumio[985]: address: '173.255.209.47', May 30 19:27:47 smsl-n100 volumio[985]: port: 443 May 30 19:27:47 smsl-n100 volumio[985]: } May 30 19:27:47 smsl-n100 volumio[985]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 30 19:27:48 smsl-n100 sudo[2423]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-05-30 19:26 May 30 19:27:48 smsl-n100 sudo[2423]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="cc0042a1eab1cb7982711a1347e242f8947b54b6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="723ba1d50268911818ebdca474fb7656df6050cb" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="smsl" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 14 Feb 2025 02:46:15 PM CET" VOLUMIO_VERSION="3.789" VOLUMIO_HARDWARE="nanopineo3" VOLUMIO_DEVICENAME="Nanopi Neo3" VOLUMIO_VENDOR_MODEL="SMSL S100" VOLUMIO_VENDOR="SMSL" VOLUMIO_MODEL="S100" VOLUMIO_HASH="215d731aee688e00fb3cc923952be9a7"