-- Logs begin at Thu 2019-02-14 18:11:58 +08, end at Fri 2025-06-13 11:12:49 +08. --
Jun 13 11:11:03 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri
Jun 13 11:11:04 minidsp-shd volumio[6327]: info: browseTIDALUri took 840 milliseconds
Jun 13 11:11:04 minidsp-shd volumio[6327]: info: Preload queue cleared
Jun 13 11:11:04 minidsp-shd volumio[6327]: info: Executing endpoint getSimilarAlbums
Jun 13 11:11:04 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums
Jun 13 11:11:04 minidsp-shd volumio[6327]: info: Executing endpoint getSimilarAlbums
Jun 13 11:11:04 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums
Jun 13 11:11:05 minidsp-shd volumio[6327]: info: Executing endpoint metavolumio
Jun 13 11:11:05 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Jun 13 11:11:07 minidsp-shd volumio[6327]: info: Executing endpoint metavolumio
Jun 13 11:11:07 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: Preload queue cleared
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CoreStateMachine::ClearQueue
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CoreStateMachine::stop
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CoreStateMachine::stPlaybackTimer
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CoreStateMachine::updateTrackBlock
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrackBlock
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 3
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CoreStateMachine::serviceStop
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 3
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CoreCommandRouter::serviceStop
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: [1749784268082] ControllerTidal::stop
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CoreStateMachine::setConsumeUpdateService mpd
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: ControllerMpd::stop
Jun 13 11:11:08 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand stop
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CorePlayQueue::clearPlayQueue
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CorePlayQueue::saveQueue
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushQueue
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CoreStateMachine::addQueueItems
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CorePlayQueue::addQueueItems
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: Preload queue cleared
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: Adding Item to queue: tidal://song/281004503
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: Using cached record of: tidal://song/281004503
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: Adding Item to queue: tidal://song/281004504
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: Using cached record of: tidal://song/281004504
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: Adding Item to queue: tidal://song/281004505
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: Using cached record of: tidal://song/281004505
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: Adding Item to queue: tidal://song/281004506
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: Using cached record of: tidal://song/281004506
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: Adding Item to queue: tidal://song/281004507
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: Using cached record of: tidal://song/281004507
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: Adding Item to queue: tidal://song/281004508
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: Using cached record of: tidal://song/281004508
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: Adding Item to queue: tidal://song/281004509
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: Using cached record of: tidal://song/281004509
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: Adding Item to queue: tidal://song/281004510
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: Using cached record of: tidal://song/281004510
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: Adding Item to queue: tidal://song/281004511
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: Using cached record of: tidal://song/281004511
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: Adding Item to queue: tidal://song/281004512
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: Using cached record of: tidal://song/281004512
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushQueue
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CorePlayQueue::saveQueue
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CoreStateMachine::updateTrackBlock
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrackBlock
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPlay
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CoreStateMachine::play index 1
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CoreStateMachine::stop
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CoreStateMachine::play index undefined
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 1
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CoreStateMachine::startPlaybackTimer
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 1
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: [1749784268154] ControllerTidal::clearAddPlayTrack
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: Getting stream with soundQuality LOSSLESS
Jun 13 11:11:08 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand stop
Jun 13 11:11:08 minidsp-shd volumio[6327]: info:
Jun 13 11:11:08 minidsp-shd volumio[6327]: ---------------------------- MPD announces state update: player
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: sendMpdCommand stop took 103 milliseconds
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: ControllerMpd::getState
Jun 13 11:11:08 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand status
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: sendMpdCommand stop took 32 milliseconds
Jun 13 11:11:08 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand clear
Jun 13 11:11:08 minidsp-shd volumio[6327]: info:
Jun 13 11:11:08 minidsp-shd volumio[6327]: ---------------------------- MPD announces state update: player
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: ControllerMpd::getState
Jun 13 11:11:08 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand status
Jun 13 11:11:08 minidsp-shd volumio[6327]: info:
Jun 13 11:11:08 minidsp-shd volumio[6327]: ---------------------------- MPD announces state update: player
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: ControllerMpd::getState
Jun 13 11:11:08 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand status
Jun 13 11:11:08 minidsp-shd volumio[6327]: info:
Jun 13 11:11:08 minidsp-shd volumio[6327]: ---------------------------- MPD announces system playlist update
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: Ignoring MPD Status Update
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: sendMpdCommand status took 43 milliseconds
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: sendMpdCommand clear took 41 milliseconds
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: sendMpdCommand status took 37 milliseconds
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: sendMpdCommand status took 34 milliseconds
Jun 13 11:11:08 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseState
Jun 13 11:11:08 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 13 11:11:08 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/281004504&soundQuality=LOSSLESS"
Jun 13 11:11:08 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseState
Jun 13 11:11:08 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseState
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: ControllerMpd::pushState
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CoreCommandRouter::servicePushState
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 1
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 1
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received mpd
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: ControllerMpd::pushState
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CoreCommandRouter::servicePushState
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 1
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 1
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received mpd
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: ------------------------------ 87ms
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: ------------------------------ 84ms
Jun 13 11:11:08 minidsp-shd volumio[6327]: info:
Jun 13 11:11:08 minidsp-shd volumio[6327]: ---------------------------- MPD announces system playlist update
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: Ignoring MPD Status Update
Jun 13 11:11:08 minidsp-shd volumio[6327]: info:
Jun 13 11:11:08 minidsp-shd volumio[6327]: ---------------------------- MPD announces system playlist update
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: Ignoring MPD Status Update
Jun 13 11:11:08 minidsp-shd volumio[6327]: error: updateQueue error: null
Jun 13 11:11:08 minidsp-shd volumio[6327]: info:
Jun 13 11:11:08 minidsp-shd volumio[6327]: ---------------------------- MPD announces system playlist update
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: Ignoring MPD Status Update
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: ------------------------------ 72ms
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: sendMpdCommand playlistinfo took 64 milliseconds
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/281004504&soundQuality=LOSSLESS" took 64 milliseconds
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: ------------------------------ 19ms
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: ------------------------------ 16ms
Jun 13 11:11:08 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseTrackInfo
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CoreStateMachine::setConsumeUpdateService mpd
Jun 13 11:11:08 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand play
Jun 13 11:11:08 minidsp-shd volumio[6327]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: ------------------------------ 129ms
Jun 13 11:11:08 minidsp-shd volumio[6327]: info:
Jun 13 11:11:08 minidsp-shd volumio[6327]: ---------------------------- MPD announces system playlist update
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: Ignoring MPD Status Update
Jun 13 11:11:08 minidsp-shd volumio[6327]: STREAMING PROXY: Handling url /?data=tidal://song/281004504&soundQuality=LOSSLESS
Jun 13 11:11:08 minidsp-shd volumio[6327]: info:
Jun 13 11:11:08 minidsp-shd volumio[6327]: ---------------------------- MPD announces system playlist update
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: Ignoring MPD Status Update
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: ------------------------------ 53ms
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: sendMpdCommand play took 43 milliseconds
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: ------------------------------ 38ms
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: ------------------------------ 35ms
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: Executing endpoint metavolumio
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: Executing endpoint getStreamUrltidal
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: tidal , getStreamUrlAPI
Jun 13 11:11:08 minidsp-shd volumio[6327]: info: getStreamUrl took 592 milliseconds
Jun 13 11:11:09 minidsp-shd volumio[6327]: STREAMING PROXY: Got real url: http://sp-pr-fa.audio.tidal.com/mediatracks/CAEaKwgDEic3Y2ZhMTQ2YTgwYzU4M2JiN2Q5NzQyMmUwY2ExMWRkZl82MS5tcDQ/0.flac?token=1749787868~M2VmZTE3NDc4NGMwZWY3ZGFjMmVkNjAzM2ZhYzU4NWE0MjQyMmYxMg==
Jun 13 11:11:09 minidsp-shd volumio[6327]: STREAMING PROXY: Response: 200, length: 33717959
Jun 13 11:11:09 minidsp-shd volumio[6327]: info:
Jun 13 11:11:09 minidsp-shd volumio[6327]: ---------------------------- MPD announces state update: player
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: ControllerMpd::getState
Jun 13 11:11:09 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand status
Jun 13 11:11:09 minidsp-shd volumio[6327]: info:
Jun 13 11:11:09 minidsp-shd volumio[6327]: ---------------------------- MPD announces state update: player
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: ControllerMpd::getState
Jun 13 11:11:09 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand status
Jun 13 11:11:09 minidsp-shd volumio[6327]: info:
Jun 13 11:11:09 minidsp-shd volumio[6327]: ---------------------------- MPD announces state update: player
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: ControllerMpd::getState
Jun 13 11:11:09 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand status
Jun 13 11:11:09 minidsp-shd volumio[6327]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred.
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: Retrying Login Due to Network Error
Jun 13 11:11:09 minidsp-shd volumio[6327]: info:
Jun 13 11:11:09 minidsp-shd volumio[6327]: ---------------------------- MPD announces state update: player
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: sendMpdCommand status took 29 milliseconds
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: ControllerMpd::getState
Jun 13 11:11:09 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand status
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: sendMpdCommand status took 23 milliseconds
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: sendMpdCommand status took 17 milliseconds
Jun 13 11:11:09 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseState
Jun 13 11:11:09 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 13 11:11:09 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseState
Jun 13 11:11:09 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 13 11:11:09 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseState
Jun 13 11:11:09 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 13 11:11:09 minidsp-shd volumio[6327]: info:
Jun 13 11:11:09 minidsp-shd volumio[6327]: ---------------------------- MPD announces state update: player
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: ControllerMpd::getState
Jun 13 11:11:09 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand status
Jun 13 11:11:09 minidsp-shd volumio[6327]: info:
Jun 13 11:11:09 minidsp-shd volumio[6327]: ---------------------------- MPD announces state update: player
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: ControllerMpd::getState
Jun 13 11:11:09 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand status
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: sendMpdCommand status took 36 milliseconds
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: sendMpdCommand playlistinfo took 32 milliseconds
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: sendMpdCommand playlistinfo took 28 milliseconds
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: sendMpdCommand status took 21 milliseconds
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: sendMpdCommand status took 17 milliseconds
Jun 13 11:11:09 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseState
Jun 13 11:11:09 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 13 11:11:09 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseTrackInfo
Jun 13 11:11:09 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseTrackInfo
Jun 13 11:11:09 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseTrackInfo
Jun 13 11:11:09 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseState
Jun 13 11:11:09 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 13 11:11:09 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseState
Jun 13 11:11:09 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: ControllerMpd::pushState
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CoreCommandRouter::servicePushState
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 1
Jun 13 11:11:09 minidsp-shd volumio[6327]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":314,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"281004504&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/281004504&soundQuality=LOSSLESS","trackType":"tidal"}
Jun 13 11:11:09 minidsp-shd volumio[6327]: verbose: CURRENT POSITION 1
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState stateService play
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState currentStatus stop
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: ControllerMpd::pushState
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CoreCommandRouter::servicePushState
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 1
Jun 13 11:11:09 minidsp-shd volumio[6327]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":314,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"281004504&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/281004504&soundQuality=LOSSLESS","trackType":"tidal"}
Jun 13 11:11:09 minidsp-shd volumio[6327]: verbose: CURRENT POSITION 1
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState stateService play
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState currentStatus play
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: Received an update from plugin. extracting info from payload
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: ControllerMpd::pushState
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CoreCommandRouter::servicePushState
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 1
Jun 13 11:11:09 minidsp-shd volumio[6327]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":314,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"281004504&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/281004504&soundQuality=LOSSLESS","trackType":"tidal"}
Jun 13 11:11:09 minidsp-shd volumio[6327]: verbose: CURRENT POSITION 1
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState stateService play
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState currentStatus play
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: Received an update from plugin. extracting info from payload
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: ------------------------------ 205ms
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: ------------------------------ 223ms
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: ------------------------------ 219ms
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: sendMpdCommand playlistinfo took 153 milliseconds
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: sendMpdCommand playlistinfo took 147 milliseconds
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: sendMpdCommand playlistinfo took 146 milliseconds
Jun 13 11:11:09 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseTrackInfo
Jun 13 11:11:09 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseTrackInfo
Jun 13 11:11:09 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseTrackInfo
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: ControllerMpd::pushState
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CoreCommandRouter::servicePushState
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 1
Jun 13 11:11:09 minidsp-shd volumio[6327]: verbose: STATE SERVICE {"status":"play","position":0,"seek":983,"duration":314,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"437 Kbps","isStreaming":false,"title":"281004504&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/281004504&soundQuality=LOSSLESS","trackType":"tidal"}
Jun 13 11:11:09 minidsp-shd volumio[6327]: verbose: CURRENT POSITION 1
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState stateService play
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState currentStatus play
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: Received an update from plugin. extracting info from payload
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: ControllerMpd::pushState
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CoreCommandRouter::servicePushState
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 1
Jun 13 11:11:09 minidsp-shd volumio[6327]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1098,"duration":314,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"513 Kbps","isStreaming":false,"title":"281004504&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/281004504&soundQuality=LOSSLESS","trackType":"tidal"}
Jun 13 11:11:09 minidsp-shd volumio[6327]: verbose: CURRENT POSITION 1
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState stateService play
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState currentStatus play
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: Received an update from plugin. extracting info from payload
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: ControllerMpd::pushState
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CoreCommandRouter::servicePushState
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 1
Jun 13 11:11:09 minidsp-shd volumio[6327]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1098,"duration":314,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"513 Kbps","isStreaming":false,"title":"281004504&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/281004504&soundQuality=LOSSLESS","trackType":"tidal"}
Jun 13 11:11:09 minidsp-shd volumio[6327]: verbose: CURRENT POSITION 1
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState stateService play
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState currentStatus play
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: Received an update from plugin. extracting info from payload
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: ------------------------------ 405ms
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: ------------------------------ 387ms
Jun 13 11:11:09 minidsp-shd volumio[6327]: info: ------------------------------ 385ms
Jun 13 11:11:10 minidsp-shd volumio[6327]: info: Executing endpoint metavolumio
Jun 13 11:11:10 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Jun 13 11:11:10 minidsp-shd volumio[6327]: error: Failed request for metavolumio API
Jun 13 11:11:11 minidsp-shd volumio[6327]: STREAMING PROXY: Client dropped request, destroying
Jun 13 11:11:19 minidsp-shd volumio[6327]: info: MyVolumio login type: Token
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioSeek
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: CoreStateMachine::seek
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 1
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: TRACKBLOCK {"album":"满江红","albumUri":"tidal://album/281004502","albumart":"https://resources.tidal.com/images/d324febc/1999/4a12/adf1/9d992b105811/640x640.jpg","artist":"姚斯婷","artistUri":"tidal://artist/7828531","audioQuality":"LOSSLESS","bitdepth":"16 bit","duration":314,"explicit":false,"name":"满江红 怒发冲冠","samplerate":"44.1 KHz","service":"tidal","title":"满江红 怒发冲冠","trackType":"tidal","tracknumber":2,"type":"track","uri":"tidal://song/281004504","volumeNumber":1}
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: CoreStateMachine::startPlaybackTimer
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 1
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: [1749784283657] ControllerTidal::seek
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: CoreStateMachine::setConsumeUpdateService mpd
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: ControllerMpd::seek
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:11:23 minidsp-shd volumio[6327]: error: null
Jun 13 11:11:23 minidsp-shd volumio[6327]: info:
Jun 13 11:11:23 minidsp-shd volumio[6327]: ---------------------------- MPD announces state update: player
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: ControllerMpd::getState
Jun 13 11:11:23 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand status
Jun 13 11:11:23 minidsp-shd volumio[6327]: info:
Jun 13 11:11:23 minidsp-shd volumio[6327]: ---------------------------- MPD announces state update: player
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: ControllerMpd::getState
Jun 13 11:11:23 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand status
Jun 13 11:11:23 minidsp-shd volumio[6327]: info:
Jun 13 11:11:23 minidsp-shd volumio[6327]: ---------------------------- MPD announces state update: player
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: ControllerMpd::getState
Jun 13 11:11:23 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand status
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: sendMpdCommand status took 32 milliseconds
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: sendMpdCommand status took 21 milliseconds
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: sendMpdCommand status took 16 milliseconds
Jun 13 11:11:23 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseState
Jun 13 11:11:23 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 13 11:11:23 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseState
Jun 13 11:11:23 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 13 11:11:23 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseState
Jun 13 11:11:23 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: sendMpdCommand playlistinfo took 21 milliseconds
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: sendMpdCommand playlistinfo took 22 milliseconds
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: sendMpdCommand playlistinfo took 21 milliseconds
Jun 13 11:11:23 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseTrackInfo
Jun 13 11:11:23 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseTrackInfo
Jun 13 11:11:23 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseTrackInfo
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: ControllerMpd::pushState
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: CoreCommandRouter::servicePushState
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 1
Jun 13 11:11:23 minidsp-shd volumio[6327]: verbose: STATE SERVICE {"status":"play","position":0,"seek":65098,"duration":314,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"865 Kbps","isStreaming":false,"title":"281004504&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/281004504&soundQuality=LOSSLESS","trackType":"tidal"}
Jun 13 11:11:23 minidsp-shd volumio[6327]: verbose: CURRENT POSITION 1
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState stateService play
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState currentStatus play
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: Received an update from plugin. extracting info from payload
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: ControllerMpd::pushState
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: CoreCommandRouter::servicePushState
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 1
Jun 13 11:11:23 minidsp-shd volumio[6327]: verbose: STATE SERVICE {"status":"play","position":0,"seek":65098,"duration":314,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"865 Kbps","isStreaming":false,"title":"281004504&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/281004504&soundQuality=LOSSLESS","trackType":"tidal"}
Jun 13 11:11:23 minidsp-shd volumio[6327]: verbose: CURRENT POSITION 1
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState stateService play
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState currentStatus play
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: Received an update from plugin. extracting info from payload
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: ControllerMpd::pushState
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: CoreCommandRouter::servicePushState
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 1
Jun 13 11:11:23 minidsp-shd volumio[6327]: verbose: STATE SERVICE {"status":"play","position":0,"seek":65098,"duration":314,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"865 Kbps","isStreaming":false,"title":"281004504&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/281004504&soundQuality=LOSSLESS","trackType":"tidal"}
Jun 13 11:11:23 minidsp-shd volumio[6327]: verbose: CURRENT POSITION 1
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState stateService play
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState currentStatus play
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: Received an update from plugin. extracting info from payload
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: ------------------------------ 250ms
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: ------------------------------ 240ms
Jun 13 11:11:23 minidsp-shd volumio[6327]: info: ------------------------------ 237ms
Jun 13 11:11:34 minidsp-shd volumio[6327]: info: Executing endpoint metavolumio
Jun 13 11:11:34 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Jun 13 11:11:34 minidsp-shd volumio[6327]: info: Executing endpoint metavolumio
Jun 13 11:11:34 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Jun 13 11:11:42 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: my_music , getSuperSearchEnabledSourcesList
Jun 13 11:11:42 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioGetBrowseSources
Jun 13 11:11:42 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioGetBrowseSources
Jun 13 11:11:42 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Jun 13 11:11:42 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: tidal , search
Jun 13 11:11:43 minidsp-shd volumio[6327]: info: searchTIDALUri took 608 milliseconds
Jun 13 11:11:43 minidsp-shd volumio[6327]: info: search took 611 milliseconds
Jun 13 11:11:43 minidsp-shd volumio[6327]: info: All search sources collected, pushing search results
Jun 13 11:11:43 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: browseTIDALUri took 2646 milliseconds
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preload queue cleared
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preload queue cleared
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preload queue cleared
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/227743470
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/227743467
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/227743468
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/325683876
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/227743476
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/429257653
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/429257657
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/326061587
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/227743469
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/326061589
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/227743471
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/227743472
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/227743478
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/325683879
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/227743474
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/325683877
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/227743475
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/325683878
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/315196732
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/227743480
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/326061588
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/429257662
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/227743473
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/325683881
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/315196731
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/326061604
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/326061590
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/326061592
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/325683880
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/217096345
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/227743573
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/227931246
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/413880129
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/227743477
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/315196733
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/326061593
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/325683882
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/413880130
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/315196734
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/227743580
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/315196735
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/315196736
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/227743484
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/227743483
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/326060751
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/326061595
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/325683883
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/326061598
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/413880132
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/227743571
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/227743470 in service tidal
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/227743467 in service tidal
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/227743468 in service tidal
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/325683876 in service tidal
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Executing endpoint getSimilarArtists
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/227743476 in service tidal
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Executing endpoint getSimilarArtists
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/429257653 in service tidal
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/429257657 in service tidal
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/326061587 in service tidal
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/227743469 in service tidal
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/326061589 in service tidal
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/227743471 in service tidal
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/227743472 in service tidal
Jun 13 11:11:46 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/227743478 in service tidal
Jun 13 11:11:47 minidsp-shd volumio[6327]: info: explodeTIDALUri took 599 milliseconds
Jun 13 11:11:47 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/325683879 in service tidal
Jun 13 11:11:47 minidsp-shd volumio[6327]: info: explodeTIDALUri took 588 milliseconds
Jun 13 11:11:47 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/227743474 in service tidal
Jun 13 11:11:47 minidsp-shd volumio[6327]: info: explodeTIDALUri took 621 milliseconds
Jun 13 11:11:47 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/325683877 in service tidal
Jun 13 11:11:47 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/227743475 in service tidal
Jun 13 11:11:47 minidsp-shd volumio[6327]: info: explodeTIDALUri took 624 milliseconds
Jun 13 11:11:47 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/325683878 in service tidal
Jun 13 11:11:47 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/315196732 in service tidal
Jun 13 11:11:47 minidsp-shd volumio[6327]: info: explodeTIDALUri took 681 milliseconds
Jun 13 11:11:47 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/227743480 in service tidal
Jun 13 11:11:47 minidsp-shd volumio[6327]: info: explodeTIDALUri took 1012 milliseconds
Jun 13 11:11:47 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/326061588 in service tidal
Jun 13 11:11:47 minidsp-shd volumio[6327]: info: explodeTIDALUri took 705 milliseconds
Jun 13 11:11:47 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/429257662 in service tidal
Jun 13 11:11:47 minidsp-shd volumio[6327]: info: explodeTIDALUri took 670 milliseconds
Jun 13 11:11:47 minidsp-shd volumio[6327]: info: explodeTIDALUri took 735 milliseconds
Jun 13 11:11:47 minidsp-shd volumio[6327]: info: explodeTIDALUri took 635 milliseconds
Jun 13 11:11:47 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/227743473 in service tidal
Jun 13 11:11:47 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/325683881 in service tidal
Jun 13 11:11:47 minidsp-shd volumio[6327]: info: explodeTIDALUri took 715 milliseconds
Jun 13 11:11:47 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/315196731 in service tidal
Jun 13 11:11:47 minidsp-shd volumio[6327]: info: explodeTIDALUri took 577 milliseconds
Jun 13 11:11:47 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/326061604 in service tidal
Jun 13 11:11:47 minidsp-shd volumio[6327]: info: explodeTIDALUri took 690 milliseconds
Jun 13 11:11:47 minidsp-shd volumio[6327]: info: Executing endpoint getSimilarArtists
Jun 13 11:11:47 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists
Jun 13 11:11:47 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/326061590 in service tidal
Jun 13 11:11:47 minidsp-shd volumio[6327]: info: explodeTIDALUri took 639 milliseconds
Jun 13 11:11:47 minidsp-shd volumio[6327]: info: Executing endpoint metavolumio
Jun 13 11:11:47 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Jun 13 11:11:47 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/326061592 in service tidal
Jun 13 11:11:47 minidsp-shd volumio[6327]: info: explodeTIDALUri took 643 milliseconds
Jun 13 11:11:47 minidsp-shd volumio[6327]: info: explodeTIDALUri took 599 milliseconds
Jun 13 11:11:47 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/325683880 in service tidal
Jun 13 11:11:47 minidsp-shd volumio[6327]: info: explodeTIDALUri took 573 milliseconds
Jun 13 11:11:47 minidsp-shd volumio[6327]: info: explodeTIDALUri took 539 milliseconds
Jun 13 11:11:47 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/217096345 in service tidal
Jun 13 11:11:47 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/227743573 in service tidal
Jun 13 11:11:47 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/227931246 in service tidal
Jun 13 11:11:48 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/413880129 in service tidal
Jun 13 11:11:48 minidsp-shd volumio[6327]: info: explodeTIDALUri took 1044 milliseconds
Jun 13 11:11:48 minidsp-shd volumio[6327]: info: explodeTIDALUri took 656 milliseconds
Jun 13 11:11:48 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/227743477 in service tidal
Jun 13 11:11:48 minidsp-shd volumio[6327]: info: explodeTIDALUri took 644 milliseconds
Jun 13 11:11:48 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/315196733 in service tidal
Jun 13 11:11:48 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/326061593 in service tidal
Jun 13 11:11:48 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/325683882 in service tidal
Jun 13 11:11:48 minidsp-shd volumio[6327]: info: explodeTIDALUri took 613 milliseconds
Jun 13 11:11:48 minidsp-shd volumio[6327]: info: explodeTIDALUri took 692 milliseconds
Jun 13 11:11:48 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/413880130 in service tidal
Jun 13 11:11:48 minidsp-shd volumio[6327]: info: explodeTIDALUri took 631 milliseconds
Jun 13 11:11:48 minidsp-shd volumio[6327]: info: explodeTIDALUri took 599 milliseconds
Jun 13 11:11:48 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/315196734 in service tidal
Jun 13 11:11:48 minidsp-shd volumio[6327]: info: explodeTIDALUri took 991 milliseconds
Jun 13 11:11:48 minidsp-shd volumio[6327]: info: explodeTIDALUri took 597 milliseconds
Jun 13 11:11:48 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/227743580 in service tidal
Jun 13 11:11:48 minidsp-shd volumio[6327]: info: explodeTIDALUri took 595 milliseconds
Jun 13 11:11:48 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/315196735 in service tidal
Jun 13 11:11:48 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/315196736 in service tidal
Jun 13 11:11:48 minidsp-shd volumio[6327]: info: explodeTIDALUri took 645 milliseconds
Jun 13 11:11:48 minidsp-shd volumio[6327]: info: Executing endpoint metavolumio
Jun 13 11:11:48 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Jun 13 11:11:48 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/227743484 in service tidal
Jun 13 11:11:48 minidsp-shd volumio[6327]: info: explodeTIDALUri took 586 milliseconds
Jun 13 11:11:48 minidsp-shd volumio[6327]: info: explodeTIDALUri took 635 milliseconds
Jun 13 11:11:48 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/227743483 in service tidal
Jun 13 11:11:48 minidsp-shd volumio[6327]: info: explodeTIDALUri took 1106 milliseconds
Jun 13 11:11:48 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/326060751 in service tidal
Jun 13 11:11:48 minidsp-shd volumio[6327]: info: explodeTIDALUri took 630 milliseconds
Jun 13 11:11:48 minidsp-shd volumio[6327]: info: explodeTIDALUri took 599 milliseconds
Jun 13 11:11:48 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/326061595 in service tidal
Jun 13 11:11:48 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/325683883 in service tidal
Jun 13 11:11:48 minidsp-shd volumio[6327]: info: explodeTIDALUri took 655 milliseconds
Jun 13 11:11:48 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/326061598 in service tidal
Jun 13 11:11:48 minidsp-shd volumio[6327]: info: explodeTIDALUri took 611 milliseconds
Jun 13 11:11:48 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/413880132 in service tidal
Jun 13 11:11:48 minidsp-shd volumio[6327]: info: explodeTIDALUri took 660 milliseconds
Jun 13 11:11:48 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/227743571 in service tidal
Jun 13 11:11:48 minidsp-shd volumio[6327]: info: explodeTIDALUri took 613 milliseconds
Jun 13 11:11:48 minidsp-shd volumio[6327]: info: explodeTIDALUri took 667 milliseconds
Jun 13 11:11:48 minidsp-shd volumio[6327]: info: explodeTIDALUri took 621 milliseconds
Jun 13 11:11:49 minidsp-shd volumio[6327]: info: explodeTIDALUri took 567 milliseconds
Jun 13 11:11:49 minidsp-shd volumio[6327]: info: explodeTIDALUri took 576 milliseconds
Jun 13 11:11:49 minidsp-shd volumio[6327]: info: explodeTIDALUri took 615 milliseconds
Jun 13 11:11:49 minidsp-shd volumio[6327]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred.
Jun 13 11:11:49 minidsp-shd volumio[6327]: info: Retrying Login Due to Network Error
Jun 13 11:11:49 minidsp-shd volumio[6327]: info: explodeTIDALUri took 576 milliseconds
Jun 13 11:11:49 minidsp-shd volumio[6327]: info: explodeTIDALUri took 576 milliseconds
Jun 13 11:11:49 minidsp-shd volumio[6327]: info: explodeTIDALUri took 558 milliseconds
Jun 13 11:11:49 minidsp-shd volumio[6327]: info: explodeTIDALUri took 566 milliseconds
Jun 13 11:11:49 minidsp-shd volumio[6327]: info: explodeTIDALUri took 524 milliseconds
Jun 13 11:11:49 minidsp-shd volumio[6327]: info: Executing endpoint metavolumio
Jun 13 11:11:49 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Jun 13 11:11:49 minidsp-shd volumio[6327]: info: explodeTIDALUri took 644 milliseconds
Jun 13 11:11:49 minidsp-shd volumio[6327]: info: explodeTIDALUri took 1022 milliseconds
Jun 13 11:11:55 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri
Jun 13 11:11:56 minidsp-shd volumio[6327]: info: browseTIDALUri took 831 milliseconds
Jun 13 11:11:56 minidsp-shd volumio[6327]: info: Preload queue cleared
Jun 13 11:11:56 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/227743572
Jun 13 11:11:56 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/227743574
Jun 13 11:11:56 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/227743575
Jun 13 11:11:56 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/227743576
Jun 13 11:11:56 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/227743577
Jun 13 11:11:56 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/227743578
Jun 13 11:11:56 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/227743579
Jun 13 11:11:56 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/227743581
Jun 13 11:11:56 minidsp-shd volumio[6327]: info: Preloading song: tidal://song/227743582
Jun 13 11:11:56 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/227743572 in service tidal
Jun 13 11:11:56 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/227743574 in service tidal
Jun 13 11:11:56 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/227743575 in service tidal
Jun 13 11:11:56 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/227743576 in service tidal
Jun 13 11:11:56 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/227743577 in service tidal
Jun 13 11:11:56 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/227743578 in service tidal
Jun 13 11:11:56 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/227743579 in service tidal
Jun 13 11:11:56 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/227743581 in service tidal
Jun 13 11:11:56 minidsp-shd volumio[6327]: info: Exploding uri tidal://song/227743582 in service tidal
Jun 13 11:11:57 minidsp-shd volumio[6327]: info: explodeTIDALUri took 522 milliseconds
Jun 13 11:11:57 minidsp-shd volumio[6327]: info: explodeTIDALUri took 562 milliseconds
Jun 13 11:11:57 minidsp-shd volumio[6327]: info: explodeTIDALUri took 547 milliseconds
Jun 13 11:11:57 minidsp-shd volumio[6327]: info: explodeTIDALUri took 598 milliseconds
Jun 13 11:11:57 minidsp-shd volumio[6327]: info: explodeTIDALUri took 558 milliseconds
Jun 13 11:11:57 minidsp-shd volumio[6327]: info: explodeTIDALUri took 534 milliseconds
Jun 13 11:11:57 minidsp-shd volumio[6327]: info: explodeTIDALUri took 553 milliseconds
Jun 13 11:11:57 minidsp-shd volumio[6327]: info: explodeTIDALUri took 997 milliseconds
Jun 13 11:11:57 minidsp-shd volumio[6327]: info: explodeTIDALUri took 606 milliseconds
Jun 13 11:11:59 minidsp-shd volumio[6327]: info: MyVolumio login type: Token
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: Preload queue cleared
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CoreStateMachine::ClearQueue
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CoreStateMachine::stop
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CoreStateMachine::stPlaybackTimer
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CoreStateMachine::updateTrackBlock
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrackBlock
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 1
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CoreStateMachine::serviceStop
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 1
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CoreCommandRouter::serviceStop
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: [1749784324132] ControllerTidal::stop
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CoreStateMachine::setConsumeUpdateService mpd
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: ControllerMpd::stop
Jun 13 11:12:04 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand stop
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CorePlayQueue::clearPlayQueue
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CorePlayQueue::saveQueue
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushQueue
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CoreStateMachine::addQueueItems
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CorePlayQueue::addQueueItems
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: Preload queue cleared
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: Adding Item to queue: tidal://song/227743571
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: Using cached record of: tidal://song/227743571
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: Adding Item to queue: tidal://song/227743572
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: Using cached record of: tidal://song/227743572
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: Adding Item to queue: tidal://song/227743573
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: Using cached record of: tidal://song/227743573
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: Adding Item to queue: tidal://song/227743574
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: Using cached record of: tidal://song/227743574
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: Adding Item to queue: tidal://song/227743575
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: Using cached record of: tidal://song/227743575
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: Adding Item to queue: tidal://song/227743576
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: Using cached record of: tidal://song/227743576
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: Adding Item to queue: tidal://song/227743577
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: Using cached record of: tidal://song/227743577
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: Adding Item to queue: tidal://song/227743578
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: Using cached record of: tidal://song/227743578
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: Adding Item to queue: tidal://song/227743579
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: Using cached record of: tidal://song/227743579
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: Adding Item to queue: tidal://song/227743580
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: Using cached record of: tidal://song/227743580
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: Adding Item to queue: tidal://song/227743581
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: Using cached record of: tidal://song/227743581
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: Adding Item to queue: tidal://song/227743582
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: Using cached record of: tidal://song/227743582
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushQueue
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CorePlayQueue::saveQueue
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CoreStateMachine::updateTrackBlock
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrackBlock
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPlay
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CoreStateMachine::play index 10
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CoreStateMachine::stop
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CoreStateMachine::play index undefined
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 10
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CoreStateMachine::startPlaybackTimer
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 10
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: [1749784324207] ControllerTidal::clearAddPlayTrack
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: Getting stream with soundQuality LOSSLESS
Jun 13 11:12:04 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand stop
Jun 13 11:12:04 minidsp-shd volumio[6327]: info:
Jun 13 11:12:04 minidsp-shd volumio[6327]: ---------------------------- MPD announces state update: player
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: sendMpdCommand stop took 94 milliseconds
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: ControllerMpd::getState
Jun 13 11:12:04 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand status
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: sendMpdCommand stop took 21 milliseconds
Jun 13 11:12:04 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand clear
Jun 13 11:12:04 minidsp-shd volumio[6327]: info:
Jun 13 11:12:04 minidsp-shd volumio[6327]: ---------------------------- MPD announces state update: player
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: ControllerMpd::getState
Jun 13 11:12:04 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand status
Jun 13 11:12:04 minidsp-shd volumio[6327]: info:
Jun 13 11:12:04 minidsp-shd volumio[6327]: ---------------------------- MPD announces state update: player
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: ControllerMpd::getState
Jun 13 11:12:04 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand status
Jun 13 11:12:04 minidsp-shd volumio[6327]: info:
Jun 13 11:12:04 minidsp-shd volumio[6327]: ---------------------------- MPD announces system playlist update
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: Ignoring MPD Status Update
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: sendMpdCommand status took 32 milliseconds
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: sendMpdCommand clear took 30 milliseconds
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: sendMpdCommand status took 26 milliseconds
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: sendMpdCommand status took 23 milliseconds
Jun 13 11:12:04 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseState
Jun 13 11:12:04 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 13 11:12:04 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/227743581&soundQuality=LOSSLESS"
Jun 13 11:12:04 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseState
Jun 13 11:12:04 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseState
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: ControllerMpd::pushState
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CoreCommandRouter::servicePushState
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 10
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 10
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received mpd
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: ControllerMpd::pushState
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CoreCommandRouter::servicePushState
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 10
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 10
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received mpd
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: ------------------------------ 80ms
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: ------------------------------ 78ms
Jun 13 11:12:04 minidsp-shd volumio[6327]: info:
Jun 13 11:12:04 minidsp-shd volumio[6327]: ---------------------------- MPD announces system playlist update
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: Ignoring MPD Status Update
Jun 13 11:12:04 minidsp-shd volumio[6327]: info:
Jun 13 11:12:04 minidsp-shd volumio[6327]: ---------------------------- MPD announces system playlist update
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: Ignoring MPD Status Update
Jun 13 11:12:04 minidsp-shd volumio[6327]: error: updateQueue error: null
Jun 13 11:12:04 minidsp-shd volumio[6327]: info:
Jun 13 11:12:04 minidsp-shd volumio[6327]: ---------------------------- MPD announces system playlist update
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: Ignoring MPD Status Update
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: ------------------------------ 73ms
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: sendMpdCommand playlistinfo took 65 milliseconds
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/227743581&soundQuality=LOSSLESS" took 65 milliseconds
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: ------------------------------ 16ms
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: ------------------------------ 14ms
Jun 13 11:12:04 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseTrackInfo
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CoreStateMachine::setConsumeUpdateService mpd
Jun 13 11:12:04 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand play
Jun 13 11:12:04 minidsp-shd volumio[6327]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: ------------------------------ 116ms
Jun 13 11:12:04 minidsp-shd volumio[6327]: info:
Jun 13 11:12:04 minidsp-shd volumio[6327]: ---------------------------- MPD announces system playlist update
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: Ignoring MPD Status Update
Jun 13 11:12:04 minidsp-shd volumio[6327]: STREAMING PROXY: Handling url /?data=tidal://song/227743581&soundQuality=LOSSLESS
Jun 13 11:12:04 minidsp-shd volumio[6327]: info:
Jun 13 11:12:04 minidsp-shd volumio[6327]: ---------------------------- MPD announces system playlist update
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: Ignoring MPD Status Update
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: ------------------------------ 44ms
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: sendMpdCommand play took 34 milliseconds
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: ------------------------------ 31ms
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: ------------------------------ 27ms
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: Executing endpoint getStreamUrltidal
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: tidal , getStreamUrlAPI
Jun 13 11:12:04 minidsp-shd volumio[6327]: info: getStreamUrl took 581 milliseconds
Jun 13 11:12:04 minidsp-shd volumio[6327]: STREAMING PROXY: Got real url: http://sp-pr-fa.audio.tidal.com/mediatracks/CAEaKwgDEidkMDM4NzUxMjVkYTlhMWNiMmIyNWJmZTkzMjEyMWMyNF82MS5tcDQ/0.flac?token=1749787924~MjNiNjRkOTY3YTYzMDI1OTUyNDkyZTA3NDlmYzg3NjZjYTM2MmU3OQ==
Jun 13 11:12:05 minidsp-shd volumio[6327]: STREAMING PROXY: Response: 200, length: 19827845
Jun 13 11:12:05 minidsp-shd volumio[6327]: info:
Jun 13 11:12:05 minidsp-shd volumio[6327]: ---------------------------- MPD announces state update: player
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: ControllerMpd::getState
Jun 13 11:12:05 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand status
Jun 13 11:12:05 minidsp-shd volumio[6327]: info:
Jun 13 11:12:05 minidsp-shd volumio[6327]: ---------------------------- MPD announces state update: player
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: ControllerMpd::getState
Jun 13 11:12:05 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand status
Jun 13 11:12:05 minidsp-shd volumio[6327]: info:
Jun 13 11:12:05 minidsp-shd volumio[6327]: ---------------------------- MPD announces state update: player
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: ControllerMpd::getState
Jun 13 11:12:05 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand status
Jun 13 11:12:05 minidsp-shd volumio[6327]: info:
Jun 13 11:12:05 minidsp-shd volumio[6327]: ---------------------------- MPD announces state update: player
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: sendMpdCommand status took 19 milliseconds
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: ControllerMpd::getState
Jun 13 11:12:05 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand status
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: sendMpdCommand status took 14 milliseconds
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: sendMpdCommand status took 9 milliseconds
Jun 13 11:12:05 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseState
Jun 13 11:12:05 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 13 11:12:05 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseState
Jun 13 11:12:05 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 13 11:12:05 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseState
Jun 13 11:12:05 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 13 11:12:05 minidsp-shd volumio[6327]: info:
Jun 13 11:12:05 minidsp-shd volumio[6327]: ---------------------------- MPD announces state update: player
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: ControllerMpd::getState
Jun 13 11:12:05 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand status
Jun 13 11:12:05 minidsp-shd volumio[6327]: info:
Jun 13 11:12:05 minidsp-shd volumio[6327]: ---------------------------- MPD announces state update: player
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: ControllerMpd::getState
Jun 13 11:12:05 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand status
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: sendMpdCommand status took 23 milliseconds
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: sendMpdCommand playlistinfo took 20 milliseconds
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: sendMpdCommand playlistinfo took 18 milliseconds
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: sendMpdCommand playlistinfo took 18 milliseconds
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: sendMpdCommand status took 13 milliseconds
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: sendMpdCommand status took 10 milliseconds
Jun 13 11:12:05 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseState
Jun 13 11:12:05 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 13 11:12:05 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseTrackInfo
Jun 13 11:12:05 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseState
Jun 13 11:12:05 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 13 11:12:05 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseState
Jun 13 11:12:05 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: ControllerMpd::pushState
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CoreCommandRouter::servicePushState
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 10
Jun 13 11:12:05 minidsp-shd volumio[6327]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":346,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"227743581&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/227743581&soundQuality=LOSSLESS","trackType":"tidal"}
Jun 13 11:12:05 minidsp-shd volumio[6327]: verbose: CURRENT POSITION 10
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState stateService play
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState currentStatus stop
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: ControllerMpd::pushState
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CoreCommandRouter::servicePushState
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 10
Jun 13 11:12:05 minidsp-shd volumio[6327]: verbose: STATE SERVICE {"status":"play","position":0,"seek":434,"duration":346,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"127 Kbps","isStreaming":false,"title":"227743581&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/227743581&soundQuality=LOSSLESS","trackType":"tidal"}
Jun 13 11:12:05 minidsp-shd volumio[6327]: verbose: CURRENT POSITION 10
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState stateService play
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState currentStatus play
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: Received an update from plugin. extracting info from payload
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: ControllerMpd::pushState
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CoreCommandRouter::servicePushState
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 10
Jun 13 11:12:05 minidsp-shd volumio[6327]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1098,"duration":346,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"125 Kbps","isStreaming":false,"title":"227743581&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/227743581&soundQuality=LOSSLESS","trackType":"tidal"}
Jun 13 11:12:05 minidsp-shd volumio[6327]: verbose: CURRENT POSITION 10
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState stateService play
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState currentStatus play
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: Received an update from plugin. extracting info from payload
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: ------------------------------ 148ms
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: ------------------------------ 175ms
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: ------------------------------ 169ms
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: sendMpdCommand playlistinfo took 129 milliseconds
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: sendMpdCommand playlistinfo took 124 milliseconds
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: sendMpdCommand playlistinfo took 123 milliseconds
Jun 13 11:12:05 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseTrackInfo
Jun 13 11:12:05 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseTrackInfo
Jun 13 11:12:05 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseTrackInfo
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: ControllerMpd::pushState
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CoreCommandRouter::servicePushState
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 10
Jun 13 11:12:05 minidsp-shd volumio[6327]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1098,"duration":346,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"125 Kbps","isStreaming":false,"title":"227743581&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/227743581&soundQuality=LOSSLESS","trackType":"tidal"}
Jun 13 11:12:05 minidsp-shd volumio[6327]: verbose: CURRENT POSITION 10
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState stateService play
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState currentStatus play
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: Received an update from plugin. extracting info from payload
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: ControllerMpd::pushState
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CoreCommandRouter::servicePushState
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 10
Jun 13 11:12:05 minidsp-shd volumio[6327]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1098,"duration":346,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"125 Kbps","isStreaming":false,"title":"227743581&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/227743581&soundQuality=LOSSLESS","trackType":"tidal"}
Jun 13 11:12:05 minidsp-shd volumio[6327]: verbose: CURRENT POSITION 10
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState stateService play
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState currentStatus play
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: Received an update from plugin. extracting info from payload
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: ControllerMpd::pushState
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CoreCommandRouter::servicePushState
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 10
Jun 13 11:12:05 minidsp-shd volumio[6327]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1098,"duration":346,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"125 Kbps","isStreaming":false,"title":"227743581&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/227743581&soundQuality=LOSSLESS","trackType":"tidal"}
Jun 13 11:12:05 minidsp-shd volumio[6327]: verbose: CURRENT POSITION 10
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState stateService play
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState currentStatus play
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: Received an update from plugin. extracting info from payload
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: ------------------------------ 281ms
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: ------------------------------ 266ms
Jun 13 11:12:05 minidsp-shd volumio[6327]: info: ------------------------------ 264ms
Jun 13 11:12:07 minidsp-shd volumio[6327]: STREAMING PROXY: Client dropped request, destroying
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioSeek
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: CoreStateMachine::seek
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 10
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: TRACKBLOCK {"album":"童丽粤语十大金曲Ⅱ","albumUri":"tidal://album/227743561","albumart":"https://resources.tidal.com/images/3da1d4c4/a237/4a2a/9ddf/48473082f6c1/640x640.jpg","artist":"童丽","artistUri":"tidal://artist/15987985","audioQuality":"LOSSLESS","bitdepth":"16 bit","duration":346,"explicit":false,"name":"李香兰","samplerate":"44.1 KHz","service":"tidal","title":"李香兰","trackType":"tidal","tracknumber":11,"type":"track","uri":"tidal://song/227743581","volumeNumber":1}
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: CoreStateMachine::startPlaybackTimer
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 10
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: [1749784329613] ControllerTidal::seek
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: CoreStateMachine::setConsumeUpdateService mpd
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: ControllerMpd::seek
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:12:09 minidsp-shd volumio[6327]: error: null
Jun 13 11:12:09 minidsp-shd volumio[6327]: info:
Jun 13 11:12:09 minidsp-shd volumio[6327]: ---------------------------- MPD announces state update: player
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: ControllerMpd::getState
Jun 13 11:12:09 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand status
Jun 13 11:12:09 minidsp-shd volumio[6327]: info:
Jun 13 11:12:09 minidsp-shd volumio[6327]: ---------------------------- MPD announces state update: player
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: ControllerMpd::getState
Jun 13 11:12:09 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand status
Jun 13 11:12:09 minidsp-shd volumio[6327]: info:
Jun 13 11:12:09 minidsp-shd volumio[6327]: ---------------------------- MPD announces state update: player
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: ControllerMpd::getState
Jun 13 11:12:09 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand status
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: sendMpdCommand status took 31 milliseconds
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: sendMpdCommand status took 20 milliseconds
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: sendMpdCommand status took 16 milliseconds
Jun 13 11:12:09 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseState
Jun 13 11:12:09 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 13 11:12:09 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseState
Jun 13 11:12:09 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 13 11:12:09 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseState
Jun 13 11:12:09 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: sendMpdCommand playlistinfo took 23 milliseconds
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: sendMpdCommand playlistinfo took 23 milliseconds
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: sendMpdCommand playlistinfo took 22 milliseconds
Jun 13 11:12:09 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseTrackInfo
Jun 13 11:12:09 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseTrackInfo
Jun 13 11:12:09 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseTrackInfo
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: ControllerMpd::pushState
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: CoreCommandRouter::servicePushState
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 10
Jun 13 11:12:09 minidsp-shd volumio[6327]: verbose: STATE SERVICE {"status":"play","position":0,"seek":76098,"duration":346,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"510 Kbps","isStreaming":false,"title":"227743581&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/227743581&soundQuality=LOSSLESS","trackType":"tidal"}
Jun 13 11:12:09 minidsp-shd volumio[6327]: verbose: CURRENT POSITION 10
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState stateService play
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState currentStatus play
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: Received an update from plugin. extracting info from payload
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: ControllerMpd::pushState
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: CoreCommandRouter::servicePushState
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 10
Jun 13 11:12:09 minidsp-shd volumio[6327]: verbose: STATE SERVICE {"status":"play","position":0,"seek":76098,"duration":346,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"491 Kbps","isStreaming":false,"title":"227743581&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/227743581&soundQuality=LOSSLESS","trackType":"tidal"}
Jun 13 11:12:09 minidsp-shd volumio[6327]: verbose: CURRENT POSITION 10
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState stateService play
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState currentStatus play
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: Received an update from plugin. extracting info from payload
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: ControllerMpd::pushState
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: CoreCommandRouter::servicePushState
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 10
Jun 13 11:12:09 minidsp-shd volumio[6327]: verbose: STATE SERVICE {"status":"play","position":0,"seek":76098,"duration":346,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"491 Kbps","isStreaming":false,"title":"227743581&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/227743581&soundQuality=LOSSLESS","trackType":"tidal"}
Jun 13 11:12:09 minidsp-shd volumio[6327]: verbose: CURRENT POSITION 10
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState stateService play
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState currentStatus play
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: Received an update from plugin. extracting info from payload
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: ------------------------------ 239ms
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: ------------------------------ 231ms
Jun 13 11:12:09 minidsp-shd volumio[6327]: info: ------------------------------ 228ms
Jun 13 11:12:19 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri
Jun 13 11:12:20 minidsp-shd volumio[6327]: info: browseTIDALUri took 843 milliseconds
Jun 13 11:12:20 minidsp-shd volumio[6327]: info: Preload queue cleared
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: Preload queue cleared
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: CoreStateMachine::ClearQueue
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: CoreStateMachine::stop
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: CoreStateMachine::stPlaybackTimer
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: CoreStateMachine::updateTrackBlock
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrackBlock
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 10
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: CoreStateMachine::serviceStop
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 10
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: CoreCommandRouter::serviceStop
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: [1749784346958] ControllerTidal::stop
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: CoreStateMachine::setConsumeUpdateService mpd
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: ControllerMpd::stop
Jun 13 11:12:26 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand stop
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: CorePlayQueue::clearPlayQueue
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: CorePlayQueue::saveQueue
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushQueue
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: CoreStateMachine::addQueueItems
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: CorePlayQueue::addQueueItems
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: Preload queue cleared
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: Adding Item to queue: tidal://song/227743467
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: Using cached record of: tidal://song/227743467
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: Adding Item to queue: tidal://song/227743468
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: Using cached record of: tidal://song/227743468
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: Adding Item to queue: tidal://song/227743469
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: Using cached record of: tidal://song/227743469
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: Adding Item to queue: tidal://song/227743470
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: Using cached record of: tidal://song/227743470
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: Adding Item to queue: tidal://song/227743471
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: Using cached record of: tidal://song/227743471
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: Adding Item to queue: tidal://song/227743472
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: Using cached record of: tidal://song/227743472
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: Adding Item to queue: tidal://song/227743473
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: Using cached record of: tidal://song/227743473
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: Adding Item to queue: tidal://song/227743474
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: Using cached record of: tidal://song/227743474
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: Adding Item to queue: tidal://song/227743475
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: Using cached record of: tidal://song/227743475
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: Adding Item to queue: tidal://song/227743476
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: Using cached record of: tidal://song/227743476
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: Adding Item to queue: tidal://song/227743477
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: Using cached record of: tidal://song/227743477
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: Adding Item to queue: tidal://song/227743478
Jun 13 11:12:26 minidsp-shd volumio[6327]: info: Using cached record of: tidal://song/227743478
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushQueue
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: CorePlayQueue::saveQueue
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: CoreStateMachine::updateTrackBlock
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrackBlock
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPlay
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: CoreStateMachine::play index 6
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: CoreStateMachine::stop
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: CoreStateMachine::play index undefined
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 6
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: CoreStateMachine::startPlaybackTimer
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 6
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: [1749784347033] ControllerTidal::clearAddPlayTrack
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: Getting stream with soundQuality LOSSLESS
Jun 13 11:12:27 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand stop
Jun 13 11:12:27 minidsp-shd volumio[6327]: info:
Jun 13 11:12:27 minidsp-shd volumio[6327]: ---------------------------- MPD announces state update: player
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: sendMpdCommand stop took 102 milliseconds
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: ControllerMpd::getState
Jun 13 11:12:27 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand status
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: sendMpdCommand stop took 29 milliseconds
Jun 13 11:12:27 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand clear
Jun 13 11:12:27 minidsp-shd volumio[6327]: info:
Jun 13 11:12:27 minidsp-shd volumio[6327]: ---------------------------- MPD announces state update: player
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: ControllerMpd::getState
Jun 13 11:12:27 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand status
Jun 13 11:12:27 minidsp-shd volumio[6327]: info:
Jun 13 11:12:27 minidsp-shd volumio[6327]: ---------------------------- MPD announces state update: player
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: ControllerMpd::getState
Jun 13 11:12:27 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand status
Jun 13 11:12:27 minidsp-shd volumio[6327]: info:
Jun 13 11:12:27 minidsp-shd volumio[6327]: ---------------------------- MPD announces system playlist update
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: Ignoring MPD Status Update
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: sendMpdCommand status took 29 milliseconds
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: sendMpdCommand clear took 28 milliseconds
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: sendMpdCommand status took 24 milliseconds
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: sendMpdCommand status took 22 milliseconds
Jun 13 11:12:27 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseState
Jun 13 11:12:27 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 13 11:12:27 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/227743473&soundQuality=LOSSLESS"
Jun 13 11:12:27 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseState
Jun 13 11:12:27 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseState
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: ControllerMpd::pushState
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: CoreCommandRouter::servicePushState
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 6
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 6
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received mpd
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: ControllerMpd::pushState
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: CoreCommandRouter::servicePushState
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 6
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 6
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received mpd
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: ------------------------------ 79ms
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: ------------------------------ 77ms
Jun 13 11:12:27 minidsp-shd volumio[6327]: info:
Jun 13 11:12:27 minidsp-shd volumio[6327]: ---------------------------- MPD announces system playlist update
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: Ignoring MPD Status Update
Jun 13 11:12:27 minidsp-shd volumio[6327]: info:
Jun 13 11:12:27 minidsp-shd volumio[6327]: ---------------------------- MPD announces system playlist update
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: Ignoring MPD Status Update
Jun 13 11:12:27 minidsp-shd volumio[6327]: error: updateQueue error: null
Jun 13 11:12:27 minidsp-shd volumio[6327]: info:
Jun 13 11:12:27 minidsp-shd volumio[6327]: ---------------------------- MPD announces system playlist update
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: Ignoring MPD Status Update
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: ------------------------------ 82ms
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: sendMpdCommand playlistinfo took 74 milliseconds
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: sendMpdCommand add "http://127.0.0.1:3245?data=tidal://song/227743473&soundQuality=LOSSLESS" took 75 milliseconds
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: ------------------------------ 25ms
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: ------------------------------ 22ms
Jun 13 11:12:27 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseTrackInfo
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: CoreStateMachine::setConsumeUpdateService mpd
Jun 13 11:12:27 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand play
Jun 13 11:12:27 minidsp-shd volumio[6327]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: ------------------------------ 126ms
Jun 13 11:12:27 minidsp-shd volumio[6327]: info:
Jun 13 11:12:27 minidsp-shd volumio[6327]: ---------------------------- MPD announces system playlist update
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: Ignoring MPD Status Update
Jun 13 11:12:27 minidsp-shd volumio[6327]: STREAMING PROXY: Handling url /?data=tidal://song/227743473&soundQuality=LOSSLESS
Jun 13 11:12:27 minidsp-shd volumio[6327]: info:
Jun 13 11:12:27 minidsp-shd volumio[6327]: ---------------------------- MPD announces system playlist update
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: Ignoring MPD Status Update
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: ------------------------------ 63ms
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: sendMpdCommand play took 46 milliseconds
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: ------------------------------ 41ms
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: ------------------------------ 38ms
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: Executing endpoint getStreamUrltidal
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: tidal , getStreamUrlAPI
Jun 13 11:12:27 minidsp-shd volumio[6327]: info: getStreamUrl took 614 milliseconds
Jun 13 11:12:27 minidsp-shd volumio[6327]: STREAMING PROXY: Got real url: http://sp-pr-fa.audio.tidal.com/mediatracks/CAEaKwgDEic4MDM5ODBhMjRlYTgyMzIxZDBmZjllYmMyZjFmYmFiYV82MS5tcDQ/0.flac?token=1749787947~ZjFlNzIyYjBhM2RjZGUwYjhlMGVkMTZkYjY2NDFkOGJiMjk0ZjBkZQ==
Jun 13 11:12:28 minidsp-shd volumio[6327]: STREAMING PROXY: Response: 200, length: 15244774
Jun 13 11:12:28 minidsp-shd volumio[6327]: info:
Jun 13 11:12:28 minidsp-shd volumio[6327]: ---------------------------- MPD announces state update: player
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: ControllerMpd::getState
Jun 13 11:12:28 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand status
Jun 13 11:12:28 minidsp-shd volumio[6327]: info:
Jun 13 11:12:28 minidsp-shd volumio[6327]: ---------------------------- MPD announces state update: player
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: ControllerMpd::getState
Jun 13 11:12:28 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand status
Jun 13 11:12:28 minidsp-shd volumio[6327]: info:
Jun 13 11:12:28 minidsp-shd volumio[6327]: ---------------------------- MPD announces state update: player
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: ControllerMpd::getState
Jun 13 11:12:28 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand status
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: sendMpdCommand status took 11 milliseconds
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: sendMpdCommand status took 7 milliseconds
Jun 13 11:12:28 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseState
Jun 13 11:12:28 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 13 11:12:28 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseState
Jun 13 11:12:28 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 13 11:12:28 minidsp-shd volumio[6327]: info:
Jun 13 11:12:28 minidsp-shd volumio[6327]: ---------------------------- MPD announces state update: player
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: ControllerMpd::getState
Jun 13 11:12:28 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand status
Jun 13 11:12:28 minidsp-shd volumio[6327]: info:
Jun 13 11:12:28 minidsp-shd volumio[6327]: ---------------------------- MPD announces state update: player
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: ControllerMpd::getState
Jun 13 11:12:28 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand status
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: sendMpdCommand status took 22 milliseconds
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: sendMpdCommand playlistinfo took 17 milliseconds
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: sendMpdCommand playlistinfo took 16 milliseconds
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: sendMpdCommand status took 12 milliseconds
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: sendMpdCommand status took 8 milliseconds
Jun 13 11:12:28 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseState
Jun 13 11:12:28 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 13 11:12:28 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseTrackInfo
Jun 13 11:12:28 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseTrackInfo
Jun 13 11:12:28 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseState
Jun 13 11:12:28 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 13 11:12:28 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseState
Jun 13 11:12:28 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: ControllerMpd::pushState
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CoreCommandRouter::servicePushState
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 6
Jun 13 11:12:28 minidsp-shd volumio[6327]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":207,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"227743473&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/227743473&soundQuality=LOSSLESS","trackType":"tidal"}
Jun 13 11:12:28 minidsp-shd volumio[6327]: verbose: CURRENT POSITION 6
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState stateService play
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState currentStatus stop
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: ControllerMpd::pushState
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CoreCommandRouter::servicePushState
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 6
Jun 13 11:12:28 minidsp-shd volumio[6327]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":207,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"227743473&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/227743473&soundQuality=LOSSLESS","trackType":"tidal"}
Jun 13 11:12:28 minidsp-shd volumio[6327]: verbose: CURRENT POSITION 6
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState stateService play
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState currentStatus play
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: Received an update from plugin. extracting info from payload
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: ------------------------------ 94ms
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: ------------------------------ 103ms
Jun 13 11:12:28 minidsp-shd volumio[6327]: info:
Jun 13 11:12:28 minidsp-shd volumio[6327]: ---------------------------- MPD announces state update: player
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: ControllerMpd::getState
Jun 13 11:12:28 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand status
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: sendMpdCommand playlistinfo took 75 milliseconds
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: sendMpdCommand playlistinfo took 69 milliseconds
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: sendMpdCommand playlistinfo took 68 milliseconds
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: sendMpdCommand status took 7 milliseconds
Jun 13 11:12:28 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseTrackInfo
Jun 13 11:12:28 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseTrackInfo
Jun 13 11:12:28 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseTrackInfo
Jun 13 11:12:28 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseState
Jun 13 11:12:28 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: ControllerMpd::pushState
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CoreCommandRouter::servicePushState
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 6
Jun 13 11:12:28 minidsp-shd volumio[6327]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":207,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"227743473&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/227743473&soundQuality=LOSSLESS","trackType":"tidal"}
Jun 13 11:12:28 minidsp-shd volumio[6327]: verbose: CURRENT POSITION 6
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState stateService play
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState currentStatus play
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: Received an update from plugin. extracting info from payload
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: ControllerMpd::pushState
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CoreCommandRouter::servicePushState
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 6
Jun 13 11:12:28 minidsp-shd volumio[6327]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":207,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"227743473&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/227743473&soundQuality=LOSSLESS","trackType":"tidal"}
Jun 13 11:12:28 minidsp-shd volumio[6327]: verbose: CURRENT POSITION 6
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState stateService play
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState currentStatus play
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: Received an update from plugin. extracting info from payload
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: ControllerMpd::pushState
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CoreCommandRouter::servicePushState
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 6
Jun 13 11:12:28 minidsp-shd volumio[6327]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":207,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"227743473&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/227743473&soundQuality=LOSSLESS","trackType":"tidal"}
Jun 13 11:12:28 minidsp-shd volumio[6327]: verbose: CURRENT POSITION 6
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState stateService play
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState currentStatus play
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: Received an update from plugin. extracting info from payload
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: ------------------------------ 214ms
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: ------------------------------ 203ms
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: ------------------------------ 202ms
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: sendMpdCommand playlistinfo took 128 milliseconds
Jun 13 11:12:28 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseTrackInfo
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: ControllerMpd::pushState
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CoreCommandRouter::servicePushState
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 6
Jun 13 11:12:28 minidsp-shd volumio[6327]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1212,"duration":207,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"183 Kbps","isStreaming":false,"title":"227743473&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/227743473&soundQuality=LOSSLESS","trackType":"tidal"}
Jun 13 11:12:28 minidsp-shd volumio[6327]: verbose: CURRENT POSITION 6
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState stateService play
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState currentStatus play
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: Received an update from plugin. extracting info from payload
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:12:28 minidsp-shd volumio[6327]: info: ------------------------------ 183ms
Jun 13 11:12:29 minidsp-shd volumio[6327]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred.
Jun 13 11:12:29 minidsp-shd volumio[6327]: info: Retrying Login Due to Network Error
Jun 13 11:12:30 minidsp-shd volumio[6327]: STREAMING PROXY: Client dropped request, destroying
Jun 13 11:12:39 minidsp-shd volumio[6327]: info: MyVolumio login type: Token
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioSeek
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: CoreStateMachine::seek
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 6
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: TRACKBLOCK {"album":"粤语十大金曲","albumUri":"tidal://album/227743466","albumart":"https://resources.tidal.com/images/91983562/1e5f/4744/8cd0/85d8bde08118/640x640.jpg","artist":"童丽","artistUri":"tidal://artist/15987985","audioQuality":"LOSSLESS","bitdepth":"16 bit","duration":207,"explicit":false,"name":"梨涡浅笑","samplerate":"44.1 KHz","service":"tidal","title":"梨涡浅笑","trackType":"tidal","tracknumber":7,"type":"track","uri":"tidal://song/227743473","volumeNumber":1}
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: CoreStateMachine::startPlaybackTimer
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 6
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: [1749784360394] ControllerTidal::seek
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: CoreStateMachine::setConsumeUpdateService mpd
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: ControllerMpd::seek
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:12:40 minidsp-shd volumio[6327]: error: null
Jun 13 11:12:40 minidsp-shd volumio[6327]: info:
Jun 13 11:12:40 minidsp-shd volumio[6327]: ---------------------------- MPD announces state update: player
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: ControllerMpd::getState
Jun 13 11:12:40 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand status
Jun 13 11:12:40 minidsp-shd volumio[6327]: info:
Jun 13 11:12:40 minidsp-shd volumio[6327]: ---------------------------- MPD announces state update: player
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: ControllerMpd::getState
Jun 13 11:12:40 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand status
Jun 13 11:12:40 minidsp-shd volumio[6327]: info:
Jun 13 11:12:40 minidsp-shd volumio[6327]: ---------------------------- MPD announces state update: player
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: ControllerMpd::getState
Jun 13 11:12:40 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand status
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: sendMpdCommand status took 40 milliseconds
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: sendMpdCommand status took 22 milliseconds
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: sendMpdCommand status took 18 milliseconds
Jun 13 11:12:40 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseState
Jun 13 11:12:40 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 13 11:12:40 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseState
Jun 13 11:12:40 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 13 11:12:40 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseState
Jun 13 11:12:40 minidsp-shd volumio[6327]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: sendMpdCommand playlistinfo took 24 milliseconds
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: sendMpdCommand playlistinfo took 23 milliseconds
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: sendMpdCommand playlistinfo took 23 milliseconds
Jun 13 11:12:40 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseTrackInfo
Jun 13 11:12:40 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseTrackInfo
Jun 13 11:12:40 minidsp-shd volumio[6327]: verbose: ControllerMpd::parseTrackInfo
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: ControllerMpd::pushState
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: CoreCommandRouter::servicePushState
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 6
Jun 13 11:12:40 minidsp-shd volumio[6327]: verbose: STATE SERVICE {"status":"play","position":0,"seek":48098,"duration":207,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"474 Kbps","isStreaming":false,"title":"227743473&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/227743473&soundQuality=LOSSLESS","trackType":"tidal"}
Jun 13 11:12:40 minidsp-shd volumio[6327]: verbose: CURRENT POSITION 6
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState stateService play
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState currentStatus play
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: Received an update from plugin. extracting info from payload
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: ControllerMpd::pushState
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: CoreCommandRouter::servicePushState
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 6
Jun 13 11:12:40 minidsp-shd volumio[6327]: verbose: STATE SERVICE {"status":"play","position":0,"seek":48098,"duration":207,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"565 Kbps","isStreaming":false,"title":"227743473&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/227743473&soundQuality=LOSSLESS","trackType":"tidal"}
Jun 13 11:12:40 minidsp-shd volumio[6327]: verbose: CURRENT POSITION 6
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState stateService play
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState currentStatus play
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: Received an update from plugin. extracting info from payload
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: ControllerMpd::pushState
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: CoreCommandRouter::servicePushState
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: CorePlayQueue::getTrack 6
Jun 13 11:12:40 minidsp-shd volumio[6327]: verbose: STATE SERVICE {"status":"play","position":0,"seek":48098,"duration":207,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"565 Kbps","isStreaming":false,"title":"227743473&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/227743473&soundQuality=LOSSLESS","trackType":"tidal"}
Jun 13 11:12:40 minidsp-shd volumio[6327]: verbose: CURRENT POSITION 6
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState stateService play
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: CoreStateMachine::syncState currentStatus play
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: Received an update from plugin. extracting info from payload
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: CoreStateMachine::pushState
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: CoreCommandRouter::volumioPushState
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output update for this device
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: MRS: Pushing multiroomSync output
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: ------------------------------ 213ms
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: ------------------------------ 196ms
Jun 13 11:12:40 minidsp-shd volumio[6327]: info: ------------------------------ 193ms
Jun 13 11:12:48 minidsp-shd volumio[6327]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 13 11:12:48 minidsp-shd volumio[6327]: Error: connect ETIMEDOUT 69.171.229.73:80
Jun 13 11:12:48 minidsp-shd volumio[6327]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) {
Jun 13 11:12:48 minidsp-shd volumio[6327]: errno: -110,
Jun 13 11:12:48 minidsp-shd volumio[6327]: code: 'ETIMEDOUT',
Jun 13 11:12:48 minidsp-shd volumio[6327]: syscall: 'connect',
Jun 13 11:12:48 minidsp-shd volumio[6327]: address: '69.171.229.73',
Jun 13 11:12:48 minidsp-shd volumio[6327]: port: 80
Jun 13 11:12:48 minidsp-shd volumio[6327]: }
Jun 13 11:12:48 minidsp-shd volumio[6327]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 13 11:12:49 minidsp-shd sudo[7153]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-13 11:11
Jun 13 11:12:49 minidsp-shd sudo[7153]: 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="17fcb754ddd6bd152b01008c46cc4ba1ca48bf35"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="281cefcd7a302aa7cfba569185cf7aae19b8c376"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="minidspshd"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 22 Mar 2024 03:13:25 PM CET"
VOLUMIO_VERSION="3.608"
VOLUMIO_HARDWARE="nanopineo3"
VOLUMIO_DEVICENAME="Nanopi Neo3"
VOLUMIO_VENDOR="miniDSP"
VOLUMIO_MODEL="SHD"
VOLUMIO_VENDOR_MODEL="miniDSP SHD"
VOLUMIO_HASH="18533ba33f8f92d7e7e459bb30f70beb"