Tidal Connect crashes very often, Pi 3 b+

[BigManz]

Figured since I was playing around with pcaps that I would take a look on the raspberry pi itself and see what mDNS traffic is flowing out of the box. So when any client opens spotify you’ll see the mdns traffic flowing from the volumio raspberry pi. However with tidal connect its only when the service starts does it do any sort of broadcasting. Aside from that you’ll never see it again. This points to the problem being on the volumio side and not the network. Since I can see traffic from the one service over mdns and not from the other. I can even see my chromecasts hitting my pi

19:46:56.488289 IP asgard.mydomainremoved.mdns > 224.0.0.251.mdns: 0*- [0q] 5/0/0 PTR _tidalconnect._tcp.local., PTR Volumio-c27afdfa9e827e4d2973ad2e5f2dfd96._tidalconnect._tcp.local., (Cache flush) SRV asgard.local.:2019 0 0, (Cache flush) A 192.168.1.92, (Cache flush) TXT "mn=Volumio" "ca=1" "id=c27afdfa9e827e4d2973ad2e5f2dfd96" "fn=asgard" "ve=1" (250)
19:47:50.312738 IP asgard.mydomainremoved.mdns > 224.0.0.251.mdns: 0 [2n] ANY (QM)? Volumio-c27afdfa9e827e4d2973ad2e5f2dfd96._tidalconnect._tcp.local. (189)
19:47:50.563486 IP asgard.mydomainremoved.mdns > 224.0.0.251.mdns: 0 [2n] ANY (QM)? Volumio-c27afdfa9e827e4d2973ad2e5f2dfd96._tidalconnect._tcp.local. (189)
19:47:50.814237 IP asgard.mydomainremoved.mdns > 224.0.0.251.mdns: 0 [2n] ANY (QM)? Volumio-c27afdfa9e827e4d2973ad2e5f2dfd96._tidalconnect._tcp.local. (189)
19:47:51.015178 IP asgard.mydomainremoved.mdns > 224.0.0.251.mdns: 0*- [0q] 5/0/0 (Cache flush) TXT "mn=Volumio" "ca=1" "id=c27afdfa9e827e4d2973ad2e5f2dfd96" "fn=asgard" "ve=1", PTR Volumio-c27afdfa9e827e4d2973ad2e5f2dfd96._tidalconnect._tcp.local., (Cache flush) SRV asgard.local.:2019 0 0, (Cache flush) A 192.168.1.92, PTR _tidalconnect._tcp.local. (250)
19:47:52.177357 IP asgard.mydomainremoved.mdns > 224.0.0.251.mdns: 0*- [0q] 5/0/0 (Cache flush) TXT "mn=Volumio" "ca=1" "id=c27afdfa9e827e4d2973ad2e5f2dfd96" "fn=asgard" "ve=1", PTR Volumio-c27afdfa9e827e4d2973ad2e5f2dfd96._tidalconnect._tcp.local., (Cache flush) SRV asgard.local.:2019 0 0, (Cache flush) A 192.168.1.92, PTR _tidalconnect._tcp.local. (250)
19:47:54.341147 IP asgard.mydomainremoved.mdns > 224.0.0.251.mdns: 0*- [0q] 5/0/0 (Cache flush) TXT "mn=Volumio" "ca=1" "id=c27afdfa9e827e4d2973ad2e5f2dfd96" "fn=asgard" "ve=1", PTR Volumio-c27afdfa9e827e4d2973ad2e5f2dfd96._tidalconnect._tcp.local., (Cache flush) SRV asgard.local.:2019 0 0, (Cache flush) A 192.168.1.92, PTR _tidalconnect._tcp.local. (250)

Compared to me opening Spotify, and you’ll see the Spotify Connect client letting everyone know its there.

> 19:53:38.936442 IP asgard.mydomainremoved.mdns > 224.0.0.251.mdns: 0*- [0q] 1/0/0 (Cache flush) A 192.168.1.92 (40)
> 19:53:40.936422 IP asgard.mydomainremoved.mdns > 224.0.0.251.mdns: 0*- [0q] 4/0/0 PTR asgard._spotify-connect._tcp.local., SRV asgard.local.:41657 0 0, TXT "VERSION=1.0" "CPath=/", A 192.168.1.92 (247)
> 19:53:40.936796 IP asgard.mydomainremoved.mdns > 224.0.0.251.mdns: 0*- [0q] 1/0/0 (Cache flush) A 192.168.1.92 (40)
> 19:53:42.936217 IP asgard.mydomainremoved.mdns > 224.0.0.251.mdns: 0*- [0q] 4/0/0 PTR asgard._spotify-connect._tcp.local., SRV asgard.local.:41657 0 0, TXT "VERSION=1.0" "CPath=/", A 192.168.1.92 (247)
> 19:53:42.936472 IP asgard.mydomainremoved.mdns > 224.0.0.251.mdns: 0*- [0q] 1/0/0 (Cache flush) A 192.168.1.92 (40)
> 19:53:44.935423 IP asgard.mydomainremoved.mdns > 224.0.0.251.mdns: 0*- [0q] 4/0/0 PTR asgard._spotify-connect._tcp.local., SRV asgard.local.:41657 0 0, TXT "VERSION=1.0" "CPath=/", A 192.168.1.92 (247)
> 19:53:44.935698 IP asgard.mydomainremoved.mdns > 224.0.0.251.mdns: 0*- [0q] 1/0/0 (Cache flush) A 192.168.1.92 (40)
> 19:53:46.937083 IP asgard.mydomainremoved.mdns > 224.0.0.251.mdns: 0*- [0q] 4/0/0 PTR asgard._spotify-connect._tcp.local., SRV asgard.local.:41657 0 0, TXT "VERSION=1.0" "CPath=/", A 192.168.1.92 (247)
> 19:53:46.937341 IP asgard.mydomainremoved.mdns > 224.0.0.251.mdns: 0*- [0q] 1/0/0 (Cache flush) A 192.168.1.92 (40)
> 19:53:48.950827 IP asgard.mydomainremoved.mdns > 224.0.0.251.mdns: 0*- [0q] 4/0/0 PTR asgard._spotify-connect._tcp.local., SRV asgard.local.:41657 0 0, TXT "VERSION=1.0" "CPath=/", A 192.168.1.92 (247)
> 19:53:48.951140 IP asgard.mydomainremoved.mdns > 224.0.0.251.mdns: 0*- [0q] 1/0/0 (Cache flush) A 192.168.1.92 (40)

Hope some of this helps…

[raitech]

Just to cite another two threads about this, or at least related:

Tidal Connect playback is erratic

I am evaluating Tidal Connect on my RPI3 with Allo Digi. Problem: Playback randomly stops and I have to hit either Previous or Next on Tidal App to get it going again. When playback stops, Tidal app spins the play button and Volumio app seems to lose contact with the device. Here’s a live log: http://logs.volumio.org/volumio/Y8D5ZJp.html I note a number of asio errors. I’m assuming the Primo Player is running identical Volumio, is this so?

Skips and Stalls with Tidal Connect

Volumio Information Volumio Version: 2.915 Hardware: RPi 3+ DAC: Allo Boss 1.2 I get skips (few seconds) and eventually stalls (spinning circle around play/pause button). This can happen once a night, or every other song. The stalls happen during the “flac decoder error” messages. Live Log Clear Copy Starting Live Log... info: CALLMETHOD: system_controller system enableLiveLog true info: CoreCommandRouter::executeOnPlugin: system , enableLiveLog info: Launching a new LiveLog session proce…

I’m on Volumio Premium trial just to listen Tidal Connect HiFi.

When I switch to “normal” quality on Tidal app, it plays joyfully. When a turn it to HiFi, it just stops. Volumio web interface says it’s playing, but Tidal app (on my Android phone or iPad, doesn’t matter) stalls - it doesn’t move the progress bar or hangs with a moving circle around play button.

Here is an excerpt my Live log from Volumio 3.175.

Starting Live Log...

info: CoreCommandRouter::volumioGetState
info: CorePlayQueue::getTrack 0
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::volumioGetState
info: CorePlayQueue::getTrack 0
info: CoreCommandRouter::volumioGetState
info: CorePlayQueue::getTrack 0
info: Currently active: mpd
info: Stopping currently active service
info: CoreCommandRouter::volumioStop
info: CoreStateMachine::stop
info: CoreStateMachine::setConsumeUpdateService undefined

info: TidalConnect Active
info: CoreCommandRouter::volumioGetState
info: CorePlayQueue::getTrack 0
info: Currently active: mpd
info: Setting Volatile state to tidalconnect
info: CoreStateMachine::setConsumeUpdateService undefined
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
[2021-12-26 16:35:43.316] [tisoc] [warning] [PlaybackControllerImpl.cpp:472] Illegal state:1
info: Pushing metadata
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
Under-voltage detected! (0x00050005)
info: Pushing metadata
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
[2021-12-26 16:35:44.109] [tisoc] [warning] [logger.cpp:22] [audio_worker.cpp:326] Attempting to initialize a decoder without initial data!
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
VTCS: PCM: volumioMultiRoomServer RATE: 44100 FORMAT: S16_LE CHANNELS: 2 PERIODSIZE: 4096 BUFFERSIZE: 32768
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: Executing endpoint metavolumio
info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
info: Executing endpoint metavolumio
info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
info: Executing endpoint metavolumio
info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Voltage normalised (0x00000000)
Connection to us1.myvolumio.org closed by remote host.
ssh exited with error status 255; restarting ssh
starting ssh (count 7)
ssh child pid is 15033
ssh: connect to host us1.myvolumio.org port 2222: Connection refused
ssh exited with error status 255; restarting ssh
starting ssh (count 8)
ssh child pid is 15034
ssh: connect to host us1.myvolumio.org port 2222: Connection refused
ssh exited with error status 255; restarting ssh
starting ssh (count 9)
ssh child pid is 15035
Warning: Permanently added '[us1.myvolumio.org]:2222,[162.243.167.188]:2222' (RSA) to the list of known hosts.
info: CALLMETHOD: system_controller system enableSSH true
info: CoreCommandRouter::executeOnPlugin: system , enableSSH
 volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start ssh.service
pam_unix(sudo:session): session opened for user root by (uid=0)
Starting OpenBSD Secure Shell server...
------------------------------------ BT MESSAGE: BT STATUS: running
BT PLUGIN MESSAGE: Playing: false
BT PLUGIN MESSAGE: VOLATILE: tidalconnect
BT PLUGIN MESSAGE: STATE:undefined
Server listening on 0.0.0.0 port 22.
Server listening on :: port 22.
Started OpenBSD Secure Shell server.
pam_unix(sudo:session): session closed for user root
 volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl enable ssh.service
pam_unix(sudo:session): session opened for user root by (uid=0)
Reloading.
/lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly.
getty@tty1.service: Current command vanished from the unit file, execution of the command list won't be resumed.
Starting Daily apt download activities...
------------------------------------ BT MESSAGE: BT STATUS: running
BT PLUGIN MESSAGE: Playing: false
BT PLUGIN MESSAGE: VOLATILE: tidalconnect
BT PLUGIN MESSAGE: STATE:undefined
Reloading.
Under-voltage detected! (0x00050005)
/lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly.
apt-daily.service: Succeeded.
Started Daily apt download activities.
Reloading.
/lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly.
pam_unix(sudo:session): session closed for user root
info: enable SSH service success
Voltage normalised (0x00000000)
Accepted password for volumio from XXX.YYY.ZZZ.177 port 58752 ssh2
pam_unix(sshd:session): session opened for user volumio by (uid=0)
Created slice User Slice of UID 1000.
Starting User Runtime Directory /run/user/1000...
------------------------------------ BT MESSAGE: BT STATUS: running
BT PLUGIN MESSAGE: Playing: false
BT PLUGIN MESSAGE: VOLATILE: tidalconnect
BT PLUGIN MESSAGE: STATE:undefined
New session 1 of user volumio.
------------------------------------ BT MESSAGE: BT STATUS: running
BT PLUGIN MESSAGE: Playing: false
BT PLUGIN MESSAGE: VOLATILE: tidalconnect
BT PLUGIN MESSAGE: STATE:undefined
------------------------------------ BT MESSAGE: BT STATUS: waiting
BT PLUGIN MESSAGE: Playing: false
BT PLUGIN MESSAGE: VOLATILE: tidalconnect
BT PLUGIN MESSAGE: STATE:undefined
Started User Runtime Directory /run/user/1000.
Starting User Manager for UID 1000...
------------------------------------ BT MESSAGE: BT STATUS: running
BT PLUGIN MESSAGE: Playing: false
BT PLUGIN MESSAGE: VOLATILE: tidalconnect
BT PLUGIN MESSAGE: STATE:undefined
pam_unix(systemd-user:session): session opened for user volumio by (uid=0)
Listening on GnuPG cryptographic agent and passphrase cache (restricted).
Listening on GnuPG network certificate management daemon.
Listening on GnuPG cryptographic agent and passphrase cache.
Reached target Paths.
Listening on GnuPG cryptographic agent (ssh-agent emulation).
mpd.socket: Failed to create listening socket ([::]:6600): Address already in use
mpd.socket: Failed to listen on sockets: Address already in use
mpd.socket: Failed with result 'resources'.
Failed to listen on mpd.socket.
Listening on Sound System.
Starting D-Bus User Message Bus Socket.
Reached target Timers.
Listening on GnuPG cryptographic agent and passphrase cache (access for web browsers).
Listening on D-Bus User Message Bus Socket.
Reached target Sockets.
Reached target Basic System.
Started User Manager for UID 1000.
Starting Music Player Daemon...
Started Session 1 of user volumio.
Dec 26 16:38 : exception: Failed to bind to '[::]:6600'
Dec 26 16:38 : exception: nested: Failed to bind socket: Address already in use
mpd.service: Main process exited, code=exited, status=1/FAILURE
mpd.service: Failed with result 'exit-code'.
Failed to start Music Player Daemon.
Reached target Default.
Startup finished in 1.163s.
 volumio : TTY=pts/0 ; PWD=/home/volumio ; USER=root ; COMMAND=/bin/su -
pam_unix(sudo:session): session opened for user root by volumio(uid=0)
(to root) volumio on pts/0
pam_unix(su-l:session): session opened for user root by volumio(uid=0)
[2021-12-26 16:38:55.176] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed:  Stream error in the HTTP/2 framing layer  -  HTTP/2 stream 0 was not closed cleanly: INTERNAL_ERROR (err 2)
[2021-12-26 16:38:55.176] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
[2021-12-26 16:38:55.409] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed:  Stream error in the HTTP/2 framing layer  -  HTTP/2 stream 0 was not closed cleanly: INTERNAL_ERROR (err 2)
[2021-12-26 16:38:55.409] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
[2021-12-26 16:38:55.624] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed:  Stream error in the HTTP/2 framing layer  -  HTTP/2 stream 0 was not closed cleanly: INTERNAL_ERROR (err 2)
[2021-12-26 16:38:55.625] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
[2021-12-26 16:38:55.627] [tisoc] [warning] [logger.cpp:22] [audio_worker.cpp:293] Max connection attempts reached!
Under-voltage detected! (0x00050005)
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: Pushing metadata
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: Unknown command: notifyPlaybackError
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
Voltage normalised (0x00000000)
[2021-12-26 16:40:42] [info] asio async_shutdown error: asio.misc:2 (End of file)
[2021-12-26 16:40:43.106] [tisoc] [warning] [PlaybackControllerImpl.cpp:859] Not send NotifyMediaChanged(media_info is null)
[2021-12-26 16:41:23] [info] asio async_shutdown error: asio.misc:2 (End of file)
[2021-12-26 16:41:23.145] [tisoc] [warning] [PlaybackControllerImpl.cpp:859] Not send NotifyMediaChanged(media_info is null)
[2021-12-26 16:42:02] [info] asio async_shutdown error: asio.misc:2 (End of file)
[2021-12-26 16:42:03.011] [tisoc] [warning] [PlaybackControllerImpl.cpp:859] Not send NotifyMediaChanged(media_info is null)
info: Pushing metadata
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: Pushing metadata
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
Under-voltage detected! (0x00050005)
[2021-12-26 16:42:16.870] [tisoc] [warning] [logger.cpp:22] [audio_worker.cpp:326] Attempting to initialize a decoder without initial data!
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
VTCS: PCM: volumioMultiRoomServer RATE: 44100 FORMAT: S16_LE CHANNELS: 2 PERIODSIZE: 4096 BUFFERSIZE: 32768
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: Pushing metadata
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: Pushing metadata
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
[2021-12-26 16:42:19.649] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed:  Stream error in the HTTP/2 framing layer  -  HTTP/2 stream 0 was not closed cleanly: INTERNAL_ERROR (err 2)
[2021-12-26 16:42:19.649] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
[2021-12-26 16:42:20.010] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed:  Stream error in the HTTP/2 framing layer  -  HTTP/2 stream 0 was not closed cleanly: INTERNAL_ERROR (err 2)
[2021-12-26 16:42:20.011] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
[2021-12-26 16:42:20.246] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed:  Stream error in the HTTP/2 framing layer  -  HTTP/2 stream 0 was not closed cleanly: INTERNAL_ERROR (err 2)
[2021-12-26 16:42:20.247] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
[2021-12-26 16:42:20.247] [tisoc] [warning] [logger.cpp:22] [audio_worker.cpp:293] Max connection attempts reached!
info: Unknown command: notifyPlaybackError
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
Voltage normalised (0x00000000)
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
pam_unix(su-l:session): session closed for user root
pam_unix(sudo:session): session closed for user root
Received disconnect from XXX.YYY.ZZZ.177 port 58752:11: disconnected by user
Disconnected from user volumio XXX.YYY.ZZZ.177 port 58752
pam_unix(sshd:session): session closed for user volumio
Session 1 logged out. Waiting for processes to exit.
session-1.scope: Succeeded.
Removed session 1.
Stopping User Manager for UID 1000...
Stopped target Default.
Stopped target Basic System.
Stopped target Paths.
Stopped target Timers.
Stopped target Sockets.
gpg-agent-browser.socket: Succeeded.
Closed GnuPG cryptographic agent and passphrase cache (access for web browsers).
gpg-agent-extra.socket: Succeeded.
Closed GnuPG cryptographic agent and passphrase cache (restricted).
gpg-agent-ssh.socket: Succeeded.
Closed GnuPG cryptographic agent (ssh-agent emulation).
dirmngr.socket: Succeeded.
Closed GnuPG network certificate management daemon.
pulseaudio.socket: Succeeded.
Closed Sound System.
dbus.socket: Succeeded.
Closed D-Bus User Message Bus Socket.
------------------------------------ BT MESSAGE: BT STATUS: running
gpg-agent.socket: Succeeded.
BT PLUGIN MESSAGE: Playing: false
BT PLUGIN MESSAGE: VOLATILE: tidalconnect
BT PLUGIN MESSAGE: STATE:undefined
Closed GnuPG cryptographic agent and passphrase cache.
Reached target Shutdown.
systemd-exit.service: Succeeded.
Started Exit the Session.
Reached target Exit the Session.
pam_unix(systemd-user:session): session closed for user volumio
user@1000.service: Succeeded.
Stopped User Manager for UID 1000.
Stopping User Runtime Directory /run/user/1000...
------------------------------------ BT MESSAGE: BT STATUS: running
BT PLUGIN MESSAGE: Playing: false
BT PLUGIN MESSAGE: VOLATILE: tidalconnect
BT PLUGIN MESSAGE: STATE:undefined
run-user-1000.mount: Succeeded.
user-runtime-dir@1000.service: Succeeded.
Stopped User Runtime Directory /run/user/1000.
Removed slice User Slice of UID 1000.
[2021-12-26 16:43:37] [info] asio async_shutdown error: asio.misc:2 (End of file)
[2021-12-26 16:43:37.778] [tisoc] [warning] [PlaybackControllerImpl.cpp:859] Not send NotifyMediaChanged(media_info is null)
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: Pushing metadata
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: Pushing metadata
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
[2021-12-26 16:43:53.368] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed:  Stream error in the HTTP/2 framing layer  -  HTTP/2 stream 0 was not closed cleanly: INTERNAL_ERROR (err 2)
[2021-12-26 16:43:53.369] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
[2021-12-26 16:43:53.578] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed:  Stream error in the HTTP/2 framing layer  -  HTTP/2 stream 0 was not closed cleanly: INTERNAL_ERROR (err 2)
[2021-12-26 16:43:53.579] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: Pushing metadata
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
[2021-12-26 16:43:53.811] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed:  Stream error in the HTTP/2 framing layer  -  HTTP/2 stream 0 was not closed cleanly: INTERNAL_ERROR (err 2)
[2021-12-26 16:43:53.812] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: Pushing metadata
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: Pushing metadata
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: Pushing metadata
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
[2021-12-26 16:43:54.310] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed:  Stream error in the HTTP/2 framing layer  -  HTTP/2 stream 0 was not closed cleanly: INTERNAL_ERROR (err 2)
[2021-12-26 16:43:54.311] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: Pushing metadata
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
rpi_firmware_get_throttled: 1 callbacks suppressed
Under-voltage detected! (0x00050005)
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: Pushing metadata
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: Pushing metadata
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
[2021-12-26 16:43:55.308] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed:  Stream error in the HTTP/2 framing layer  -  HTTP/2 stream 0 was not closed cleanly: INTERNAL_ERROR (err 2)
[2021-12-26 16:43:55.310] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
[2021-12-26 16:43:55.600] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed:  Stream error in the HTTP/2 framing layer  -  HTTP/2 stream 0 was not closed cleanly: INTERNAL_ERROR (err 2)
[2021-12-26 16:43:55.601] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
[2021-12-26 16:43:55.878] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed:  Stream error in the HTTP/2 framing layer  -  HTTP/2 stream 0 was not closed cleanly: INTERNAL_ERROR (err 2)
[2021-12-26 16:43:55.880] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
[2021-12-26 16:43:55.883] [tisoc] [warning] [logger.cpp:22] [audio_worker.cpp:293] Max connection attempts reached!
info: Unknown command: notifyPlaybackError
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: Pushing metadata
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: Pushing metadata
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
VTCS: PCM: volumioMultiRoomServer RATE: 44100 FORMAT: S16_LE CHANNELS: 2 PERIODSIZE: 4096 BUFFERSIZE: 32768
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
rpi_firmware_get_throttled: 1 callbacks suppressed
Voltage normalised (0x00000000)
Under-voltage detected! (0x00050005)
Voltage normalised (0x00000000)
Under-voltage detected! (0x00050005)
Voltage normalised (0x00000000)
[2021-12-26 16:47:11.989] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed:  Stream error in the HTTP/2 framing layer  -  HTTP/2 stream 0 was not closed cleanly: INTERNAL_ERROR (err 2)
[2021-12-26 16:47:11.990] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
[2021-12-26 16:47:12.589] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed:  Stream error in the HTTP/2 framing layer  -  HTTP/2 stream 0 was not closed cleanly: INTERNAL_ERROR (err 2)
[2021-12-26 16:47:12.590] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
[2021-12-26 16:47:13.376] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed:  Stream error in the HTTP/2 framing layer  -  HTTP/2 stream 0 was not closed cleanly: INTERNAL_ERROR (err 2)
[2021-12-26 16:47:13.379] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
[2021-12-26 16:47:13.379] [tisoc] [warning] [logger.cpp:22] [audio_worker.cpp:293] Max connection attempts reached!
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: Pushing metadata
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: Unknown command: notifyPlaybackError
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
[2021-12-26 16:48:42] [info] asio async_shutdown error: asio.misc:2 (End of file)
[2021-12-26 16:48:42.957] [tisoc] [warning] [PlaybackControllerImpl.cpp:859] Not send NotifyMediaChanged(media_info is null)
[2021-12-26 16:49:58] [info] asio async_shutdown error: asio.misc:2 (End of file)
[2021-12-26 16:49:58.924] [tisoc] [warning] [PlaybackControllerImpl.cpp:859] Not send NotifyMediaChanged(media_info is null)
[2021-12-26 16:50:37] [info] asio async_shutdown error: asio.misc:2 (End of file)
[2021-12-26 16:50:37.945] [tisoc] [warning] [PlaybackControllerImpl.cpp:859] Not send NotifyMediaChanged(media_info is null)
[2021-12-26 16:51:17] [info] asio async_shutdown error: asio.misc:2 (End of file)
[2021-12-26 16:51:17.978] [tisoc] [warning] [PlaybackControllerImpl.cpp:859] Not send NotifyMediaChanged(media_info is null)
[2021-12-26 16:53:51] [error] handle_read_frame error: asio.system:104 (Connection reset by peer)
[2021-12-26 16:53:51] [info] asio async_shutdown error: asio.system:32 (Broken pipe)
Under-voltage detected! (0x00050005)
Voltage normalised (0x00000000)
[2021-12-26 16:58:26.571] [tisoc] [warning] [PlaybackControllerImpl.cpp:859] Not send NotifyMediaChanged(media_info is null)
info: Pushing metadata
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: Pushing metadata
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
VTCS: PCM: volumioMultiRoomServer RATE: 44100 FORMAT: S16_LE CHANNELS: 2 PERIODSIZE: 4096 BUFFERSIZE: 32768
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
Under-voltage detected! (0x00050005)
Voltage normalised (0x00000000)
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: Pushing metadata
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: Pushing metadata
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
Under-voltage detected! (0x00050005)
[2021-12-26 16:59:18.302] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed:  Stream error in the HTTP/2 framing layer  -  HTTP/2 stream 0 was not closed cleanly: INTERNAL_ERROR (err 2)
[2021-12-26 16:59:18.304] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
[2021-12-26 16:59:19.342] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed:  Stream error in the HTTP/2 framing layer  -  HTTP/2 stream 0 was not closed cleanly: INTERNAL_ERROR (err 2)
[2021-12-26 16:59:19.344] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
[2021-12-26 16:59:20.396] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed:  Stream error in the HTTP/2 framing layer  -  HTTP/2 stream 0 was not closed cleanly: INTERNAL_ERROR (err 2)
[2021-12-26 16:59:20.397] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
[2021-12-26 16:59:20.402] [tisoc] [warning] [logger.cpp:22] [audio_worker.cpp:293] Max connection attempts reached!
...
[2021-12-26 17:10:34.184] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed:  Stream error in the HTTP/2 framing layer  -  HTTP/2 stream 0 was not closed cleanly: INTERNAL_ERROR (err 2)
[2021-12-26 17:10:34.186] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
[2021-12-26 17:10:34.194] [tisoc] [warning] [logger.cpp:22] [audio_worker.cpp:326] Attempting to initialize a decoder without initial data!
[2021-12-26 17:10:34.200] [tisoc] [warning] [logger.cpp:22] [audio_worker.cpp:326] Attempting to initialize a decoder without initial data!
[2021-12-26 17:10:34.205] [tisoc] [warning] [logger.cpp:22] [audio_worker.cpp:326] Attempting to initialize a decoder without initial data!
...
[2021-12-26 17:12:49.623] [tisoc] [warning] [logger.cpp:22] [audio_worker.cpp:326] Attempting to initialize a decoder without initial data!
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: Pushing metadata
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: Pushing metadata
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
[2021-12-26 17:12:50.265] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed:  Stream error in the HTTP/2 framing layer  -  HTTP/2 stream 0 was not closed cleanly: INTERNAL_ERROR (err 2)
[2021-12-26 17:12:50.269] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
[2021-12-26 17:12:50.586] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed:  Stream error in the HTTP/2 framing layer  -  HTTP/2 stream 0 was not closed cleanly: INTERNAL_ERROR (err 2)
[2021-12-26 17:12:50.588] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
[2021-12-26 17:12:50.915] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed:  Stream error in the HTTP/2 framing layer  -  HTTP/2 stream 0 was not closed cleanly: INTERNAL_ERROR (err 2)
[2021-12-26 17:12:50.916] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
[2021-12-26 17:12:50.917] [tisoc] [warning] [logger.cpp:22] [audio_worker.cpp:293] Max connection attempts reached!
info: Unknown command: notifyPlaybackError
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState
info: CoreCommandRouter::servicePushState
info: CoreStateMachine::pushState
info: CoreCommandRouter::volumioPushState

It’s running on a Raspberry Pi 3B+, over WiFi (tried with 2.4 and 5.8 GHz networks, same behavior). And it’s plugged into a Topping E30 DAC, via USB.

[raitech]

Well, the problem happens without the DAC (using the not that great sounding 3.5mm jack).

Tested with just cabled network connection, and the problem stills.

Normal and High quality plays nicely, HiFi does not.

[Jacob_Rodgers]

@raitech I am getting similar behavior with Tidal Connect, mainly the part where the Tidal app just shows a spinning circle and in the log I have the following output:

Dec 29 21:46:25 volumio vtcs[1024]: [2021-12-29 21:46:25.151] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed:  Stream error in the HTTP/2 framing layer  -  HTTP/2 stream 0 was not closed cleanly: INTERNAL_ERROR (err 2)
Dec 29 21:46:25 volumio vtcs[1024]: [2021-12-29 21:46:25.151] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
Dec 29 21:46:25 volumio vtcs[1024]: [2021-12-29 21:46:25.301] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed:  Stream error in the HTTP/2 framing layer  -  HTTP/2 stream 0 was not closed cleanly: INTERNAL_ERROR (err 2)
Dec 29 21:46:25 volumio vtcs[1024]: [2021-12-29 21:46:25.302] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
Dec 29 21:46:25 volumio vtcs[1024]: [2021-12-29 21:46:25.415] [tisoc] [error] [logger.cpp:25] [operation_curl.cpp:257] curl_easy_perform failed:  Stream error in the HTTP/2 framing layer  -  HTTP/2 stream 0 was not closed cleanly: INTERNAL_ERROR (err 2)
Dec 29 21:46:25 volumio vtcs[1024]: [2021-12-29 21:46:25.416] [tisoc] [error] [logger.cpp:25] [http_stream_fetcher.cpp:162] Content-Range is missing from response!
Dec 29 21:46:25 volumio vtcs[1024]: [2021-12-29 21:46:25.418] [tisoc] [warning] [logger.cpp:22] [audio_worker.cpp:293] Max connection attempts reached!
Dec 29 21:46:25 volumio volumio[674]: info: Unknown command: notifyPlaybackError

I see you have the same excerpt in your log.