-- Logs begin at Thu 2019-02-14 12:11:58 EET, end at Tue 2026-02-17 13:06:45 EET. -- Feb 17 13:05:47 rivo volumio[3181]: info: Pushing metadata Feb 17 13:05:47 rivo volumio[3181]: info: CoreCommandRouter::servicePushState Feb 17 13:05:47 rivo volumio[3181]: info: CoreStateMachine::pushState Feb 17 13:05:47 rivo volumio[3181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 13:05:47 rivo volumio[3181]: info: CoreCommandRouter::volumioPushState Feb 17 13:05:47 rivo volumio[3181]: info: CoreCommandRouter::volumioGetState Feb 17 13:05:47 rivo volumio[3181]: info: MRS: Pushing multiroomSync output update for this device Feb 17 13:05:47 rivo volumio[3181]: info: MRS: Pushing multiroomSync output Feb 17 13:05:47 rivo volumio[3181]: info: CoreCommandRouter::servicePushState Feb 17 13:05:47 rivo volumio[3181]: info: CoreStateMachine::pushState Feb 17 13:05:47 rivo volumio[3181]: info: CoreCommandRouter::volumioPushState Feb 17 13:05:47 rivo volumio[3181]: info: CoreCommandRouter::volumioGetState Feb 17 13:05:47 rivo volumio[3181]: info: MRS: Pushing multiroomSync output update for this device Feb 17 13:05:47 rivo volumio[3181]: info: MRS: Pushing multiroomSync output Feb 17 13:05:47 rivo volumio[3181]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 17 13:05:47 rivo volumio[3181]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 17 13:06:17 rivo vtcs[3910]: [close:85] Entering Feb 17 13:06:17 rivo vtcs[3910]: [feedThread:276] Exiting Feb 17 13:06:17 rivo vtcs[3910]: [close:100] Exiting Feb 17 13:06:17 rivo volumio[3181]: info: CoreCommandRouter::servicePushState Feb 17 13:06:17 rivo volumio[3181]: info: CoreStateMachine::pushState Feb 17 13:06:17 rivo volumio[3181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 13:06:17 rivo volumio[3181]: info: CoreCommandRouter::volumioPushState Feb 17 13:06:17 rivo volumio[3181]: info: CoreCommandRouter::volumioGetState Feb 17 13:06:17 rivo volumio[3181]: info: MRS: Pushing multiroomSync output update for this device Feb 17 13:06:17 rivo volumio[3181]: info: MRS: Pushing multiroomSync output Feb 17 13:06:17 rivo volumio[3181]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 17 13:06:17 rivo volumio[3181]: info: MCU Signalled Playback Inactive Feb 17 13:06:17 rivo vtcs[3910]: [2026-02-17 13:06:17.692] [tisoc] [warning] [PlaybackControllerImpl.cpp:213] Ignore play request because playback state is not STARTED. state_=2, playstate_=1, player_state_=0 Feb 17 13:06:17 rivo volumio[3181]: info: Pushing metadata Feb 17 13:06:17 rivo volumio[3181]: info: CoreCommandRouter::servicePushState Feb 17 13:06:17 rivo volumio[3181]: info: CoreStateMachine::pushState Feb 17 13:06:17 rivo volumio[3181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 13:06:17 rivo volumio[3181]: info: CoreCommandRouter::volumioPushState Feb 17 13:06:17 rivo volumio[3181]: info: CoreCommandRouter::volumioGetState Feb 17 13:06:17 rivo volumio[3181]: info: MRS: Pushing multiroomSync output update for this device Feb 17 13:06:17 rivo volumio[3181]: info: MRS: Pushing multiroomSync output Feb 17 13:06:17 rivo volumio[3181]: info: CoreCommandRouter::servicePushState Feb 17 13:06:17 rivo volumio[3181]: info: CoreStateMachine::pushState Feb 17 13:06:17 rivo volumio[3181]: info: CoreCommandRouter::volumioPushState Feb 17 13:06:17 rivo volumio[3181]: info: CoreCommandRouter::volumioGetState Feb 17 13:06:17 rivo volumio[3181]: info: MRS: Pushing multiroomSync output update for this device Feb 17 13:06:17 rivo volumio[3181]: info: MRS: Pushing multiroomSync output Feb 17 13:06:17 rivo volumio[3181]: info: CoreCommandRouter::servicePushState Feb 17 13:06:17 rivo volumio[3181]: info: CoreStateMachine::pushState Feb 17 13:06:17 rivo volumio[3181]: info: CoreCommandRouter::volumioPushState Feb 17 13:06:17 rivo volumio[3181]: info: CoreCommandRouter::volumioGetState Feb 17 13:06:17 rivo volumio[3181]: info: MRS: Pushing multiroomSync output update for this device Feb 17 13:06:17 rivo volumio[3181]: info: MRS: Pushing multiroomSync output Feb 17 13:06:17 rivo volumio[3181]: info: CoreCommandRouter::servicePushState Feb 17 13:06:17 rivo volumio[3181]: info: CoreStateMachine::pushState Feb 17 13:06:17 rivo volumio[3181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 13:06:17 rivo volumio[3181]: info: CoreCommandRouter::volumioPushState Feb 17 13:06:17 rivo volumio[3181]: info: CoreCommandRouter::volumioGetState Feb 17 13:06:17 rivo volumio[3181]: info: MRS: Pushing multiroomSync output update for this device Feb 17 13:06:17 rivo volumio[3181]: info: MRS: Pushing multiroomSync output Feb 17 13:06:17 rivo volumio[3181]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 17 13:06:17 rivo volumio[3181]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 17 13:06:17 rivo volumio[3181]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 17 13:06:17 rivo volumio[3181]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 17 13:06:17 rivo volumio[3181]: info: Signalling Playback active due to playback status change Feb 17 13:06:17 rivo volumio[3181]: info: MCU Signalled Playback Active Feb 17 13:06:18 rivo vtcs[3910]: [close:85] Entering Feb 17 13:06:18 rivo vtcs[3910]: [close:100] Exiting Feb 17 13:06:18 rivo volumio[3181]: info: Pushing metadata Feb 17 13:06:18 rivo volumio[3181]: info: CoreCommandRouter::servicePushState Feb 17 13:06:18 rivo volumio[3181]: info: CoreStateMachine::pushState Feb 17 13:06:18 rivo volumio[3181]: info: CoreCommandRouter::volumioPushState Feb 17 13:06:18 rivo volumio[3181]: info: CoreCommandRouter::volumioGetState Feb 17 13:06:18 rivo volumio[3181]: info: MRS: Pushing multiroomSync output update for this device Feb 17 13:06:18 rivo volumio[3181]: info: MRS: Pushing multiroomSync output Feb 17 13:06:18 rivo volumio[3181]: info: CoreCommandRouter::servicePushState Feb 17 13:06:18 rivo volumio[3181]: info: CoreStateMachine::pushState Feb 17 13:06:18 rivo volumio[3181]: info: CoreCommandRouter::volumioPushState Feb 17 13:06:18 rivo volumio[3181]: info: CoreCommandRouter::volumioGetState Feb 17 13:06:18 rivo volumio[3181]: info: MRS: Pushing multiroomSync output update for this device Feb 17 13:06:18 rivo volumio[3181]: info: MRS: Pushing multiroomSync output Feb 17 13:06:18 rivo volumio[3181]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 17 13:06:18 rivo volumio[3181]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 17 13:06:18 rivo vtcs[3910]: [close:85] Entering Feb 17 13:06:18 rivo vtcs[3910]: [close:100] Exiting Feb 17 13:06:18 rivo vtcs[3910]: [open:50] Opening with sample rate: 44100, type: 0 Feb 17 13:06:18 rivo vtcs[3910]: [start:106] Entering Feb 17 13:06:18 rivo vtcs[3910]: [start:113] Reopening PCM device... Feb 17 13:06:18 rivo volumio[3181]: info: CoreCommandRouter::servicePushState Feb 17 13:06:18 rivo volumio[3181]: info: CoreStateMachine::pushState Feb 17 13:06:18 rivo volumio[3181]: info: CoreCommandRouter::volumioPushState Feb 17 13:06:18 rivo volumio[3181]: info: CoreCommandRouter::volumioGetState Feb 17 13:06:18 rivo volumio[3181]: info: MRS: Pushing multiroomSync output update for this device Feb 17 13:06:18 rivo volumio[3181]: info: MRS: Pushing multiroomSync output Feb 17 13:06:18 rivo vtcs[3910]: [start:115] PCM opened successfully. Feb 17 13:06:18 rivo vtcs[3910]: [start:120] Exiting Feb 17 13:06:18 rivo vtcs[3910]: [feedThread:223] Entering Feb 17 13:06:18 rivo volumio[3181]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 17 13:06:18 rivo volumio[3181]: info: CoreCommandRouter::servicePushState Feb 17 13:06:18 rivo volumio[3181]: info: CoreStateMachine::pushState Feb 17 13:06:18 rivo volumio[3181]: info: CoreCommandRouter::volumioPushState Feb 17 13:06:18 rivo volumio[3181]: info: CoreCommandRouter::volumioGetState Feb 17 13:06:18 rivo volumio[3181]: info: MRS: Pushing multiroomSync output update for this device Feb 17 13:06:18 rivo volumio[3181]: info: MRS: Pushing multiroomSync output Feb 17 13:06:18 rivo volumio[3181]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 17 13:06:19 rivo volumio[3181]: info: CoreCommandRouter::servicePushState Feb 17 13:06:19 rivo volumio[3181]: info: CoreStateMachine::pushState Feb 17 13:06:19 rivo volumio[3181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 13:06:19 rivo volumio[3181]: info: CoreCommandRouter::volumioPushState Feb 17 13:06:19 rivo volumio[3181]: info: CoreCommandRouter::volumioGetState Feb 17 13:06:19 rivo volumio[3181]: info: MRS: Pushing multiroomSync output update for this device Feb 17 13:06:19 rivo volumio[3181]: info: MRS: Pushing multiroomSync output Feb 17 13:06:19 rivo volumio[3181]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 17 13:06:19 rivo volumio[3181]: info: Executing endpoint metavolumio Feb 17 13:06:19 rivo volumio[3181]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 17 13:06:19 rivo volumio[3181]: info: Executing endpoint metavolumio Feb 17 13:06:19 rivo volumio[3181]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 17 13:06:19 rivo volumio[3181]: info: Executing endpoint metavolumio Feb 17 13:06:19 rivo volumio[3181]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 17 13:06:29 rivo vtcs[3910]: [close:85] Entering Feb 17 13:06:29 rivo vtcs[3910]: [feedThread:276] Exiting Feb 17 13:06:29 rivo vtcs[3910]: [close:100] Exiting Feb 17 13:06:29 rivo vtcs[3910]: [2026-02-17 13:06:29.565] [tisoc] [warning] [PlaybackControllerImpl.cpp:220] Ignore play request because player state is already PLAYING. state_=2, playstate_=1, player_state_=1 Feb 17 13:06:29 rivo volumio[3181]: info: Pushing metadata Feb 17 13:06:29 rivo volumio[3181]: info: CoreCommandRouter::servicePushState Feb 17 13:06:29 rivo volumio[3181]: info: CoreStateMachine::pushState Feb 17 13:06:29 rivo volumio[3181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 13:06:29 rivo volumio[3181]: info: CoreCommandRouter::volumioPushState Feb 17 13:06:29 rivo volumio[3181]: info: CoreCommandRouter::volumioGetState Feb 17 13:06:29 rivo volumio[3181]: info: MRS: Pushing multiroomSync output update for this device Feb 17 13:06:29 rivo volumio[3181]: info: MRS: Pushing multiroomSync output Feb 17 13:06:29 rivo volumio[3181]: info: CoreCommandRouter::servicePushState Feb 17 13:06:29 rivo volumio[3181]: info: CoreStateMachine::pushState Feb 17 13:06:29 rivo volumio[3181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 13:06:29 rivo volumio[3181]: info: CoreCommandRouter::volumioPushState Feb 17 13:06:29 rivo volumio[3181]: info: CoreCommandRouter::volumioGetState Feb 17 13:06:29 rivo volumio[3181]: info: MRS: Pushing multiroomSync output update for this device Feb 17 13:06:29 rivo volumio[3181]: info: MRS: Pushing multiroomSync output Feb 17 13:06:29 rivo volumio[3181]: info: CoreCommandRouter::servicePushState Feb 17 13:06:29 rivo volumio[3181]: info: CoreStateMachine::pushState Feb 17 13:06:29 rivo volumio[3181]: info: CoreCommandRouter::volumioPushState Feb 17 13:06:29 rivo volumio[3181]: info: CoreCommandRouter::volumioGetState Feb 17 13:06:29 rivo volumio[3181]: info: MRS: Pushing multiroomSync output update for this device Feb 17 13:06:29 rivo volumio[3181]: info: MRS: Pushing multiroomSync output Feb 17 13:06:29 rivo volumio[3181]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 17 13:06:29 rivo volumio[3181]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 17 13:06:29 rivo volumio[3181]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 17 13:06:29 rivo vtcs[3910]: [close:85] Entering Feb 17 13:06:29 rivo vtcs[3910]: [close:100] Exiting Feb 17 13:06:29 rivo volumio[3181]: info: Pushing metadata Feb 17 13:06:29 rivo volumio[3181]: info: CoreCommandRouter::servicePushState Feb 17 13:06:29 rivo volumio[3181]: info: CoreStateMachine::pushState Feb 17 13:06:29 rivo volumio[3181]: info: CoreCommandRouter::volumioPushState Feb 17 13:06:29 rivo volumio[3181]: info: CoreCommandRouter::volumioGetState Feb 17 13:06:29 rivo volumio[3181]: info: MRS: Pushing multiroomSync output update for this device Feb 17 13:06:29 rivo volumio[3181]: info: MRS: Pushing multiroomSync output Feb 17 13:06:29 rivo volumio[3181]: info: CoreCommandRouter::servicePushState Feb 17 13:06:29 rivo volumio[3181]: info: CoreStateMachine::pushState Feb 17 13:06:29 rivo volumio[3181]: info: CoreCommandRouter::volumioPushState Feb 17 13:06:29 rivo volumio[3181]: info: CoreCommandRouter::volumioGetState Feb 17 13:06:29 rivo volumio[3181]: info: MRS: Pushing multiroomSync output update for this device Feb 17 13:06:29 rivo volumio[3181]: info: MRS: Pushing multiroomSync output Feb 17 13:06:29 rivo volumio[3181]: info: CoreCommandRouter::servicePushState Feb 17 13:06:29 rivo volumio[3181]: info: CoreStateMachine::pushState Feb 17 13:06:29 rivo volumio[3181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 13:06:29 rivo volumio[3181]: info: CoreCommandRouter::volumioPushState Feb 17 13:06:29 rivo volumio[3181]: info: CoreCommandRouter::volumioGetState Feb 17 13:06:29 rivo volumio[3181]: info: MRS: Pushing multiroomSync output update for this device Feb 17 13:06:29 rivo volumio[3181]: info: MRS: Pushing multiroomSync output Feb 17 13:06:29 rivo volumio[3181]: info: CoreCommandRouter::servicePushState Feb 17 13:06:29 rivo volumio[3181]: info: CoreStateMachine::pushState Feb 17 13:06:29 rivo volumio[3181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 13:06:29 rivo vtcs[3910]: [close:85] Entering Feb 17 13:06:29 rivo vtcs[3910]: [close:100] Exiting Feb 17 13:06:29 rivo volumio[3181]: info: CoreCommandRouter::volumioPushState Feb 17 13:06:29 rivo volumio[3181]: info: CoreCommandRouter::volumioGetState Feb 17 13:06:29 rivo volumio[3181]: info: MRS: Pushing multiroomSync output update for this device Feb 17 13:06:29 rivo volumio[3181]: info: MRS: Pushing multiroomSync output Feb 17 13:06:29 rivo volumio[3181]: info: CoreCommandRouter::servicePushState Feb 17 13:06:29 rivo volumio[3181]: info: CoreStateMachine::pushState Feb 17 13:06:29 rivo volumio[3181]: info: CoreCommandRouter::volumioPushState Feb 17 13:06:29 rivo volumio[3181]: info: CoreCommandRouter::volumioGetState Feb 17 13:06:29 rivo volumio[3181]: info: MRS: Pushing multiroomSync output update for this device Feb 17 13:06:29 rivo volumio[3181]: info: MRS: Pushing multiroomSync output Feb 17 13:06:29 rivo volumio[3181]: info: CoreCommandRouter::servicePushState Feb 17 13:06:29 rivo volumio[3181]: info: CoreStateMachine::pushState Feb 17 13:06:29 rivo volumio[3181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 13:06:29 rivo volumio[3181]: info: CoreCommandRouter::volumioPushState Feb 17 13:06:29 rivo volumio[3181]: info: CoreCommandRouter::volumioGetState Feb 17 13:06:29 rivo volumio[3181]: info: MRS: Pushing multiroomSync output update for this device Feb 17 13:06:29 rivo volumio[3181]: info: MRS: Pushing multiroomSync output Feb 17 13:06:29 rivo volumio[3181]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 17 13:06:29 rivo volumio[3181]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 17 13:06:29 rivo volumio[3181]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 17 13:06:29 rivo volumio[3181]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 17 13:06:29 rivo volumio[3181]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 17 13:06:29 rivo volumio[3181]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 17 13:06:30 rivo volumio[3181]: info: Signalling Playback active due to playback status change Feb 17 13:06:30 rivo vtcs[3910]: [2026-02-17 13:06:30.036] [tisoc] [warning] [PlaybackControllerImpl.cpp:213] Ignore play request because playback state is not STARTED. state_=2, playstate_=1, player_state_=0 Feb 17 13:06:30 rivo volumio[3181]: info: Pushing metadata Feb 17 13:06:30 rivo volumio[3181]: info: CoreCommandRouter::servicePushState Feb 17 13:06:30 rivo volumio[3181]: info: CoreStateMachine::pushState Feb 17 13:06:30 rivo volumio[3181]: info: CoreCommandRouter::volumioPushState Feb 17 13:06:30 rivo volumio[3181]: info: CoreCommandRouter::volumioGetState Feb 17 13:06:30 rivo volumio[3181]: info: MRS: Pushing multiroomSync output update for this device Feb 17 13:06:30 rivo volumio[3181]: info: MRS: Pushing multiroomSync output Feb 17 13:06:30 rivo volumio[3181]: info: CoreCommandRouter::servicePushState Feb 17 13:06:30 rivo volumio[3181]: info: CoreStateMachine::pushState Feb 17 13:06:30 rivo volumio[3181]: info: CoreCommandRouter::volumioPushState Feb 17 13:06:30 rivo volumio[3181]: info: CoreCommandRouter::volumioGetState Feb 17 13:06:30 rivo volumio[3181]: info: MRS: Pushing multiroomSync output update for this device Feb 17 13:06:30 rivo volumio[3181]: info: MRS: Pushing multiroomSync output Feb 17 13:06:30 rivo volumio[3181]: info: CoreCommandRouter::servicePushState Feb 17 13:06:30 rivo volumio[3181]: info: CoreStateMachine::pushState Feb 17 13:06:30 rivo volumio[3181]: info: CoreCommandRouter::volumioPushState Feb 17 13:06:30 rivo volumio[3181]: info: CoreCommandRouter::volumioGetState Feb 17 13:06:30 rivo volumio[3181]: info: MRS: Pushing multiroomSync output update for this device Feb 17 13:06:30 rivo volumio[3181]: info: MRS: Pushing multiroomSync output Feb 17 13:06:30 rivo volumio[3181]: info: CoreCommandRouter::servicePushState Feb 17 13:06:30 rivo volumio[3181]: info: CoreStateMachine::pushState Feb 17 13:06:30 rivo volumio[3181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 13:06:30 rivo volumio[3181]: info: CoreCommandRouter::volumioPushState Feb 17 13:06:30 rivo volumio[3181]: info: CoreCommandRouter::volumioGetState Feb 17 13:06:30 rivo volumio[3181]: info: MRS: Pushing multiroomSync output update for this device Feb 17 13:06:30 rivo volumio[3181]: info: MRS: Pushing multiroomSync output Feb 17 13:06:30 rivo volumio[3181]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 17 13:06:30 rivo volumio[3181]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 17 13:06:30 rivo volumio[3181]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 17 13:06:30 rivo volumio[3181]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 17 13:06:30 rivo volumio[3181]: info: Signalling Playback active due to playback status change Feb 17 13:06:30 rivo volumio[3181]: info: MCU Signalled Playback Inactive Feb 17 13:06:30 rivo volumio[3181]: info: MCU Signalled Playback Active Feb 17 13:06:30 rivo volumio[3181]: info: MCU Signalled Playback Inactive Feb 17 13:06:30 rivo vtcs[3910]: [close:85] Entering Feb 17 13:06:30 rivo vtcs[3910]: [close:100] Exiting Feb 17 13:06:30 rivo volumio[3181]: info: Pushing metadata Feb 17 13:06:30 rivo volumio[3181]: info: CoreCommandRouter::servicePushState Feb 17 13:06:30 rivo volumio[3181]: info: CoreStateMachine::pushState Feb 17 13:06:30 rivo volumio[3181]: info: CoreCommandRouter::volumioPushState Feb 17 13:06:30 rivo volumio[3181]: info: CoreCommandRouter::volumioGetState Feb 17 13:06:30 rivo volumio[3181]: info: MRS: Pushing multiroomSync output update for this device Feb 17 13:06:30 rivo volumio[3181]: info: MRS: Pushing multiroomSync output Feb 17 13:06:30 rivo volumio[3181]: info: CoreCommandRouter::servicePushState Feb 17 13:06:30 rivo volumio[3181]: info: CoreStateMachine::pushState Feb 17 13:06:30 rivo volumio[3181]: info: CoreCommandRouter::volumioPushState Feb 17 13:06:30 rivo volumio[3181]: info: CoreCommandRouter::volumioGetState Feb 17 13:06:30 rivo volumio[3181]: info: MRS: Pushing multiroomSync output update for this device Feb 17 13:06:30 rivo volumio[3181]: info: MRS: Pushing multiroomSync output Feb 17 13:06:30 rivo volumio[3181]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 17 13:06:30 rivo volumio[3181]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 17 13:06:30 rivo volumio[3181]: info: MCU Signalled Playback Active Feb 17 13:06:30 rivo vtcs[3910]: [close:85] Entering Feb 17 13:06:30 rivo vtcs[3910]: [close:100] Exiting Feb 17 13:06:30 rivo vtcs[3910]: [open:50] Opening with sample rate: 44100, type: 0 Feb 17 13:06:30 rivo vtcs[3910]: [start:106] Entering Feb 17 13:06:30 rivo vtcs[3910]: [start:113] Reopening PCM device... Feb 17 13:06:30 rivo volumio[3181]: info: CoreCommandRouter::servicePushState Feb 17 13:06:30 rivo volumio[3181]: info: CoreStateMachine::pushState Feb 17 13:06:30 rivo volumio[3181]: info: CoreCommandRouter::volumioPushState Feb 17 13:06:30 rivo volumio[3181]: info: CoreCommandRouter::volumioGetState Feb 17 13:06:30 rivo volumio[3181]: info: MRS: Pushing multiroomSync output update for this device Feb 17 13:06:30 rivo volumio[3181]: info: MRS: Pushing multiroomSync output Feb 17 13:06:30 rivo vtcs[3910]: [start:115] PCM opened successfully. Feb 17 13:06:30 rivo vtcs[3910]: [start:120] Exiting Feb 17 13:06:30 rivo vtcs[3910]: [feedThread:223] Entering Feb 17 13:06:30 rivo volumio[3181]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 17 13:06:30 rivo volumio[3181]: info: CoreCommandRouter::servicePushState Feb 17 13:06:30 rivo volumio[3181]: info: CoreStateMachine::pushState Feb 17 13:06:30 rivo volumio[3181]: info: CoreCommandRouter::volumioPushState Feb 17 13:06:30 rivo volumio[3181]: info: CoreCommandRouter::volumioGetState Feb 17 13:06:30 rivo volumio[3181]: info: MRS: Pushing multiroomSync output update for this device Feb 17 13:06:30 rivo volumio[3181]: info: MRS: Pushing multiroomSync output Feb 17 13:06:30 rivo volumio[3181]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 17 13:06:30 rivo volumio[3181]: info: CoreCommandRouter::servicePushState Feb 17 13:06:30 rivo volumio[3181]: info: CoreStateMachine::pushState Feb 17 13:06:30 rivo volumio[3181]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 13:06:30 rivo volumio[3181]: info: CoreCommandRouter::volumioPushState Feb 17 13:06:31 rivo volumio[3181]: info: CoreCommandRouter::volumioGetState Feb 17 13:06:31 rivo volumio[3181]: info: MRS: Pushing multiroomSync output update for this device Feb 17 13:06:31 rivo volumio[3181]: info: MRS: Pushing multiroomSync output Feb 17 13:06:31 rivo volumio[3181]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 17 13:06:31 rivo volumio[3181]: info: Executing endpoint metavolumio Feb 17 13:06:31 rivo volumio[3181]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 17 13:06:31 rivo volumio[3181]: info: Executing endpoint metavolumio Feb 17 13:06:31 rivo volumio[3181]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 17 13:06:31 rivo volumio[3181]: info: Executing endpoint metavolumio Feb 17 13:06:31 rivo volumio[3181]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 17 13:06:32 rivo kernel: meson-remote ff808040.rc: invalid custom:0xf50a3612 Feb 17 13:06:32 rivo kernel: meson-remote ff808040.rc: cur_custom is nulll Feb 17 13:06:32 rivo kernel: meson-remote ff808040.rc: no valid key to handle Feb 17 13:06:32 rivo kernel: meson-remote ff808040.rc: invalid custom:0xf50a3612 Feb 17 13:06:32 rivo kernel: meson-remote ff808040.rc: cur_custom is nulll Feb 17 13:06:32 rivo kernel: meson-remote ff808040.rc: no valid key to handle Feb 17 13:06:32 rivo kernel: meson-remote ff808040.rc: invalid custom:0xf50a3612 Feb 17 13:06:32 rivo kernel: meson-remote ff808040.rc: cur_custom is nulll Feb 17 13:06:32 rivo kernel: meson-remote ff808040.rc: no valid key to handle Feb 17 13:06:32 rivo kernel: meson-remote ff808040.rc: invalid custom:0xf50a3612 Feb 17 13:06:32 rivo kernel: meson-remote ff808040.rc: cur_custom is nulll Feb 17 13:06:32 rivo kernel: meson-remote ff808040.rc: no valid key to handle Feb 17 13:06:33 rivo kernel: meson-remote ff808040.rc: invalid custom:0xf50a3612 Feb 17 13:06:33 rivo kernel: meson-remote ff808040.rc: cur_custom is nulll Feb 17 13:06:33 rivo kernel: meson-remote ff808040.rc: no valid key to handle Feb 17 13:06:34 rivo kernel: meson-remote ff808040.rc: invalid custom:0xf50a3612 Feb 17 13:06:34 rivo kernel: meson-remote ff808040.rc: cur_custom is nulll Feb 17 13:06:34 rivo kernel: meson-remote ff808040.rc: no valid key to handle Feb 17 13:06:34 rivo kernel: meson-remote ff808040.rc: invalid custom:0xf50a3612 Feb 17 13:06:34 rivo kernel: meson-remote ff808040.rc: cur_custom is nulll Feb 17 13:06:34 rivo kernel: meson-remote ff808040.rc: no valid key to handle Feb 17 13:06:34 rivo kernel: meson-remote ff808040.rc: invalid custom:0xf50a3612 Feb 17 13:06:34 rivo kernel: meson-remote ff808040.rc: cur_custom is nulll Feb 17 13:06:34 rivo kernel: meson-remote ff808040.rc: no valid key to handle Feb 17 13:06:44 rivo volumio[3181]: info: CorePlayQueue::getTrack 0 Feb 17 13:06:44 rivo volumio[3181]: info: CorePlayQueue::getTrack 27 Feb 17 13:06:44 rivo volumio[3181]: info: Prefetching next song Feb 17 13:06:44 rivo volumio[3181]: info: [1771326404825] ControllerTidal::prefetch Feb 17 13:06:44 rivo volumio[3181]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 17 13:06:44 rivo volumio[3181]: TypeError: Cannot read property 'highestSoundQuality' of undefined Feb 17 13:06:44 rivo volumio[3181]: at ControllerTidal.getProperSoundQuality (/volumio/app/plugins/music_service/tidal/tidal_real:1:19583) Feb 17 13:06:44 rivo volumio[3181]: at ControllerTidal.prefetch (/volumio/app/plugins/music_service/tidal/tidal_real:1:20287) Feb 17 13:06:44 rivo volumio[3181]: at CoreStateMachine.increasePlaybackTimer (/volumio/app/statemachine.js:464:18) Feb 17 13:06:44 rivo volumio[3181]: at listOnTimeout (internal/timers.js:557:17) Feb 17 13:06:44 rivo volumio[3181]: at processTimers (internal/timers.js:500:7) Feb 17 13:06:44 rivo volumio[3181]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 17 13:06:45 rivo sudo[6101]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-17 13:05 Feb 17 13:06:45 rivo sudo[6101]: 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="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivo" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 05 Feb 2026 02:25:23 PM CET" VOLUMIO_VERSION="3.908" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="ab3f2fa07b5f7b8b5e7143217bee70a8"