-- Logs begin at Fri 2025-06-27 23:07:17 CEST, end at Sat 2025-06-28 08:52:21 CEST. --
Jun 28 08:51:20 rivo---streamer volumio[3414]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 28 08:51:20 rivo---streamer volumio[3414]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 28 08:51:20 rivo---streamer volumio[3414]: info: Discovery: Getting this device information
Jun 28 08:51:20 rivo---streamer volumio[3414]: info: CoreCommandRouter::volumioGetState
Jun 28 08:51:20 rivo---streamer volumio[3414]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 28 08:51:21 rivo---streamer volumio[3414]: info: CoreCommandRouter::volumioGetQueue
Jun 28 08:51:21 rivo---streamer volumio[3414]: info: CoreStateMachine::getQueue
Jun 28 08:51:21 rivo---streamer volumio[3414]: info: CorePlayQueue::getQueue
Jun 28 08:51:25 rivo---streamer volumio[3414]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri
Jun 28 08:51:26 rivo---streamer volumio[3414]: info: browseTIDALUri took 140 milliseconds
Jun 28 08:51:26 rivo---streamer volumio[3414]: info: Preload queue cleared
Jun 28 08:51:26 rivo---streamer volumio[3414]: info: Preload queue cleared
Jun 28 08:51:31 rivo---streamer volumio[3414]: Searching plugin music_service/tidal
Jun 28 08:51:31 rivo---streamer volumio[3414]: info: CoreCommandRouter::executeOnPlugin: tidal , search
Jun 28 08:51:31 rivo---streamer volumio[3414]: info: searchTIDALUri took 447 milliseconds
Jun 28 08:51:31 rivo---streamer volumio[3414]: info: search took 450 milliseconds
Jun 28 08:51:31 rivo---streamer volumio[3414]: info: All search sources collected, pushing search results
Jun 28 08:51:33 rivo---streamer volumio[3414]: Searching plugin music_service/tidal
Jun 28 08:51:33 rivo---streamer volumio[3414]: info: CoreCommandRouter::executeOnPlugin: tidal , search
Jun 28 08:51:33 rivo---streamer volumio[3414]: info: searchTIDALUri took 393 milliseconds
Jun 28 08:51:33 rivo---streamer volumio[3414]: info: search took 394 milliseconds
Jun 28 08:51:33 rivo---streamer volumio[3414]: info: All search sources collected, pushing search results
Jun 28 08:51:35 rivo---streamer volumiologrotate[2830]: ls: cannot access '/var/log/samba/log.wb-RIVO': No such file or directory
Jun 28 08:51:35 rivo---streamer volumiologrotate[2830]: ls: cannot access '-': No such file or directory
Jun 28 08:51:35 rivo---streamer volumiologrotate[2830]: ls: cannot access 'STREAMER': No such file or directory
Jun 28 08:51:35 rivo---streamer volumio[3414]: Searching plugin music_service/tidal
Jun 28 08:51:35 rivo---streamer volumio[3414]: info: CoreCommandRouter::executeOnPlugin: tidal , search
Jun 28 08:51:35 rivo---streamer volumio[3414]: info: searchTIDALUri took 262 milliseconds
Jun 28 08:51:35 rivo---streamer volumio[3414]: info: search took 263 milliseconds
Jun 28 08:51:35 rivo---streamer volumio[3414]: info: All search sources collected, pushing search results
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: browseTIDALUri took 780 milliseconds
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preload queue cleared
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preload queue cleared
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preload queue cleared
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/428730863
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/420811226
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/420811213
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/420811238
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/420811211
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/420811215
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/420811217
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/420811212
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/420811219
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/420811220
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/420811221
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/306034991
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/306034994
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/306034997
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/306035011
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/306035000
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/306035003
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/306035024
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/306035021
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/306035006
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/306035015
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/306035018
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/306035026
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/397145203
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/397145204
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/397145205
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/397145209
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/397145206
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/397145207
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/397145210
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/397145208
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/397145211
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/212784037
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/397145212
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/212784036
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/397145213
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/397145214
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/397145216
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/397145217
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/397145215
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/397145218
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/212784038
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/212784039
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/212784040
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/212784041
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/212784045
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/212784046
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/212784042
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/212784044
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/212784043
Jun 28 08:51:37 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/428730863 in service tidal
Jun 28 08:51:38 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/420811226 in service tidal
Jun 28 08:51:38 rivo---streamer volumio[3414]: info: No valid Plugin REST Endpoint: getSimilarArtists
Jun 28 08:51:38 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/420811213 in service tidal
Jun 28 08:51:38 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/420811238 in service tidal
Jun 28 08:51:38 rivo---streamer volumio[3414]: info: explodeTIDALUri took 198 milliseconds
Jun 28 08:51:38 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/420811211 in service tidal
Jun 28 08:51:38 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/420811215 in service tidal
Jun 28 08:51:38 rivo---streamer volumio[3414]: info: explodeTIDALUri took 216 milliseconds
Jun 28 08:51:38 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/420811217 in service tidal
Jun 28 08:51:38 rivo---streamer volumio[3414]: info: explodeTIDALUri took 214 milliseconds
Jun 28 08:51:38 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/420811212 in service tidal
Jun 28 08:51:38 rivo---streamer volumio[3414]: info: explodeTIDALUri took 222 milliseconds
Jun 28 08:51:38 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/420811219 in service tidal
Jun 28 08:51:38 rivo---streamer volumio[3414]: info: explodeTIDALUri took 211 milliseconds
Jun 28 08:51:38 rivo---streamer volumio[3414]: info: explodeTIDALUri took 178 milliseconds
Jun 28 08:51:38 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/420811220 in service tidal
Jun 28 08:51:38 rivo---streamer volumio[3414]: info: explodeTIDALUri took 166 milliseconds
Jun 28 08:51:38 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/420811221 in service tidal
Jun 28 08:51:38 rivo---streamer volumio[3414]: info: explodeTIDALUri took 190 milliseconds
Jun 28 08:51:38 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/306034991 in service tidal
Jun 28 08:51:38 rivo---streamer volumio[3414]: info: explodeTIDALUri took 190 milliseconds
Jun 28 08:51:38 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/306034994 in service tidal
Jun 28 08:51:38 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/306034997 in service tidal
Jun 28 08:51:38 rivo---streamer volumio[3414]: info: explodeTIDALUri took 240 milliseconds
Jun 28 08:51:38 rivo---streamer volumio[3414]: info: explodeTIDALUri took 188 milliseconds
Jun 28 08:51:38 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/306035011 in service tidal
Jun 28 08:51:38 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/306035000 in service tidal
Jun 28 08:51:38 rivo---streamer volumio[3414]: info: explodeTIDALUri took 199 milliseconds
Jun 28 08:51:38 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/306035003 in service tidal
Jun 28 08:51:38 rivo---streamer volumio[3414]: info: explodeTIDALUri took 230 milliseconds
Jun 28 08:51:38 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/306035024 in service tidal
Jun 28 08:51:38 rivo---streamer volumio[3414]: info: explodeTIDALUri took 220 milliseconds
Jun 28 08:51:38 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/306035021 in service tidal
Jun 28 08:51:38 rivo---streamer volumio[3414]: info: explodeTIDALUri took 205 milliseconds
Jun 28 08:51:38 rivo---streamer volumio[3414]: info: explodeTIDALUri took 184 milliseconds
Jun 28 08:51:38 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/306035006 in service tidal
Jun 28 08:51:38 rivo---streamer volumio[3414]: info: explodeTIDALUri took 167 milliseconds
Jun 28 08:51:38 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/306035015 in service tidal
Jun 28 08:51:38 rivo---streamer volumio[3414]: info: explodeTIDALUri took 183 milliseconds
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/306035018 in service tidal
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: explodeTIDALUri took 198 milliseconds
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/306035026 in service tidal
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: explodeTIDALUri took 176 milliseconds
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/397145203 in service tidal
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: explodeTIDALUri took 196 milliseconds
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/397145204 in service tidal
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/397145205 in service tidal
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: explodeTIDALUri took 203 milliseconds
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/397145209 in service tidal
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: explodeTIDALUri took 226 milliseconds
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/397145206 in service tidal
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: explodeTIDALUri took 217 milliseconds
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: explodeTIDALUri took 180 milliseconds
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/397145207 in service tidal
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: explodeTIDALUri took 191 milliseconds
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/397145210 in service tidal
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: explodeTIDALUri took 172 milliseconds
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/397145208 in service tidal
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: explodeTIDALUri took 172 milliseconds
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/397145211 in service tidal
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: explodeTIDALUri took 164 milliseconds
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/212784037 in service tidal
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: explodeTIDALUri took 175 milliseconds
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/397145212 in service tidal
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: explodeTIDALUri took 200 milliseconds
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/212784036 in service tidal
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/397145213 in service tidal
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: explodeTIDALUri took 205 milliseconds
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/397145214 in service tidal
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: explodeTIDALUri took 198 milliseconds
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/397145216 in service tidal
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: explodeTIDALUri took 222 milliseconds
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/397145217 in service tidal
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: explodeTIDALUri took 200 milliseconds
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/397145215 in service tidal
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: explodeTIDALUri took 198 milliseconds
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: explodeTIDALUri took 174 milliseconds
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: browseTIDALUri took 351 milliseconds
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/397145218 in service tidal
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: explodeTIDALUri took 169 milliseconds
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: Preload queue cleared
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/420811214
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/420811216
Jun 28 08:51:39 rivo---streamer volumio[3414]: info: Preloading song: tidal://song/420811218
Jun 28 08:51:40 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/420811214 in service tidal
Jun 28 08:51:40 rivo---streamer volumio[3414]: info: explodeTIDALUri took 200 milliseconds
Jun 28 08:51:40 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/420811216 in service tidal
Jun 28 08:51:40 rivo---streamer volumio[3414]: info: explodeTIDALUri took 196 milliseconds
Jun 28 08:51:40 rivo---streamer volumio[3414]: info: explodeTIDALUri took 167 milliseconds
Jun 28 08:51:40 rivo---streamer volumio[3414]: info: Exploding uri tidal://song/420811218 in service tidal
Jun 28 08:51:40 rivo---streamer volumio[3414]: info: No valid Plugin REST Endpoint: getSimilarAlbums
Jun 28 08:51:40 rivo---streamer volumio[3414]: info: explodeTIDALUri took 199 milliseconds
Jun 28 08:51:40 rivo---streamer volumio[3414]: info: explodeTIDALUri took 188 milliseconds
Jun 28 08:51:40 rivo---streamer volumio[3414]: info: explodeTIDALUri took 203 milliseconds
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: Preload queue cleared
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CoreStateMachine::ClearQueue
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CoreStateMachine::stop
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CoreStateMachine::serviceStop
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CoreCommandRouter::serviceStop
Jun 28 08:51:42 rivo---streamer vtcs[3815]: [close:85] Entering
Jun 28 08:51:42 rivo---streamer vtcs[3815]: [close:100] Exiting
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CorePlayQueue::clearPlayQueue
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CorePlayQueue::saveQueue
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CoreCommandRouter::volumioPushQueue
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CoreStateMachine::addQueueItems
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CorePlayQueue::addQueueItems
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: Preload queue cleared
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: Adding Item to queue: tidal://album/420811205
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: Exploding uri tidal://album/420811205 in service tidal
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: PlaybackInactive
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: Device Session is_active: true
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: DeviceInactive
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: Relinquishing Volumio State
Jun 28 08:51:42 rivo---streamer volumio[3414]: verbose: UNSET VOLATILE: Service: tidalconnect
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: unSetVolatile called
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: Relinquishing Volumio State to another service
Jun 28 08:51:42 rivo---streamer vtcs[3815]: [2025-06-28 08:51:42.150] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: explodeTIDALUri took 133 milliseconds
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CoreCommandRouter::volumioPushQueue
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CorePlayQueue::saveQueue
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CoreStateMachine::updateTrackBlock
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CorePlayQueue::getTrackBlock
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CoreCommandRouter::volumioPlay
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CoreStateMachine::play index 0
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CoreStateMachine::stop
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CoreStateMachine::updateTrackBlock
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CorePlayQueue::getTrackBlock
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CoreStateMachine::stPlaybackTimer
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CoreStateMachine::pushState
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CorePlayQueue::getTrack 0
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CoreCommandRouter::volumioPushState
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CoreCommandRouter::volumioGetState
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CorePlayQueue::getTrack 0
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CoreStateMachine::serviceStop
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CorePlayQueue::getTrack 0
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CoreCommandRouter::serviceStop
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: [1751093502302] ControllerTidal::stop
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CoreStateMachine::setConsumeUpdateService mpd
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: ControllerMpd::stop
Jun 28 08:51:42 rivo---streamer volumio[3414]: verbose: ControllerMpd::sendMpdCommand stop
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: sendMpdCommand stop took 16 milliseconds
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CoreStateMachine::play index undefined
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CorePlayQueue::getTrack 0
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CoreStateMachine::startPlaybackTimer
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CorePlayQueue::getTrack 0
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: [1751093502326] ControllerTidal::clearAddPlayTrack
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: Getting stream with soundQuality LOSSLESS
Jun 28 08:51:42 rivo---streamer volumio[3414]: verbose: ControllerMpd::sendMpdCommand stop
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: sendMpdCommand stop took 2 milliseconds
Jun 28 08:51:42 rivo---streamer volumio[3414]: verbose: ControllerMpd::sendMpdCommand clear
Jun 28 08:51:42 rivo---streamer volumio[3414]: info:
Jun 28 08:51:42 rivo---streamer volumio[3414]: ---------------------------- MPD announces system playlist update
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: Ignoring MPD Status Update
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: sendMpdCommand clear took 4 milliseconds
Jun 28 08:51:42 rivo---streamer volumio[3414]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/420811211&soundQuality=LOSSLESS"
Jun 28 08:51:42 rivo---streamer volumio[3414]: error: updateQueue error: null
Jun 28 08:51:42 rivo---streamer volumio[3414]: info:
Jun 28 08:51:42 rivo---streamer volumio[3414]: ---------------------------- MPD announces system playlist update
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: Ignoring MPD Status Update
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: ------------------------------ 8ms
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/420811211&soundQuality=LOSSLESS" took 9 milliseconds
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CoreStateMachine::setConsumeUpdateService mpd
Jun 28 08:51:42 rivo---streamer volumio[3414]: verbose: ControllerMpd::sendMpdCommand play
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: ------------------------------ 11ms
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: sendMpdCommand play took 4 milliseconds
Jun 28 08:51:42 rivo---streamer volumio[3414]: STREAMING PROXY: Handling url /?data=tidal://song/420811211&soundQuality=LOSSLESS
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: Executing endpoint getStreamUrltidal
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CoreCommandRouter::executeOnPlugin: tidal , getStreamUrlAPI
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: getStreamUrl took 224 milliseconds
Jun 28 08:51:42 rivo---streamer volumio[3414]: STREAMING PROXY: Got real url: http://lgf.audio.tidal.com/mediatracks/CAEaKAgDEiRiNzRmOWMzMGU1OWI2NTNjZDZmNWI0MjRiMjI2MTZhMS5tcDQ/0.flac?token=1751097102~MTg2MDI1NGQxYWQ1NDYwYzZmNTY3OWEyZmRhMTU2ZjBmYzViYTNkZA==
Jun 28 08:51:42 rivo---streamer volumio[3414]: STREAMING PROXY: Response: 200, length: 26987022
Jun 28 08:51:42 rivo---streamer volumio[3414]: info:
Jun 28 08:51:42 rivo---streamer volumio[3414]: ---------------------------- MPD announces state update: player
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: ControllerMpd::getState
Jun 28 08:51:42 rivo---streamer volumio[3414]: verbose: ControllerMpd::sendMpdCommand status
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: FusionDsp - ---- read samplerate from file: 44100
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: camilladsp stopping service pid 31643...
Jun 28 08:51:42 rivo---streamer kernel: spdif_a keep clk continuous
Jun 28 08:51:42 rivo---streamer kernel: aml_spdif_close
Jun 28 08:51:42 rivo---streamer kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:spdif@0
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: camilladsp service terminated, instance 1
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: FusionDsp - If filter freq >samplerate/2 then disable it
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: camilladsp service started and running in background, instance 1
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: FusionDsp - ---- read samplerate from file: 44100
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: FusionDsp - If filter freq >samplerate/2 then disable it
Jun 28 08:51:42 rivo---streamer volumio[3414]: info:
Jun 28 08:51:42 rivo---streamer volumio[3414]: ---------------------------- MPD announces state update: player
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: sendMpdCommand status took 118 milliseconds
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: ControllerMpd::getState
Jun 28 08:51:42 rivo---streamer volumio[3414]: verbose: ControllerMpd::sendMpdCommand status
Jun 28 08:51:42 rivo---streamer volumio[3414]: verbose: ControllerMpd::parseState
Jun 28 08:51:42 rivo---streamer volumio[3414]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: sendMpdCommand status took 8 milliseconds
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: sendMpdCommand playlistinfo took 6 milliseconds
Jun 28 08:51:42 rivo---streamer volumio[3414]: verbose: ControllerMpd::parseState
Jun 28 08:51:42 rivo---streamer volumio[3414]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 28 08:51:42 rivo---streamer volumio[3414]: verbose: ControllerMpd::parseTrackInfo
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: ControllerMpd::pushState
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CoreCommandRouter::servicePushState
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CorePlayQueue::getTrack 0
Jun 28 08:51:42 rivo---streamer volumio[3414]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":219,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"565 Kbps","isStreaming":false,"title":"420811211&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/420811211&soundQuality=LOSSLESS","trackType":"tidal"}
Jun 28 08:51:42 rivo---streamer volumio[3414]: verbose: CURRENT POSITION 0
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CoreStateMachine::syncState stateService play
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CoreStateMachine::syncState currentStatus stop
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: ------------------------------ 139ms
Jun 28 08:51:42 rivo---streamer volumio[3414]: error: FusionDsp - WebSocket error: [object Object]
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: camilladsp spawned new process with pid 31878, instance 1, run: true
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: sendMpdCommand playlistinfo took 42 milliseconds
Jun 28 08:51:42 rivo---streamer volumio[3414]: verbose: ControllerMpd::parseTrackInfo
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: ControllerMpd::pushState
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CoreCommandRouter::servicePushState
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CorePlayQueue::getTrack 0
Jun 28 08:51:42 rivo---streamer volumio[3414]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1601,"duration":219,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"710 Kbps","isStreaming":false,"title":"420811211&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/420811211&soundQuality=LOSSLESS","trackType":"tidal"}
Jun 28 08:51:42 rivo---streamer volumio[3414]: verbose: CURRENT POSITION 0
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CoreStateMachine::syncState stateService play
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CoreStateMachine::syncState currentStatus play
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: Received an update from plugin. extracting info from payload
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CoreStateMachine::pushState
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CoreCommandRouter::volumioPushState
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CoreCommandRouter::volumioGetState
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CoreStateMachine::pushState
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CoreCommandRouter::volumioPushState
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: CoreCommandRouter::volumioGetState
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: ------------------------------ 90ms
Jun 28 08:51:42 rivo---streamer kernel: aml_spdif_open
Jun 28 08:51:42 rivo---streamer kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:spdif@0
Jun 28 08:51:42 rivo---streamer kernel: set normal 512 fs /4 fs
Jun 28 08:51:42 rivo---streamer kernel: set spdifout clk:5644800, mpll:22579200
Jun 28 08:51:42 rivo---streamer kernel: get spdifout clk:5644797, mpll:22579186
Jun 28 08:51:42 rivo---streamer kernel: aml_dai_set_spdif_fmt , fmt 0x4000
Jun 28 08:51:42 rivo---streamer kernel: set normal 512 fs /4 fs
Jun 28 08:51:42 rivo---streamer kernel: set spdifout clk:5644800, mpll:22579200
Jun 28 08:51:42 rivo---streamer kernel: get spdifout clk:5644797, mpll:22579186
Jun 28 08:51:42 rivo---streamer kernel: spdif_info: rate: 44100, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x0, ch1_r:0x0
Jun 28 08:51:42 rivo---streamer kernel: aml_spdif_fifo_ctrl, bit depth:24, frddr type:4, toddr:type:4
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: Signalling Playback active due to playback status change
Jun 28 08:51:42 rivo---streamer volumio[3414]: info: Signalling Playback active due to playback status change
Jun 28 08:51:42 rivo---streamer kernel: asoc-aml-card auge_sound: S/PDIF Playback enable
Jun 28 08:51:43 rivo---streamer volumio[3414]: info: MCU Signalled Playback Active
Jun 28 08:51:44 rivo---streamer volumio[3414]: STREAMING PROXY: Client dropped request, destroying
Jun 28 08:51:47 rivo---streamer vtcs[3815]: [2025-06-28 08:51:47] [error] handle_read_frame error: asio.system:104 (Connection reset by peer)
Jun 28 08:51:50 rivo---streamer volumio[3414]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 28 08:51:50 rivo---streamer volumio[3414]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 28 08:51:50 rivo---streamer volumio[3414]: info: Discovery: Getting this device information
Jun 28 08:51:50 rivo---streamer volumio[3414]: info: CoreCommandRouter::volumioGetState
Jun 28 08:51:50 rivo---streamer volumio[3414]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 28 08:52:20 rivo---streamer volumio[3414]: info: CoreCommandRouter::executeOnPlugin: metavolumio , superSearch
Jun 28 08:52:20 rivo---streamer volumio[3414]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 28 08:52:20 rivo---streamer volumio[3414]: TypeError: Cannot read property 'then' of undefined
Jun 28 08:52:20 rivo---streamer volumio[3414]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:498:20)
Jun 28 08:52:20 rivo---streamer volumio[3414]: at Socket.emit (events.js:400:28)
Jun 28 08:52:20 rivo---streamer volumio[3414]: at /volumio/node_modules/socket.io/lib/socket.js:528:12
Jun 28 08:52:20 rivo---streamer volumio[3414]: at processTicksAndRejections (internal/process/task_queues.js:77:11)
Jun 28 08:52:20 rivo---streamer volumio[3414]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 28 08:52:21 rivo---streamer sudo[31972]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-28 08:51
Jun 28 08:52:21 rivo---streamer sudo[31972]: 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="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="rivo"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 06:01:16 PM CEST"
VOLUMIO_VERSION="3.816"
VOLUMIO_HARDWARE="mp1"
VOLUMIO_DEVICENAME="Volumio MP1"
VOLUMIO_VENDOR_MODEL="Volumio Rivo"
VOLUMIO_VENDOR="Volumio"
VOLUMIO_MODEL="Rivo"
VOLUMIO_HASH="5a6f819282ea0c6f84bf87456dce95cb"