<div dir="ltr"><div>Other observations with the pulseaudio-raop2 git code as of 2014-04-15: </div><div>Tested and works with Fedora 20 and Ubuntu 13.10. </div><div> </div><div>Switching from the Logitech UE Air Speaker (volume set to 30%) to another sink set at 100% causes a brief loud period from the Air Speaker before it cuts out. That does appear to be caused by the RAOP driver resetting the volume just prior to switching over. ( 332.683| 0.000) D: [raop-sink] raop_client.c: Resending 1 packets starting at 8384 ( 332.685| 0.001) D: [raop-sink] module-raop-sink.c: Received control packet. ( 332.685| 0.000) D: [raop-sink] raop_client.c: Resending 1 packets starting at 8385 ( 332.685| 0.000) D: [raop-sink] module-raop-sink.c: Received control packet. ( 332.685| 0.000) D: [raop-sink] raop_client.c: Resending 1 packets starting at 8386 ( 335.107| 2.422) D: [raop-sink] module-raop-sink.c: Received timing packet. ( 337.207| 2.099) D: [raop-sink] module-raop-sink.c: Received timing packet. ( 339.534| 2.327) D: [raop-sink] module-raop-sink.c: Received timing packet. ( 342.034| 2.500) D: [raop-sink] module-raop-sink.c: Received timing packet. ( 342.549| 0.514) D: [raop-sink] module-raop-sink.c: Received control packet. ( 342.549| 0.000) D: [raop-sink] raop_client.c: Resending 1 packets starting at 9638 ( 343.694| 1.145) I: [lt-pulseaudio] source-output.c: Freeing output 4 "Peak detect" ( 343.694| 0.000) D: [lt-pulseaudio] module-raop-sink.c: Volume adjusted: orig=62965 adjusted=63778 ( 343.694| 0.000) D: [lt-pulseaudio] module-raop-sink.c: Requested volume: front-left: 62965 / 96%, front-right: 62965 / 96% ( 343.694| 0.000) D: [lt-pulseaudio] module-raop-sink.c: Got hardware volume: front-left: 63778 / 97%, front-right: 63778 / 97% ( 343.695| 0.000) D: [lt-pulseaudio] module-raop-sink.c: Calculated software volume: front-left: 65536 / 100% / 0.00 dB, front-right: 65536 / 100% / 0.00 dB ( 343.695| 0.000) D: [lt-pulseaudio] raop_client.c: volume=63778 db=-0.708542 ( 343.695| 0.000) D: [lt-pulseaudio] rtsp_client.c: Sending command: SET_PARAMETER ( 343.695| 0.000) D: [raop-sink] sink.c: Requesting rewind due to started move ( 343.695| 0.000) D: [raop-sink] module-raop-sink.c: RAOP: IDLE ( 343.695| 0.000) D: [raop-sink] rtsp_client.c: Sending command: FLUSH ( 343.695| 0.000) I: [lt-pulseaudio] sink-input.c: Trying to change sample rate ( 343.695| 0.000) I: [lt-pulseaudio] sink.c: Cannot update rate, monitor source is RUNNING ( 343.695| 0.000) I: [lt-pulseaudio] protocol-native.c: Requested tlength=200.00 ms, minreq=10.00 ms ( 343.695| 0.000) D: [lt-pulseaudio] protocol-native.c: Adjust latency mode enabled, configuring sink latency to half of overall latency. ( 343.695| 0.000) D: [lt-pulseaudio] protocol-native.c: Requested latency=90.00 ms, Received latency=90.00 ms ( 343.695| 0.000) I: [lt-pulseaudio] resampler.c: Using resampler 'speex-float-1' ( 343.695| 0.000) I: [lt-pulseaudio] resampler.c: Using float32le as working format. ( 343.695| 0.000) I: [lt-pulseaudio] resampler.c: Choosing speex quality setting 1. ( 343.695| 0.000) D: [lt-pulseaudio] memblockq.c: memblockq requested: maxlength=33554432, tlength=0, base=4, prebuf=0, minreq=1 maxrewind=0 ( 343.695| 0.000) D: [lt-pulseaudio] memblockq.c: memblockq sanitized: maxlength=33554432, tlength=33554432, base=4, prebuf=0, minreq=4 maxrewind=0 ( 343.695| 0.000) D: [lt-pulseaudio] sink-input.c: Updated resampler for sink input 2 ( 343.696| 0.000) D: [alsa-sink-HDMI 0] sink.c: Requesting rewind due to finished move ( 343.696| 0.000) D: [alsa-sink-HDMI 0] alsa-sink.c: Latency set to 20.00ms ( 343.696| 0.000) D: [alsa-sink-HDMI 0] alsa-sink.c: hwbuf_unused=62920 ( 343.696| 0.000) D: [alsa-sink-HDMI 0] alsa-sink.c: setting avail_min=16058 ( 343.696| 0.000) D: [alsa-sink-HDMI 0] alsa-sink.c: Requested to rewind 65536 bytes. ( 343.696| 0.000) D: [alsa-sink-HDMI 0] alsa-sink.c: Limited to 2312 bytes. ( 343.696| 0.000) D: [lt-pulseaudio] sink-input.c: Successfully moved sink input 2 to alsa_output.pci-0000_01_00.1.hdmi-stereo. ( 343.696| 0.000) D: [alsa-sink-HDMI 0] alsa-sink.c: before: 578 ( 343.696| 0.000) D: [lt-pulseaudio] module-suspend-on-idle.c: Sink alsa_output.pci-0000_01_00.1.hdmi-stereo becomes busy, resuming. ( 343.696| 0.000) D: [alsa-sink-HDMI 0] alsa-sink.c: after: 578 ( 343.696| 0.000) D: [alsa-sink-HDMI 0] alsa-sink.c: Rewound 2312 bytes. ( 343.696| 0.000) D: [lt-pulseaudio] core-subscribe.c: Dropped redundant event due to change event. </div> The "Builtin Audio Analog Stereo" option is not present with the raop2 branch code. Is that just an omission on my part when building the code or is that a deeper issue? </div><div class="gmail_extra"> <div class="gmail_quote">On Wed, Apr 16, 2014 at 6:43 PM, Toby Haynes <<a href="mailto:tjwhaynes@gmail.com" target="_blank">tjwhaynes@gmail.com</a>> wrote: <blockquote class="gmail_quote" style="margin:0 0 0 .8ex;border-left:1px #ccc solid;padding-left:1ex"> <div dir="ltr"><div> </div><div>Bingo! I've got so used to firewall states behaving properly I forgot to ever consider this as a problem. Feel free to add the Logitech UE Air Speaker to the list of "tested, works" devices. Also if anyone is looking for one of these, <a href="http://tigerdirect.ca" target="_blank">tigerdirect.ca</a> is selling them for less than $100 US (MRSP $390). </div><div>Is there any way to automatically push ports open on via systemd for the firewall? It would be good to detect needed ports and open them up if they are closed. </div><div>Many thanks, </div><div> Toby Haynes </div></div><div class="HOEnZb"><div class="h5"><div class="gmail_extra"> <div class="gmail_quote">On Wed, Apr 16, 2014 at 3:35 PM, Martin Blanchard <<a href="mailto:tchaik@gmx.com" target="_blank">tchaik@gmx.com</a>> wrote: <blockquote class="gmail_quote" style="margin:0 0 0 .8ex;border-left:1px #ccc solid;padding-left:1ex">It seems that you're firewall is blocking UDP traffic on port 6002 and probably on 6001 also. On fedora you can try (as root): # systemctl stop firewalld.service Or something like this: # firewall-cmd --zone=trusted --add-interface=wlp3s0 <div><div> On Tue, 2014-04-15 at 22:58 -0400, Toby Haynes wrote: > I''ve collected network traffic between my Fedora 20 laptop > (192.168.1.109) and the Logitech UE Air Speaker (192.168.1.103) using > > tshark -p -i wlp3s0 -w logitech-ue.pcap host 192.168.1.103 > > > I've also included the output log from pulseaudio-raop2. The two files > can be downloaded using the following links (you should not need to > sign into Google to get them). > > <a href="https://drive.google.com/file/d/0B6e6VZu2JQS-Q2NhVFVBVDFqeTg/edit?usp=sharing" target="_blank">https://drive.google.com/file/d/0B6e6VZu2JQS-Q2NhVFVBVDFqeTg/edit?usp=sharing</a> > <a href="https://drive.google.com/file/d/0B6e6VZu2JQS-TWxSVTdpZFdrYU0/edit?usp=sharing" target="_blank">https://drive.google.com/file/d/0B6e6VZu2JQS-TWxSVTdpZFdrYU0/edit?usp=sharing</a> > > > The capture begins before the pulseaudio-raop2 code is started and > covers starting QuodLibet, ensuring that QuodLibet is using the > Logitech sink and clicking Play in QuodLibet. I'm happy to perform > experiments, hack on the code and use a debugger to step through > code/memory. > > > > I really appreciate any help, > > > Thanks, > Toby Haynes > > > > On Tue, Apr 15, 2014 at 3:15 PM, Martin Blanchard <<a href="mailto:tchaik@gmx.com" target="_blank">tchaik@gmx.com</a>> > wrote: > Hello Toby, > > From what I can read here, the server is responding with '500 > Internal > Server Error' to the rtsp RECORD request sent by pulseaudio. > We may find > quite a lot of reasons to this, and I'm afraid pulseaudio's > log won't be > enough to debug the issue... > > Is it possible to you to dump the network traffic down to a > file while > this is happening ? You can use WireShark [1] for example, > available in > fedora repos. The dump will hopefully help identify the > problem... > > Thanks, > Martin > > [1] <a href="http://www.wireshark.org" target="_blank">http://www.wireshark.org</a> > > On Mon, 2014-04-14 at 22:09 -0400, Toby Haynes wrote: > > I've been trying to get my Logitech UE Air Speaker to > receive audio > > from either of my Fedora 20 or Ubuntu 13.10 installations > (both > > 64bit). The speaker works reasonably with the android app > Streambels > > so I know it is properly associated with the network and > functional. > > > > > > I've compiled the latest git repository from > > <a href="http://hfujita.github.io/pulseaudio-raop2/" target="_blank">hfujita.github.io/pulseaudio-raop2/</a> and run the newly built > > pulseaudio > > > > ./src/pulseaudio -n -F src/<a href="http://default.pa" target="_blank">default.pa</a> -p $(pwd)/src/ > --log-time=1 > > -vvvv 2>&1 | tee pulse.log > > > > > > I can see the Logitech UE Air Speaker in the list of devices > from > > pavucontol and I can select it for the Quod Libet music > player. > > Attempting to start playing a song gets: > > > > ( 333.067| 125.120) D: [raop-sink] protocol-native.c: > Requesting > > rewind due to end of underrun. > > ( 333.067| 0.000) D: [raop-sink] protocol-native.c: > Requesting > > rewind due to end of underrun. > > ( 333.067| 0.000) D: [raop-sink] protocol-native.c: > Requesting > > rewind due to end of underrun. > > ( 333.068| 0.000) D: [raop-sink] protocol-native.c: > Requesting > > rewind due to end of underrun. > > ( 333.068| 0.000) D: [raop-sink] protocol-native.c: > Requesting > > rewind due to end of underrun. > > ( 333.068| 0.000) D: [raop-sink] protocol-native.c: > Requesting > > rewind due to end of underrun. > > ( 333.068| 0.000) D: [raop-sink] protocol-native.c: > Requesting > > rewind due to end of underrun. > > ( 333.068| 0.000) D: [raop-sink] protocol-native.c: > Requesting > > rewind due to end of underrun. > > ( 333.068| 0.000) D: [raop-sink] sink-input.c: Requesting > rewind due > > to uncorking > > ( 333.068| 0.000) D: [lt-pulseaudio] > module-suspend-on-idle.c: Sink > > raop_output.Logitech-UE-Air-Speaker-39DB34.local becomes > busy, > > resuming. > > ( 333.068| 0.000) D: [raop-sink] module-raop-sink.c: RAOP: > RUNNING > > ( 333.068| 0.000) D: [raop-sink] rtsp_client.c: Attempting > to > > connect to server '<a href="http://192.168.1.102:1167" target="_blank">192.168.1.102:1167</a>' > > ( 333.070| 0.001) D: [lt-pulseaudio] rtsp_client.c: > Established RTSP > > connection from local ip 192.168.1.109 > > ( 333.070| 0.000) D: [lt-pulseaudio] rtsp_client.c: > Sending command: > > OPTIONS > > ( 333.073| 0.003) D: [lt-pulseaudio] rtsp_client.c: Full > response > > received. Dispatching > > ( 333.073| 0.000) D: [lt-pulseaudio] raop_client.c: RAOP: > OPTIONS > > ( 333.074| 0.000) D: [lt-pulseaudio] rtsp_client.c: > Sending command: > > ANNOUNCE > > ( 333.078| 0.004) D: [lt-pulseaudio] rtsp_client.c: Full > response > > received. Dispatching > > ( 333.078| 0.000) D: [lt-pulseaudio] raop_client.c: Socket > bound to > > port 6001 (SOCK_DGRAM) > > ( 333.078| 0.000) D: [lt-pulseaudio] raop_client.c: Socket > bound to > > port 6002 (SOCK_DGRAM) > > ( 333.078| 0.000) D: [lt-pulseaudio] rtsp_client.c: > Sending command: > > SETUP > > ( 334.075| 0.996) D: [lt-pulseaudio] rtsp_client.c: Full > response > > received. Dispatching > > ( 334.075| 0.000) D: [lt-pulseaudio] raop_client.c: RAOP: > SETUP > > ( 334.075| 0.000) D: [lt-pulseaudio] raop_client.c: Using > > server_port=1324, control_port=1325 & timing_port=1326 > > ( 334.075| 0.000) D: [lt-pulseaudio] raop_client.c: > Connected to > > 192.168.1.102 on port 1324 (SOCK_DGRAM) > > ( 334.075| 0.000) D: [lt-pulseaudio] raop_client.c: > Connected to > > 192.168.1.102 on port 1325 (SOCK_DGRAM) > > ( 334.075| 0.000) D: [lt-pulseaudio] raop_client.c: > Connected to > > 192.168.1.102 on port 1326 (SOCK_DGRAM) > > ( 334.075| 0.000) D: [lt-pulseaudio] module-raop-sink.c: > Connection > > authenticated, syncing with server... > > ( 334.075| 0.000) D: [lt-pulseaudio] rtsp_client.c: > Sending command: > > RECORD > > ( 335.582| 1.506) W: [lt-pulseaudio] rtsp_client.c: > Unexpected > > response: RTSP/1.0 500 Internal Server Error > > ( 335.582| 0.000) W: [lt-pulseaudio] rtsp_client.c: > Unexpected > > response: Server: AirTunes/103.2 > > ( 335.582| 0.000) W: [lt-pulseaudio] rtsp_client.c: > Unexpected > > response: CSeq: 4 > > ( 335.582| 0.000) W: [lt-pulseaudio] rtsp_client.c: > Unexpected > > response: > > > > > > and the song stays at position 0.00. Pausing the song gets > > > > ( 970.603| 635.021) D: [raop-sink] protocol-native.c: > Requesting > > rewind due to end of underrun. > > ( 970.603| 0.000) D: [raop-sink] sink-input.c: Requesting > rewind due > > to corking > > ( 970.603| 0.000) D: [raop-sink] module-raop-sink.c: RAOP: > IDLE > > ( 970.603| 0.000) D: [raop-sink] rtsp_client.c: Sending > command: > > FLUSH > > ( 970.603| 0.000) D: [lt-pulseaudio] > module-suspend-on-idle.c: Sink > > raop_output.Logitech-UE-Air-Speaker-39DB34.local becomes > idle, timeout > > in 5 seconds. > > ( 971.447| 0.844) W: [lt-pulseaudio] rtsp_client.c: > Unexpected > > response: RTSP/1.0 455 Method Not Valid In This State > > ( 971.447| 0.000) W: [lt-pulseaudio] rtsp_client.c: > Unexpected > > response: Server: AirTunes/103.2 > > ( 971.447| 0.000) W: [lt-pulseaudio] rtsp_client.c: > Unexpected > > response: CSeq: 5 > > ( 971.447| 0.000) W: [lt-pulseaudio] rtsp_client.c: > Unexpected > > response: > > ( 975.604| 4.156) I: [lt-pulseaudio] > module-suspend-on-idle.c: Sink > > raop_output.Logitech-UE-Air-Speaker-39DB34.local idle for > too long, > > suspending ... > > ( 975.604| 0.000) D: [lt-pulseaudio] sink.c: Suspend cause > of sink > > raop_output.Logitech-UE-Air-Speaker-39DB34.local is 0x0004, > suspending > > ( 975.604| 0.000) D: [raop-sink] module-raop-sink.c: RAOP: > SUSPENDED > > ( 975.604| 0.000) D: [raop-sink] rtsp_client.c: Sending > command: > > TEARDOWN > > ( 975.604| 0.000) I: [lt-pulseaudio] core.c: All sinks and > sources > > are suspended, vacuuming memory > > ( 975.617| 0.012) D: [lt-pulseaudio] rtsp_client.c: Full > response > > received. Dispatching > > ( 975.617| 0.000) D: [lt-pulseaudio] raop_client.c: RAOP: > TEARDOWN > > ( 975.617| 0.000) D: [lt-pulseaudio] raop_client.c: RTSP > control > > channel closed (teardown) > > ( 975.617| 0.000) D: [lt-pulseaudio] module-raop-sink.c: > Connection > > closed, informing IO thread... > > > > > > Attempting to play again gets the same issue. > > > > > > Double clicking on a new track however looks like it is > actually > > workin - however, no sound is heard from the Air Speaker. > Manually > > adjusting the volume on the speaker has no impact. > > > > (1010.990| 7.400) D: [raop-sink] protocol-native.c: > Requesting > > rewind due to end of underrun. > > (1010.990| 0.000) D: [raop-sink] sink-input.c: Requesting > rewind due > > to corking > > (1010.990| 0.000) D: [raop-sink] module-raop-sink.c: RAOP: > IDLE > > (1010.990| 0.000) D: [raop-sink] rtsp_client.c: Sending > command: > > FLUSH > > (1010.990| 0.000) D: [lt-pulseaudio] > module-suspend-on-idle.c: Sink > > raop_output.Logitech-UE-Air-Speaker-39DB34.local becomes > idle, timeout > > in 5 seconds. > > (1010.991| 0.001) D: [lt-pulseaudio] module-raop-sink.c: > Volume > > adjusted: orig=99957 adjusted=89072 > > (1010.991| 0.000) D: [lt-pulseaudio] module-raop-sink.c: > Requested > > volume: front-left: 99957 / 153%, front-right: 99957 / > 153% > > (1010.991| 0.000) D: [lt-pulseaudio] module-raop-sink.c: > Got > > hardware volume: front-left: 89072 / 136%, front-right: > 89072 / 136% > > (1010.991| 0.000) D: [lt-pulseaudio] module-raop-sink.c: > Calculated > > software volume: front-left: 65536 / 100% / 0.00 dB, > front-right: > > 65536 / 100% / 0.00 dB > > (1010.991| 0.000) D: [lt-pulseaudio] raop_client.c: > volume=89072 > > db=0.000000 > > (1010.991| 0.000) D: [lt-pulseaudio] rtsp_client.c: > Sending command: > > SET_PARAMETER > > (1010.991| 0.000) D: [lt-pulseaudio] > module-suspend-on-idle.c: Sink > > raop_output.Logitech-UE-Air-Speaker-39DB34.local becomes > idle, timeout > > in 5 seconds. > > (1010.991| 0.000) D: [lt-pulseaudio] core.c: Hmm, no > streams around, > > trying to vacuum. > > (1010.991| 0.000) I: [lt-pulseaudio] sink-input.c: Freeing > input 1 > > "'Shame for You' by 'Lily Allen'" > > (1010.991| 0.000) I: [lt-pulseaudio] client.c: Freed 3 > "Quod Libet" > > (1010.991| 0.000) I: [lt-pulseaudio] protocol-native.c: > Connection > > died. > > (1010.994| 0.002) W: [lt-pulseaudio] rtsp_client.c: > Unexpected > > response: RTSP/1.0 455 Method Not Valid In This State > > (1010.994| 0.000) W: [lt-pulseaudio] rtsp_client.c: > Unexpected > > response: Server: AirTunes/103.2 > > (1010.994| 0.000) W: [lt-pulseaudio] rtsp_client.c: > Unexpected > > response: CSeq: 5 > > (1010.994| 0.000) W: [lt-pulseaudio] rtsp_client.c: > Unexpected > > response: > > (1010.997| 0.002) I: [lt-pulseaudio] client.c: Created 4 > "Native > > client (UNIX socket client)" > > (1010.997| 0.000) D: [lt-pulseaudio] protocol-native.c: > Protocol > > version: remote 29, local 29 > > (1010.997| 0.000) I: [lt-pulseaudio] protocol-native.c: > Got > > credentials: uid=1000 gid=1000 success=1 > > (1010.997| 0.000) D: [lt-pulseaudio] protocol-native.c: > SHM > > possible: yes > > (1010.997| 0.000) D: [lt-pulseaudio] protocol-native.c: > Negotiated > > SHM: yes > > (1010.997| 0.000) D: [lt-pulseaudio] > module-augment-properties.c: > > Looking for .desktop file for python2.7 > > (1010.998| 0.001) D: [lt-pulseaudio] rtsp_client.c: Full > response > > received. Dispatching > > (1010.998| 0.000) D: [lt-pulseaudio] raop_client.c: RAOP: > > SET_PARAMETER > > (1011.076| 0.077) I: [lt-pulseaudio] > module-stream-restore.c: > > Restoring device for stream sink-input-by-media-role:music. > > (1011.076| 0.000) D: [lt-pulseaudio] > module-intended-roles.c: Not > > setting device for stream pulsesink probe, because already > set. > > (1011.076| 0.000) D: [lt-pulseaudio] sink-input.c: > Negotiated > > format: pcm, format.sample_format = "\"s16le\"" format.rate > = "44100" > > format.channels = "2" > > (1011.076| 0.000) I: [lt-pulseaudio] > module-stream-restore.c: > > Restoring volume for sink input > sink-input-by-media-role:music. > > (1011.076| 0.000) I: [lt-pulseaudio] > module-stream-restore.c: > > Restoring mute state for sink input > sink-input-by-media-role:music. > > (1011.076| 0.000) D: [lt-pulseaudio] > module-suspend-on-idle.c: Sink > > raop_output.Logitech-UE-Air-Speaker-39DB34.local becomes > busy, > > resuming. > > (1011.076| 0.000) D: [lt-pulseaudio] memblockq.c: > memblockq > > requested: maxlength=33554432, tlength=0, base=4, prebuf=0, > minreq=1 > > maxrewind=0 > > (1011.076| 0.000) D: [lt-pulseaudio] memblockq.c: > memblockq > > sanitized: maxlength=33554432, tlength=33554432, base=4, > prebuf=0, > > minreq=4 maxrewind=0 > > (1011.076| 0.000) I: [lt-pulseaudio] sink-input.c: Created > input 2 > > "pulsesink probe" on > raop_output.Logitech-UE-Air-Speaker-39DB34.local > > with sample spec s16le 2ch 44100Hz and channel map > > front-left,front-right > > (1011.076| 0.000) I: [lt-pulseaudio] sink-input.c: > <a href="http://media.name" target="_blank">media.name</a> = > > "pulsesink probe" > > (1011.076| 0.000) I: [lt-pulseaudio] sink-input.c: > > <a href="http://application.name" target="_blank">application.name</a> = "Quod Libet" > > (1011.076| 0.000) I: [lt-pulseaudio] sink-input.c: > > native-protocol.peer = "UNIX socket client" > > (1011.076| 0.000) I: [lt-pulseaudio] sink-input.c: > > native-protocol.version = "29" > > (1011.076| 0.000) I: [lt-pulseaudio] sink-input.c: > media.role = > > "music" > > (1011.076| 0.000) I: [lt-pulseaudio] sink-input.c: > > application.icon_name = "quodlibet" > > (1011.076| 0.000) I: [lt-pulseaudio] sink-input.c: > > <a href="http://application.process.id" target="_blank">application.process.id</a> = "19885" > > (1011.076| 0.000) I: [lt-pulseaudio] sink-input.c: > > application.process.user = "thaynes" > > (1011.076| 0.000) I: [lt-pulseaudio] sink-input.c: > > application.process.host = "<a href="http://nexus6.torolab.ibm.com" target="_blank">nexus6.torolab.ibm.com</a>" > > (1011.076| 0.000) I: [lt-pulseaudio] sink-input.c: > > application.process.binary = "python2.7" > > (1011.076| 0.000) I: [lt-pulseaudio] sink-input.c: > > application.language = "en_US.utf8" > > (1011.076| 0.000) I: [lt-pulseaudio] sink-input.c: > > window.x11.display = ":0" > > (1011.076| 0.000) I: [lt-pulseaudio] sink-input.c: > > application.process.machine_id = > "dd52b532d0cb43738efff1f3e90d00f2" > > (1011.076| 0.000) I: [lt-pulseaudio] sink-input.c: > > application.process.session_id = "4" > > (1011.076| 0.000) I: [lt-pulseaudio] sink-input.c: > > <a href="http://module-stream-restore.id" target="_blank">module-stream-restore.id</a> = "sink-input-by-media-role:music" > > (1011.076| 0.000) I: [lt-pulseaudio] protocol-native.c: > Requested > > tlength=272.11 ms, minreq=20.00 ms > > (1011.076| 0.000) D: [lt-pulseaudio] protocol-native.c: > Adjust > > latency mode enabled, configuring sink latency to half of > overall > > latency. > > (1011.076| 0.000) D: [lt-pulseaudio] protocol-native.c: > Requested > > latency=116.05 ms, Received latency=250.00 ms > > (1011.076| 0.000) D: [lt-pulseaudio] memblockq.c: > memblockq > > requested: maxlength=4194304, tlength=51156, base=4, > prebuf=47632, > > minreq=3528 maxrewind=0 > > (1011.076| 0.000) D: [lt-pulseaudio] memblockq.c: > memblockq > > sanitized: maxlength=4194304, tlength=51156, base=4, > prebuf=47632, > > minreq=3528 maxrewind=0 > > (1011.076| 0.000) I: [lt-pulseaudio] protocol-native.c: > Final > > latency 540.00 ms = 250.00 ms + 2*20.00 ms + 250.00 ms > > (1011.076| 0.000) D: [lt-pulseaudio] module-raop-sink.c: > Volume > > adjusted: orig=66683 adjusted=66320 > > (1011.076| 0.000) D: [lt-pulseaudio] module-raop-sink.c: > Requested > > volume: front-left: 66683 / 102%, front-right: 66683 / > 102% > > (1011.076| 0.000) D: [lt-pulseaudio] module-raop-sink.c: > Got > > hardware volume: front-left: 66320 / 101%, front-right: > 66320 / 101% > > (1011.076| 0.000) D: [lt-pulseaudio] module-raop-sink.c: > Calculated > > software volume: front-left: 65536 / 100% / 0.00 dB, > front-right: > > 65536 / 100% / 0.00 dB > > (1011.076| 0.000) D: [lt-pulseaudio] raop_client.c: > volume=66320 > > db=0.000000 > > (1011.076| 0.000) D: [lt-pulseaudio] rtsp_client.c: > Sending command: > > SET_PARAMETER > > (1011.080| 0.003) D: [lt-pulseaudio] rtsp_client.c: Full > response > > received. Dispatching > > (1011.080| 0.000) D: [lt-pulseaudio] raop_client.c: RAOP: > > SET_PARAMETER > > (1011.217| 0.136) D: [lt-pulseaudio] module-raop-sink.c: > Volume > > adjusted: orig=99957 adjusted=89072 > > (1011.217| 0.000) D: [lt-pulseaudio] module-raop-sink.c: > Requested > > volume: front-left: 99957 / 153%, front-right: 99957 / > 153% > > (1011.217| 0.000) D: [lt-pulseaudio] module-raop-sink.c: > Got > > hardware volume: front-left: 89072 / 136%, front-right: > 89072 / 136% > > (1011.217| 0.000) D: [lt-pulseaudio] module-raop-sink.c: > Calculated > > software volume: front-left: 65536 / 100% / 0.00 dB, > front-right: > > 65536 / 100% / 0.00 dB > > (1011.217| 0.000) D: [lt-pulseaudio] raop_client.c: > volume=89072 > > db=0.000000 > > (1011.217| 0.000) D: [lt-pulseaudio] rtsp_client.c: > Sending command: > > SET_PARAMETER > > (1011.217| 0.000) D: [lt-pulseaudio] > module-suspend-on-idle.c: Sink > > raop_output.Logitech-UE-Air-Speaker-39DB34.local becomes > idle, timeout > > in 5 seconds. > > (1011.217| 0.000) D: [lt-pulseaudio] core.c: Hmm, no > streams around, > > trying to vacuum. > > (1011.218| 0.000) I: [lt-pulseaudio] sink-input.c: Freeing > input 2 > > "pulsesink probe" > > (1011.218| 0.000) I: [lt-pulseaudio] > module-stream-restore.c: > > Restoring device for stream sink-input-by-media-role:music. > > (1011.218| 0.000) D: [lt-pulseaudio] > module-intended-roles.c: Not > > setting device for stream Playback Stream, because already > set. > > (1011.218| 0.000) D: [lt-pulseaudio] sink-input.c: > Negotiated > > format: pcm, format.sample_format = "\"s16le\"" > format.channels = "2" > > format.rate = "48000" format.channel_map = > "\"front-left,front-right > > \"" > > (1011.218| 0.000) I: [lt-pulseaudio] sink-input.c: Trying > to change > > sample rate > > (1011.218| 0.000) I: [lt-pulseaudio] > module-stream-restore.c: > > Restoring volume for sink input > sink-input-by-media-role:music. > > (1011.218| 0.000) I: [lt-pulseaudio] > module-stream-restore.c: > > Restoring mute state for sink input > sink-input-by-media-role:music. > > (1011.218| 0.000) D: [lt-pulseaudio] > module-suspend-on-idle.c: Sink > > raop_output.Logitech-UE-Air-Speaker-39DB34.local becomes > busy, > > resuming. > > (1011.218| 0.000) I: [lt-pulseaudio] resampler.c: Using > resampler > > 'speex-float-1' > > (1011.218| 0.000) I: [lt-pulseaudio] resampler.c: Using > float32le as > > working format. > > (1011.218| 0.000) I: [lt-pulseaudio] resampler.c: Choosing > speex > > quality setting 1. > > (1011.218| 0.000) D: [lt-pulseaudio] memblockq.c: > memblockq > > requested: maxlength=33554432, tlength=0, base=4, prebuf=0, > minreq=1 > > maxrewind=0 > > (1011.218| 0.000) D: [lt-pulseaudio] memblockq.c: > memblockq > > sanitized: maxlength=33554432, tlength=33554432, base=4, > prebuf=0, > > minreq=4 maxrewind=0 > > (1011.218| 0.000) I: [lt-pulseaudio] sink-input.c: Created > input 3 > > "Playback Stream" on > raop_output.Logitech-UE-Air-Speaker-39DB34.local > > with sample spec s16le 2ch 48000Hz and channel map > > front-left,front-right > > (1011.218| 0.000) I: [lt-pulseaudio] sink-input.c: > <a href="http://media.name" target="_blank">media.name</a> = > > "Playback Stream" > > (1011.218| 0.000) I: [lt-pulseaudio] sink-input.c: > > <a href="http://application.name" target="_blank">application.name</a> = "Quod Libet" > > (1011.218| 0.000) I: [lt-pulseaudio] sink-input.c: > > native-protocol.peer = "UNIX socket client" > > (1011.218| 0.000) I: [lt-pulseaudio] sink-input.c: > > native-protocol.version = "29" > > (1011.218| 0.000) I: [lt-pulseaudio] sink-input.c: > media.role = > > "music" > > (1011.218| 0.000) I: [lt-pulseaudio] sink-input.c: > > application.icon_name = "quodlibet" > > (1011.218| 0.000) I: [lt-pulseaudio] sink-input.c: > > <a href="http://application.process.id" target="_blank">application.process.id</a> = "19885" > > (1011.218| 0.000) I: [lt-pulseaudio] sink-input.c: > > application.process.user = "thaynes" > > (1011.218| 0.000) I: [lt-pulseaudio] sink-input.c: > > application.process.host = "<a href="http://nexus6.torolab.ibm.com" target="_blank">nexus6.torolab.ibm.com</a>" > > (1011.218| 0.000) I: [lt-pulseaudio] sink-input.c: > > application.process.binary = "python2.7" > > (1011.218| 0.000) I: [lt-pulseaudio] sink-input.c: > > application.language = "en_US.utf8" > > (1011.218| 0.000) I: [lt-pulseaudio] sink-input.c: > > window.x11.display = ":0" > > (1011.218| 0.000) I: [lt-pulseaudio] sink-input.c: > > application.process.machine_id = > "dd52b532d0cb43738efff1f3e90d00f2" > > (1011.218| 0.000) I: [lt-pulseaudio] sink-input.c: > > application.process.session_id = "4" > > (1011.218| 0.000) I: [lt-pulseaudio] sink-input.c: > > <a href="http://module-stream-restore.id" target="_blank">module-stream-restore.id</a> = "sink-input-by-media-role:music" > > (1011.218| 0.000) I: [lt-pulseaudio] protocol-native.c: > Requested > > tlength=200.00 ms, minreq=10.00 ms > > (1011.218| 0.000) D: [lt-pulseaudio] protocol-native.c: > Adjust > > latency mode enabled, configuring sink latency to half of > overall > > latency. > > (1011.218| 0.000) D: [lt-pulseaudio] protocol-native.c: > Requested > > latency=90.00 ms, Received latency=250.00 ms > > (1011.218| 0.000) D: [lt-pulseaudio] memblockq.c: > memblockq > > requested: maxlength=4194304, tlength=51840, base=4, > prebuf=0, > > minreq=1920 maxrewind=0 > > (1011.218| 0.000) D: [lt-pulseaudio] memblockq.c: > memblockq > > sanitized: maxlength=4194304, tlength=51840, base=4, > prebuf=0, > > minreq=1920 maxrewind=0 > > (1011.219| 0.000) I: [lt-pulseaudio] protocol-native.c: > Final > > latency 520.00 ms = 250.00 ms + 2*10.00 ms + 250.00 ms > > (1011.219| 0.000) D: [lt-pulseaudio] module-raop-sink.c: > Volume > > adjusted: orig=66683 adjusted=66320 > > (1011.219| 0.000) D: [lt-pulseaudio] module-raop-sink.c: > Requested > > volume: front-left: 66683 / 102%, front-right: 66683 / > 102% > > (1011.219| 0.000) D: [lt-pulseaudio] module-raop-sink.c: > Got > > hardware volume: front-left: 66320 / 101%, front-right: > 66320 / 101% > > (1011.219| 0.000) D: [lt-pulseaudio] module-raop-sink.c: > Calculated > > software volume: front-left: 65536 / 100% / 0.00 dB, > front-right: > > 65536 / 100% / 0.00 dB > > (1011.219| 0.000) D: [lt-pulseaudio] raop_client.c: > volume=66320 > > db=0.000000 > > (1011.219| 0.000) D: [lt-pulseaudio] rtsp_client.c: > Sending command: > > SET_PARAMETER > > (1011.221| 0.002) D: [raop-sink] protocol-native.c: > Requesting > > rewind due to end of underrun. > > (1011.221| 0.000) D: [raop-sink] protocol-native.c: > Requesting > > rewind due to end of underrun. > > (1011.221| 0.000) D: [raop-sink] protocol-native.c: > Requesting > > rewind due to end of underrun. > > (1011.221| 0.000) D: [raop-sink] protocol-native.c: > Requesting > > rewind due to end of underrun. > > (1011.221| 0.000) D: [raop-sink] protocol-native.c: > Requesting > > rewind due to end of underrun. > > (1011.222| 0.000) D: [raop-sink] protocol-native.c: > Requesting > > rewind due to end of underrun. > > (1011.222| 0.000) D: [raop-sink] protocol-native.c: > Requesting > > rewind due to end of underrun. > > (1011.222| 0.000) D: [raop-sink] protocol-native.c: > Requesting > > rewind due to end of underrun. > > (1011.222| 0.000) D: [raop-sink] protocol-native.c: > Requesting > > rewind due to end of underrun. > > (1011.222| 0.000) D: [raop-sink] protocol-native.c: > Requesting > > rewind due to end of underrun. > > (1011.222| 0.000) D: [raop-sink] protocol-native.c: > Requesting > > rewind due to end of underrun. > > (1011.222| 0.000) D: [raop-sink] protocol-native.c: > Requesting > > rewind due to end of underrun. > > (1011.222| 0.000) D: [raop-sink] protocol-native.c: > Requesting > > rewind due to end of underrun. > > (1011.222| 0.000) D: [raop-sink] protocol-native.c: > Requesting > > rewind due to end of underrun. > > (1011.222| 0.000) D: [raop-sink] protocol-native.c: > Requesting > > rewind due to end of underrun. > > (1011.222| 0.000) D: [raop-sink] sink-input.c: Requesting > rewind due > > to uncorking > > (1011.222| 0.000) D: [lt-pulseaudio] > module-suspend-on-idle.c: Sink > > raop_output.Logitech-UE-Air-Speaker-39DB34.local becomes > busy, > > resuming. > > (1011.222| 0.000) D: [raop-sink] module-raop-sink.c: RAOP: > RUNNING > > (1011.947| 0.725) D: [lt-pulseaudio] rtsp_client.c: Full > response > > received. Dispatching > > (1011.947| 0.000) D: [lt-pulseaudio] raop_client.c: RAOP: > > SET_PARAMETER > > (1011.947| 0.000) D: [lt-pulseaudio] rtsp_client.c: Full > response > > received. Dispatching > > (1011.947| 0.000) D: [lt-pulseaudio] raop_client.c: RAOP: > > SET_PARAMETER > > (1012.788| 0.840) D: [raop-sink] module-raop-sink.c: > Received > > control packet. > > (1012.788| 0.000) D: [raop-sink] raop_client.c: Resending > 1 packets > > starting at 47073 > > (1021.737| 8.949) D: [raop-sink] module-raop-sink.c: > Received > > control packet. > > (1021.738| 0.000) D: [raop-sink] raop_client.c: Resending > 1 packets > > starting at 48180 > > (1021.738| 0.000) D: [raop-sink] module-raop-sink.c: > Received > > control packet. > > (1021.738| 0.000) D: [raop-sink] raop_client.c: Resending > 1 packets > > starting at 48181 > > (1021.745| 0.007) D: [raop-sink] module-raop-sink.c: > Received > > control packet. > > (1021.745| 0.000) D: [raop-sink] raop_client.c: Resending > 1 packets > > starting at 48182 > > (1021.746| 0.001) D: [raop-sink] module-raop-sink.c: > Received > > control packet. > > (1021.747| 0.000) D: [raop-sink] raop_client.c: Resending > 1 packets > > starting at 48183 > > (1021.752| 0.005) D: [raop-sink] module-raop-sink.c: > Received > > control packet. > > > > > > I'm looking for suggestions for next diagnostic steps. Any > help is > > much appreciated. > > > > Thanks, > > Toby Haynes > > > > > _______________________________________________ > > pulseaudio-discuss mailing list > > <a href="mailto:pulseaudio-discuss@lists.freedesktop.org" target="_blank">pulseaudio-discuss@lists.freedesktop.org</a> > > > <a href="http://lists.freedesktop.org/mailman/listinfo/pulseaudio-discuss" target="_blank">http://lists.freedesktop.org/mailman/listinfo/pulseaudio-discuss</a> > > > _______________________________________________ > pulseaudio-discuss mailing list > <a href="mailto:pulseaudio-discuss@lists.freedesktop.org" target="_blank">pulseaudio-discuss@lists.freedesktop.org</a> > <a href="http://lists.freedesktop.org/mailman/listinfo/pulseaudio-discuss" target="_blank">http://lists.freedesktop.org/mailman/listinfo/pulseaudio-discuss</a> > > > > _______________________________________________ > pulseaudio-discuss mailing list > <a href="mailto:pulseaudio-discuss@lists.freedesktop.org" target="_blank">pulseaudio-discuss@lists.freedesktop.org</a> > <a href="http://lists.freedesktop.org/mailman/listinfo/pulseaudio-discuss" target="_blank">http://lists.freedesktop.org/mailman/listinfo/pulseaudio-discuss</a> </div></div> _______________________________________________ pulseaudio-discuss mailing list <a href="mailto:pulseaudio-discuss@lists.freedesktop.org" target="_blank">pulseaudio-discuss@lists.freedesktop.org</a> <a href="http://lists.freedesktop.org/mailman/listinfo/pulseaudio-discuss" target="_blank">http://lists.freedesktop.org/mailman/listinfo/pulseaudio-discuss</a> </blockquote></div> </div> </div></div></blockquote></div> </div>