Streaming with pulseaudio-dlna doesn't work

I’ve tried to stream audio from Ubuntu to Volumio via pulseaudio-dlna. After starting pulseaudio.dlna, my Ubuntu discovered volumio as audio sink and I selected it. Volumio didn’t play any sound however.

I use Volumio 2.295. I haven’t found anything related in volumio.log. This is the output of pulseaudio-dlna:

10-16 21:44:05 pulseaudio_dlna.pulseaudio                     INFO     Added the device "Volumio (DLNA)".
10-16 21:44:31 pulseaudio_dlna.pulseaudio                     INFO     on_new_playback_stream "/org/pulseaudio/core1/playback_stream18"
10-16 21:44:32 pulseaudio_dlna.pulseaudio                     INFO     _async_handle_sink_update /org/pulseaudio/core1/sink4
10-16 21:44:32 pulseaudio_dlna.pulseaudio                     INFO     Instructing the device "Volumio (DLNA)" to play ...
10-16 21:44:34 pulseaudio_dlna.plugins.upnp.renderer          INFO     Device state is stopped. Sending play command.
10-16 21:44:34 pulseaudio_dlna.pulseaudio                     INFO     The device "Volumio (DLNA)" is playing.
10-16 21:44:34 pulseaudio_dlna.pulseaudio                     INFO     _async_handle_sink_update /org/pulseaudio/core1/sink4 finished!
10-16 21:44:34 pulseaudio_dlna.pulseaudio                     INFO     on_playback_stream_removed "/org/pulseaudio/core1/playback_stream18"
10-16 21:44:34 pulseaudio_dlna.streamserver                   INFO     URL settings: /dWRuPSJ1dWlkOjA0MjU1Y2I0LTExZjAtNThkYi0wMDUzLTc0ZGEzODMzZGQyYyIsdHlwZT0iYnJpZGdlIg%3D%3D/stream.mp3 (udn="uuid:04255cb4-11f0-58db-0053-74da3833dd2c",type="bridge")
10-16 21:44:34 pulseaudio_dlna.streamserver                   INFO     Registered stream "/dWRuPSJ1dWlkOjA0MjU1Y2I0LTExZjAtNThkYi0wMDUzLTc0ZGEzODMzZGQyYyIsdHlwZT0iYnJpZGdlIg%3D%3D/stream.mp3" (0x7f3600fdeb50) ...
10-16 21:44:34 pulseaudio_dlna.streamserver                   INFO     Starting processes "parec --format=s16le -d volumio_dlna.monitor | lame -b 192 -r -"
10-16 21:44:34 pulseaudio_dlna.streamserver                   INFO     Processes of /dWRuPSJ1dWlkOjA0MjU1Y2I0LTExZjAtNThkYi0wMDUzLTc0ZGEzODMzZGQyYyIsdHlwZT0iYnJpZGdlIg%3D%3D/stream.mp3 initialized ...
10-16 21:44:35 pulseaudio_dlna.pulseaudio                     INFO     _async_handle_sink_update /org/pulseaudio/core1/sink4
10-16 21:44:35 pulseaudio_dlna.pulseaudio                     INFO     Instructing the device "Volumio (DLNA)" to stop ...
10-16 21:44:35 pulseaudio_dlna.pulseaudio                     INFO     The device "Volumio (DLNA)" was stopped.
10-16 21:44:35 pulseaudio_dlna.pulseaudio                     INFO     _async_handle_sink_update /org/pulseaudio/core1/sink4 finished!
10-16 21:44:36 pulseaudio_dlna.streamserver                   INFO     Unregistered stream "/dWRuPSJ1dWlkOjA0MjU1Y2I0LTExZjAtNThkYi0wMDUzLTc0ZGEzODMzZGQyYyIsdHlwZT0iYnJpZGdlIg%3D%3D/stream.mp3" (0x7f3600fdeb50) ...
10-16 21:44:38 pulseaudio_dlna.streamserver                   INFO     No more stream from device "Volumio".
10-16 21:46:09 pulseaudio_dlna.pulseaudio                     INFO     on_new_playback_stream "/org/pulseaudio/core1/playback_stream19"

IMHO there is something wrong with how pulseaudio-dlna controls volumio. See:

10-16 21:44:35 pulseaudio_dlna.pulseaudio                     INFO     Instructing the device "Volumio (DLNA)" to stop 

It’s telling Volumio to stop… Don’t know why…

So you think pulseaudio-dlna tells volumio to stop before it had time to play the stream? I’ve noticed that the stop command is issued just 1 s after the play command. I’ll file a report for pulseaudio-dlna if you think that pulseaudio-dlna is at fault.

Here’s the debug log https://pastebin.com/DGQwrnJu