I: [pulseaudio] module-stream-restore.c: Restoring device for stream sink-input-by-media-role:music. D: [pulseaudio] module-intended-roles.c: Not setting device for stream Playback Stream, because already set. D: [pulseaudio] sink-input.c: Negotiated format: pcm, format.sample_format = "\"s16le\"" format.channels = "2" format.rate = "44100" format.channel_map = "\"front-left,front-right\"" I: [pulseaudio] module-stream-restore.c: Restoring volume for sink input sink-input-by-media-role:music. I: [pulseaudio] module-stream-restore.c: Restoring mute state for sink input sink-input-by-media-role:music. D: [pulseaudio] module-suspend-on-idle.c: Sink raop_output.Denon-AVR-X1400H--------------.local becomes busy, resuming. D: [pulseaudio] memblockq.c: memblockq requested: maxlength=33554432, tlength=0, base=4, prebuf=0, minreq=1 maxrewind=0 D: [pulseaudio] memblockq.c: memblockq sanitized: maxlength=33554432, tlength=33554432, base=4, prebuf=0, minreq=4 maxrewind=0 I: [pulseaudio] sink-input.c: Created input 1 "Playback Stream" on raop_output.Denon-AVR-X1400H--------------.local with sample spec s16le 2ch 44100Hz and channel map front-left,front-right I: [pulseaudio] sink-input.c: media.name = "Playback Stream" I: [pulseaudio] sink-input.c: application.name = "Lollypop" I: [pulseaudio] sink-input.c: native-protocol.peer = "UNIX socket client" I: [pulseaudio] sink-input.c: native-protocol.version = "32" I: [pulseaudio] sink-input.c: media.role = "music" I: [pulseaudio] sink-input.c: application.icon_name = "org.gnome.Lollypop" I: [pulseaudio] sink-input.c: application.process.id = "3" I: [pulseaudio] sink-input.c: application.process.user = "fina" I: [pulseaudio] sink-input.c: application.process.host = "samarium" I: [pulseaudio] sink-input.c: application.process.binary = "python3.5" I: [pulseaudio] sink-input.c: application.language = "en_US.UTF-8" I: [pulseaudio] sink-input.c: window.x11.display = ":99.0" I: [pulseaudio] sink-input.c: application.process.machine_id = "samarium" I: [pulseaudio] sink-input.c: application.process.session_id = "55" I: [pulseaudio] sink-input.c: module-stream-restore.id = "sink-input-by-media-role:music" I: [pulseaudio] protocol-native.c: Requested tlength=200,00 ms, minreq=10,00 ms D: [pulseaudio] protocol-native.c: Adjust latency mode enabled, configuring sink latency to half of overall latency. D: [pulseaudio] protocol-native.c: Requested latency=90,00 ms, Received latency=250,00 ms D: [pulseaudio] memblockq.c: memblockq requested: maxlength=4194304, tlength=47628, base=4, prebuf=0, minreq=1764 maxrewind=0 D: [pulseaudio] memblockq.c: memblockq sanitized: maxlength=4194304, tlength=47628, base=4, prebuf=0, minreq=1764 maxrewind=0 I: [pulseaudio] protocol-native.c: Final latency 520,00 ms = 250,00 ms + 2*10,00 ms + 250,00 ms D: [raop-sink-[192.168.1.52]:5000] raop-client.c: Can't stream, connection not established yet... D: [raop-sink-[192.168.1.52]:5000] raop-client.c: Can't stream, connection not established yet... D: [raop-sink-[192.168.1.52]:5000] raop-client.c: Can't stream, connection not established yet... D: [raop-sink-[192.168.1.52]:5000] raop-client.c: Can't stream, connection not established yet... D: [pulseaudio] sink-input.c: Sink input 1: proplist[media.name]: (data) -> (data) D: [pulseaudio] sink-input.c: Sink input 1: proplist[media.title]: (unset) -> (data) D: [pulseaudio] sink-input.c: Sink input 1: proplist[media.artist]: (unset) -> (data) D: [pulseaudio] core-subscribe.c: Dropped redundant event due to change event. D: [raop-sink-[192.168.1.52]:5000] raop-client.c: Can't stream, connection not established yet... D: [raop-sink-[192.168.1.52]:5000] raop-client.c: Can't stream, connection not established yet... D: [raop-sink-[192.168.1.52]:5000] raop-client.c: Can't stream, connection not established yet... D: [raop-sink-[192.168.1.52]:5000] raop-client.c: Can't stream, connection not established yet... D: [raop-sink-[192.168.1.52]:5000] raop-client.c: Can't stream, connection not established yet... D: [raop-sink-[192.168.1.52]:5000] raop-client.c: Can't stream, connection not established yet... D: [raop-sink-[192.168.1.52]:5000] raop-client.c: Can't stream, connection not established yet... D: [raop-sink-[192.168.1.52]:5000] raop-client.c: Can't stream, connection not established yet... D: [raop-sink-[192.168.1.52]:5000] raop-client.c: Can't stream, connection not established yet... D: [raop-sink-[192.168.1.52]:5000] raop-client.c: Can't stream, connection not established yet... D: [raop-sink-[192.168.1.52]:5000] protocol-native.c: Requesting rewind due to end of underrun. D: [raop-sink-[192.168.1.52]:5000] protocol-native.c: Requesting rewind due to end of underrun. D: [raop-sink-[192.168.1.52]:5000] protocol-native.c: Requesting rewind due to end of underrun. D: [raop-sink-[192.168.1.52]:5000] protocol-native.c: Requesting rewind due to end of underrun. D: [raop-sink-[192.168.1.52]:5000] protocol-native.c: Requesting rewind due to end of underrun. D: [raop-sink-[192.168.1.52]:5000] protocol-native.c: Requesting rewind due to end of underrun. D: [raop-sink-[192.168.1.52]:5000] protocol-native.c: Requesting rewind due to end of underrun. D: [raop-sink-[192.168.1.52]:5000] protocol-native.c: Requesting rewind due to end of underrun. D: [raop-sink-[192.168.1.52]:5000] protocol-native.c: Requesting rewind due to end of underrun. D: [raop-sink-[192.168.1.52]:5000] protocol-native.c: Requesting rewind due to end of underrun. D: [raop-sink-[192.168.1.52]:5000] raop-client.c: Can't stream, connection not established yet... D: [raop-sink-[192.168.1.52]:5000] protocol-native.c: Requesting rewind due to end of underrun. D: [raop-sink-[192.168.1.52]:5000] sink-input.c: Requesting rewind due to uncorking D: [pulseaudio] module-suspend-on-idle.c: Sink raop_output.Denon-AVR-X1400H--------------.local becomes busy, resuming. D: [raop-sink-[192.168.1.52]:5000] raop-sink.c: RAOP: RUNNING D: [raop-sink-[192.168.1.52]:5000] raop-client.c: Not alive, connection not established yet... D: [raop-sink-[192.168.1.52]:5000] rtsp_client.c: Attempting to connect to server '192.168.1.52:5000' D: [pulseaudio] rtsp_client.c: Established RTSP connection from local ip 192.168.1.110 D: [pulseaudio] raop-client.c: RAOP: CONNECTED D: [pulseaudio] rtsp_client.c: Sending command: ANNOUNCE D: [pulseaudio] rtsp_client.c: Full response received. Dispatching D: [pulseaudio] raop-client.c: RAOP: ANNOUNCE D: [pulseaudio] raop-client.c: Socket bound to port 6001 (SOCK_DGRAM) D: [pulseaudio] raop-client.c: Socket bound to port 6002 (SOCK_DGRAM) D: [pulseaudio] rtsp_client.c: Sending command: SETUP D: [pulseaudio] module-intended-roles.c: Not setting device for stream Peak detect, because already set. D: [pulseaudio] source-output.c: Negotiated format: pcm, format.sample_format = "\"float32le\"" format.rate = "25" format.channels = "1" format.channel_map = "\"mono\"" I: [pulseaudio] source-output.c: Trying to change sample rate I: [pulseaudio] source.c: Cannot update rate, SOURCE_IS_RUNNING, will keep using 44100 Hz D: [pulseaudio] module-suspend-on-idle.c: Sink raop_output.Denon-AVR-X1400H--------------.local becomes busy, resuming. D: [pulseaudio] resampler.c: Resampler: D: [pulseaudio] resampler.c: rate 44100 -> 25 (method peaks) D: [pulseaudio] resampler.c: format s16le -> float32le (intermediate s16le) D: [pulseaudio] resampler.c: channels 2 -> 1 (resampling 1) D: [pulseaudio] resampler.c: Channel matrix: D: [pulseaudio] resampler.c: I00 I01 D: [pulseaudio] resampler.c: +------------ D: [pulseaudio] resampler.c: O00 | 0,500 0,500 I: [pulseaudio] remap.c: Using stereo to mono remapping D: [pulseaudio] memblockq.c: memblockq requested: maxlength=33554432, tlength=0, base=4, prebuf=0, minreq=1 maxrewind=0 D: [pulseaudio] memblockq.c: memblockq sanitized: maxlength=33554432, tlength=33554432, base=4, prebuf=0, minreq=4 maxrewind=0 I: [pulseaudio] source-output.c: Created output 7 "Peak detect" on raop_output.Denon-AVR-X1400H--------------.local.monitor with sample spec float32le 1ch 25Hz and channel map mono I: [pulseaudio] source-output.c: media.name = "Peak detect" I: [pulseaudio] source-output.c: application.name = "PulseAudio Volume Control" I: [pulseaudio] source-output.c: native-protocol.peer = "UNIX socket client" I: [pulseaudio] source-output.c: native-protocol.version = "32" I: [pulseaudio] source-output.c: application.id = "org.PulseAudio.pavucontrol" I: [pulseaudio] source-output.c: application.icon_name = "audio-card" I: [pulseaudio] source-output.c: application.version = "3.0" I: [pulseaudio] source-output.c: application.process.id = "3451" I: [pulseaudio] source-output.c: application.process.user = "fina" I: [pulseaudio] source-output.c: application.process.host = "samarium" I: [pulseaudio] source-output.c: application.process.binary = "pavucontrol" I: [pulseaudio] source-output.c: application.language = "en_US.UTF-8" I: [pulseaudio] source-output.c: window.x11.display = ":0" I: [pulseaudio] source-output.c: application.process.machine_id = "f3a6f7fb71dd4eec975ea359f3587cab" I: [pulseaudio] source-output.c: application.process.session_id = "55" I: [pulseaudio] source-output.c: module-stream-restore.id = "source-output-by-application-id:org.PulseAudio.pavucontrol" D: [pulseaudio] memblockq.c: memblockq requested: maxlength=4194304, tlength=0, base=4, prebuf=1, minreq=0 maxrewind=0 D: [pulseaudio] memblockq.c: memblockq sanitized: maxlength=4194304, tlength=4194304, base=4, prebuf=4, minreq=4 maxrewind=0 I: [pulseaudio] protocol-native.c: Final latency 490,00 ms = 240,00 ms + 250,00 ms D: [pulseaudio] rtsp_client.c: Full response received. Dispatching D: [pulseaudio] raop-client.c: RAOP: SETUP D: [pulseaudio] raop-client.c: Connected to 192.168.1.52 on port 51111 (SOCK_DGRAM) D: [pulseaudio] raop-client.c: Connected to 192.168.1.52 on port 38257 (SOCK_DGRAM) D: [pulseaudio] raop-client.c: Connected to 192.168.1.52 on port 56145 (SOCK_DGRAM) D: [pulseaudio] raop-client.c: Connection established (UDP;control_port=38257;timing_port=56145) D: [pulseaudio] raop-sink.c: State change recieved, informing IO thread... D: [pulseaudio] rtsp_client.c: Sending command: RECORD D: [raop-sink-[192.168.1.52]:5000] raop-client.c: Received UDP timing packet... D: [raop-sink-[192.168.1.52]:5000] raop-client.c: Sending timing packet at 9488541803209278136 D: [raop-sink-[192.168.1.52]:5000] raop-client.c: Received UDP timing packet... D: [raop-sink-[192.168.1.52]:5000] raop-client.c: Sending timing packet at 9488541803213650413 D: [raop-sink-[192.168.1.52]:5000] raop-client.c: Received UDP timing packet... D: [raop-sink-[192.168.1.52]:5000] raop-client.c: Sending timing packet at 9488541803217876661 D: [pulseaudio] rtsp_client.c: Full response received. Dispatching D: [pulseaudio] raop-client.c: RAOP: RECORD D: [pulseaudio] raop-sink.c: State change recieved, informing IO thread... D: [raop-sink-[192.168.1.52]:5000] raop-sink.c: Volume adjusted: orig=17148 adjusted=32449 D: [raop-sink-[192.168.1.52]:5000] raop-sink.c: Requested volume: front-left: 17148 / 26%, front-right: 17148 / 26% D: [raop-sink-[192.168.1.52]:5000] raop-sink.c: Got hardware volume: front-left: 32449 / 50%, front-right: 32449 / 50% D: [raop-sink-[192.168.1.52]:5000] raop-sink.c: Calculated software volume: front-left: 34633 / 53% / -16,62 dB, front-right: 34633 / 53% / -16,62 dB D: [raop-sink-[192.168.1.52]:5000] raop-client.c: volume=32449 db=-18,316717 D: [raop-sink-[192.168.1.52]:5000] rtsp_client.c: Sending command: SET_PARAMETER D: [pulseaudio] rtsp_client.c: Full response received. Dispatching D: [pulseaudio] raop-client.c: RAOP: SET_PARAMETER I: [alsa-source-ALC257 Analog] alsa-source.c: Overrun! I: [alsa-source-ALC257 Analog] alsa-source.c: Increasing wakeup watermark to 35,99 ms I: [alsa-source-ALC257 Analog] alsa-source.c: Overrun! I: [alsa-source-ALC257 Analog] alsa-source.c: Increasing minimal latency to 56,00 ms D: [alsa-source-ALC257 Analog] alsa-source.c: latency set to 56,00ms D: [alsa-source-ALC257 Analog] alsa-source.c: hwbuf_unused=342924 D: [alsa-source-ALC257 Analog] alsa-source.c: setting avail_min=883 D: [raop-sink-[192.168.1.52]:5000] raop-client.c: Received UDP timing packet... D: [raop-sink-[192.168.1.52]:5000] raop-client.c: Sending timing packet at 9488541813291597899