Volumio 3 not playing continuously

Dynodenny · January 7, 2022, 7:07pm

I have upgraded from 2 to V3 running on a Pi4 with a Cambridge Audio DAC.

V3 seems to be inconsistant at playing tracks on albums or playlists continuously. It will be fine for much of the time then just stop playing continuously. I have toggled the playback option for single and continuous and of course rebooting, but it just seems a random issue that once it starts prevails. IAny assistance welcome.

gkkpch · January 7, 2022, 7:16pm

You could start yourself with helping us with answering your own question. How are we to know what installation your talking about?
You don’t even mention which Cambridge DAC you have
Would you share some system logs please?
Preferable from a fresh reboot, with minimal steps to reproduce the problem

Dynodenny · January 7, 2022, 7:38pm

Helki and thank you.

Both using a dacmagic 100 and dacmagic 200. Hence not being specific. I will get logs when I am back home.

Thanks

gkkpch · January 7, 2022, 7:40pm

ok, thanks. I’ll check them after you’ve posted the link.

zoltar · January 7, 2022, 11:34pm

@Dynodenny I’m running a Pi3 w/ Volumio v3.179 connected via USB to a CA DacMagic 200M. Using Roon I haven’t encountered any playback issues. Feel free to ask me any questions to see if we can troubleshoot your setup.

Dynodenny · January 8, 2022, 2:36am

Hello Here is the link to the log file:
http://logs.volumio.org/volumio/2Ra8vvR.html
Thank you

Dynodenny · January 8, 2022, 2:38am

Thank you. I might be back to you about this and Roon as well!

Dynodenny · January 8, 2022, 3:38am

Here is a live log where the playback stopped twice:

Starting Live Log...
info: ------------------------------ 42ms

info: CoreCommandRouter::volumioGetState
info: CoreCommandRouter::volumioGetQueue
info: CoreStateMachine::getQueue
info: CorePlayQueue::getQueue
info: CoreCommandRouter::executeOnPlugin: system , getHwuuid
info: CALLMETHOD: system_controller system enableLiveLog true
info: CoreCommandRouter::executeOnPlugin: system , enableLiveLog
info: Launching a new LiveLog session
info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
info: CorePlayQueue::getTrack 3
info: CorePlayQueue::getTrack 4
info: Prefetching next song
info: [1641611846013] ControllerTidal::prefetch
info: Getting stream with soundQuality LOSSLESS
info: getStreamUrl took 620 milliseconds

info:
---------------------------- MPD announces system playlist update
info: Ignoring MPD Status Update
info: sendMpdCommand add "http://sp-pr-fa.audio.tidal.com/mediatracks/CAEaKRInYzg3ZTcxMzg4OWI2YjZjZjA5YmMzMjJhM2JhZDI5NTZfNjEubXA0/0.flac?token=1641615446~ZDMwZGQ2ZWM0MmQ4ZDkzYmI4NDdkNjVjOTUwZmU3ZWY3ZGY5MWJiNw==" took 2 milliseconds
info: CoreStateMachine::setConsumeUpdateService mpd

info: ------------------------------ 3ms
info: sendMpdCommand consume 1 took 1 milliseconds
info:
---------------------------- MPD announces system playlist update
info: Ignoring MPD Status Update
info:
---------------------------- MPD announces state update: player
info: ControllerMpd::getState

info: ------------------------------ 5ms
info: sendMpdCommand status took 1 milliseconds


info: sendMpdCommand playlistinfo took 1 milliseconds

info: ControllerMpd::pushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::startPlaybackTimer
info: CorePlayQueue::getTrack 4
info: CorePlayQueue::getTrack 4


info: CoreStateMachine::syncState   stateService play
info: CoreStateMachine::syncState   currentStatus play
info: Received an update from plugin. extracting info from payload
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: ------------------------------ 23ms
info: CoreCommandRouter::volumioGetState
info: VolumeController::SetAlsaVolume-
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::volumioGetState
info: VolumeController::SetAlsaVolume-
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CorePlayQueue::getTrack 4
info: CorePlayQueue::getTrack 5
info: Prefetching next song
info: [1641612108426] ControllerTidal::prefetch
info: Getting stream with soundQuality LOSSLESS
info: getStreamUrl took 668 milliseconds

info:
---------------------------- MPD announces system playlist update
info: Ignoring MPD Status Update
info: sendMpdCommand add "http://sp-pr-fa.audio.tidal.com/mediatracks/CAEaKRInOTIyOWUxYTk4MDIwZmQxNDMxOGU2YTE0MDFhYTNjNjBfNjEubXA0/0.flac?token=1641615708~OWQyNWUzZjViODI4ZmY3MTExOTkyYmIxMzRmMTYzYjU1NGVhY2ZmNw==" took 1 milliseconds
info: CoreStateMachine::setConsumeUpdateService mpd

info: ------------------------------ 3ms
info: sendMpdCommand consume 1 took 2 milliseconds
info: CoreStateMachine::startPlaybackTimer
info: CorePlayQueue::getTrack 5
info:
---------------------------- MPD announces system playlist update
info: Ignoring MPD Status Update
info:
---------------------------- MPD announces state update: player
info: ControllerMpd::getState

info: ------------------------------ 8ms
info: sendMpdCommand status took 7 milliseconds


info: sendMpdCommand playlistinfo took 4 milliseconds

info: ControllerMpd::pushState
info: CoreCommandRouter::servicePushState
info: CorePlayQueue::getTrack 5


info: CoreStateMachine::syncState   stateService play
info: CoreStateMachine::syncState   currentStatus play
info: Received an update from plugin. extracting info from payload
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: ------------------------------ 29ms
info: CoreCommandRouter::volumioGetState
info: VolumeController::SetAlsaVolume+
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::volumioGetState
info: VolumeController::SetAlsaVolume+
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::volumioGetState
info: VolumeController::SetAlsaVolume+
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::volumioGetState
info: VolumeController::SetAlsaVolume+
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::volumioReplaceandPlayItems
info: CoreStateMachine::ClearQueue
info: CoreStateMachine::stop
info: CoreStateMachine::setConsumeUpdateService undefined

info: CoreStateMachine::stPlaybackTimer
info: CoreStateMachine::updateTrackBlock
info: CorePlayQueue::getTrackBlock
info: CoreStateMachine::pushState
info: CorePlayQueue::getTrack 5
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreStateMachine::serviceStop
info: CorePlayQueue::getTrack 5
info: CoreCommandRouter::serviceStop
info: [1641612177049] ControllerTidal::stop
info: CoreStateMachine::setConsumeUpdateService mpd
info: ControllerMpd::stop

info: CorePlayQueue::clearPlayQueue
info: CorePlayQueue::saveQueue
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::volumioPushQueue
info: CoreStateMachine::addQueueItems
info: CorePlayQueue::addQueueItems
info: Adding Item to queue: tidal://song/77698517
info: Exploding uri tidal://song/77698517 in service tidal
info: Adding Item to queue: tidal://song/1381024
info: Exploding uri tidal://song/1381024 in service tidal
info: Adding Item to queue: tidal://song/77641995
info: Exploding uri tidal://song/77641995 in service tidal
info: Adding Item to queue: tidal://song/209809
info: Exploding uri tidal://song/209809 in service tidal
info: Adding Item to queue: tidal://song/109623522
info: Exploding uri tidal://song/109623522 in service tidal
info: Adding Item to queue: tidal://song/1577563
info: Exploding uri tidal://song/1577563 in service tidal
info: Adding Item to queue: tidal://song/1401815
info: Exploding uri tidal://song/1401815 in service tidal
info: Adding Item to queue: tidal://song/1381022
info: Exploding uri tidal://song/1381022 in service tidal
info: Adding Item to queue: tidal://song/1358815
info: Exploding uri tidal://song/1358815 in service tidal
info: Adding Item to queue: tidal://song/3462132
info: Exploding uri tidal://song/3462132 in service tidal
info: Adding Item to queue: tidal://song/74657339
info: Exploding uri tidal://song/74657339 in service tidal
info: Adding Item to queue: tidal://song/209807
info: Exploding uri tidal://song/209807 in service tidal
info: Adding Item to queue: tidal://song/94441872
info: Exploding uri tidal://song/94441872 in service tidal
info: Adding Item to queue: tidal://song/1577560
info: Exploding uri tidal://song/1577560 in service tidal
info: Adding Item to queue: tidal://song/77609731
info: Exploding uri tidal://song/77609731 in service tidal
info: Adding Item to queue: tidal://song/19046034
info: Exploding uri tidal://song/19046034 in service tidal
info: Adding Item to queue: tidal://song/2797491
info: Exploding uri tidal://song/2797491 in service tidal
info: Adding Item to queue: tidal://song/2178487
info: Exploding uri tidal://song/2178487 in service tidal
info: Adding Item to queue: tidal://song/58462910
info: Exploding uri tidal://song/58462910 in service tidal
info: Adding Item to queue: tidal://song/209808
info: Exploding uri tidal://song/209808 in service tidal
info: Adding Item to queue: tidal://song/279976
info: Exploding uri tidal://song/279976 in service tidal
info: Adding Item to queue: tidal://song/94477818
info: Exploding uri tidal://song/94477818 in service tidal
info: Adding Item to queue: tidal://song/4981814
info: Exploding uri tidal://song/4981814 in service tidal
info: Adding Item to queue: tidal://song/91847422
info: Exploding uri tidal://song/91847422 in service tidal
info: Adding Item to queue: tidal://song/91519392
info: Exploding uri tidal://song/91519392 in service tidal
info: Adding Item to queue: tidal://song/77609730
info: Exploding uri tidal://song/77609730 in service tidal
info: Adding Item to queue: tidal://song/1205912
info: Exploding uri tidal://song/1205912 in service tidal
info: Adding Item to queue: tidal://song/2178486
info: Exploding uri tidal://song/2178486 in service tidal
info: Adding Item to queue: tidal://song/1381762
info: Exploding uri tidal://song/1381762 in service tidal
info: Adding Item to queue: tidal://song/77611559
info: Exploding uri tidal://song/77611559 in service tidal
info: Adding Item to queue: tidal://song/279978
info: Exploding uri tidal://song/279978 in service tidal
info: Adding Item to queue: tidal://song/77632948
info: Exploding uri tidal://song/77632948 in service tidal
info: Adding Item to queue: tidal://song/1461670
info: Exploding uri tidal://song/1461670 in service tidal
info: Adding Item to queue: tidal://song/211064
info: Exploding uri tidal://song/211064 in service tidal
info: Adding Item to queue: tidal://song/1111034
info: Exploding uri tidal://song/1111034 in service tidal
info: Adding Item to queue: tidal://song/547178
info: Exploding uri tidal://song/547178 in service tidal
info: Adding Item to queue: tidal://song/102146444
info: Exploding uri tidal://song/102146444 in service tidal
info: Adding Item to queue: tidal://song/4081375
info: Exploding uri tidal://song/4081375 in service tidal
info: Adding Item to queue: tidal://song/91560146
info: Exploding uri tidal://song/91560146 in service tidal
info: Adding Item to queue: tidal://song/2044474
info: Exploding uri tidal://song/2044474 in service tidal
info:
---------------------------- MPD announces state update: player
info: sendMpdCommand stop took 150 milliseconds
info: ControllerMpd::getState

info: sendMpdCommand status took 2 milliseconds


info: sendMpdCommand playlistinfo took 1 milliseconds

info: ControllerMpd::pushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CorePlayQueue::getTrack 5


info: CoreStateMachine::syncState   stateService stop
info: CoreStateMachine::syncState   currentStatus stop
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: No code
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: ------------------------------ 25ms
info: explodeTIDALUri took 731 milliseconds
info: explodeTIDALUri took 752 milliseconds
info: explodeTIDALUri took 751 milliseconds
info: explodeTIDALUri took 795 milliseconds
info: explodeTIDALUri took 808 milliseconds
info: explodeTIDALUri took 811 milliseconds
info: explodeTIDALUri took 813 milliseconds
info: explodeTIDALUri took 829 milliseconds
info: explodeTIDALUri took 856 milliseconds
info: explodeTIDALUri took 870 milliseconds
info: explodeTIDALUri took 847 milliseconds
info: explodeTIDALUri took 849 milliseconds
info: explodeTIDALUri took 861 milliseconds
info: explodeTIDALUri took 874 milliseconds
info: explodeTIDALUri took 870 milliseconds
info: explodeTIDALUri took 861 milliseconds
info: explodeTIDALUri took 889 milliseconds
info: explodeTIDALUri took 874 milliseconds
info: explodeTIDALUri took 902 milliseconds
info: explodeTIDALUri took 898 milliseconds
info: explodeTIDALUri took 913 milliseconds
info: explodeTIDALUri took 907 milliseconds
info: explodeTIDALUri took 916 milliseconds
info: explodeTIDALUri took 911 milliseconds
info: explodeTIDALUri took 891 milliseconds
info: explodeTIDALUri took 895 milliseconds
info: explodeTIDALUri took 902 milliseconds
info: explodeTIDALUri took 924 milliseconds
info: explodeTIDALUri took 926 milliseconds
info: explodeTIDALUri took 950 milliseconds
info: explodeTIDALUri took 960 milliseconds
info: explodeTIDALUri took 942 milliseconds
info: explodeTIDALUri took 968 milliseconds
info: explodeTIDALUri took 957 milliseconds
info: explodeTIDALUri took 971 milliseconds
info: explodeTIDALUri took 949 milliseconds
info: explodeTIDALUri took 948 milliseconds
info: explodeTIDALUri took 953 milliseconds
info: explodeTIDALUri took 1030 milliseconds
info: explodeTIDALUri took 1029 milliseconds
info: CorePlayQueue::saveQueue
info: CoreCommandRouter::volumioPushQueue
info: CoreStateMachine::updateTrackBlock
info: CorePlayQueue::getTrackBlock
info: CoreCommandRouter::volumioPlay

info: CoreStateMachine::play index 18
info: CoreStateMachine::setConsumeUpdateService undefined
info: CoreStateMachine::stop
info: CoreStateMachine::setConsumeUpdateService undefined

info: CoreStateMachine::play index undefined
info: CoreStateMachine::setConsumeUpdateService undefined
info: CorePlayQueue::getTrack 18
info: CoreStateMachine::startPlaybackTimer
info: CorePlayQueue::getTrack 18
info: [1641612178105] ControllerTidal::clearAddPlayTrack
info: Getting stream with soundQuality HI_RES
info: getStreamUrl took 634 milliseconds

info: sendMpdCommand stop took 0 milliseconds

info:
---------------------------- MPD announces system playlist update
info: Ignoring MPD Status Update
info: sendMpdCommand clear took 1 milliseconds

error: updateQueue error: null
info:
---------------------------- MPD announces system playlist update
info: Ignoring MPD Status Update
info: ------------------------------ 2ms
info: sendMpdCommand add "http://sp-pr-fa.audio.tidal.com/mediatracks/CAEaKRInOWIyMjk5ZGFiYTU3NTc3MjBmODc3ZTNmOGJmYWE3MDJfNjAubXA0/0.flac?token=1641615778~YzVkZDg0ZjAzN2FiNWNiNmI3N2MyNjhhODEwZTk3NTBiYzNkZDYzYw==" took 1 milliseconds
info: CoreStateMachine::setConsumeUpdateService mpd

info: ------------------------------ 1ms
info: sendMpdCommand play took 1 milliseconds
info:
---------------------------- MPD announces state update: player
info: ControllerMpd::getState

info:
---------------------------- MPD announces state update: player
info: sendMpdCommand status took 12 milliseconds
info: ControllerMpd::getState



info: sendMpdCommand status took 3 milliseconds
info: sendMpdCommand playlistinfo took 3 milliseconds



info: ControllerMpd::pushState
info: CoreCommandRouter::servicePushState
info: CorePlayQueue::getTrack 18


info: CoreStateMachine::syncState   stateService play
info: CoreStateMachine::syncState   currentStatus stop
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: ------------------------------ 27ms
info: sendMpdCommand playlistinfo took 10 milliseconds

info: ControllerMpd::pushState
info: CoreCommandRouter::servicePushState
info: CorePlayQueue::getTrack 18


info: CoreStateMachine::syncState   stateService play
info: CoreStateMachine::syncState   currentStatus play
info: Received an update from plugin. extracting info from payload
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: ------------------------------ 29ms
info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri
info: browseTIDALUri took 903 milliseconds
info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri
info: browseTIDALUri took 847 milliseconds
info: CoreCommandRouter::volumioReplaceandPlayItems
info: CoreStateMachine::ClearQueue
info: CoreStateMachine::stop
info: CoreStateMachine::setConsumeUpdateService undefined

info: CoreStateMachine::stPlaybackTimer
info: CoreStateMachine::updateTrackBlock
info: CorePlayQueue::getTrackBlock
info: CoreStateMachine::pushState
info: CorePlayQueue::getTrack 18
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreStateMachine::serviceStop
info: CorePlayQueue::getTrack 18
info: CoreCommandRouter::serviceStop
info: [1641612220950] ControllerTidal::stop
info: CoreStateMachine::setConsumeUpdateService mpd
info: ControllerMpd::stop

info: CorePlayQueue::clearPlayQueue
info: CorePlayQueue::saveQueue
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::volumioPushQueue
info: CoreStateMachine::addQueueItems
info: CorePlayQueue::addQueueItems
info: Adding Item to queue: tidal://mymusic/mixes/002e96fbc0cb7cf2d892cc59607ad2
info: Exploding uri tidal://mymusic/mixes/002e96fbc0cb7cf2d892cc59607ad2 in service tidal
info:
---------------------------- MPD announces state update: player
info: sendMpdCommand stop took 80 milliseconds
info: ControllerMpd::getState

info: sendMpdCommand status took 1 milliseconds


info: sendMpdCommand playlistinfo took 1 milliseconds

info: ControllerMpd::pushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CorePlayQueue::getTrack 18


info: CoreStateMachine::syncState   stateService stop
info: CoreStateMachine::syncState   currentStatus stop
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: No code
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: ------------------------------ 22ms
info: explodeTIDALUri took 704 milliseconds
info: CorePlayQueue::saveQueue
info: CoreCommandRouter::volumioPushQueue
info: CoreStateMachine::updateTrackBlock
info: CorePlayQueue::getTrackBlock
info: CoreCommandRouter::volumioPlay

info: CoreStateMachine::play index 0
info: CoreStateMachine::setConsumeUpdateService undefined
info: CoreStateMachine::stop
info: CoreStateMachine::setConsumeUpdateService undefined

info: CoreStateMachine::play index undefined
info: CoreStateMachine::setConsumeUpdateService undefined
info: CorePlayQueue::getTrack 0
info: CoreStateMachine::startPlaybackTimer
info: CorePlayQueue::getTrack 0
info: [1641612221668] ControllerTidal::clearAddPlayTrack
info: Getting stream with soundQuality HI_RES
info: getStreamUrl took 641 milliseconds

info: sendMpdCommand stop took 1 milliseconds

info:
---------------------------- MPD announces system playlist update
info: Ignoring MPD Status Update
info: sendMpdCommand clear took 1 milliseconds

error: updateQueue error: null
info:
---------------------------- MPD announces system playlist update
info: Ignoring MPD Status Update
info: ------------------------------ 2ms
info: sendMpdCommand add "http://sp-pr-fa.audio.tidal.com/mediatracks/CAEaKRInYWE5MjVmNTg4OGRmMDJkMWFkNzE2YTVhYmViN2ZlNGFfNjAubXA0/0.flac?token=1641615822~NjI1OGVjMmUzMzcwYmNmZDNlMWM2YTZmMGE1MDk3OGY5ZjM5OThlNw==" took 1 milliseconds
info: CoreStateMachine::setConsumeUpdateService mpd

info: ------------------------------ 1ms
info: sendMpdCommand play took 1 milliseconds
info:
---------------------------- MPD announces state update: player
info: ControllerMpd::getState

info:
---------------------------- MPD announces state update: player
info: sendMpdCommand status took 13 milliseconds
info: ControllerMpd::getState



info: sendMpdCommand status took 2 milliseconds
info: sendMpdCommand playlistinfo took 2 milliseconds



info: ControllerMpd::pushState
info: CoreCommandRouter::servicePushState
info: CorePlayQueue::getTrack 0


info: CoreStateMachine::syncState   stateService play
info: CoreStateMachine::syncState   currentStatus stop
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: ------------------------------ 32ms
info: sendMpdCommand playlistinfo took 12 milliseconds

info: ControllerMpd::pushState
info: CoreCommandRouter::servicePushState
info: CorePlayQueue::getTrack 0


info: CoreStateMachine::syncState   stateService play
info: CoreStateMachine::syncState   currentStatus play
info: Received an update from plugin. extracting info from payload
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: ------------------------------ 38ms
info: CoreCommandRouter::volumioGetState
info: VolumeController::SetAlsaVolume-
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::volumioGetState
info: VolumeController::SetAlsaVolume-
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CorePlayQueue::getTrack 0
info: CorePlayQueue::getTrack 1
info: Prefetching next song
info: [1641612550293] ControllerTidal::prefetch
info: Getting stream with soundQuality HI_RES
info: getStreamUrl took 636 milliseconds

info:
---------------------------- MPD announces system playlist update
info: Ignoring MPD Status Update
info: sendMpdCommand add "http://sp-pr-cf.audio.tidal.com/mediatracks/CAEaKRInZmQzMDM5MWQ2YWNhZDBmODYyNmJiYjJmMWVkZjUxN2NfNjAubXA0/0.flac?Expires=1641616150&Signature=fRGrelXs~UlwprPx8ciOYUGr82oMGAgzSAH0zNtO2glapAFYI786XA0pZrfHmh7Oy2xlFpPLFqf-sGGRm6n9Fbu1zlY5Ha9JE0N89CbbdnG3g5R-0zFooWlL1Vqn16CtG229zh1t7WRQsYg8aSIizT0i5sKptfbUubEn9swIpOGho02wQyGpJUAkSnZGJqcnl90zv9HCZ9qlkP8Ce4Yq0vbOqOMa7w8gnZ6LoBN8KeEU34~Yco1cgrA9~r0JBChR0c8xNOk1R5wpfRSP3uKqA3MLeWHQ5m3BqrILZig1aFK~8t4OKrfGd4e3WzXHZW4O9dildBYDUbwAeej0g-VR-g__&Key-Pair-Id=APKAIZ3WPBE4R6SP555A" took 2 milliseconds
info: CoreStateMachine::setConsumeUpdateService mpd

info: ------------------------------ 3ms
info: sendMpdCommand consume 1 took 2 milliseconds
info:
---------------------------- MPD announces system playlist update
info: Ignoring MPD Status Update
info:
---------------------------- MPD announces state update: player
info: ControllerMpd::getState

info: ------------------------------ 2ms
info: sendMpdCommand status took 1 milliseconds


info: sendMpdCommand playlistinfo took 1 milliseconds

info: ControllerMpd::pushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::startPlaybackTimer
info: CorePlayQueue::getTrack 1
info: CorePlayQueue::getTrack 1


info: CoreStateMachine::syncState   stateService play
info: CoreStateMachine::syncState   currentStatus play
info: Received an update from plugin. extracting info from payload
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: ------------------------------ 21ms
info: CorePlayQueue::getTrack 1
info: CorePlayQueue::getTrack 2
info: Prefetching next song
info: [1641612878742] ControllerTidal::prefetch
info: Getting stream with soundQuality HI_RES
info: getStreamUrl took 657 milliseconds

info:
---------------------------- MPD announces system playlist update
info: Ignoring MPD Status Update
info: sendMpdCommand add "http://sp-pr-fa.audio.tidal.com/mediatracks/CAEaKRInM2M4N2RhMzI4YmFmNWZjY2NkYmE3ZTAwNTFjMmFjYzdfNjAubXA0/0.flac?token=1641616479~M2ZjNTk5MzgzZmE5Y2I3NmZhZWRhYjE1ZmUxNGJmMWM4NzJhNjBmMg==" took 2 milliseconds
info: CoreStateMachine::setConsumeUpdateService mpd

info: ------------------------------ 2ms
info: sendMpdCommand consume 1 took 1 milliseconds
info: CoreStateMachine::startPlaybackTimer
info: CorePlayQueue::getTrack 2
info:
---------------------------- MPD announces system playlist update
info: Ignoring MPD Status Update
info:
---------------------------- MPD announces state update: player
info: ControllerMpd::getState

info: ------------------------------ 1ms
info: sendMpdCommand status took 1 milliseconds


info: sendMpdCommand playlistinfo took 1 milliseconds

info: ControllerMpd::pushState
info: CoreCommandRouter::servicePushState
info: CorePlayQueue::getTrack 2


info: CoreStateMachine::syncState   stateService play
info: CoreStateMachine::syncState   currentStatus play
info: Received an update from plugin. extracting info from payload
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: ------------------------------ 15ms
info: CoreCommandRouter::volumioStop
info: CoreStateMachine::stop
info: CoreStateMachine::setConsumeUpdateService undefined

info: CoreStateMachine::stPlaybackTimer
info: CoreStateMachine::updateTrackBlock
info: CorePlayQueue::getTrackBlock
info: CoreStateMachine::pushState
info: CorePlayQueue::getTrack 2
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreStateMachine::serviceStop
info: CorePlayQueue::getTrack 2
info: CoreCommandRouter::serviceStop
info: [1641612966448] ControllerTidal::stop
info: CoreStateMachine::setConsumeUpdateService mpd
info: ControllerMpd::stop

info:
---------------------------- MPD announces state update: player
info: sendMpdCommand stop took 21 milliseconds
info: ControllerMpd::getState

info: sendMpdCommand status took 1 milliseconds


info: sendMpdCommand playlistinfo took 1 milliseconds

info: ControllerMpd::pushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CorePlayQueue::getTrack 2


info: CoreStateMachine::syncState   stateService stop
info: CoreStateMachine::syncState   currentStatus stop
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: No code
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: ------------------------------ 26ms
info: CoreCommandRouter::volumioStop
info: CoreStateMachine::stop
info: CoreStateMachine::setConsumeUpdateService undefined

info: CoreCommandRouter::volumioStop
info: CoreStateMachine::stop
info: CoreStateMachine::setConsumeUpdateService undefined

info: CoreCommandRouter::volumioReplaceandPlayItems
info: CoreStateMachine::ClearQueue
info: CoreStateMachine::stop
info: CoreStateMachine::setConsumeUpdateService undefined

info: CorePlayQueue::clearPlayQueue
info: CorePlayQueue::saveQueue
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::volumioPushQueue
info: CoreStateMachine::addQueueItems
info: CorePlayQueue::addQueueItems
info: Adding Item to queue: tidal://song/346464
info: Exploding uri tidal://song/346464 in service tidal
info: Adding Item to queue: tidal://song/34450428
info: Exploding uri tidal://song/34450428 in service tidal
info: Adding Item to queue: tidal://song/2061296
info: Exploding uri tidal://song/2061296 in service tidal
info: Adding Item to queue: tidal://song/1298020
info: Exploding uri tidal://song/1298020 in service tidal
info: Adding Item to queue: tidal://song/77686407
info: Exploding uri tidal://song/77686407 in service tidal
info: Adding Item to queue: tidal://song/36443913
info: Exploding uri tidal://song/36443913 in service tidal
info: Adding Item to queue: tidal://song/1984691
info: Exploding uri tidal://song/1984691 in service tidal
info: Adding Item to queue: tidal://song/82697544
info: Exploding uri tidal://song/82697544 in service tidal
info: Adding Item to queue: tidal://song/4077453
info: Exploding uri tidal://song/4077453 in service tidal
info: Adding Item to queue: tidal://song/159971225
info: Exploding uri tidal://song/159971225 in service tidal
info: Adding Item to queue: tidal://song/79133529
info: Exploding uri tidal://song/79133529 in service tidal
info: Adding Item to queue: tidal://song/1298016
info: Exploding uri tidal://song/1298016 in service tidal
info: Adding Item to queue: tidal://song/274080
info: Exploding uri tidal://song/274080 in service tidal
info: Adding Item to queue: tidal://song/35665493
info: Exploding uri tidal://song/35665493 in service tidal
info: Adding Item to queue: tidal://song/346470
info: Exploding uri tidal://song/346470 in service tidal
info: Adding Item to queue: tidal://song/35980458
info: Exploding uri tidal://song/35980458 in service tidal
info: Adding Item to queue: tidal://song/26798607
info: Exploding uri tidal://song/26798607 in service tidal
info: Adding Item to queue: tidal://song/14306374
info: Exploding uri tidal://song/14306374 in service tidal
info: Adding Item to queue: tidal://song/4077541
info: Exploding uri tidal://song/4077541 in service tidal
info: Adding Item to queue: tidal://song/77676941
info: Exploding uri tidal://song/77676941 in service tidal
info: Adding Item to queue: tidal://song/145945698
info: Exploding uri tidal://song/145945698 in service tidal
info: Adding Item to queue: tidal://song/68650848
info: Exploding uri tidal://song/68650848 in service tidal
info: Adding Item to queue: tidal://song/71102680
info: Exploding uri tidal://song/71102680 in service tidal
info: Adding Item to queue: tidal://song/35665487
info: Exploding uri tidal://song/35665487 in service tidal
info: Adding Item to queue: tidal://song/14518156
info: Exploding uri tidal://song/14518156 in service tidal
info: Adding Item to queue: tidal://song/1289214
info: Exploding uri tidal://song/1289214 in service tidal
info: Adding Item to queue: tidal://song/14219098
info: Exploding uri tidal://song/14219098 in service tidal
info: Adding Item to queue: tidal://song/1894837
info: Exploding uri tidal://song/1894837 in service tidal
info: Adding Item to queue: tidal://song/83867540
info: Exploding uri tidal://song/83867540 in service tidal
info: Adding Item to queue: tidal://song/49654058
info: Exploding uri tidal://song/49654058 in service tidal
info: Adding Item to queue: tidal://song/22188006
info: Exploding uri tidal://song/22188006 in service tidal
info: Adding Item to queue: tidal://song/19129810
info: Exploding uri tidal://song/19129810 in service tidal
info: Adding Item to queue: tidal://song/93614143
info: Exploding uri tidal://song/93614143 in service tidal
info: Adding Item to queue: tidal://song/4073874
info: Exploding uri tidal://song/4073874 in service tidal
info: Adding Item to queue: tidal://song/86810973
info: Exploding uri tidal://song/86810973 in service tidal
info: Adding Item to queue: tidal://song/120565780
info: Exploding uri tidal://song/120565780 in service tidal
info: Adding Item to queue: tidal://song/49654059
info: Exploding uri tidal://song/49654059 in service tidal
info: Adding Item to queue: tidal://song/116620798
info: Exploding uri tidal://song/116620798 in service tidal
info: Adding Item to queue: tidal://song/201688139
info: Exploding uri tidal://song/201688139 in service tidal
info: Adding Item to queue: tidal://song/119420533
info: Exploding uri tidal://song/119420533 in service tidal
info: explodeTIDALUri took 717 milliseconds
info: explodeTIDALUri took 723 milliseconds
info: explodeTIDALUri took 735 milliseconds
info: explodeTIDALUri took 746 milliseconds
info: explodeTIDALUri took 754 milliseconds
info: explodeTIDALUri took 767 milliseconds
info: explodeTIDALUri took 769 milliseconds
info: explodeTIDALUri took 784 milliseconds
info: explodeTIDALUri took 779 milliseconds
info: explodeTIDALUri took 786 milliseconds
info: explodeTIDALUri took 787 milliseconds
info: explodeTIDALUri took 786 milliseconds
info: explodeTIDALUri took 798 milliseconds
info: explodeTIDALUri took 810 milliseconds
info: explodeTIDALUri took 802 milliseconds
info: explodeTIDALUri took 804 milliseconds
info: explodeTIDALUri took 806 milliseconds
info: explodeTIDALUri took 816 milliseconds
info: explodeTIDALUri took 814 milliseconds
info: explodeTIDALUri took 837 milliseconds
info: explodeTIDALUri took 838 milliseconds
info: explodeTIDALUri took 843 milliseconds
info: explodeTIDALUri took 860 milliseconds
info: explodeTIDALUri took 853 milliseconds
info: explodeTIDALUri took 857 milliseconds
info: explodeTIDALUri took 856 milliseconds
info: explodeTIDALUri took 859 milliseconds
info: explodeTIDALUri took 870 milliseconds
info: explodeTIDALUri took 869 milliseconds
info: explodeTIDALUri took 866 milliseconds
info: explodeTIDALUri took 871 milliseconds
info: explodeTIDALUri took 867 milliseconds
info: explodeTIDALUri took 870 milliseconds
info: explodeTIDALUri took 872 milliseconds
info: explodeTIDALUri took 876 milliseconds
info: explodeTIDALUri took 884 milliseconds
info: explodeTIDALUri took 888 milliseconds
info: explodeTIDALUri took 888 milliseconds
info: explodeTIDALUri took 925 milliseconds
info: explodeTIDALUri took 936 milliseconds
info: CorePlayQueue::saveQueue
info: CoreCommandRouter::volumioPushQueue
info: CoreStateMachine::updateTrackBlock
info: CorePlayQueue::getTrackBlock
info: CoreCommandRouter::volumioPlay

info: CoreStateMachine::play index 2
info: CoreStateMachine::setConsumeUpdateService undefined
info: CoreStateMachine::stop
info: CoreStateMachine::setConsumeUpdateService undefined

info: CoreStateMachine::play index undefined
info: CoreStateMachine::setConsumeUpdateService undefined
info: CorePlayQueue::getTrack 2
info: CoreStateMachine::startPlaybackTimer
info: CorePlayQueue::getTrack 2
info: [1641612978844] ControllerTidal::clearAddPlayTrack
info: Getting stream with soundQuality HI_RES
info: getStreamUrl took 636 milliseconds

info: sendMpdCommand stop took 1 milliseconds

info:
---------------------------- MPD announces system playlist update
info: Ignoring MPD Status Update
info: sendMpdCommand clear took 4 milliseconds

error: updateQueue error: null
info:
---------------------------- MPD announces system playlist update
info: Ignoring MPD Status Update
info: ------------------------------ 4ms
info: sendMpdCommand add "http://sp-pr-cf.audio.tidal.com/mediatracks/CAEaKRInM2M4N2RhMzI4YmFmNWZjY2NkYmE3ZTAwNTFjMmFjYzdfNjAubXA0/0.flac?Expires=1641616579&Signature=asmDH8UaW-cexSMiEYVMhzjNonUQ-7TyL1EBeRJam6trU05EKodLwYlRmTcojcK3a0XkfXmlrIvtamNk2y~9OEvAUZUzcVG-qOqWo4FX-PtEzobJYK2Dgqbk2zd2rClA4-UiseVh67pv1TUshzjph97i34on8tl1fVw~TObKFd6W4Z7A5xal~IxxzBxSRZFhVzD9ar6IV0JFGGiiZzNXXfqvg7XXw-k5O82MpMlPu~vsTFEbGVVR2CELodBdkugTzdPfFbry0E5acBj4SLQ87B~Xrj8v6TIYvgdCRt46IByY9QUQ2iSBsa13kAu0zLKXY3a3Aa21ZyC7hhQvptfn9w__&Key-Pair-Id=APKAIZ3WPBE4R6SP555A" took 2 milliseconds
info: CoreStateMachine::setConsumeUpdateService mpd

info: ------------------------------ 2ms
info: sendMpdCommand play took 1 milliseconds
info:
---------------------------- MPD announces state update: player
info: ControllerMpd::getState

info:
---------------------------- MPD announces state update: player
info: sendMpdCommand status took 8 milliseconds
info: ControllerMpd::getState



info: sendMpdCommand status took 2 milliseconds
info: sendMpdCommand playlistinfo took 1 milliseconds



info: ControllerMpd::pushState
info: CoreCommandRouter::servicePushState
info: CorePlayQueue::getTrack 2


info: CoreStateMachine::syncState   stateService play
info: CoreStateMachine::syncState   currentStatus stop
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: ------------------------------ 24ms
info: sendMpdCommand playlistinfo took 12 milliseconds

info: ControllerMpd::pushState
info: CoreCommandRouter::servicePushState
info: CorePlayQueue::getTrack 2


info: CoreStateMachine::syncState   stateService play
info: CoreStateMachine::syncState   currentStatus play
info: Received an update from plugin. extracting info from payload
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: ------------------------------ 35ms

Dynodenny · January 8, 2022, 3:39am

And a log file where playback stopped:
http://logs.volumio.org/volumio/K1MDOwV.html

Piotr_Bagniewski · June 21, 2022, 12:53am

Hi, did you resolve this, I seem to have similar problem. In Tidal app it never stops, but in Volumio after 2nd song it will stop in the middle of the 3rd song (usually), I then have to skip it and next one will play just fine until it stops again later.

biker972 · January 24, 2023, 6:02pm

I have the same issue, Tidal connect (from Tidal app) randomly stops to play.
Log link http://logs.volumio.org/volumio/vdYUDRZ.html
I have to click on another song, or to close the app, or sometimes to dance in front of the my Pi device to start to play again This is very annoying, and it starts to happen 3-4 months ago. It doesn’t matter if I use Android or Apple device.

Definitely the problem is with Tidal connect, if I play tidal playlist directly from volumio app it plays without stops… Volumio team, please help here, I’m a premium user and guess that issue is on your side!!!