search

masmu / pulseaudio-dlna

A lightweight streaming server which brings DLNA / UPNP and Chromecast support to PulseAudio and Linux
GNU General Public License v3.0
1.25k stars 162 forks source link

pulseaudio-dlna connects - but no sound! #424

Closed coffseducation closed 2 years ago

coffseducation commented 2 years ago

I am trying to connect to an Audiolab stereo. I have connect many times in the past but cannot get sound now.

$pulseaudio-dlna --debug 03-30 13:37:29 pulseaudio_dlna.rules DEBUG Loaded rules: 03-30 13:37:29 pulseaudio_dlna.rules DEBUG DISABLE_DEVICE_STOP = <class 'pulseaudio_dlna.rules.DISABLE_DEVICE_STOP'> 03-30 13:37:29 pulseaudio_dlna.rules DEBUG DISABLE_MIMETYPE_CHECK = <class 'pulseaudio_dlna.rules.DISABLE_MIMETYPE_CHECK'> 03-30 13:37:29 pulseaudio_dlna.rules DEBUG DISABLE_PLAY_COMMAND = <class 'pulseaudio_dlna.rules.DISABLE_PLAY_COMMAND'> 03-30 13:37:29 pulseaudio_dlna.rules DEBUG FAKE_HTTP_CONTENT_LENGTH = <class 'pulseaudio_dlna.rules.FAKE_HTTP_CONTENT_LENGTH'> 03-30 13:37:29 pulseaudio_dlna.rules DEBUG REQUEST_TIMEOUT = <class 'pulseaudio_dlna.rules.REQUEST_TIMEOUT'> 03-30 13:37:29 pulseaudio_dlna.encoder.avconv DEBUG Loaded encoders: 03-30 13:37:29 pulseaudio_dlna.encoder.avconv DEBUG <class 'pulseaudio_dlna.encoders.avconv.AVConvAacEncoder'> 03-30 13:37:29 pulseaudio_dlna.encoder.avconv DEBUG <class 'pulseaudio_dlna.encoders.avconv.AVConvFlacEncoder'> 03-30 13:37:29 pulseaudio_dlna.encoder.avconv DEBUG <class 'pulseaudio_dlna.encoders.avconv.AVConvL16Encoder'> 03-30 13:37:29 pulseaudio_dlna.encoder.avconv DEBUG <class 'pulseaudio_dlna.encoders.avconv.AVConvMp3Encoder'> 03-30 13:37:29 pulseaudio_dlna.encoder.avconv DEBUG <class 'pulseaudio_dlna.encoders.avconv.AVConvOggEncoder'> 03-30 13:37:29 pulseaudio_dlna.encoder.avconv DEBUG <class 'pulseaudio_dlna.encoders.avconv.AVConvOpusEncoder'> 03-30 13:37:29 pulseaudio_dlna.encoder.avconv DEBUG <class 'pulseaudio_dlna.encoders.avconv.AVConvWavEncoder'> 03-30 13:37:29 pulseaudio_dlna.encoder.avconv DEBUG <class 'pulseaudio_dlna.encoders.ffmpeg.FFMpegAacEncoder'> 03-30 13:37:29 pulseaudio_dlna.encoder.avconv DEBUG <class 'pulseaudio_dlna.encoders.ffmpeg.FFMpegFlacEncoder'> 03-30 13:37:29 pulseaudio_dlna.encoder.avconv DEBUG <class 'pulseaudio_dlna.encoders.ffmpeg.FFMpegL16Encoder'> 03-30 13:37:29 pulseaudio_dlna.encoder.avconv DEBUG <class 'pulseaudio_dlna.encoders.ffmpeg.FFMpegMp3Encoder'> 03-30 13:37:29 pulseaudio_dlna.encoder.avconv DEBUG <class 'pulseaudio_dlna.encoders.ffmpeg.FFMpegOggEncoder'> 03-30 13:37:29 pulseaudio_dlna.encoder.avconv DEBUG <class 'pulseaudio_dlna.encoders.ffmpeg.FFMpegOpusEncoder'> 03-30 13:37:29 pulseaudio_dlna.encoder.avconv DEBUG <class 'pulseaudio_dlna.encoders.ffmpeg.FFMpegWavEncoder'> 03-30 13:37:29 pulseaudio_dlna.encoder.avconv DEBUG <class 'pulseaudio_dlna.encoders.generic.FaacAacEncoder'> 03-30 13:37:29 pulseaudio_dlna.encoder.avconv DEBUG <class 'pulseaudio_dlna.encoders.generic.FlacFlacEncoder'> 03-30 13:37:29 pulseaudio_dlna.encoder.avconv DEBUG <class 'pulseaudio_dlna.encoders.generic.LameMp3Encoder'> 03-30 13:37:29 pulseaudio_dlna.encoder.avconv DEBUG <class 'pulseaudio_dlna.encoders.NullEncoder'> 03-30 13:37:29 pulseaudio_dlna.encoder.avconv DEBUG <class 'pulseaudio_dlna.encoders.generic.OggencOggEncoder'> 03-30 13:37:29 pulseaudio_dlna.encoder.avconv DEBUG <class 'pulseaudio_dlna.encoders.generic.OpusencOpusEncoder'> 03-30 13:37:29 pulseaudio_dlna.encoder.avconv DEBUG <class 'pulseaudio_dlna.encoders.generic.SoxL16Encoder'> 03-30 13:37:29 pulseaudio_dlna.encoder.avconv DEBUG <class 'pulseaudio_dlna.encoders.generic.SoxWavEncoder'> 03-30 13:37:29 pulseaudio_dlna.codecs DEBUG Loaded codecs: 03-30 13:37:29 pulseaudio_dlna.codecs DEBUG aac = <class 'pulseaudio_dlna.codecs.AacCodec'> 03-30 13:37:29 pulseaudio_dlna.codecs DEBUG flac = <class 'pulseaudio_dlna.codecs.FlacCodec'> 03-30 13:37:29 pulseaudio_dlna.codecs DEBUG l16 = <class 'pulseaudio_dlna.codecs.L16Codec'> 03-30 13:37:29 pulseaudio_dlna.codecs DEBUG mp3 = <class 'pulseaudio_dlna.codecs.Mp3Codec'> 03-30 13:37:29 pulseaudio_dlna.codecs DEBUG ogg = <class 'pulseaudio_dlna.codecs.OggCodec'> 03-30 13:37:29 pulseaudio_dlna.codecs DEBUG opus = <class 'pulseaudio_dlna.codecs.OpusCodec'> 03-30 13:37:29 pulseaudio_dlna.codecs DEBUG wav = <class 'pulseaudio_dlna.codecs.WavCodec'> 03-30 13:37:30 pulseaudio_dlna.application INFO Using version: 0.6.0 03-30 13:37:30 pulseaudio_dlna.application INFO Binding to *:8080 03-30 13:37:30 pulseaudio_dlna.application INFO Encoder settings: 03-30 13:37:30 pulseaudio_dlna.application INFO 03-30 13:37:30 pulseaudio_dlna.application INFO 03-30 13:37:30 pulseaudio_dlna.application INFO 03-30 13:37:30 pulseaudio_dlna.application INFO 03-30 13:37:30 pulseaudio_dlna.application INFO 03-30 13:37:30 pulseaudio_dlna.application INFO 03-30 13:37:30 pulseaudio_dlna.application INFO 03-30 13:37:30 pulseaudio_dlna.application INFO 03-30 13:37:30 pulseaudio_dlna.application INFO 03-30 13:37:30 pulseaudio_dlna.application INFO 03-30 13:37:30 pulseaudio_dlna.application INFO 03-30 13:37:30 pulseaudio_dlna.application INFO 03-30 13:37:30 pulseaudio_dlna.application INFO 03-30 13:37:30 pulseaudio_dlna.application INFO 03-30 13:37:30 pulseaudio_dlna.application INFO 03-30 13:37:30 pulseaudio_dlna.application INFO 03-30 13:37:30 pulseaudio_dlna.application INFO 03-30 13:37:30 pulseaudio_dlna.application INFO 03-30 13:37:30 pulseaudio_dlna.application INFO 03-30 13:37:30 pulseaudio_dlna.application INFO 03-30 13:37:30 pulseaudio_dlna.application INFO 03-30 13:37:30 pulseaudio_dlna.application INFO 03-30 13:37:30 pulseaudio_dlna.application INFO Codec settings: 03-30 13:37:30 pulseaudio_dlna.application INFO 03-30 13:37:30 pulseaudio_dlna.application INFO 03-30 13:37:30 pulseaudio_dlna.application INFO 03-30 13:37:30 pulseaudio_dlna.application INFO 03-30 13:37:30 pulseaudio_dlna.application INFO 03-30 13:37:30 pulseaudio_dlna.application INFO 03-30 13:37:30 pulseaudio_dlna.application INFO 03-30 13:37:30 pulseaudio_dlna.streamserver CRITICAL The streaming server could not bind to your specified port (8080). Perhaps this is already in use? The application cannot work properly! 03-30 13:37:30 pulseaudio_dlna.discover DEBUG Binding socket to "" ... 03-30 13:37:30 pulseaudio_dlna.plugins.chromecast INFO ChromecastPlugin.discover() 03-30 13:37:30 pulseaudio_dlna.pulseaudio INFO Module "module-dbus-protocol" already loaded. 03-30 13:37:30 pulseaudio_dlna.pulseaudio INFO Probing for $PULSE_DBUS_SERVER unsuccessful. 03-30 13:37:30 pulseaudio_dlna.pulseaudio INFO Probing for /run/pulse/dbus-socket unsuccessful. 03-30 13:37:30 pulseaudio_dlna.pulseaudio INFO Probing for $XDG_RUNTIME_DIR successful (unix:path=/run/user/1000/pulse/dbus-socket). 03-30 13:37:30 pulseaudio_dlna.pulseaudio INFO Probing for org.PulseAudio.ServerLookup1 successful (unix:path=/run/user/1000/pulse/dbus-socket). 03-30 13:37:30 pulseaudio_dlna.pulseaudio INFO Found the following pulseaudio server addresses: unix:path=/run/user/1000/pulse/dbus-socket 03-30 13:37:30 pulseaudio_dlna.pulseaudio INFO Connecting to pulseaudio on "unix:path=/run/user/1000/pulse/dbus-socket" ... 03-30 13:37:35 pulseaudio_dlna.discover INFO SSDPDiscover.search() 03-30 13:39:25 urllib3.connectionpool DEBUG Starting new HTTP connection (1): 192.168.0.190:49152 03-30 13:39:25 urllib3.connectionpool DEBUG http://192.168.0.190:49152 "GET /description.xml HTTP/1.1" 200 2422 03-30 13:39:25 pyupnpv2 DEBUG Response from UPNP device (http://192.168.0.190:49152/description.xml) <?xml version="1.0"?>

1 0 urn:schemas-upnp-org:device:MediaRenderer:1 QPlay:2 uuid:3d62cbc4-32f8-4fbc-8618-60b6062146a7 Audiolab 192.168.0.190 49152 Phorus www.phorus.com Phorus-Renderer Phorus-Renderer 1.0 www.phorus.com DMR-1.50 000000000001 000000000001 image/png 72 72 32 /upnpmplayer.png urn:schemas-upnp-org:service:AVTransport:1 urn:upnp-org:serviceId:AVTransport /upnp/control/AVTransport1 /upnp/event/AVTransport1 AVTransport.xml urn:schemas-upnp-org:service:RenderingControl:1 urn:upnp-org:serviceId:RenderingControl /upnp/control/RenderingControl1 /upnp/event/RenderingControl1 RendererControl.xml urn:schemas-upnp-org:service:ConnectionManager:1 urn:upnp-org:serviceId:ConnectionManager /upnp/control/ConnectionManager1 /upnp/event/ConnectionManager1 ConnectionManager.xml urn:schemas-tencent-com:service:QPlay:1 urn:tencent-com:serviceId:QPlay /upnp/control/QPlay1 /upnp/event/QPlay1 QPlayQueueService.xml http://192.168.0.190:49152/

03-30 13:39:25 urllib3.connectionpool DEBUG Starting new HTTP connection (1): 192.168.0.190:49152 03-30 13:39:25 urllib3.connectionpool DEBUG http://192.168.0.190:49152 "GET /AVTransport.xml HTTP/1.1" 200 20253 03-30 13:39:25 urllib3.connectionpool DEBUG Resetting dropped connection: 192.168.0.190 03-30 13:39:25 urllib3.connectionpool DEBUG http://192.168.0.190:49152 "GET /RendererControl.xml HTTP/1.1" 200 7358 03-30 13:39:25 urllib3.connectionpool DEBUG Resetting dropped connection: 192.168.0.190 03-30 13:39:25 urllib3.connectionpool DEBUG http://192.168.0.190:49152 "GET /ConnectionManager.xml HTTP/1.1" 200 3595 03-30 13:39:25 urllib3.connectionpool DEBUG Resetting dropped connection: 192.168.0.190 03-30 13:39:25 urllib3.connectionpool DEBUG Starting new HTTP connection (1): 192.168.0.190:49152 03-30 13:39:25 urllib3.connectionpool DEBUG http://192.168.0.190:49152 "POST /upnp/control/ConnectionManager1 HTTP/1.1" 200 603 03-30 13:39:25 pyupnpv2 DEBUG SENT {'Content-Type': 'text/xml; charset="utf-8"', 'SOAPAction': '"urn:schemas-upnp-org:service:ConnectionManager:1#GetProtocolInfo"'}: URL: http://192.168.0.190:49152/upnp/control/ConnectionManager1 b'<?xml version=\'1.0\' encoding=\'utf-8\'?>\n</s:Body></s:Envelope>' 03-30 13:39:25 pyupnpv2 DEBUG RECEIVED [200] - {'CONTENT-LENGTH': '603', 'CONTENT-TYPE': 'text/xml; charset="utf-8"', 'DATE': 'Wed, 30 Mar 2022 02:39:25 GMT', 'EXT': '', 'SERVER': 'Linux/3.12.74-retail-development, UPnP/1.0, Portable SDK for UPnP devices/1.6.19', 'X-User-Agent': 'redsonic'}: b'\n\r\n\r\nhttp-get::audio/wav:,http-get::audio/x-wav:,http-get::audio/mpeg:,http-get::audio/mp3:,http-get::audio/aac:,http-get::audio/ac3:,http-get::audio/x-flac:,http-get::audio/flac:,http-get::audio/vnd.dlna.adts:,http-get::audio/x-hx-aac-adts:,http-get::audio/3gpp:,http-get::audio/mp4:\r\n</u:GetProtocolInfoResponse>\r\n</s:Body> </s:Envelope>' 03-30 13:39:25 urllib3.connectionpool DEBUG http://192.168.0.190:49152 "GET /description.xml HTTP/1.1" 200 2422 03-30 13:39:25 pyupnpv2 DEBUG Response from UPNP device (http://192.168.0.190:49152/description.xml) <?xml version="1.0"?>

1 0 urn:schemas-upnp-org:device:MediaRenderer:1 QPlay:2 uuid:3d62cbc4-32f8-4fbc-8618-60b6062146a7 Audiolab 192.168.0.190 49152 Phorus www.phorus.com Phorus-Renderer Phorus-Renderer 1.0 www.phorus.com DMR-1.50 000000000001 000000000001 image/png 72 72 32 /upnpmplayer.png urn:schemas-upnp-org:service:AVTransport:1 urn:upnp-org:serviceId:AVTransport /upnp/control/AVTransport1 /upnp/event/AVTransport1 AVTransport.xml urn:schemas-upnp-org:service:RenderingControl:1 urn:upnp-org:serviceId:RenderingControl /upnp/control/RenderingControl1 /upnp/event/RenderingControl1 RendererControl.xml urn:schemas-upnp-org:service:ConnectionManager:1 urn:upnp-org:serviceId:ConnectionManager /upnp/control/ConnectionManager1 /upnp/event/ConnectionManager1 ConnectionManager.xml urn:schemas-tencent-com:service:QPlay:1 urn:tencent-com:serviceId:QPlay /upnp/control/QPlay1 /upnp/event/QPlay1 QPlayQueueService.xml http://192.168.0.190:49152/

03-30 13:39:25 urllib3.connectionpool DEBUG Starting new HTTP connection (1): 192.168.0.190:49152 03-30 13:39:25 urllib3.connectionpool DEBUG http://192.168.0.190:49152 "GET /AVTransport.xml HTTP/1.1" 200 20253 03-30 13:39:25 urllib3.connectionpool DEBUG Resetting dropped connection: 192.168.0.190 03-30 13:39:25 urllib3.connectionpool DEBUG http://192.168.0.190:49152 "GET /RendererControl.xml HTTP/1.1" 200 7358 03-30 13:39:25 pulseaudio_dlna.pulseaudio INFO Added the device "Audiolab (DLNA)". 03-30 13:39:25 pulseaudio_dlna.pulseaudio INFO on_device_updated "/org/pulseaudio/core1/sink25" 03-30 13:39:25 urllib3.connectionpool DEBUG Resetting dropped connection: 192.168.0.190 03-30 13:39:25 urllib3.connectionpool DEBUG http://192.168.0.190:49152 "GET /ConnectionManager.xml HTTP/1.1" 200 3595 03-30 13:39:26 pulseaudio_dlna.pulseaudio INFO _async_handle_sink_update /org/pulseaudio/core1/sink25 03-30 13:39:26 pulseaudio_dlna.pulseaudio DEBUG

03-30 13:39:26 pulseaudio_dlna.pulseaudio INFO Instructing the device "Audiolab (DLNA)" to play ... 03-30 13:39:26 urllib3.connectionpool DEBUG Starting new HTTP connection (1): 192.168.0.190:49152 03-30 13:39:26 urllib3.connectionpool DEBUG http://192.168.0.190:49152 "POST /upnp/control/AVTransport1 HTTP/1.1" 200 262 03-30 13:39:26 pyupnpv2 DEBUG SENT {'Content-Type': 'text/xml; charset="utf-8"', 'SOAPAction': '"urn:schemas-upnp-org:service:AVTransport:1#SetAVTransportURI"'}: URL: http://192.168.0.190:49152/upnp/control/AVTransport1 b'\n0http://192.168.0.188:8080/dHlwZT0iYnJpZGdlIix1ZG49InV1aWQ6M2Q2MmNiYzQtMzJmOC00ZmJjLTg2MTgtNjBiNjA2MjE0NmE3Ig%3D%3D/stream.mp3<?xml version=\'1.0\' encoding=\'utf-8\'?>\n<DIDL-Lite xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/" xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:dlna="urn:schemas-dlna-org:metadata-1-0/" xmlns:sec="http://www.sec.co.kr/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/"><item id="0" parentID="0" restricted="1"><upnp:class>object.item.audioItem.musicTrack</upnp:class><dc:title>Music Player Daemon</dc:title><dc:creator></dc:creator><upnp:artist>Liveaudio on LuNoHo</upnp:artist><upnp:albumArtURI>http://192.168.0.188:8080/dHlwZT0iaW1hZ2UiLG5hbWU9ImRlZmF1bHQucG5nIg%3D%3D/</upnp:albumArtURI><upnp:album></upnp:album><res protocolInfo="http-get:*:audio/mpeg:DLNA.ORG_OP=00;DLNA.ORG_CI=0;DLNA.ORG_FLAGS=01700000000000000000000000000000">http://192.168.0.188:8080/dHlwZT0iYnJpZGdlIix1ZG49InV1aWQ6M2Q2MmNiYzQtMzJmOC00ZmJjLTg2MTgtNjBiNjA2MjE0NmE3Ig%3D%3D/stream.mp3</res></item></DIDL-Lite>' 03-30 13:39:26 pyupnpv2 DEBUG RECEIVED [200] - {'CONTENT-LENGTH': '262', 'CONTENT-TYPE': 'text/xml; charset="utf-8"', 'DATE': 'Wed, 30 Mar 2022 02:39:26 GMT', 'EXT': '', 'SERVER': 'Linux/3.12.74-retail-development, UPnP/1.0, Portable SDK for UPnP devices/1.6.19', 'X-User-Agent': 'redsonic'}: b'\n\r\n ' 03-30 13:39:26 urllib3.connectionpool DEBUG Resetting dropped connection: 192.168.0.190 03-30 13:39:26 urllib3.connectionpool DEBUG http://192.168.0.190:49152 "POST /upnp/control/AVTransport1 HTTP/1.1" 200 403 03-30 13:39:26 pyupnpv2 DEBUG SENT {'Content-Type': 'text/xml; charset="utf-8"', 'SOAPAction': '"urn:schemas-upnp-org:service:AVTransport:1#GetTransportInfo"'}: URL: http://192.168.0.190:49152/upnp/control/AVTransport1 b'\n0' 03-30 13:39:26 pyupnpv2 DEBUG RECEIVED [200] - {'CONTENT-LENGTH': '403', 'CONTENT-TYPE': 'text/xml; charset="utf-8"', 'DATE': 'Wed, 30 Mar 2022 02:39:26 GMT', 'EXT': '', 'SERVER': 'Linux/3.12.74-retail-development, UPnP/1.0, Portable SDK for UPnP devices/1.6.19', 'X-User-Agent': 'redsonic'}: b'\n\r\nSTOPPED\r\nOK\r\n1\r\n\r\n ' 03-30 13:39:26 pulseaudio_dlna.plugins.dlna.renderer INFO Device state is stopped. Sending play command. 03-30 13:39:26 urllib3.connectionpool DEBUG Resetting dropped connection: 192.168.0.190 03-30 13:39:26 urllib3.connectionpool DEBUG http://192.168.0.190:49152 "POST /upnp/control/AVTransport1 HTTP/1.1" 200 236 03-30 13:39:26 pyupnpv2 DEBUG SENT {'Content-Type': 'text/xml; charset="utf-8"', 'SOAPAction': '"urn:schemas-upnp-org:service:AVTransport:1#Play"'}: URL: http://192.168.0.190:49152/upnp/control/AVTransport1 b'\n01' 03-30 13:39:26 pyupnpv2 DEBUG RECEIVED [200] - {'CONTENT-LENGTH': '236', 'CONTENT-TYPE': 'text/xml; charset="utf-8"', 'DATE': 'Wed, 30 Mar 2022 02:39:26 GMT', 'EXT': '', 'SERVER': 'Linux/3.12.74-retail-development, UPnP/1.0, Portable SDK for UPnP devices/1.6.19', 'X-User-Agent': 'redsonic'}: b'\n\r\n ' 03-30 13:39:26 pulseaudio_dlna.pulseaudio INFO The device "Audiolab (DLNA)" is playing. 03-30 13:39:26 pulseaudio_dlna.pulseaudio INFO _async_handle_sink_update /org/pulseaudio/core1/sink25 finished! Operating System: Kubuntu 21.10 KDE Plasma Version: 5.24.3 KDE Frameworks Version: 5.92.0 Qt Version: 5.15.2 Kernel Version: 5.13.0-37-generic (64-bit) Graphics Platform: X11 Processors: 8 × Intel® Core™ i7-7820HQ CPU @ 2.90GHz Memory: 31.2 GiB of RAM Graphics Processor: Mesa Intel® HD Graphics 630
coffseducation commented 2 years ago

Update:

After re-installing pulseaudio-dlna, disabling UFW and using a different port, I was able to connect.

Where on Kubuntu can I find the pulseaudio-dlna.service file in order to add a different default port (as per https://github.com/masmu/pulseaudio-dlna/issues/395#issuecomment-787959004).

Now I just need to figure out how to UFW add a port.

coffseducation commented 2 years ago

hmm, I could not find a file to edit the default port, so I just created a bash script with the new port to autostart at login, with the port added to the firewall.