search

owntone / owntone-server

Linux/FreeBSD DAAP (iTunes) and MPD audio server with support for AirPlay 1 and 2 speakers (multiroom), Apple Remote (and compatibles), Chromecast, Spotify and internet radio.
https://owntone.github.io/owntone-server
GNU General Public License v2.0
2.07k stars 237 forks source link

Owntone Server to Shairport-Sync (development branch) - intermittent audio #1537

Closed kevocl closed 1 year ago

kevocl commented 2 years ago

Hello,

When I try to play audio from Owntone to Shairport-Sync (Airplay 2 development branch), the audio plays for about 24 seconds and then cuts out for a couple of seconds, and this pattern repeats.

I know Owntone sees Shairport-Sync speakers as Airplay 1, and that's fine by me. I'm not sure if the issue lies with my Owntone setup or my Shairport one.

I used to have a working Forked-Daapd Docker image streaming flawlessly to Shairport-Sync (Airplay 2 development branch) but my HDD died, and I lost the configs. I've rebuilt the system and I'm having this problem.

I've tried using the linuxserver.io Daapd Docker image, and I've tried installing via apt (on a Raspberry Pi 3+) from the owntone repo. I've tried using the mikebrady Docker image for shairport, as well as building myself. With each combination of the latest builds, the issue persists.

Owntone Version 28.5, Compiled with support for ffmpeg, Spotify, librespot-c, LastFM, Chromecast, MPD, Websockets, ALSA, Pulseaudio, Webinterface, Regex.

Linux 5.15.61-v8+ #1579 SMP PREEMPT Fri Aug 26 11:16:44 BST 2022 aarch64 GNU/Linux Debian 11 bullseye

Owntone DEBUG log from when one of the dropouts happen

[2022-09-22 17:29:47] [DEBUG]     raop: send_progress: Sending SET_PARAMETER to 'Shairport-Sync'
[2022-09-22 17:29:47] [DEBUG]     dacp: DACP request: '/ctrl-int/1/getproperty?properties=dmcp.volume'
[2022-09-22 17:29:47] [DEBUG]   player: Player status: playing
[2022-09-22 17:29:47] [DEBUG]       db: Running query 'BEGIN TRANSACTION;'
[2022-09-22 17:29:47] [DEBUG]       db: Starting enum 'SELECT * FROM queue f WHERE id = 39 ORDER BY pos;'
[2022-09-22 17:29:47] [DEBUG]       db: Running query 'END TRANSACTION;'
[2022-09-22 17:29:47] [DEBUG]     dacp: DACP request: '/ctrl-int/1/getspeakers'
[2022-09-22 17:29:47] [DEBUG]     dacp: DACP request: '/ctrl-int/1/playstatusupdate?revision-number=40'
[2022-09-22 17:29:48] [DEBUG]     dacp: Update request: client closed connection
[2022-09-22 17:29:49] [DEBUG]     dacp: DACP request: '/ctrl-int/1/getproperty?properties=dmcp.volume'
[2022-09-22 17:29:49] [DEBUG]   player: Player status: playing
[2022-09-22 17:29:49] [DEBUG]       db: Running query 'BEGIN TRANSACTION;'
[2022-09-22 17:29:49] [DEBUG]       db: Starting enum 'SELECT * FROM queue f WHERE id = 39 ORDER BY pos;'
[2022-09-22 17:29:49] [DEBUG]       db: Running query 'END TRANSACTION;'
[2022-09-22 17:29:49] [DEBUG]     dacp: DACP request: '/ctrl-int/1/getspeakers'
[2022-09-22 17:29:49] [DEBUG]     dacp: DACP request: '/ctrl-int/1/playstatusupdate?revision-number=40'
[2022-09-22 17:29:49] [DEBUG]     dacp: Update request: client closed connection
[2022-09-22 17:29:50] [DEBUG]     dacp: DACP request: '/ctrl-int/1/getproperty?properties=dmcp.volume'
[2022-09-22 17:29:50] [DEBUG]   player: Player status: playing
[2022-09-22 17:29:50] [DEBUG]       db: Running query 'BEGIN TRANSACTION;'
[2022-09-22 17:29:50] [DEBUG]       db: Starting enum 'SELECT * FROM queue f WHERE id = 39 ORDER BY pos;'
[2022-09-22 17:29:50] [DEBUG]       db: Running query 'END TRANSACTION;'
[2022-09-22 17:29:50] [DEBUG]     dacp: DACP request: '/ctrl-int/1/getspeakers'
[2022-09-22 17:29:50] [DEBUG]     dacp: DACP request: '/ctrl-int/1/playstatusupdate?revision-number=40'
[2022-09-22 17:29:51] [DEBUG]     dacp: Update request: client closed connection

Shairport-Sync log from the same time (timestamps are an hour different UTC vs GMT)

2022-09-22T16:29:41.502394316Z          8.014096664 "player.c:2574"          0.22          -51.0          119.0         0        1          0             1            8222           254           257      44100.00           0.00         44097.41         44097.60               0.00               0
2022-09-22T16:29:47.400556337Z          5.898102654 "rtsp.c:1293" Connection 3: RTSP connection traffic has resumed.
2022-09-22T16:29:51.403483856Z          4.002673228 "rtsp.c:1281" Connection 3: RTSP connection is idle.
2022-09-22T16:29:51.543039176Z          0.140086718 "player.c:2574"          0.42           -8.5           65.1         0        1          0             1            8298           254           256      44100.00           0.00         43924.04         43924.43               0.00               0
ejurgensen commented 2 years ago

Let's keep the discussion to https://github.com/mikebrady/shairport-sync/issues/1540 since we need to understand why SPS is stopping. Owntone just sees a disconnect, it seems.