1.4 problem playing audio/L16 streams via UPnP/DLNA

asdfrewq · July 4, 2014, 11:56pm

Hello.

I’ve been attempting to stream to Volumio via the Jamcast Spotify plugin. This setup currently appears to be the best solution to getting Spotify on Volumio without sacrificing sound quality (ie. Mopidy).

While UPnP device discovery, searching, and push requests are working perfectly, MPD playback of the audio/L16 stream is failing. Sometimes it will refuse playback altogether, other times will result in whitenoise or heavily distorted squeals, but nothing resembling the music playing.

Is there any reason why MPD fails to render these streams, or anything that can be done in future releases to get it working?

Thankyou.

volumio · July 5, 2014, 12:24am

Try airfoil
https://www.rogueamoeba.com/airfoil/

It works really good and SQ is just fine, even for me lol

asdfrewq · July 5, 2014, 12:36am

Hi michelangelo! As I understand, Airfoil just sends the PC Audio output to the device, yeah? This isn’t really an option for me as I don’t have an Audio device enabled on my server nor I don’t really want have the full spotify software running on that system.

The Jamcast solution, using the spotify plugin, is ideal since it acts as a full DLNA server for spotify without requiring the spotify software or additional software.

Anyway, if we can’t get audio/L16 to stream, I’ll definitely look at accommodating Airfoil into my setup.

volumio · July 5, 2014, 12:51am

Ok, gotcha. Could you please explain what L16 means? We can however investigate and understand whats going wrong via mpd log, so you can enable mpd logging and paste it here. If you don’t know how to do it, let me know and I’ll guide you trough it

asdfrewq · July 5, 2014, 1:10am

I’m by no means an expert, but L16 is just a form of LPCM audio encoding. en.wikipedia.org/wiki/Pulse-code_modulation

I don’t have access to the Pi right now, but I’ll post the MPD logs within the next day.

volumio · July 5, 2014, 3:13pm

So you’re using Pi with latest 1.4 I guess. Which output device are you using? I2S DAC, USB DAC or what? Replicating your issue here

asdfrewq · July 6, 2014, 5:53am

RPi Model B 256mb Rev 1 with a PCM2702 based usb DAC. Running Volumio 1.4. Using a wired ethernet connection and have a 2.4" TFT attached to the GPIO, but the issue is present with or without it.

Example MPD logs when attempting to play from spotify source:

Jul 02 10:12 : playlist: stop Jul 02 10:12 : player: played "http://192.168.1.100:58642/Media/audio/L16/d636b426/spotify%3Atrack%3A67xazpRk0c0JXNbOx8MkJD" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [12] opened from 127.0.0.1:42037 Jul 02 10:12 : client: [12] closed Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [13] opened from 127.0.0.1:42051 Jul 02 10:12 : client: [13] closed Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "status" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "currentsong" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo "1"" Jul 02 10:12 : client: [0] command returned 0 Jul 02 10:12 : client: [0] process command "playlistinfo" Jul 02 10:12 : client: [0] command returned 0

And here’s my mpd.conf file:

[code]###################################

Auto generated mpd.conf file

please DO NOT edit it manually!

Use player-UI MPD config section

###################################

follow_outside_symlinks “yes”
follow_inside_symlinks “yes”
db_file “/var/lib/mpd/tag_cache”
sticker_file “/var/lib/mpd/sticker.sql”
log_file “/var/log/mpd/mpd.log”
pid_file “/var/run/mpd/pid”
music_directory “/var/lib/mpd/music”
playlist_directory “/var/lib/mpd/playlists”
state_file “/var/lib/mpd/state”
log_level “verbose”
user “mpd”
bind_to_address “any”
port “6600”
zeroconf_enabled “yes”
zeroconf_name “volumio”
audio_output_format “44100:24:2”
samplerate_converter “Fastest Sinc Interpolator”
volume_normalization “no”
audio_buffer_size “2048”
buffer_before_play “20%”
filesystem_charset “UTF-8”
id3v1_encoding “UTF-8”
gapless_mp3_playback “yes”
auto_update “no”
group “audio”
max_connections “20”

decoder {
plugin “ffmpeg”
enabled “yes”
}

input {
plugin “curl”
}

audio_output {

	 type 		"alsa"
	 name 		"Output"
	 device 	"hw:0,0"
	 mixer_control 	"Master"
	 mixer_device 	"hw:0"
	 mixer_index 	"0"
	 dsd_usb 	"yes"

}
[/code]

asdfrewq · July 6, 2014, 5:54am

Ok, I posted a reply but it has indicated it needs to be approved by a moderator. Strange.

volumio · July 7, 2014, 2:56am

Thanks for the logs. I’m also working on that. We have to look into the upmpdcli log file, since this is the utility managing upnp\dlna playback and then routes it to mpd.

So, to enable upmpdcli logging

sudo nano /etc/upmpdcli.conf

And set

logfilename = /var/log/upmpdcli.log

You can also set the verbosity as you wish. Please note that /var/log is mounted in RAM so every log will be dumped at reboot.
Let’s work and solve it!

asdfrewq · July 7, 2014, 7:21am

Ok, my upmpdcli logs are here: pastebin.com/pqF5xaAr I set verbosity to the highest, so there’s a lot of junk in there, but you can see a few instances where I’ve attempted to push spotify tracks to the device.

As a side note, isn’t it about time someone wrote a proper mpd plugin to handle spotify playback? Mopidy is a great piece of software and it’s really cool what they’re doing with it, but it just lacks the audio quality and stability options of mpd. I remember a few offshoots of the despotify project looking promising, but they seem to have been lost to the wind. Oh well

volumio · July 7, 2014, 10:56am

Oh yes sir. I suffer a lot for this lack of MPD. I worked last summer to have spotify integrated, then it all changed and it stopped working, suddenly. Maybe we can ask to mantainers if someone is willing to do that, and offer our help… And I agree on the quality: that is why I’m still with MPD, mopidy just doesn’t sound as good.

medoc92 · July 8, 2014, 4:38am

As far as I know, L16 is a raw PCM stream (no encapsulation, no headers). The problem here is that upmpdcli has no way to tell MPD what the stream characteristics are (bit depth, sample rate etc.). MPD normally retrieves these from the file header, which is absent, and there is nothing in the MPD client protocol to send the info while adding an URL (upmpdcli does have the information, it’s communicated by the UPnP control point which gets it from the Media Server).

I think that I’ll just remove these formats from the supported ones, because I can’t find a way to make it work (this is a call for help by the way, if anyone gets an idea).

jf

asdfrewq · July 8, 2014, 11:48am

I’m afraid I can’t help resolve the issue, but removing the format as supported could be a quick and dirty fix for this specific problem. As I understand, the Jamcast software trancodes streams for devices which don’t list support for the original format. It would also, of course, cause a drop in sound quality due to transcoding one lossy format to another, but that’s probably a hit I’m willing to take just for spotify compatibility.

medoc92 · July 8, 2014, 2:25pm

If Jamcast is able to “transcode” to Wav (this is no transcoding, just adding a header), there should be no loss in quality (same bits exactly as L16 except for the added header).

I’m not sure of what upmpdcli version is currently in Volumio. In the last version (0.7.1), you can tune the list of advertised formats just by editing a text file: /usr/share/upmpdcli/protocolinfo.txt

You just need to delete the lines for audio/L16 and restart upmpdcli.

Actually, I just checked, and the audio/Lxx formats are already commented out in the 0.7.1 protocolinfo, so updating the package would be enough (no file editing needed).

If the file does not exist, the upmpdcli version is not the latest, and you would have to update the package for changing the list.

asdfrewq · July 9, 2014, 7:46am

Success! Mostly… I had to disable WAV also as mpd was having the exact same issue with it. I’m assuming there may be an issue with the headers being attached by Jamcast. Not to worry though, 320kbps mp3 seems to be adequate for Spotify.

michelangelo, if the version of upmpdcli isn’t already >= 0.7.1, could we get the packages upgraded and the relevant config changes made for the next release? When I find the time, I’ll write up a short tutorial for getting Jamcast+Spotify up and running with volumio, if there’s any interest.

Thanks everyone for their help!

medoc92 · July 10, 2014, 6:26pm

Hi again,

Full disclosure: I wrote Upmpdcli: github.com/medoc92/upmpdcli/blob/master/AUTHORS

About the wav issue: I can’t be totally sure without testing for myself, but this is very likely to be related to a bunch of problems which we are having with high data rate formats and the upmpdcli/mpd couple.

The thing which is special when you use upmpdcli to control mpd is that all data retrieval goes through curl (HTTP), instead of normal file access system calls, for the more common situation where mpd accesses the audio data inside its music directory.

The thing which is special about curl is that read requests sometimes return less data than was requested.

This tends to happen more with high data rates and mostly causes problems with less commonly streamed formats (the mp3 decoder was probably fixed for short reads ages ago), and it has awaken a whole nest of creepy-crawlies.

Specifically, problems were seen with:

wav files: you need to use the sndfile plugin (not audiofile which you should get completely rid of afaik), with a patch which is in the recent git MPD code, or can be applied to older versions. See this issue: bugs.musicpd.org/view.php?id=3968
aiff: Same kind of problem, I have a workaround but no certain patch. See the discussion on this issue: bugs.musicpd.org/view.php?id=4014
dsd: same issue. A patch was proposed and was just merged into the git code: bugs.musicpd.org/view.php?id=4015

Finally, about L16 again, there is a fundamental issue with using this with upmpdcli/mpd: we have no way to tell mpd about the sound format (sample rate, size, channel count), and mpd can’t guess because there is no descriptive header. There is no simple solution to this issue, this would need relatively significant modifications to mpd.

If anybody needs more details, I’ll check this thread, or you can reach me at jf at dockes . org.

Cheers,

jf

medoc92 · October 15, 2016, 7:45am

This is an old thread, but it ends on a wrong conclusion, so here comes the truth:

The way the Media Renderers (e.g. upmpdcli/mpd) obtain data rate and channel count information for L16 streams is through HTTP headers returned when the renderer fetches the stream (I didn’t know this at the time of the original thread).

Older MPD versions did not know how to use this information. This is fixed in very recent MPD versions (0.20, not released yet).

I have 0.19 version of MPD patched with the 0.20 L16 support code (a simple change). Contact me if you have a need for this: jf@dockes.org.

jfd