-- Logs begin at Thu 2019-02-14 17:11:58 +07, end at Mon 2025-01-13 12:57:58 +07. -- Jan 13 12:56:00 volumio kernel: usb 1-1.4: USB disconnect, device number 3 Jan 13 12:56:00 volumio thd[619]: Error reading device '/dev/input/event0' Jan 13 12:56:00 volumio kernel: usb 1-1.4: new full-speed USB device number 4 using xhci_hcd Jan 13 12:56:00 volumio kernel: usb 1-1.4: New USB device found, idVendor=0712, idProduct=0009, bcdDevice= 2.00 Jan 13 12:56:00 volumio kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Jan 13 12:56:00 volumio kernel: usb 1-1.4: Product: WaveShare Jan 13 12:56:00 volumio kernel: usb 1-1.4: Manufacturer: WaveShare Jan 13 12:56:00 volumio kernel: usb 1-1.4: SerialNumber: 000000000089 Jan 13 12:56:00 volumio kernel: input: WaveShare WaveShare as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.4/1-1.4:1.0/0003:0712:0009.0002/input/input2 Jan 13 12:56:00 volumio kernel: hid-multitouch 0003:0712:0009.0002: input,hidraw0: USB HID v1.11 Device [WaveShare WaveShare] on usb-0000:01:00.0-1.4/input0 Jan 13 12:56:01 volumio systemd-udevd[2949]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 13 12:56:01 volumio systemd-udevd[2950]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 13 12:56:02 volumio kernel: usb 1-1.4: USB disconnect, device number 4 Jan 13 12:56:03 volumio kernel: usb 1-1.4: new full-speed USB device number 5 using xhci_hcd Jan 13 12:56:03 volumio kernel: usb 1-1.4: New USB device found, idVendor=0712, idProduct=0009, bcdDevice= 2.00 Jan 13 12:56:03 volumio kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Jan 13 12:56:03 volumio kernel: usb 1-1.4: Product: WaveShare Jan 13 12:56:03 volumio kernel: usb 1-1.4: Manufacturer: WaveShare Jan 13 12:56:03 volumio kernel: usb 1-1.4: SerialNumber: 000000000089 Jan 13 12:56:03 volumio kernel: input: WaveShare WaveShare as /devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb1/1-1/1-1.4/1-1.4:1.0/0003:0712:0009.0003/input/input3 Jan 13 12:56:03 volumio kernel: hid-multitouch 0003:0712:0009.0003: input,hidraw0: USB HID v1.11 Device [WaveShare WaveShare] on usb-0000:01:00.0-1.4/input0 Jan 13 12:56:03 volumio systemd-udevd[2949]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 13 12:56:03 volumio systemd-udevd[2950]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 13 12:56:10 volumio volumio[996]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 13 12:56:10 volumio volumio[996]: xcb_connection_has_error() returned true Jan 13 12:56:10 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jan 13 12:56:10 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 13 12:56:10 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 13 12:56:10 volumio volumio[996]: xcb_connection_has_error() returned true Jan 13 12:56:10 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 12:56:10 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 12:56:10 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 12:56:10 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 12:56:10 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 12:56:10 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 12:56:10 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 12:56:10 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jan 13 12:56:10 volumio volumio[996]: xcb_connection_has_error() returned true Jan 13 12:56:10 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 13 12:56:19 volumio ntpd[763]: Soliciting pool server 115.165.161.155 Jan 13 12:56:22 volumio ntpd[763]: Soliciting pool server 27.71.27.209 Jan 13 12:56:22 volumio ntpd[763]: Soliciting pool server 103.184.124.254 Jan 13 12:56:23 volumio ntpd[763]: Soliciting pool server 103.184.124.254 Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:56:30 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:56:30 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:56:30 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:56:30 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:56:30 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:56:30 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:56:30 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:56:30 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:56:30 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:56:30 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:56:30 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:56:30 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:56:30 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:56:30 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:56:30 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:56:30 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:56:30 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:56:30 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:56:30 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:56:30 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:56:30 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:56:30 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:56:30 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:56:30 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:56:30 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:56:30 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:56:32 volumio kernel: usb 1-1.3: new high-speed USB device number 6 using xhci_hcd Jan 13 12:56:32 volumio kernel: usb 1-1.3: New USB device found, idVendor=2afd, idProduct=000b, bcdDevice= 1.30 Jan 13 12:56:32 volumio kernel: usb 1-1.3: New USB device strings: Mfr=1, Product=3, SerialNumber=2 Jan 13 12:56:32 volumio kernel: usb 1-1.3: Product: McIntosh Jan 13 12:56:32 volumio kernel: usb 1-1.3: Manufacturer: DA2 Jan 13 12:56:32 volumio kernel: usb 1-1.3: 1:3 : unsupported format bits 0x100000000 Jan 13 12:56:32 volumio kernel: usbcore: registered new interface driver snd-usb-audio Jan 13 12:56:32 volumio systemd-udevd[3062]: Process '/usr/sbin/alsactl -E HOME=/run/alsa restore 5' failed with exit code 99. Jan 13 12:56:32 volumio volumio[996]: info: Jan 13 12:56:32 volumio volumio[996]: ---------------------------- USB Audio Device Attached Jan 13 12:56:32 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Jan 13 12:56:42 volumio volumio[996]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 13 12:56:42 volumio volumio[996]: xcb_connection_has_error() returned true Jan 13 12:56:42 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jan 13 12:56:42 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 13 12:56:42 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 13 12:56:42 volumio volumio[996]: xcb_connection_has_error() returned true Jan 13 12:56:42 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 12:56:42 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 12:56:42 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 12:56:42 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 12:56:42 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 12:56:42 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 12:56:42 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 12:56:42 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jan 13 12:56:42 volumio volumio[996]: xcb_connection_has_error() returned true Jan 13 12:56:42 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 13 12:56:47 volumio volumio[996]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Jan 13 12:56:47 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Jan 13 12:56:47 volumio volumio[996]: info: Preparing to save Alsa Options, stopping services first Jan 13 12:56:47 volumio volumio[996]: info: CoreCommandRouter::volumioGetState Jan 13 12:56:47 volumio volumio[996]: info: CoreCommandRouter::volumioPause Jan 13 12:56:47 volumio volumio[996]: info: CoreStateMachine::pause Jan 13 12:56:47 volumio volumio[996]: info: CoreStateMachine::stPlaybackTimer Jan 13 12:56:47 volumio volumio[996]: info: CoreStateMachine::servicePause Jan 13 12:56:47 volumio volumio[996]: info: CoreCommandRouter::servicePause Jan 13 12:56:47 volumio volumio[996]: info: Airplay Pause with DBUS Call Jan 13 12:56:47 volumio volumio[996]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"McIntosh"},"i2s":false,"i2sid":{"value":"adafruit-max98357","label":"Adafruit MAX98357"}} Jan 13 12:56:47 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 13 12:56:47 volumio volumio[996]: xcb_connection_has_error() returned true Jan 13 12:56:47 volumio volumio[996]: xcb_connection_has_error() returned true Jan 13 12:56:47 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 13 12:56:47 volumio volumio[996]: xcb_connection_has_error() returned true Jan 13 12:56:47 volumio volumio[996]: info: Device 5 does not have any Mixer Control Available Jan 13 12:56:47 volumio vtcs[1426]: [2025-01-13 12:56:47.389] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Jan 13 12:56:47 volumio vtcs[1426]: [2025-01-13 12:56:47.389] [tisoc] [error] [SpkconServer.cpp:381] recv error. client fd=8 errorno=104 error=Connection reset by peer Jan 13 12:56:47 volumio vtcs[1426]: [2025-01-13 12:56:47.389] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected Jan 13 12:56:47 volumio sudo[3118]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 13 12:56:47 volumio sudo[3118]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 12:56:47 volumio systemd[1]: Stopping Volumio Tidal Connect Service... Jan 13 12:56:47 volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Jan 13 12:56:47 volumio systemd[1]: vtcs.service: Succeeded. Jan 13 12:56:47 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Jan 13 12:56:47 volumio volumio[996]: xcb_connection_has_error() returned true Jan 13 12:56:47 volumio volumio[996]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jan 13 12:56:47 volumio sudo[3118]: pam_unix(sudo:session): session closed for user root Jan 13 12:56:47 volumio volumio[996]: info: Updating Volume Controller Parameters: Device: 5 Name: McIntosh Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jan 13 12:56:47 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jan 13 12:56:47 volumio volumio[996]: info: Disabling external Volume Control Jan 13 12:56:47 volumio volumio[996]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 13 12:56:47 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:56:47 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 12:56:47 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:56:47 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:56:47 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:56:47 volumio volumio[996]: info: Preparing to generate the ALSA configuration file Jan 13 12:56:47 volumio volumio[996]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 13 12:56:47 volumio sudo[3125]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 13 12:56:47 volumio sudo[3125]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 12:56:47 volumio volumio[996]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jan 13 12:56:47 volumio volumio[996]: info: Reading ALSA contributions from plugins. Jan 13 12:56:47 volumio volumio[996]: info: Jan 13 12:56:47 volumio volumio[996]: ---------------------------- MPD announces state update: mixer Jan 13 12:56:47 volumio volumio[996]: info: ControllerMpd::getState Jan 13 12:56:47 volumio volumio[996]: verbose: ControllerMpd::sendMpdCommand status Jan 13 12:56:47 volumio volumio[996]: 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 Jan 13 12:56:47 volumio volumio[996]: Error org.freedesktop.DBus.Error.ServiceUnknown: The name org.gnome.ShairportSync was not provided by any .service files Jan 13 12:56:47 volumio sudo[3125]: pam_unix(sudo:session): session closed for user root Jan 13 12:56:47 volumio volumio[996]: info: sendMpdCommand status took 10 milliseconds Jan 13 12:56:47 volumio volumio[996]: verbose: ControllerMpd::parseState Jan 13 12:56:47 volumio volumio[996]: info: ControllerMpd::pushState Jan 13 12:56:47 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:56:47 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:56:47 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:56:47 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:56:47 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:56:47 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Jan 13 12:56:47 volumio volumio[996]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jan 13 12:56:47 volumio volumio[996]: verbose: CURRENT POSITION 0 Jan 13 12:56:47 volumio volumio[996]: info: CoreStateMachine::syncState stateService stop Jan 13 12:56:47 volumio volumio[996]: info: CoreStateMachine::syncState currentStatus pause Jan 13 12:56:47 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:56:47 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:56:47 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:56:47 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:56:47 volumio volumio[996]: info: ------------------------------ 44ms Jan 13 12:56:47 volumio volumio[996]: xcb_connection_has_error() returned true Jan 13 12:56:47 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jan 13 12:56:47 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 13 12:56:47 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 13 12:56:47 volumio volumio[996]: xcb_connection_has_error() returned true Jan 13 12:56:47 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 12:56:47 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 12:56:47 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 12:56:47 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 12:56:47 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 12:56:47 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 12:56:47 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 12:56:47 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jan 13 12:56:47 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 13 12:56:47 volumio volumio[996]: info: Asound.conf file written Jan 13 12:56:47 volumio sudo[3133]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jan 13 12:56:47 volumio sudo[3133]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 12:56:47 volumio sudo[3133]: pam_unix(sudo:session): session closed for user root Jan 13 12:56:47 volumio volumio[996]: xcb_connection_has_error() returned true Jan 13 12:56:47 volumio volumio[996]: No state is present for card McIntosh Jan 13 12:56:47 volumio volumio[996]: Found hardware: "USB-Audio" "USB Mixer" "USB2afd:000b" "" "" Jan 13 12:56:47 volumio volumio[996]: Hardware is initialized using a generic method Jan 13 12:56:47 volumio volumio[996]: No state is present for card McIntosh Jan 13 12:56:47 volumio volumio[996]: info: Output device has changed, restarting MPD Jan 13 12:56:47 volumio sudo[3138]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 13 12:56:47 volumio sudo[3138]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 12:56:47 volumio sudo[3138]: pam_unix(sudo:session): session closed for user root Jan 13 12:56:47 volumio volumio[996]: info: Output device has changed, restarting Shairport Sync Jan 13 12:56:47 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:47 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 13 12:56:47 volumio sudo[3141]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 13 12:56:47 volumio sudo[3141]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 12:56:47 volumio systemd[1]: Stopping Music Player Daemon... Jan 13 12:56:47 volumio volumio[996]: xcb_connection_has_error() returned true Jan 13 12:56:47 volumio volumio[996]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 13 12:56:47 volumio volumio[996]: xcb_connection_has_error() returned true Jan 13 12:56:47 volumio volumio[996]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 13 12:56:47 volumio systemd[1]: mpd.service: Succeeded. Jan 13 12:56:47 volumio systemd[1]: Stopped Music Player Daemon. Jan 13 12:56:47 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:47 volumio volumio[996]: info: Output device has changed, restarting MPD Jan 13 12:56:47 volumio sudo[3150]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 13 12:56:47 volumio sudo[3150]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 12:56:47 volumio systemd[1]: Starting Music Player Daemon... Jan 13 12:56:47 volumio sudo[3153]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 13 12:56:47 volumio sudo[3153]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 12:56:47 volumio sudo[3153]: pam_unix(sudo:session): session closed for user root Jan 13 12:56:47 volumio sudo[3150]: pam_unix(sudo:session): session closed for user root Jan 13 12:56:47 volumio volumio[996]: info: Output device has changed, restarting Shairport Sync Jan 13 12:56:47 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:47 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 13 12:56:47 volumio sudo[3157]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 13 12:56:47 volumio sudo[3157]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 12:56:47 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jan 13 12:56:47 volumio systemd[1]: mpd.service: Succeeded. Jan 13 12:56:47 volumio systemd[1]: Stopped Music Player Daemon. Jan 13 12:56:47 volumio systemd[1]: Starting Music Player Daemon... Jan 13 12:56:48 volumio volumio[996]: xcb_connection_has_error() returned true Jan 13 12:56:48 volumio volumio[996]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 13 12:56:48 volumio volumio[996]: xcb_connection_has_error() returned true Jan 13 12:56:48 volumio volumio[996]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 13 12:56:48 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:48 volumio sudo[3166]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 13 12:56:48 volumio sudo[3166]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 12:56:48 volumio sudo[3162]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 13 12:56:48 volumio sudo[3162]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 12:56:48 volumio sudo[3162]: pam_unix(sudo:session): session closed for user root Jan 13 12:56:48 volumio sudo[3169]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 13 12:56:48 volumio sudo[3169]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 12:56:48 volumio sudo[3174]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 13 12:56:48 volumio volumio[996]: info: Jan 13 12:56:48 volumio volumio[996]: ---------------------------- MPD announces state update: mixer Jan 13 12:56:48 volumio volumio[996]: info: ControllerMpd::getState Jan 13 12:56:48 volumio volumio[996]: verbose: ControllerMpd::sendMpdCommand status Jan 13 12:56:48 volumio volumio[996]: error: MPD error: Error: write EPIPE Jan 13 12:56:48 volumio volumio[996]: error: write EPIPE {"errno":-32,"code":"EPIPE","syscall":"write"} Jan 13 12:56:48 volumio volumio[996]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 13 12:56:48 volumio volumio[996]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 13 12:56:48 volumio volumio[996]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 13 12:56:48 volumio sudo[3174]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 12:56:48 volumio volumio[996]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 13 12:56:48 volumio volumio[996]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 13 12:56:48 volumio volumio[996]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 13 12:56:48 volumio volumio[996]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 13 12:56:48 volumio volumio[996]: info: MPD Permissions set Jan 13 12:56:48 volumio volumio[996]: info: MPD Permissions set Jan 13 12:56:48 volumio sudo[3169]: pam_unix(sudo:session): session closed for user root Jan 13 12:56:48 volumio volumio[996]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 13 12:56:48 volumio volumio[996]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 13 12:56:48 volumio sudo[3166]: pam_unix(sudo:session): session closed for user root Jan 13 12:56:48 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:48 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:48 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:48 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:48 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:48 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:48 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:48 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:48 volumio sudo[3174]: pam_unix(sudo:session): session closed for user root Jan 13 12:56:48 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 13 12:56:48 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:48 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:48 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:48 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:48 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:48 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:48 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:48 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:48 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:48 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 13 12:56:48 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:48 volumio volumio[996]: info: Starting Shairport Sync Jan 13 12:56:48 volumio volumio[996]: info: Starting Shairport Sync Jan 13 12:56:48 volumio sudo[3188]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 13 12:56:48 volumio sudo[3188]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 12:56:48 volumio volumio[996]: info: Preparing to generate the ALSA configuration file Jan 13 12:56:48 volumio sudo[3190]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 13 12:56:48 volumio sudo[3190]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 12:56:48 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 13 12:56:48 volumio volumio[996]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jan 13 12:56:48 volumio volumio[996]: info: Reading ALSA contributions from plugins. Jan 13 12:56:48 volumio systemd[1]: shairport-sync.service: Succeeded. Jan 13 12:56:48 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 13 12:56:48 volumio volumio[996]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 13 12:56:48 volumio volumio[996]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 13 12:56:48 volumio volumio[996]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 13 12:56:48 volumio volumio[996]: info: Asound.conf file written Jan 13 12:56:48 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 13 12:56:48 volumio sudo[3188]: pam_unix(sudo:session): session closed for user root Jan 13 12:56:48 volumio sudo[3195]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jan 13 12:56:48 volumio sudo[3195]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 12:56:48 volumio sudo[3190]: pam_unix(sudo:session): session closed for user root Jan 13 12:56:48 volumio sudo[3195]: pam_unix(sudo:session): session closed for user root Jan 13 12:56:48 volumio volumio[996]: xcb_connection_has_error() returned true Jan 13 12:56:48 volumio volumio[996]: No state is present for card McIntosh Jan 13 12:56:48 volumio volumio[996]: Found hardware: "USB-Audio" "USB Mixer" "USB2afd:000b" "" "" Jan 13 12:56:48 volumio volumio[996]: Hardware is initialized using a generic method Jan 13 12:56:48 volumio volumio[996]: No state is present for card McIntosh Jan 13 12:56:48 volumio volumio[996]: info: Output device has changed, restarting MPD Jan 13 12:56:48 volumio sudo[3202]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 13 12:56:48 volumio sudo[3202]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 12:56:48 volumio volumio[996]: info: Output device has changed, restarting Shairport Sync Jan 13 12:56:48 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:48 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 13 12:56:48 volumio sudo[3202]: pam_unix(sudo:session): session closed for user root Jan 13 12:56:48 volumio sudo[3205]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 13 12:56:48 volumio sudo[3205]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 12:56:48 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jan 13 12:56:48 volumio systemd[1]: mpd.service: Succeeded. Jan 13 12:56:48 volumio systemd[1]: Stopped Music Player Daemon. Jan 13 12:56:48 volumio volumio[996]: xcb_connection_has_error() returned true Jan 13 12:56:48 volumio volumio[996]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 13 12:56:48 volumio volumio[996]: xcb_connection_has_error() returned true Jan 13 12:56:48 volumio volumio[996]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 13 12:56:48 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:48 volumio systemd[1]: Starting Music Player Daemon... Jan 13 12:56:48 volumio sudo[3214]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 13 12:56:48 volumio sudo[3214]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 12:56:48 volumio volumio[996]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 13 12:56:48 volumio volumio[996]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 13 12:56:48 volumio volumio[996]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 13 12:56:48 volumio volumio[996]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 13 12:56:48 volumio volumio[996]: info: MPD Permissions set Jan 13 12:56:48 volumio volumio[996]: info: Shairport-Sync Started Jan 13 12:56:48 volumio sudo[3218]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 13 12:56:48 volumio volumio[996]: info: Shairport-Sync Started Jan 13 12:56:48 volumio sudo[3218]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 12:56:48 volumio volumio[996]: info: Preparing to generate the ALSA configuration file Jan 13 12:56:48 volumio sudo[3214]: pam_unix(sudo:session): session closed for user root Jan 13 12:56:48 volumio volumio[996]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jan 13 12:56:48 volumio volumio[996]: info: Reading ALSA contributions from plugins. Jan 13 12:56:48 volumio sudo[3210]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 13 12:56:48 volumio sudo[3210]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 12:56:48 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:48 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:48 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:48 volumio sudo[3218]: pam_unix(sudo:session): session closed for user root Jan 13 12:56:48 volumio sudo[3210]: pam_unix(sudo:session): session closed for user root Jan 13 12:56:48 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 13 12:56:48 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:48 volumio volumio[996]: info: Starting Shairport Sync Jan 13 12:56:48 volumio volumio[996]: info: Asound.conf file unchanged, so no further update is needed Jan 13 12:56:48 volumio volumio[996]: info: Output device has changed, restarting MPD Jan 13 12:56:48 volumio sudo[3229]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 13 12:56:48 volumio sudo[3229]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 12:56:48 volumio sudo[3232]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 13 12:56:48 volumio sudo[3232]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 12:56:48 volumio sudo[3232]: pam_unix(sudo:session): session closed for user root Jan 13 12:56:48 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 13 12:56:48 volumio volumio[996]: info: Output device has changed, restarting Shairport Sync Jan 13 12:56:48 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:48 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 13 12:56:48 volumio sudo[3236]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 13 12:56:48 volumio sudo[3236]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 12:56:48 volumio systemd[1]: shairport-sync.service: Succeeded. Jan 13 12:56:48 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 13 12:56:48 volumio volumio[996]: xcb_connection_has_error() returned true Jan 13 12:56:48 volumio volumio[996]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 13 12:56:48 volumio volumio[996]: xcb_connection_has_error() returned true Jan 13 12:56:48 volumio volumio[996]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 13 12:56:48 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:48 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 13 12:56:48 volumio sudo[3229]: pam_unix(sudo:session): session closed for user root Jan 13 12:56:48 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jan 13 12:56:48 volumio systemd[1]: mpd.service: Succeeded. Jan 13 12:56:48 volumio systemd[1]: Stopped Music Player Daemon. Jan 13 12:56:48 volumio sudo[3245]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 13 12:56:48 volumio sudo[3245]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 12:56:48 volumio systemd[1]: Starting Music Player Daemon... Jan 13 12:56:48 volumio volumio[996]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 13 12:56:48 volumio volumio[996]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 13 12:56:48 volumio volumio[996]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 13 12:56:48 volumio sudo[3248]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 13 12:56:48 volumio sudo[3248]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 12:56:48 volumio volumio[996]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 13 12:56:48 volumio volumio[996]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 13 12:56:48 volumio volumio[996]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 13 12:56:48 volumio volumio[996]: info: MPD Permissions set Jan 13 12:56:48 volumio volumio[996]: info: Shairport-Sync Started Jan 13 12:56:48 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:48 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:48 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:48 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:48 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:48 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:48 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:48 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:48 volumio sudo[3248]: pam_unix(sudo:session): session closed for user root Jan 13 12:56:48 volumio sudo[3245]: pam_unix(sudo:session): session closed for user root Jan 13 12:56:48 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 13 12:56:48 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:48 volumio volumio[996]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 13 12:56:48 volumio volumio[996]: info: Starting Shairport Sync Jan 13 12:56:48 volumio sudo[3249]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 13 12:56:48 volumio sudo[3249]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 12:56:48 volumio sudo[3249]: pam_unix(sudo:session): session closed for user root Jan 13 12:56:48 volumio sudo[3262]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 13 12:56:48 volumio sudo[3262]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 12:56:48 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 13 12:56:48 volumio systemd[1]: shairport-sync.service: Succeeded. Jan 13 12:56:48 volumio volumio[996]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 13 12:56:48 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 13 12:56:49 volumio volumio[996]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 13 12:56:49 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 13 12:56:49 volumio sudo[3262]: pam_unix(sudo:session): session closed for user root Jan 13 12:56:49 volumio volumio[996]: info: Shairport-Sync Started Jan 13 12:56:49 volumio volumio[996]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Jan 13 12:56:49 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Jan 13 12:56:49 volumio volumio[996]: info: Preparing to save Alsa Options, stopping services first Jan 13 12:56:49 volumio volumio[996]: info: CoreCommandRouter::volumioGetState Jan 13 12:56:49 volumio volumio[996]: info: CoreCommandRouter::volumioPause Jan 13 12:56:49 volumio volumio[996]: info: CoreStateMachine::pause Jan 13 12:56:49 volumio volumio[996]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"McIntosh"},"i2s":false,"i2sid":{"value":"adafruit-max98357","label":"Adafruit MAX98357"}} Jan 13 12:56:49 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 13 12:56:49 volumio mpd[3261]: Jan 13 12:56 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 13 12:56:49 volumio systemd[1]: Started Music Player Daemon. Jan 13 12:56:49 volumio sudo[3157]: pam_unix(sudo:session): session closed for user root Jan 13 12:56:49 volumio sudo[3236]: pam_unix(sudo:session): session closed for user root Jan 13 12:56:49 volumio sudo[3141]: pam_unix(sudo:session): session closed for user root Jan 13 12:56:49 volumio sudo[3205]: pam_unix(sudo:session): session closed for user root Jan 13 12:56:49 volumio volumio[996]: xcb_connection_has_error() returned true Jan 13 12:56:49 volumio volumio[996]: xcb_connection_has_error() returned true Jan 13 12:56:49 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 13 12:56:49 volumio volumio[996]: xcb_connection_has_error() returned true Jan 13 12:56:49 volumio volumio[996]: info: Device 5 does not have any Mixer Control Available Jan 13 12:56:49 volumio sudo[3276]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 13 12:56:49 volumio sudo[3276]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 12:56:49 volumio sudo[3276]: pam_unix(sudo:session): session closed for user root Jan 13 12:56:49 volumio volumio[996]: xcb_connection_has_error() returned true Jan 13 12:56:49 volumio volumio[996]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jan 13 12:56:49 volumio volumio[996]: info: Updating Volume Controller Parameters: Device: 5 Name: McIntosh Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jan 13 12:56:49 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jan 13 12:56:49 volumio volumio[996]: info: Disabling external Volume Control Jan 13 12:56:49 volumio volumio[996]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 13 12:56:49 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:56:49 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 12:56:49 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:56:49 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:56:49 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:56:49 volumio volumio[996]: info: Preparing to generate the ALSA configuration file Jan 13 12:56:49 volumio volumio[996]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jan 13 12:56:49 volumio volumio[996]: info: Reading ALSA contributions from plugins. Jan 13 12:56:49 volumio sudo[3282]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 13 12:56:49 volumio sudo[3282]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 12:56:49 volumio sudo[3282]: pam_unix(sudo:session): session closed for user root Jan 13 12:56:49 volumio volumio[996]: error: MPD error: The expression evaluated to a falsy value: Jan 13 12:56:49 volumio volumio[996]: assert.ok(self.idling) Jan 13 12:56:49 volumio volumio[996]: error: The expression evaluated to a falsy value: Jan 13 12:56:49 volumio volumio[996]: assert.ok(self.idling) Jan 13 12:56:49 volumio volumio[996]: error: MPD error: The expression evaluated to a falsy value: Jan 13 12:56:49 volumio volumio[996]: assert.ok(self.idling) Jan 13 12:56:49 volumio volumio[996]: error: The expression evaluated to a falsy value: Jan 13 12:56:49 volumio volumio[996]: assert.ok(self.idling) Jan 13 12:56:49 volumio volumio[996]: error: MPD error: The expression evaluated to a falsy value: Jan 13 12:56:49 volumio volumio[996]: assert.ok(self.idling) Jan 13 12:56:49 volumio volumio[996]: error: The expression evaluated to a falsy value: Jan 13 12:56:49 volumio volumio[996]: assert.ok(self.idling) Jan 13 12:56:49 volumio volumio[996]: xcb_connection_has_error() returned true Jan 13 12:56:49 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jan 13 12:56:49 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 13 12:56:49 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 13 12:56:49 volumio volumio[996]: xcb_connection_has_error() returned true Jan 13 12:56:49 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 12:56:49 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 12:56:49 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 12:56:49 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 12:56:49 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 12:56:49 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 12:56:49 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 13 12:56:49 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jan 13 12:56:49 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 13 12:56:49 volumio volumio[996]: error: updateQueue error: null Jan 13 12:56:49 volumio volumio[996]: info: Asound.conf file unchanged, so no further update is needed Jan 13 12:56:49 volumio volumio[996]: info: Output device has changed, restarting MPD Jan 13 12:56:49 volumio sudo[3290]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 13 12:56:49 volumio sudo[3290]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 12:56:49 volumio volumio[996]: info: Output device has changed, restarting Shairport Sync Jan 13 12:56:49 volumio sudo[3290]: pam_unix(sudo:session): session closed for user root Jan 13 12:56:50 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:50 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 13 12:56:50 volumio sudo[3293]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 13 12:56:50 volumio sudo[3293]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 12:56:50 volumio systemd[1]: Stopping Music Player Daemon... Jan 13 12:56:50 volumio systemd[1]: mpd.service: Succeeded. Jan 13 12:56:50 volumio systemd[1]: Stopped Music Player Daemon. Jan 13 12:56:50 volumio volumio[996]: xcb_connection_has_error() returned true Jan 13 12:56:50 volumio volumio[996]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 13 12:56:50 volumio volumio[996]: xcb_connection_has_error() returned true Jan 13 12:56:50 volumio volumio[996]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 13 12:56:50 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:50 volumio sudo[3302]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 13 12:56:50 volumio sudo[3302]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 12:56:50 volumio systemd[1]: Starting Music Player Daemon... Jan 13 12:56:50 volumio volumio[996]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 13 12:56:50 volumio volumio[996]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 13 12:56:50 volumio sudo[3305]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 13 12:56:50 volumio volumio[996]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 13 12:56:50 volumio sudo[3305]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 12:56:50 volumio volumio[996]: info: MPD Permissions set Jan 13 12:56:50 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:50 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:50 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:50 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:50 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:50 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:50 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:50 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:50 volumio sudo[3302]: pam_unix(sudo:session): session closed for user root Jan 13 12:56:50 volumio sudo[3305]: pam_unix(sudo:session): session closed for user root Jan 13 12:56:50 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 13 12:56:50 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 12:56:50 volumio volumio[996]: info: Starting Shairport Sync Jan 13 12:56:50 volumio sudo[3298]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 13 12:56:50 volumio sudo[3298]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 12:56:50 volumio sudo[3298]: pam_unix(sudo:session): session closed for user root Jan 13 12:56:50 volumio sudo[3314]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 13 12:56:50 volumio sudo[3314]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 12:56:50 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 13 12:56:50 volumio volumio[996]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 13 12:56:50 volumio systemd[1]: shairport-sync.service: Succeeded. Jan 13 12:56:50 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 13 12:56:50 volumio volumio[996]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 13 12:56:50 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 13 12:56:50 volumio sudo[3314]: pam_unix(sudo:session): session closed for user root Jan 13 12:56:50 volumio volumio[996]: info: Shairport-Sync Started Jan 13 12:56:50 volumio volumio[996]: info: TidalConnect service stoped! Jan 13 12:56:50 volumio volumio[996]: info: TidalConnect service stoped! Jan 13 12:56:50 volumio volumio[996]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jan 13 12:56:50 volumio volumio[996]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jan 13 12:56:50 volumio sudo[3330]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jan 13 12:56:50 volumio sudo[3330]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 12:56:50 volumio systemd[1]: Started Volumio Tidal Connect Service. Jan 13 12:56:50 volumio sudo[3330]: pam_unix(sudo:session): session closed for user root Jan 13 12:56:50 volumio volumio[996]: info: Executing endpoint tc_getconfig Jan 13 12:56:50 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Jan 13 12:56:50 volumio vtcs[3332]: STARTING TidalConnect services, version: 1.4.0.34 Jan 13 12:56:50 volumio mpd[3317]: Jan 13 12:56 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 13 12:56:50 volumio systemd[1]: Started Music Player Daemon. Jan 13 12:56:50 volumio sudo[3293]: pam_unix(sudo:session): session closed for user root Jan 13 12:56:50 volumio volumio[996]: error: updateQueue error: null Jan 13 12:56:50 volumio vtcs[3332]: STARTED TidalConnect services. Jan 13 12:56:50 volumio volumio[996]: info: Executing endpoint tc_connect Jan 13 12:56:50 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Jan 13 12:56:50 volumio volumio[996]: info: Connecting to TidalConnect Jan 13 12:56:50 volumio volumio[996]: info: TidalConnect service stoped! Jan 13 12:56:50 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:56:50 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:56:50 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 12:56:50 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:56:50 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:56:50 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:56:50 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Jan 13 12:56:50 volumio volumio[996]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Jan 13 12:56:50 volumio volumio[996]: verbose: CURRENT POSITION 0 Jan 13 12:56:50 volumio volumio[996]: info: CoreStateMachine::syncState stateService stop Jan 13 12:56:50 volumio volumio[996]: info: CoreStateMachine::syncState currentStatus pause Jan 13 12:56:50 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:56:50 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 12:56:50 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:56:50 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:56:50 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:56:50 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:56:50 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:56:50 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:56:50 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:56:50 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:56:50 volumio volumio[996]: info: CorePlayQueue::getTrack 0 Jan 13 12:56:50 volumio volumio[996]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Jan 13 12:56:50 volumio volumio[996]: verbose: CURRENT POSITION 0 Jan 13 12:56:50 volumio volumio[996]: info: CoreStateMachine::syncState stateService stop Jan 13 12:56:50 volumio volumio[996]: info: CoreStateMachine::syncState currentStatus pause Jan 13 12:56:50 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:56:50 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:56:50 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:56:50 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:56:51 volumio volumio[996]: info: TidalConnect service stoped! Jan 13 12:56:51 volumio volumio[996]: info: TidalConnect service stoped! Jan 13 12:56:51 volumio volumio[996]: info: TidalConnect service stoped! Jan 13 12:56:51 volumio volumio[996]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jan 13 12:56:51 volumio volumio[996]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jan 13 12:56:51 volumio sudo[3369]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jan 13 12:56:51 volumio sudo[3369]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 12:56:51 volumio volumio[996]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jan 13 12:56:51 volumio volumio[996]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jan 13 12:56:51 volumio sudo[3369]: pam_unix(sudo:session): session closed for user root Jan 13 12:56:51 volumio sudo[3377]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jan 13 12:56:51 volumio sudo[3377]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 12:56:51 volumio sudo[3377]: pam_unix(sudo:session): session closed for user root Jan 13 12:56:51 volumio volumio[996]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Jan 13 12:56:51 volumio volumio[996]: info: CoreStateMachine::getcurrentVolume Jan 13 12:56:51 volumio volumio[996]: info: CoreCommandRouter::volumioRetrievevolume Jan 13 12:56:51 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:56:51 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 12:56:51 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:56:51 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:56:51 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:56:51 volumio volumio[996]: info: TidalConnect service stoped! Jan 13 12:56:51 volumio volumio[996]: info: TidalConnect service stoped! Jan 13 12:56:51 volumio volumio[996]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jan 13 12:56:51 volumio volumio[996]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jan 13 12:56:51 volumio sudo[3389]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jan 13 12:56:51 volumio sudo[3389]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 12:56:51 volumio sudo[3389]: pam_unix(sudo:session): session closed for user root Jan 13 12:56:51 volumio volumio[996]: info: TidalConnect service stoped! Jan 13 12:56:51 volumio volumio[996]: info: TidalConnect service stoped! Jan 13 12:56:51 volumio volumio[996]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jan 13 12:56:51 volumio volumio[996]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jan 13 12:56:51 volumio sudo[3401]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jan 13 12:56:51 volumio sudo[3401]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 12:56:51 volumio sudo[3401]: pam_unix(sudo:session): session closed for user root Jan 13 12:56:52 volumio volumio[996]: info: TidalConnect service stoped! Jan 13 12:56:52 volumio volumio[996]: info: TidalConnect service stoped! Jan 13 12:56:52 volumio volumio[996]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jan 13 12:56:52 volumio volumio[996]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jan 13 12:56:52 volumio sudo[3413]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jan 13 12:56:52 volumio sudo[3413]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 12:56:52 volumio sudo[3413]: pam_unix(sudo:session): session closed for user root Jan 13 12:56:53 volumio volumio[996]: info: TidalConnect service stoped! Jan 13 12:56:53 volumio volumio[996]: info: TidalConnect service stoped! Jan 13 12:56:53 volumio volumio[996]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jan 13 12:56:53 volumio volumio[996]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jan 13 12:56:53 volumio sudo[3425]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jan 13 12:56:53 volumio sudo[3425]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 13 12:56:53 volumio sudo[3425]: pam_unix(sudo:session): session closed for user root Jan 13 12:56:53 volumio volumio[996]: info: TidalConnect service started! Jan 13 12:56:53 volumio volumio[996]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Jan 13 12:56:53 volumio volumio[996]: info: CoreStateMachine::getcurrentVolume Jan 13 12:56:53 volumio volumio[996]: info: CoreCommandRouter::volumioRetrievevolume Jan 13 12:56:53 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:56:53 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 12:56:53 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:56:53 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:56:53 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:56:54 volumio volumio[996]: info: TidalConnect service started! Jan 13 12:56:54 volumio volumio[996]: info: TidalConnect service started! Jan 13 12:56:54 volumio volumio[996]: info: TidalConnect service started! Jan 13 12:56:54 volumio volumio[996]: info: TidalConnect service started! Jan 13 12:56:55 volumio volumio[996]: info: TidalConnect service started! Jan 13 12:56:56 volumio volumio[996]: info: TidalConnect service started! Jan 13 12:57:04 volumio volumio[996]: info: Airplay started streaming, receiving metadatas Jan 13 12:57:04 volumio volumio[996]: info: Airplay started streaming, receiving metadatas Jan 13 12:57:04 volumio volumio[996]: info: Airplay started streaming, receiving metadatas Jan 13 12:57:04 volumio shairport-sync[3318]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 13 12:57:04 volumio shairport-sync[3318]: Dload Upload Total Spent Left Speed Jan 13 12:57:04 volumio volumio[996]: info: Jan 13 12:57:04 volumio volumio[996]: ---------------------------- Client requests Start Airplay PlaybackRoutine Jan 13 12:57:04 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startAirplayPlayback Jan 13 12:57:04 volumio volumio[996]: info: Airplay playback start Jan 13 12:57:04 volumio shairport-sync[3318]: [158B blob data] Jan 13 12:57:04 volumio shairport-sync[3318]: {"time":1736747824499,"response":"startAirplayPlayback Success"}ALSA lib /home/pi/volumio-alsa-plugin/src/pcm_volumioswitch.c:257:(_snd_pcm_volumioswitch_hw_params) PCM volumioMultiRoomServer has buffer size 131072, but target_pcm volumioOutput has buffer size 88200 Jan 13 12:57:04 volumio shairport-sync[3318]: ALSA lib /home/pi/volumio-alsa-plugin/src/pcm_volumioswitch.c:268:(_snd_pcm_volumioswitch_hw_params) PCM volumioMultiRoomServer has buffer size 131072, but target_pcm volumioOutput has buffer size 88200 Jan 13 12:57:04 volumio shairport-sync[3318]: ALSA lib /home/pi/volumio-alsa-plugin/src/pcm_volumioswitch.c:257:(_snd_pcm_volumioswitch_hw_params) PCM volumioMultiRoomServer has buffer size 131072, but target_pcm volumioOutput has buffer size 88200 Jan 13 12:57:04 volumio shairport-sync[3318]: ALSA lib /home/pi/volumio-alsa-plugin/src/pcm_volumioswitch.c:268:(_snd_pcm_volumioswitch_hw_params) PCM volumioMultiRoomServer has buffer size 131072, but target_pcm volumioOutput has buffer size 88200 Jan 13 12:57:05 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:57:05 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:57:05 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 12:57:05 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:57:05 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:57:05 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:57:05 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:57:05 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:57:05 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:57:05 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:57:05 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:57:05 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:57:05 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:57:05 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:57:05 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:57:05 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:57:05 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:57:05 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:57:05 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:57:05 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:57:05 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:57:05 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:57:05 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:57:05 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:57:05 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:57:05 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:57:05 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:57:05 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:57:05 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:57:05 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:57:05 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:57:05 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:57:05 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:57:05 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:57:05 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:57:05 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:57:05 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:57:05 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:57:05 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:57:05 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:57:05 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:57:05 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:57:05 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:57:05 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:57:05 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:57:05 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:57:05 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:57:05 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:57:05 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:57:05 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:57:05 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:57:06 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:57:06 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:57:06 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 12:57:06 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:57:06 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:57:06 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:57:06 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:57:06 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:57:06 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:57:06 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:57:06 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:57:06 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:57:06 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:57:06 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:57:06 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:57:06 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:57:06 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:57:06 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:57:06 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:57:06 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:57:06 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:57:06 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:57:06 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:57:06 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:57:06 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:57:06 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:57:06 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:57:06 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:57:06 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:57:06 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:57:06 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:57:06 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:57:06 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:57:06 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:57:06 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:57:06 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:57:06 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:57:06 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:57:06 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:57:06 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:57:06 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:57:06 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:57:06 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:57:06 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:57:06 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:57:06 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:57:06 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:57:06 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:57:06 volumio volumio[996]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 12:57:06 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:57:06 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:57:06 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:57:06 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:57:06 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:57:06 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:57:06 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:57:06 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:57:06 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:57:06 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:57:06 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:57:06 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:57:06 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:57:06 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:57:06 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:57:06 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:57:06 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:57:06 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:57:06 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:57:06 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:57:06 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:57:06 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:57:06 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:57:06 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:57:06 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:57:06 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:57:06 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:57:06 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:57:06 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:57:06 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:57:06 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:57:06 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:57:06 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:57:06 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:57:06 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:57:06 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:57:06 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:57:06 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:57:06 volumio volumio[996]: info: CoreCommandRouter::servicePushState Jan 13 12:57:06 volumio volumio[996]: info: CoreStateMachine::pushState Jan 13 12:57:06 volumio volumio[996]: info: CoreCommandRouter::volumioPushState Jan 13 12:57:06 volumio volumio[996]: info: MRS: Pushing multiroomSync output update for this device Jan 13 12:57:06 volumio volumio[996]: info: MRS: Pushing multiroomSync output Jan 13 12:57:24 volumio ntpd[763]: Soliciting pool server 27.71.27.209 Jan 13 12:57:28 volumio ntpd[763]: Soliciting pool server 115.165.161.155 Jan 13 12:57:29 volumio ntpd[763]: Soliciting pool server 103.184.124.254 Jan 13 12:57:29 volumio ntpd[763]: Soliciting pool server 115.165.161.155 Jan 13 12:57:58 volumio volumio[996]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 13 12:57:58 volumio volumio[996]: Error: connect ETIMEDOUT 151.101.78.79:443 Jan 13 12:57:58 volumio volumio[996]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Jan 13 12:57:58 volumio volumio[996]: errno: -110, Jan 13 12:57:58 volumio volumio[996]: code: 'ETIMEDOUT', Jan 13 12:57:58 volumio volumio[996]: syscall: 'connect', Jan 13 12:57:58 volumio volumio[996]: address: '151.101.78.79', Jan 13 12:57:58 volumio volumio[996]: port: 443 Jan 13 12:57:58 volumio volumio[996]: } Jan 13 12:57:58 volumio volumio[996]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 13 12:57:58 volumio sudo[3604]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-13 12:56 Jan 13 12:57:58 volumio sudo[3604]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"