pulseaudio-dlna
pulseaudio-dlna copied to clipboard
masmu
0.6.0_pre20200114: pulseaudio_dlna.pulseaudio ERROR The device "Office NAD D3020 (Chromecast)" failed to play! (500) - Chromecast 192.168.1.174:8009 is connecting...
Hi. I'm trying to connect pulseaudio-dlna to Chromecast Audio, but not sure where things are going wrong. Using Google Chrome to cast a browser tab works fine, so I don't think network layer is the problem.
(PS my kernel has IPv6 disabled, because I have yet to need it for anything.)
leho@papaya ~ $ [-] pulseaudio-dlna --codec mp3 --encoder-backend=ffmpeg --host=localhost --debug
...
03-06 21:51:19 pulseaudio_dlna.discover DEBUG Binding socket to "localhost" ...
03-06 21:51:19 pulseaudio_dlna.plugins.chromecast INFO ChromecastPlugin.discover()
03-06 21:51:19 pulseaudio_dlna.pulseaudio INFO Module "module-dbus-protocol" already loaded.
03-06 21:51:19 pulseaudio_dlna.pulseaudio INFO Probing for $PULSE_DBUS_SERVER unsuccessful.
03-06 21:51:19 pulseaudio_dlna.pulseaudio INFO Probing for /run/pulse/dbus-socket unsuccessful.
03-06 21:51:19 pulseaudio_dlna.pulseaudio INFO Probing for $XDG_RUNTIME_DIR successful (unix:path=/run/user/1000/pulse/dbus-socket).
03-06 21:51:19 pulseaudio_dlna.pulseaudio INFO Probing for org.PulseAudio.ServerLookup1 successful (unix:path=/run/user/1000/pulse/dbus-socket).
03-06 21:51:19 pulseaudio_dlna.pulseaudio INFO Found the following pulseaudio server addresses: unix:path=/run/user/1000/pulse/dbus-socket 03-06 21:51:19 pulseaudio_dlna.pulseaudio INFO Connecting to pulseaudio on "unix:path=/run/user/1000/pulse/dbus-socket" ...
03-06 21:51:19 pychromecast.discovery DEBUG add_service _googlecast._tcp.local., Chromecast-Audio-1f220099adb5f84ec26d36ed80218301._googlecast._tcp.local.
03-06 21:51:19 pychromecast DEBUG _get_chromecast_from_host ('192.168.1.174', 8009, UUID('1f220099-adb5-f84e-c26d-36ed80218301'), 'Chromecast Audio', 'Office NAD D3020')
03-06 21:51:19 pychromecast INFO Querying device status
03-06 21:51:19 urllib3.connectionpool DEBUG Starting new HTTP connection (1): 192.168.1.174:8008
03-06 21:51:19 urllib3.connectionpool DEBUG http://192.168.1.174:8008 "GET /setup/eureka_info?options=detail HTTP/1.1" 200 1358
03-06 21:51:19 pulseaudio_dlna.pulseaudio INFO Added the device "Office NAD D3020 (Chromecast)".
Exception in thread Thread-5:
Traceback (most recent call last): File "/usr/lib64/python3.6/threading.py", line 916, in _bootstrap_inner
self.run()
File "/usr/lib64/python3.6/threading.py", line 1182, in run
self.function(*self.args, **self.kwargs)
File "/usr/lib64/python3.6/site-packages/pulseaudio_dlna/plugins/dlna/ssdp/discover.py", line 124, in _send_discover
sock.sendto(msg, (self.SSDP_ADDRESS, self.SSDP_PORT))
OSError: [Errno 22] Invalid argument
03-06 21:51:22 pulseaudio_dlna.discover INFO SSDPDiscover.search()
03-06 21:51:28 pulseaudio_dlna.pulseaudio INFO on_device_updated "/org/pulseaudio/core1/sink11"
03-06 21:51:29 pulseaudio_dlna.pulseaudio INFO _async_handle_sink_update /org/pulseaudio/core1/sink11
03-06 21:51:29 pulseaudio_dlna.pulseaudio DEBUG
<Bridge>
<PulseSink path="/org/pulseaudio/core1/sink11" label="Office NAD D3020 (Chromecast)" name="officenadd3020_chromecast" index="11" module="32">
<PulseStream path="/org/pulseaudio/core1/playback_stream1" device="/org/pulseaudio/core1/sink11" index="1" client="15">
<ChromecastRenderer name="Office NAD D3020" short="officenadd3020_chromecast" state="STOPPED" udn="uuid:1f220099-adb5-f84e-c26d-36ed80218301" model_name="Chromecast Audio" model_number="None" model_description="None" manufacturer="Unkno
wn manufacturer" timeout="15.0">
03-06 21:51:29 pulseaudio_dlna.pulseaudio INFO Instructing the device "Office NAD D3020 (Chromecast)" to play ...
03-06 21:51:29 pychromecast DEBUG _get_chromecast_from_host ('192.168.1.174', 8009, 'uuid:1f220099-adb5-f84e-c26d-36ed80218301', 'Chromecast Audio', 'Office NAD D3020')
03-06 21:51:29 pychromecast INFO Querying device status
03-06 21:51:29 urllib3.connectionpool DEBUG Starting new HTTP connection (1): 192.168.1.174:8008
03-06 21:51:29 urllib3.connectionpool DEBUG http://192.168.1.174:8008 "GET /setup/eureka_info?options=detail HTTP/1.1" 200 1358
03-06 21:51:29 pychromecast.controllers DEBUG Receiver:Updating status
03-06 21:51:29 pychromecast.socket_client DEBUG [192.168.1.174:8009] Sending: Message urn:x-cast:com.google.cast.tp.connection from sender-0 to receiver-0: {'type': 'CONNECT', 'origin': {}, 'userAgent': 'PyChromecast'
, 'senderInfo': {'sdkType': 2, 'version': '15.605.1.3', 'browserVersion': '44.0.2403.30', 'platform': 4, 'systemVersion': 'Macintosh; Intel Mac OS X10_10_3', 'connectionType': 1}}
03-06 21:51:29 pulseaudio_dlna.pulseaudio ERROR The device "Office NAD D3020 (Chromecast)" failed to play! (500) - Chromecast 192.168.1.174:8009 is connecting...
03-06 21:51:29 pulseaudio_dlna.pulseaudio INFO _async_handle_sink_update /org/pulseaudio/core1/sink11 finished!
Any ideas? :thinking:
Exactly the same problem here. I notice that it happens very quickly and wonder if it's timing out too fast. Previously, when connecting to chromecast was working for me (a number of months ago) it would take a few seconds to connect, so for it to 'give up' so quickly seems off.
I haven't had the time to really dig further here, basically just waiting for the next pre-release tagged into an ebuild on Gentoo and :pray: that it works better.
Same problem here. log;
04-07 21:23:52 pulseaudio_dlna.pulseaudio INFO on_new_playback_stream "/org/pulseaudio/core1/playback_stream140" 04-07 21:23:53 pulseaudio_dlna.pulseaudio INFO _async_handle_sink_update /org/pulseaudio/core1/sink2 04-07 21:23:53 pulseaudio_dlna.pulseaudio INFO Instructing the device "Salle TV (Chromecast)" to play ... 04-07 21:23:53 pychromecast INFO Querying device status 04-07 21:23:53 pulseaudio_dlna.pulseaudio ERROR The device "Salle TV (Chromecast)" failed to play! (500) - Chromecast 192.168.1.99:8009 is connecting... 04-07 21:23:53 pulseaudio_dlna.pulseaudio INFO _async_handle_sink_update /org/pulseaudio/core1/sink2 finished! 04-07 21:23:53 pulseaudio_dlna.pulseaudio INFO on_new_playback_stream "/org/pulseaudio/core1/playback_stream141" 04-07 21:23:53 pulseaudio_dlna.pulseaudio INFO on_device_updated "/org/pulseaudio/core1/sink0" 04-07 21:23:54 pulseaudio_dlna.pulseaudio INFO _async_handle_sink_update /org/pulseaudio/core1/sink2 04-07 21:23:54 pulseaudio_dlna.pulseaudio INFO Instructing the device "Salle TV (Chromecast)" to play ... 04-07 21:23:54 pychromecast INFO Querying device status 04-07 21:23:54 pulseaudio_dlna.pulseaudio ERROR The device "Salle TV (Chromecast)" failed to play! (500) - Chromecast 192.168.1.99:8009 is connecting... 04-07 21:23:54 pulseaudio_dlna.pulseaudio INFO _async_handle_sink_update /org/pulseaudio/core1/sink2 finished! 04-07 21:23:54 pulseaudio_dlna.pulseaudio INFO _async_handle_sink_update /org/pulseaudio/core1/sink0 04-07 21:23:54 pulseaudio_dlna.pulseaudio INFO _async_handle_sink_update /org/pulseaudio/core1/sink0 finished! 04-07 21:23:54 pulseaudio_dlna.pulseaudio INFO on_device_updated "/org/pulseaudio/core1/sink0" 04-07 21:23:54 pulseaudio_dlna.pulseaudio INFO on_playback_stream_removed "/org/pulseaudio/core1/playback_stream141" 04-07 21:23:55 pulseaudio_dlna.pulseaudio INFO _async_handle_sink_update /org/pulseaudio/core1/sink0 04-07 21:23:55 pulseaudio_dlna.pulseaudio INFO _async_handle_sink_update /org/pulseaudio/core1/sink0 finished! 04-07 21:24:00 pulseaudio_dlna.pulseaudio INFO on_new_playback_stream "/org/pulseaudio/core1/playback_stream142" 04-07 21:24:00 pulseaudio_dlna.pulseaudio INFO on_playback_stream_removed "/org/pulseaudio/core1/playback_stream142" 04-07 21:24:01 pulseaudio_dlna.pulseaudio INFO _async_handle_sink_update /org/pulseaudio/core1/sink0 04-07 21:24:01 pulseaudio_dlna.pulseaudio INFO _async_handle_sink_update /org/pulseaudio/core1/sink0 finished!
Same issue here as well.
04-18 21:17:54 pulseaudio_dlna.pulseaudio INFO Instructing the device "Sound System (Chromecast)" to play ...
04-18 21:17:54 pychromecast DEBUG _get_chromecast_from_host ('192.168.1.242', 8009, 'uuid:d8d6cff6-3439-5f5d-6349-da301ab5c1d4', 'SmartCast Sound Bar 36512-F6', 'Sound System')
04-18 21:17:54 pychromecast INFO Querying device status
04-18 21:17:54 urllib3.connectionpool DEBUG Starting new HTTP connection (1): 192.168.1.242:8008
04-18 21:17:54 urllib3.connectionpool DEBUG http://192.168.1.242:8008 "GET /setup/eureka_info?options=detail HTTP/1.1" 200 1479
04-18 21:17:54 pychromecast.controllers DEBUG Receiver:Updating status
04-18 21:17:54 pychromecast.socket_client DEBUG [192.168.1.242:8009] Sending: Message urn:x-cast:com.google.cast.tp.connection from sender-0 to receiver-0: {'type': 'CONNECT', 'origin': {}, 'userAgent': 'PyChromecast', 'senderInfo': {'sdkType': 2, 'version': '15.605.1.3', 'browserVersion': '44.0.2403.30', 'platform': 4, 'systemVersion': 'Macintosh; Intel Mac OS X10_10_3', 'connectionType': 1}}
04-18 21:17:54 pulseaudio_dlna.pulseaudio ERROR The device "Sound System (Chromecast)" failed to play! (500) - Chromecast 192.168.1.242:8009 is connecting...
04-18 21:17:54 pulseaudio_dlna.pulseaudio DEBUG
<Bridge>
<PulseSink path="/org/pulseaudio/core1/sink22" label="Kid's Room Speaker (Chromecast)" name="kidsroomspeaker_chromecast" index="22" module="49">
-- no streams --
<ChromecastRenderer name="Kid's Room Speaker" short="kidsroomspeaker_chromecast" state="STOPPED" udn="uuid:403152a2-2787-9848-45da-06c294ccffe7" model_name="Google Home Mini" model_number="None" model_description="None" manufacturer="Unknown manufacturer" timeout="30.0">
04-18 21:17:54 pulseaudio_dlna.pulseaudio DEBUG
<Bridge>
<PulseSink path="/org/pulseaudio/core1/sink23" label="Home Group (Chromecast)" name="homegroup_chromecast" index="23" module="50">
-- no streams --
<ChromecastRenderer name="Home Group" short="homegroup_chromecast" state="STOPPED" udn="uuid:7ac896a1-3a6f-4ff8-a4e1-bacc9fe5e392" model_name="Google Cast Group" model_number="None" model_description="None" manufacturer="Unknown manufacturer" timeout="30.0">
04-18 21:17:54 pulseaudio_dlna.pulseaudio DEBUG
<Bridge>
<PulseSink path="/org/pulseaudio/core1/sink24" label="Speaker Group (Chromecast)" name="speakergroup_chromecast" index="24" module="51">
-- no streams --
<ChromecastRenderer name="Speaker Group" short="speakergroup_chromecast" state="STOPPED" udn="uuid:88e0ee72-c632-44da-b78e-073507b9f80d" model_name="Google Cast Group" model_number="None" model_description="None" manufacturer="Unknown manufacturer" timeout="30.0">
04-18 21:17:54 pulseaudio_dlna.pulseaudio DEBUG
<Bridge>
<PulseSink path="/org/pulseaudio/core1/sink25" label="Living Room (Chromecast)" name="livingroom_chromecast" index="25" module="52">
-- no streams --
<ChromecastRenderer name="Living Room" short="livingroom_chromecast" state="STOPPED" udn="uuid:943e8dfc-eeff-4f56-9727-f94ed1c3cb23" model_name="Google Cast Group" model_number="None" model_description="None" manufacturer="VIZIO" timeout="30.0">
04-18 21:17:54 pulseaudio_dlna.pulseaudio DEBUG
<Bridge>
<PulseSink path="/org/pulseaudio/core1/sink26" label="Living Room TV (Chromecast)" name="livingroomtv_chromecast" index="26" module="53">
-- no streams --
<ChromecastRenderer name="Living Room TV" short="livingroomtv_chromecast" state="STOPPED" udn="uuid:7d4efe19-a7e4-b1e5-923a-cc07a73df5fb" model_name="Chromecast" model_number="None" model_description="None" manufacturer="Unknown manufacturer" timeout="30.0">
04-18 21:17:54 pulseaudio_dlna.pulseaudio INFO _async_handle_sink_update /org/pulseaudio/core1/sink21 finished!
04-18 21:17:57 urllib3.connectionpool DEBUG http://192.168.1.182:8008 "GET /setup/eureka_info?options=detail HTTP/1.1" 200 1323
04-18 21:17:57 pulseaudio_dlna.pulseaudio DEBUG PulseStreamFactory - Could not get "/org/pulseaudio/core1/playback_stream217" from dbus.
04-18 21:17:57 pulseaudio_dlna.pulseaudio DEBUG PulseStreamFactory - Could not get "/org/pulseaudio/core1/playback_stream271" from dbus.
Perhaps give #398 a try.
I was able to test and verify that this commit allowed me to play through to my Chromecast.