-- Logs begin at Sat 2025-01-11 11:34:25 CET, end at Sun 2025-01-12 14:44:51 CET. -- Jan 12 14:43:20 volumio-rivo-plus volumiologrotate[2843]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Jan 12 14:43:20 volumio-rivo-plus volumiologrotate[2843]: ls: cannot access 'RIVO': No such file or directory Jan 12 14:43:20 volumio-rivo-plus volumiologrotate[2843]: ls: cannot access 'PLUS': No such file or directory Jan 12 14:43:26 volumio-rivo-plus volumio[3439]: info: [1736689406458] [80s80s] Pushing the next song state The Cranberries - Zombie and getting next track. Jan 12 14:43:26 volumio-rivo-plus volumio[3439]: info: CorePlayQueue::getTrack 0 Jan 12 14:43:26 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::servicePushState Jan 12 14:43:26 volumio-rivo-plus volumio[3439]: info: CorePlayQueue::getTrack 0 Jan 12 14:43:26 volumio-rivo-plus volumio[3439]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is5-ssl.mzstatic.com/image/thumb/Music115/v4/a8/32/0a/a8320ad0-c7f1-23e0-2512-6809a4fb2c89/source/600x600bb.jpg","name":"The Cranberries - Zombie","title":"Zombie","artist":"90s90s Grunge","album":"","streaming":true,"disableUiControls":true,"duration":"236","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Jan 12 14:43:26 volumio-rivo-plus volumio[3439]: verbose: CURRENT POSITION 0 Jan 12 14:43:26 volumio-rivo-plus volumio[3439]: info: CoreStateMachine::syncState stateService play Jan 12 14:43:26 volumio-rivo-plus volumio[3439]: info: CoreStateMachine::syncState currentStatus play Jan 12 14:43:26 volumio-rivo-plus volumio[3439]: info: Received an update from plugin. extracting info from payload Jan 12 14:43:26 volumio-rivo-plus volumio[3439]: info: CoreStateMachine::pushState Jan 12 14:43:26 volumio-rivo-plus volumio[3439]: info: CorePlayQueue::getTrack 0 Jan 12 14:43:26 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 14:43:26 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::volumioPushState Jan 12 14:43:26 volumio-rivo-plus volumio[3439]: info: MRS: Pushing multiroomSync output update for this device Jan 12 14:43:26 volumio-rivo-plus volumio[3439]: info: MRS: Pushing multiroomSync output Jan 12 14:43:26 volumio-rivo-plus volumio[3439]: info: CoreStateMachine::pushState Jan 12 14:43:26 volumio-rivo-plus volumio[3439]: info: CorePlayQueue::getTrack 0 Jan 12 14:43:26 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::volumioPushState Jan 12 14:43:26 volumio-rivo-plus volumio[3439]: info: MRS: Pushing multiroomSync output update for this device Jan 12 14:43:26 volumio-rivo-plus volumio[3439]: info: MRS: Pushing multiroomSync output Jan 12 14:43:26 volumio-rivo-plus volumio[3439]: info: [1736689406497] [80s80s] getContentOfUrl started with url http://iris-90s90s.loverad.io/flow.json?station=253&count=1 Jan 12 14:43:26 volumio-rivo-plus volumio[3439]: info: CorePlayQueue::getTrack 0 Jan 12 14:43:26 volumio-rivo-plus volumio[3439]: info: CorePlayQueue::getTrack 1 Jan 12 14:43:26 volumio-rivo-plus volumio[3439]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 12 14:43:26 volumio-rivo-plus volumio[3439]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 12 14:43:26 volumio-rivo-plus volumio[3439]: info: [1736689406704] [80s80s] received new event containing 1 songs. Jan 12 14:43:26 volumio-rivo-plus volumio[3439]: info: [1736689406705] [80s80s] PlayNextTrack API delay: 30 Jan 12 14:43:26 volumio-rivo-plus volumio[3439]: info: [1736689406726] [80s80s] Setting timer to: 236000 milliseconds. Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::volumioGetState Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: CorePlayQueue::getTrack 0 Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::volumioGetState Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: CorePlayQueue::getTrack 0 Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: Currently active: 80s80s Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: Stopping currently active service Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::volumioStop Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: CoreStateMachine::stop Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: CoreStateMachine::stPlaybackTimer Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: CoreStateMachine::updateTrackBlock Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: CorePlayQueue::getTrackBlock Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: CoreStateMachine::pushState Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: CorePlayQueue::getTrack 0 Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::volumioPushState Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: MRS: Pushing multiroomSync output update for this device Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: MRS: Pushing multiroomSync output Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: CoreStateMachine::serviceStop Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: CorePlayQueue::getTrack 0 Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::serviceStop Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: ControllerMpd::stop Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: verbose: ControllerMpd::sendMpdCommand stop Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: ---------------------------- MPD announces state update: player Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: sendMpdCommand stop took 32 milliseconds Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: ControllerMpd::getState Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: verbose: ControllerMpd::sendMpdCommand status Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::servicePushState Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: CoreStateMachine::pushState Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: CorePlayQueue::getTrack 0 Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::volumioPushState Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: MRS: Pushing multiroomSync output update for this device Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: MRS: Pushing multiroomSync output Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: CorePlayQueue::getTrack 0 Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: verbose: STATE SERVICE {"status":"stop","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is5-ssl.mzstatic.com/image/thumb/Music115/v4/a8/32/0a/a8320ad0-c7f1-23e0-2512-6809a4fb2c89/source/600x600bb.jpg","name":"The Cranberries - Zombie","title":"Zombie","artist":"90s90s Grunge","album":"","streaming":true,"disableUiControls":true,"duration":"236","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: verbose: CURRENT POSITION 0 Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: CoreStateMachine::syncState stateService stop Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: CoreStateMachine::syncState currentStatus stop Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: CoreStateMachine::pushState Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: CorePlayQueue::getTrack 0 Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::volumioPushState Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: MRS: Pushing multiroomSync output update for this device Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: MRS: Pushing multiroomSync output Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: No code Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: CoreStateMachine::pushState Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: CorePlayQueue::getTrack 0 Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::volumioPushState Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: MRS: Pushing multiroomSync output update for this device Jan 12 14:43:37 volumio-rivo-plus volumio[3439]: info: MRS: Pushing multiroomSync output Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: TidalConnect Active Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::volumioGetState Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CorePlayQueue::getTrack 0 Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: Currently active: 80s80s Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: Setting Volatile state to tidalconnect Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::servicePushState Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CoreStateMachine::pushState Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::volumioPushState Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: MRS: Pushing multiroomSync output update for this device Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: MRS: Pushing multiroomSync output Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CorePlayQueue::getTrack 0 Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received tidalconnect Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::servicePushState Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CoreStateMachine::pushState Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::volumioPushState Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: MRS: Pushing multiroomSync output update for this device Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: MRS: Pushing multiroomSync output Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CorePlayQueue::getTrack 0 Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received tidalconnect Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: ---------------------------- MPD announces state update: player Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: ControllerMpd::getState Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: verbose: ControllerMpd::sendMpdCommand status Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: ---------------------------- MPD announces state update: player Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: ControllerMpd::getState Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: verbose: ControllerMpd::sendMpdCommand status Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: ---------------------------- MPD announces state update: player Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: ControllerMpd::getState Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: verbose: ControllerMpd::sendMpdCommand status Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: sendMpdCommand status took 101 milliseconds Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: sendMpdCommand status took 25 milliseconds Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: sendMpdCommand status took 23 milliseconds Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: sendMpdCommand status took 21 milliseconds Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: verbose: ControllerMpd::parseState Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: verbose: ControllerMpd::parseState Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: verbose: ControllerMpd::parseState Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: verbose: ControllerMpd::parseState Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: error: Failed to parse state for serial connection: TypeError: Cannot read property 'toUpperCase' of undefined Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: sendMpdCommand playlistinfo took 46 milliseconds Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: sendMpdCommand playlistinfo took 45 milliseconds Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: sendMpdCommand playlistinfo took 46 milliseconds Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: verbose: ControllerMpd::parseTrackInfo Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: ControllerMpd::pushState Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::servicePushState Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CoreStateMachine::pushState Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::volumioPushState Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: MRS: Pushing multiroomSync output update for this device Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: MRS: Pushing multiroomSync output Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CorePlayQueue::getTrack 0 Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: ControllerMpd::pushState Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::servicePushState Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CoreStateMachine::pushState Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::volumioPushState Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: MRS: Pushing multiroomSync output update for this device Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: MRS: Pushing multiroomSync output Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CorePlayQueue::getTrack 0 Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: ControllerMpd::pushState Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::servicePushState Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CoreStateMachine::pushState Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::volumioPushState Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: MRS: Pushing multiroomSync output update for this device Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: MRS: Pushing multiroomSync output Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CorePlayQueue::getTrack 0 Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: ControllerMpd::pushState Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::servicePushState Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CoreStateMachine::pushState Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::volumioPushState Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: MRS: Pushing multiroomSync output update for this device Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: MRS: Pushing multiroomSync output Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CorePlayQueue::getTrack 0 Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: ------------------------------ 219ms Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: ------------------------------ 143ms Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: ------------------------------ 141ms Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: ------------------------------ 139ms Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: error: Failed to parse state for serial connection: TypeError: Cannot read property 'toUpperCase' of undefined Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: error: Failed to parse state for serial connection: TypeError: Cannot read property 'toUpperCase' of undefined Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: error: Failed to parse state for serial connection: TypeError: Cannot read property 'toUpperCase' of undefined Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: error: Failed to parse state for serial connection: TypeError: Cannot read property 'toUpperCase' of undefined Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: MCU Signalled Playback Inactive Jan 12 14:43:38 volumio-rivo-plus vtcs[4532]: [2025-01-12 14:43:38.280] [tisoc] [warning] [PlaybackControllerImpl.cpp:510] Illegal state:1 Jan 12 14:43:38 volumio-rivo-plus vtcs[4532]: [2025-01-12 14:43:38.281] [tisoc] [warning] [PlaybackControllerImpl.cpp:214] Ignore play request because playback state is not STARTED. state_=2, playstate_=1, player_state_=0 Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: Pushing metadata Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::servicePushState Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CoreStateMachine::pushState Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::volumioPushState Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: MRS: Pushing multiroomSync output update for this device Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: MRS: Pushing multiroomSync output Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CorePlayQueue::getTrack 0 Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received tidalconnect Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::servicePushState Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CoreStateMachine::pushState Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::volumioPushState Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: MRS: Pushing multiroomSync output update for this device Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: MRS: Pushing multiroomSync output Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CorePlayQueue::getTrack 0 Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received tidalconnect Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::servicePushState Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CoreStateMachine::pushState Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::volumioPushState Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: MRS: Pushing multiroomSync output update for this device Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: MRS: Pushing multiroomSync output Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::servicePushState Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CoreStateMachine::pushState Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::volumioPushState Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: MRS: Pushing multiroomSync output update for this device Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: MRS: Pushing multiroomSync output Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: error: Failed to parse state for serial connection: TypeError: Cannot read property 'toUpperCase' of undefined Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: error: Failed to parse state for serial connection: TypeError: Cannot read property 'toUpperCase' of undefined Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: Signalling Playback active due to playback status change Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: MCU Signalled Playback Active Jan 12 14:43:38 volumio-rivo-plus volumio[3439]: info: camilladsp spawned new process with pid 21302, instance 1, run: true Jan 12 14:43:39 volumio-rivo-plus volumio[3439]: info: Pushing metadata Jan 12 14:43:39 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::servicePushState Jan 12 14:43:39 volumio-rivo-plus volumio[3439]: info: CoreStateMachine::pushState Jan 12 14:43:39 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::volumioPushState Jan 12 14:43:39 volumio-rivo-plus volumio[3439]: info: MRS: Pushing multiroomSync output update for this device Jan 12 14:43:39 volumio-rivo-plus volumio[3439]: info: MRS: Pushing multiroomSync output Jan 12 14:43:39 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::servicePushState Jan 12 14:43:39 volumio-rivo-plus volumio[3439]: info: CoreStateMachine::pushState Jan 12 14:43:39 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::volumioPushState Jan 12 14:43:39 volumio-rivo-plus volumio[3439]: info: MRS: Pushing multiroomSync output update for this device Jan 12 14:43:39 volumio-rivo-plus volumio[3439]: info: MRS: Pushing multiroomSync output Jan 12 14:43:39 volumio-rivo-plus volumio[3439]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 12 14:43:39 volumio-rivo-plus volumio[3439]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 12 14:43:39 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::servicePushState Jan 12 14:43:39 volumio-rivo-plus volumio[3439]: info: CoreStateMachine::pushState Jan 12 14:43:39 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 14:43:39 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::volumioPushState Jan 12 14:43:39 volumio-rivo-plus volumio[3439]: info: MRS: Pushing multiroomSync output update for this device Jan 12 14:43:39 volumio-rivo-plus volumio[3439]: info: MRS: Pushing multiroomSync output Jan 12 14:43:39 volumio-rivo-plus volumio[3439]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 12 14:43:39 volumio-rivo-plus volumio[3439]: info: FusionDsp - ---- read samplerate, raw: 96000,S32_LE,2,32 Jan 12 14:43:39 volumio-rivo-plus volumio[3439]: info: FusionDsp - ---- read samplerate from file: 96000 Jan 12 14:43:39 volumio-rivo-plus volumio[3439]: info: camilladsp stopping service pid 21302... Jan 12 14:43:39 volumio-rivo-plus vtcs[4532]: [2025-01-12 14:43:39.369] [tisoc] [warning] [flac_decoder.cpp:282] FLACDecoder::error_callback FLAC__STREAM_DECODER_ERROR_STATUS_LOST_SYNC Jan 12 14:43:39 volumio-rivo-plus volumio[3439]: info: camilladsp service terminated, instance 1 Jan 12 14:43:39 volumio-rivo-plus volumio[3439]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jan 12 14:43:39 volumio-rivo-plus volumio[3439]: info: camilladsp service started and running in background, instance 1 Jan 12 14:43:39 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::servicePushState Jan 12 14:43:39 volumio-rivo-plus volumio[3439]: info: CoreStateMachine::pushState Jan 12 14:43:39 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::volumioPushState Jan 12 14:43:39 volumio-rivo-plus volumio[3439]: info: MRS: Pushing multiroomSync output update for this device Jan 12 14:43:39 volumio-rivo-plus volumio[3439]: info: MRS: Pushing multiroomSync output Jan 12 14:43:39 volumio-rivo-plus volumio[3439]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 12 14:43:39 volumio-rivo-plus volumio[3439]: info: camilladsp spawned new process with pid 21315, instance 1, run: true Jan 12 14:43:39 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::servicePushState Jan 12 14:43:39 volumio-rivo-plus volumio[3439]: info: CoreStateMachine::pushState Jan 12 14:43:39 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 14:43:39 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::volumioPushState Jan 12 14:43:39 volumio-rivo-plus volumio[3439]: info: MRS: Pushing multiroomSync output update for this device Jan 12 14:43:39 volumio-rivo-plus volumio[3439]: info: MRS: Pushing multiroomSync output Jan 12 14:43:39 volumio-rivo-plus volumio[3439]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 12 14:43:41 volumio-rivo-plus volumio[3439]: info: Executing endpoint metavolumio Jan 12 14:43:41 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jan 12 14:43:41 volumio-rivo-plus volumio[3439]: info: Executing endpoint metavolumio Jan 12 14:43:41 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jan 12 14:43:41 volumio-rivo-plus volumio[3439]: info: Executing endpoint metavolumio Jan 12 14:43:41 volumio-rivo-plus volumio[3439]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jan 12 14:43:44 volumio-rivo-plus vtcs[4532]: [2025-01-12 14:43:44] [info] asio async_shutdown error: asio.misc:2 (End of file) Jan 12 14:44:20 volumio-rivo-plus volumiologrotate[2843]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Jan 12 14:44:20 volumio-rivo-plus volumiologrotate[2843]: ls: cannot access 'RIVO': No such file or directory Jan 12 14:44:20 volumio-rivo-plus volumiologrotate[2843]: ls: cannot access 'PLUS': No such file or directory Jan 12 14:44:50 volumio-rivo-plus volumio[3439]: info: [1736689490598] [80s80s] Pushing the next song state The Cranberries - Zombie and getting next track. Jan 12 14:44:50 volumio-rivo-plus volumio[3439]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 12 14:44:50 volumio-rivo-plus volumio[3439]: TypeError: Cannot set property 'name' of undefined Jan 12 14:44:50 volumio-rivo-plus volumio[3439]: at Controller80s80s.pushSongState (/data/plugins/music_service/80s80s/index.js:565:20) Jan 12 14:44:50 volumio-rivo-plus volumio[3439]: at Controller80s80s.playNextTrack (/data/plugins/music_service/80s80s/index.js:665:34) Jan 12 14:44:50 volumio-rivo-plus volumio[3439]: at NanoTimer.setTimeout (/data/plugins/music_service/80s80s/node_modules/nanotimer/lib/nanotimer.js:343:9) Jan 12 14:44:50 volumio-rivo-plus volumio[3439]: at Immediate. (/data/plugins/music_service/80s80s/node_modules/nanotimer/lib/nanotimer.js:327:66) Jan 12 14:44:50 volumio-rivo-plus volumio[3439]: at processImmediate (internal/timers.js:464:21) Jan 12 14:44:50 volumio-rivo-plus volumio[3439]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 12 14:44:51 volumio-rivo-plus sudo[21522]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-12 14:43 Jan 12 14:44:51 volumio-rivo-plus sudo[21522]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivoplus" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 06:24:00 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="a9e7f7cddbf07b638557a97b929dd627"