Skip to content

Instantly share code, notes, and snippets.

@vDorst
Created May 20, 2014 08:07
Show Gist options
  • Save vDorst/89a333a63b773c3f8815 to your computer and use it in GitHub Desktop.
Save vDorst/89a333a63b773c3f8815 to your computer and use it in GitHub Desktop.
Denon AVR2312 RAOP2 log 2
N: [lt-pulseaudio] daemon-conf.c: Detected that we are run from the build tree, fixing search path.
( 0.000| 0.000) I: [lt-pulseaudio] main.c: setrlimit(RLIMIT_NICE, (31, 31)) failed: Operation not permitted
( 0.000| 0.000) I: [lt-pulseaudio] main.c: setrlimit(RLIMIT_RTPRIO, (9, 9)) failed: Operation not permitted
( 0.000| 0.000) D: [lt-pulseaudio] core-rtclock.c: Timer slack is set to 50 us.
( 0.025| 0.025) I: [lt-pulseaudio] core-util.c: Failed to acquire high-priority scheduling: Permission denied
( 0.025| 0.000) I: [lt-pulseaudio] main.c: This is PulseAudio 5.0-38-g60a2
( 0.025| 0.000) D: [lt-pulseaudio] main.c: Compilation host: x86_64-unknown-linux-gnu
( 0.025| 0.000) D: [lt-pulseaudio] main.c: Compilation CFLAGS: -ggdb3 -O0 -Wall -W -Wextra -pipe -Wno-long-long -Wno-overlength-strings -Wunsafe-loop-optimizations -Wundef -Wformat=2 -Wlogical-op -Wsign-compare -Wformat-security -Wmissing-include-dirs -Wformat-nonliteral -Wpointer-arith -Winit-self -Wdeclaration-after-statement -Wfloat-equal -Wmissing-prototypes -Wredundant-decls -Wmissing-declarations -Wmissing-noreturn -Wshadow -Wendif-labels -Wcast-align -Wstrict-aliasing -Wwrite-strings -Wno-unused-parameter -ffast-math -fno-common -fdiagnostics-show-option
( 0.025| 0.000) D: [lt-pulseaudio] main.c: Running on host: Linux x86_64 3.13.0-24-generic #47-Ubuntu SMP Fri May 2 23:30:00 UTC 2014
( 0.025| 0.000) D: [lt-pulseaudio] main.c: Found 2 CPUs.
( 0.025| 0.000) I: [lt-pulseaudio] main.c: Page size is 4096 bytes
( 0.025| 0.000) D: [lt-pulseaudio] main.c: Compiled with Valgrind support: yes
( 0.025| 0.000) D: [lt-pulseaudio] main.c: Running in valgrind mode: no
( 0.025| 0.000) D: [lt-pulseaudio] main.c: Running in VM: no
( 0.025| 0.000) D: [lt-pulseaudio] main.c: Optimized build: no
( 0.025| 0.000) D: [lt-pulseaudio] main.c: All asserts enabled.
( 0.025| 0.000) I: [lt-pulseaudio] main.c: Machine ID is Thirsty.
( 0.025| 0.000) I: [lt-pulseaudio] main.c: Session ID is 15.
( 0.025| 0.000) E: [lt-pulseaudio] core-util.c: Failed to create secure directory (/run/user/1006/pulse): Permission denied
cubox@Thirsty:/usr/src/raop2$ ^C
cubox@Thirsty:/usr/src/raop2$ ./src/pulseaudio -n -F src/default.pa -p $(pwd)/src/ --log-time=1 -vvvv 2>&1 | tee ~/pulse.log
N: [lt-pulseaudio] daemon-conf.c: Detected that we are run from the build tree, fixing search path.
( 0.000| 0.000) I: [lt-pulseaudio] main.c: setrlimit(RLIMIT_NICE, (31, 31)) failed: Operation not permitted
( 0.000| 0.000) I: [lt-pulseaudio] main.c: setrlimit(RLIMIT_RTPRIO, (9, 9)) failed: Operation not permitted
( 0.000| 0.000) D: [lt-pulseaudio] core-rtclock.c: Timer slack is set to 50 us.
( 0.027| 0.027) I: [lt-pulseaudio] core-util.c: Failed to acquire high-priority scheduling: Permission denied
( 0.027| 0.000) I: [lt-pulseaudio] main.c: This is PulseAudio 5.0-38-g60a2
( 0.027| 0.000) D: [lt-pulseaudio] main.c: Compilation host: x86_64-unknown-linux-gnu
( 0.027| 0.000) D: [lt-pulseaudio] main.c: Compilation CFLAGS: -ggdb3 -O0 -Wall -W -Wextra -pipe -Wno-long-long -Wno-overlength-strings -Wunsafe-loop-optimizations -Wundef -Wformat=2 -Wlogical-op -Wsign-compare -Wformat-security -Wmissing-include-dirs -Wformat-nonliteral -Wpointer-arith -Winit-self -Wdeclaration-after-statement -Wfloat-equal -Wmissing-prototypes -Wredundant-decls -Wmissing-declarations -Wmissing-noreturn -Wshadow -Wendif-labels -Wcast-align -Wstrict-aliasing -Wwrite-strings -Wno-unused-parameter -ffast-math -fno-common -fdiagnostics-show-option
( 0.027| 0.000) D: [lt-pulseaudio] main.c: Running on host: Linux x86_64 3.13.0-24-generic #47-Ubuntu SMP Fri May 2 23:30:00 UTC 2014
( 0.027| 0.000) D: [lt-pulseaudio] main.c: Found 2 CPUs.
( 0.027| 0.000) I: [lt-pulseaudio] main.c: Page size is 4096 bytes
( 0.027| 0.000) D: [lt-pulseaudio] main.c: Compiled with Valgrind support: yes
( 0.027| 0.000) D: [lt-pulseaudio] main.c: Running in valgrind mode: no
( 0.027| 0.000) D: [lt-pulseaudio] main.c: Running in VM: no
( 0.027| 0.000) D: [lt-pulseaudio] main.c: Optimized build: no
( 0.027| 0.000) D: [lt-pulseaudio] main.c: All asserts enabled.
( 0.027| 0.000) I: [lt-pulseaudio] main.c: Machine ID is Thirsty.
( 0.027| 0.000) I: [lt-pulseaudio] main.c: Session ID is 15.
( 0.027| 0.000) I: [lt-pulseaudio] main.c: Using runtime directory /run/user/1006/pulse.
( 0.028| 0.000) I: [lt-pulseaudio] main.c: Using state directory /home/cubox/.pulse.
( 0.028| 0.000) I: [lt-pulseaudio] main.c: Using modules directory /usr/src/raop2/src/.
( 0.028| 0.000) I: [lt-pulseaudio] main.c: Running in system mode: no
( 0.028| 0.000) W: [lt-pulseaudio] pid.c: Stale PID file, overwriting.
( 0.028| 0.000) I: [lt-pulseaudio] main.c: Fresh high-resolution timers available! Bon appetit!
( 0.028| 0.000) D: [lt-pulseaudio] memblock.c: Using shared memory pool with 1024 slots of size 64.0 KiB each, total size is 64.0 MiB, maximum usable slot size is 65472
( 0.028| 0.000) I: [lt-pulseaudio] cpu-x86.c: CPU flags: CMOV MMX SSE SSE2 SSE3 SSSE3 SSE4_1 SSE4_2 MMXEXT
( 0.028| 0.000) I: [lt-pulseaudio] svolume_mmx.c: Initialising MMX optimized volume functions.
( 0.028| 0.000) I: [lt-pulseaudio] remap_mmx.c: Initialising MMX optimized remappers.
( 0.028| 0.000) I: [lt-pulseaudio] svolume_sse.c: Initialising SSE2 optimized volume functions.
( 0.028| 0.000) I: [lt-pulseaudio] remap_sse.c: Initialising SSE2 optimized remappers.
( 0.028| 0.000) I: [lt-pulseaudio] sconv_sse.c: Initialising SSE2 optimized conversions.
( 0.028| 0.000) I: [lt-pulseaudio] svolume_orc.c: Initialising ORC optimized volume functions.
( 0.028| 0.000) D: [lt-pulseaudio] cli-command.c: Parsing script '/usr/src/raop2/src/default.pa'
( 0.029| 0.000) D: [lt-pulseaudio] database-tdb.c: Opened TDB database '/home/cubox/.pulse/Thirsty-device-volumes.tdb'
( 0.029| 0.000) I: [lt-pulseaudio] module-device-restore.c: Successfully opened database file '/home/cubox/.pulse/Thirsty-device-volumes'.
( 0.029| 0.000) I: [lt-pulseaudio] module.c: Loaded "module-device-restore" (index: #0; argument: "").
( 0.030| 0.000) D: [lt-pulseaudio] database-tdb.c: Opened TDB database '/home/cubox/.pulse/Thirsty-stream-volumes.tdb'
( 0.030| 0.000) I: [lt-pulseaudio] module-stream-restore.c: Successfully opened database file '/home/cubox/.pulse/Thirsty-stream-volumes'.
( 0.030| 0.000) D: [lt-pulseaudio] protocol-dbus.c: Interface org.PulseAudio.Ext.StreamRestore1 added for object /org/pulseaudio/stream_restore1
( 0.030| 0.000) I: [lt-pulseaudio] module.c: Loaded "module-stream-restore" (index: #1; argument: "").
( 0.030| 0.000) D: [lt-pulseaudio] database-tdb.c: Opened TDB database '/home/cubox/.pulse/Thirsty-card-database.tdb'
( 0.030| 0.000) I: [lt-pulseaudio] module-card-restore.c: Successfully opened database file '/home/cubox/.pulse/Thirsty-card-database'.
( 0.030| 0.000) I: [lt-pulseaudio] module.c: Loaded "module-card-restore" (index: #2; argument: "").
( 0.031| 0.000) I: [lt-pulseaudio] module.c: Loaded "module-augment-properties" (index: #3; argument: "").
( 0.031| 0.000) I: [lt-pulseaudio] module.c: Loaded "module-switch-on-port-available" (index: #4; argument: "").
( 0.031| 0.000) D: [lt-pulseaudio] module.c: Checking for existence of '/usr/src/raop2/src/module-udev-detect.so': failure
( 0.031| 0.000) D: [lt-pulseaudio] module.c: Checking for existence of '/usr/src/raop2/src/.libs/module-udev-detect.so': success
( 0.033| 0.001) D: [lt-pulseaudio] module-udev-detect.c: /dev/snd/controlC0 is accessible: no
( 0.033| 0.000) D: [lt-pulseaudio] module-udev-detect.c: /dev/snd/controlC1 is accessible: no
( 0.033| 0.000) I: [lt-pulseaudio] module-udev-detect.c: Found 2 cards.
( 0.033| 0.000) I: [lt-pulseaudio] module.c: Loaded "module-udev-detect" (index: #5; argument: "").
( 0.033| 0.000) D: [lt-pulseaudio] module.c: Checking for existence of '/usr/src/raop2/src/module-jackdbus-detect.so': failure
( 0.033| 0.000) D: [lt-pulseaudio] module.c: Checking for existence of '/usr/src/raop2/src/.libs/module-jackdbus-detect.so': success
( 0.033| 0.000) E: [lt-pulseaudio] module-jackdbus-detect.c: Unable to contact D-Bus session bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11
( 0.033| 0.000) E: [lt-pulseaudio] module.c: Failed to load module "module-jackdbus-detect" (argument: "channels=2"): initialization failed.
( 0.033| 0.000) D: [lt-pulseaudio] module.c: Checking for existence of '/usr/src/raop2/src/module-bluetooth-policy.so': failure
( 0.033| 0.000) D: [lt-pulseaudio] module.c: Checking for existence of '/usr/src/raop2/src/.libs/module-bluetooth-policy.so': success
( 0.034| 0.000) I: [lt-pulseaudio] module.c: Loaded "module-bluetooth-policy" (index: #7; argument: "").
( 0.034| 0.000) D: [lt-pulseaudio] module.c: Checking for existence of '/usr/src/raop2/src/module-bluetooth-discover.so': failure
( 0.034| 0.000) D: [lt-pulseaudio] module.c: Checking for existence of '/usr/src/raop2/src/.libs/module-bluetooth-discover.so': success
( 0.034| 0.000) D: [lt-pulseaudio] module.c: Checking for existence of '/usr/src/raop2/src/module-bluez5-discover.so': failure
( 0.034| 0.000) D: [lt-pulseaudio] module.c: Checking for existence of '/usr/src/raop2/src/.libs/module-bluez5-discover.so': success
( 0.035| 0.001) D: [lt-pulseaudio] dbus-util.c: Successfully connected to D-Bus system bus 39550ba3f682fe1dd0ba0e305370dcc6 as :1.208
( 0.036| 0.001) I: [lt-pulseaudio] module.c: Loaded "module-bluez5-discover" (index: #9; argument: "").
( 0.036| 0.000) D: [lt-pulseaudio] module.c: Checking for existence of '/usr/src/raop2/src/module-bluez4-discover.so': failure
( 0.036| 0.000) D: [lt-pulseaudio] module.c: Checking for existence of '/usr/src/raop2/src/.libs/module-bluez4-discover.so': success
( 0.038| 0.001) I: [lt-pulseaudio] module.c: Loaded "module-bluez4-discover" (index: #10; argument: "").
( 0.039| 0.000) I: [lt-pulseaudio] module.c: Loaded "module-bluetooth-discover" (index: #8; argument: "").
( 0.039| 0.000) D: [lt-pulseaudio] module.c: Checking for existence of '/usr/src/raop2/src/module-esound-protocol-unix.so': failure
( 0.039| 0.000) D: [lt-pulseaudio] module.c: Checking for existence of '/usr/src/raop2/src/.libs/module-esound-protocol-unix.so': success
( 0.040| 0.000) I: [lt-pulseaudio] module.c: Loaded "module-esound-protocol-unix" (index: #11; argument: "").
( 0.040| 0.000) I: [lt-pulseaudio] module.c: Loaded "module-native-protocol-unix" (index: #12; argument: "").
( 0.040| 0.000) D: [lt-pulseaudio] module.c: Checking for existence of '/usr/src/raop2/src/module-gconf.so': failure
( 0.041| 0.000) D: [lt-pulseaudio] module.c: Checking for existence of '/usr/src/raop2/src/.libs/module-gconf.so': success
( 0.061| 0.020) I: [lt-pulseaudio] module.c: Loaded "module-gconf" (index: #13; argument: "").
( 0.062| 0.000) I: [lt-pulseaudio] module-default-device-restore.c: Saved default sink 'raop_output.DENON-AVR-2312.local' not existent, not restoring default sink setting.
( 0.062| 0.000) I: [lt-pulseaudio] module-default-device-restore.c: Saved default source 'raop_output.DENON-AVR-2312.local.monitor' not existent, not restoring default source setting.
( 0.062| 0.000) I: [lt-pulseaudio] module.c: Loaded "module-default-device-restore" (index: #14; argument: "").
( 0.063| 0.000) I: [lt-pulseaudio] module.c: Loaded "module-rescue-streams" (index: #15; argument: "").
( 0.063| 0.000) D: [lt-pulseaudio] module-always-sink.c: Autoloading null-sink as no other sinks detected.
( 0.064| 0.000) I: [lt-pulseaudio] sink.c: Created sink 0 "auto_null" with sample spec s16le 2ch 44100Hz and channel map front-left,front-right
( 0.064| 0.000) I: [lt-pulseaudio] sink.c: device.description = "Dummy Output"
( 0.064| 0.000) I: [lt-pulseaudio] sink.c: device.class = "abstract"
( 0.064| 0.000) I: [lt-pulseaudio] sink.c: device.icon_name = "audio-card"
( 0.064| 0.000) D: [lt-pulseaudio] core-subscribe.c: Dropped redundant event due to change event.
( 0.064| 0.000) I: [lt-pulseaudio] source.c: Created source 0 "auto_null.monitor" with sample spec s16le 2ch 44100Hz and channel map front-left,front-right
( 0.064| 0.000) I: [lt-pulseaudio] source.c: device.description = "Monitor of Dummy Output"
( 0.064| 0.000) I: [lt-pulseaudio] source.c: device.class = "monitor"
( 0.064| 0.000) I: [lt-pulseaudio] source.c: device.icon_name = "audio-input-microphone"
( 0.064| 0.000) D: [null-sink] module-null-sink.c: Thread starting up
( 0.065| 0.000) D: [lt-pulseaudio] module-device-restore.c: Could not set format on sink auto_null
( 0.065| 0.000) I: [lt-pulseaudio] module.c: Loaded "module-null-sink" (index: #17; argument: "sink_name=auto_null sink_properties='device.description="Dummy Output"'").
( 0.065| 0.000) I: [lt-pulseaudio] module.c: Loaded "module-always-sink" (index: #16; argument: "").
( 0.065| 0.000) I: [lt-pulseaudio] module.c: Loaded "module-intended-roles" (index: #18; argument: "").
( 0.065| 0.000) D: [lt-pulseaudio] module-suspend-on-idle.c: Sink auto_null becomes idle, timeout in 5 seconds.
( 0.066| 0.000) I: [lt-pulseaudio] module.c: Loaded "module-suspend-on-idle" (index: #19; argument: "").
( 0.066| 0.000) D: [lt-pulseaudio] module.c: Checking for existence of '/usr/src/raop2/src/module-console-kit.so': failure
( 0.066| 0.000) D: [lt-pulseaudio] module.c: Checking for existence of '/usr/src/raop2/src/.libs/module-console-kit.so': success
( 0.066| 0.000) I: [lt-pulseaudio] module.c: Loaded "module-console-kit" (index: #20; argument: "").
( 0.066| 0.000) D: [lt-pulseaudio] module.c: Checking for existence of '/usr/src/raop2/src/module-systemd-login.so': failure
( 0.066| 0.000) D: [lt-pulseaudio] module.c: Checking for existence of '/usr/src/raop2/src/.libs/module-systemd-login.so': success
( 0.067| 0.000) I: [lt-pulseaudio] client.c: Created 0 "Login Session 16"
( 0.067| 0.000) D: [lt-pulseaudio] module-systemd-login.c: Added new session 16
( 0.067| 0.000) I: [lt-pulseaudio] client.c: Created 1 "Login Session 15"
( 0.067| 0.000) D: [lt-pulseaudio] module-systemd-login.c: Added new session 15
( 0.067| 0.000) I: [lt-pulseaudio] module.c: Loaded "module-systemd-login" (index: #21; argument: "").
( 0.068| 0.000) I: [lt-pulseaudio] module.c: Loaded "module-position-event-sounds" (index: #22; argument: "").
( 0.068| 0.000) D: [lt-pulseaudio] module-role-cork.c: Using role 'phone' as trigger role.
( 0.068| 0.000) D: [lt-pulseaudio] module-role-cork.c: Using roles 'music' and 'video' as cork roles.
( 0.068| 0.000) I: [lt-pulseaudio] module.c: Loaded "module-role-cork" (index: #23; argument: "").
( 0.068| 0.000) I: [lt-pulseaudio] module.c: Loaded "module-filter-heuristics" (index: #24; argument: "").
( 0.069| 0.000) I: [lt-pulseaudio] module.c: Loaded "module-filter-apply" (index: #25; argument: "").
( 0.072| 0.003) I: [lt-pulseaudio] module.c: Loaded "module-raop-discover" (index: #26; argument: "").
( 0.073| 0.000) E: [lt-pulseaudio] main.c: Module load failed.
( 0.073| 0.000) W: [lt-pulseaudio] server-lookup.c: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11
( 0.073| 0.000) W: [lt-pulseaudio] main.c: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11
( 0.073| 0.000) I: [lt-pulseaudio] main.c: Daemon startup complete.
( 0.073| 0.000) D: [lt-pulseaudio] bluez4-util.c: dbus: interface=org.freedesktop.DBus, path=/org/freedesktop/DBus, member=NameAcquired
( 0.073| 0.000) E: [lt-pulseaudio] bluez5-util.c: GetManagedObjects() failed: org.freedesktop.DBus.Error.ServiceUnknown: The name org.bluez was not provided by any .service files
( 0.073| 0.000) D: [lt-pulseaudio] bluez4-util.c: Bluetooth daemon is apparently not available.
( 0.074| 0.000) D: [lt-pulseaudio] module-raop-discover.c: Found RAOP: DENON:[AVR-2312]
( 0.074| 0.000) D: [lt-pulseaudio] module-raop-discover.c: Found key: 'txtvers' with value: '1'
( 0.074| 0.000) D: [lt-pulseaudio] module-raop-discover.c: Found key: 'ch' with value: '2'
( 0.074| 0.000) D: [lt-pulseaudio] module-raop-discover.c: Found key: 'cn' with value: '0,1'
( 0.074| 0.000) D: [lt-pulseaudio] module-raop-discover.c: Found key: 'et' with value: '0,4'
( 0.074| 0.000) D: [lt-pulseaudio] module-raop-discover.c: Found key: 'sv' with value: 'false'
( 0.074| 0.000) D: [lt-pulseaudio] module-raop-discover.c: Found key: 'da' with value: 'true'
( 0.074| 0.000) D: [lt-pulseaudio] module-raop-discover.c: Found key: 'sr' with value: '44100'
( 0.074| 0.000) D: [lt-pulseaudio] module-raop-discover.c: Found key: 'ss' with value: '16'
( 0.074| 0.000) D: [lt-pulseaudio] module-raop-discover.c: Found key: 'pw' with value: 'false'
( 0.074| 0.000) D: [lt-pulseaudio] module-raop-discover.c: Found key: 'vn' with value: '65537'
( 0.074| 0.000) D: [lt-pulseaudio] module-raop-discover.c: Found key: 'tp' with value: 'UDP'
( 0.074| 0.000) D: [lt-pulseaudio] module-raop-discover.c: Found key: 'md' with value: '0,1,2'
( 0.074| 0.000) D: [lt-pulseaudio] module-raop-discover.c: Found key: 'vs' with value: '103.2'
( 0.074| 0.000) D: [lt-pulseaudio] module-raop-discover.c: Found key: 'am' with value: 'DENON,1'
( 0.074| 0.000) D: [lt-pulseaudio] module-raop-discover.c: Found key: 'fv' with value: '65.9200'
( 0.074| 0.000) D: [lt-pulseaudio] module-raop-discover.c: Loading module-raop-sink with arguments 'server=[192.168.10.20]:1036 sink_name=raop_output.DENON-AVR-2312.local sink_properties='device.description="DENON:[AVR-2312]"' protocol=UDP encryption=none codec=PCM channels=2 format=16 rate=44100'
( 0.076| 0.002) I: [lt-pulseaudio] sink.c: Created sink 1 "raop_output.DENON-AVR-2312.local" with sample spec s16le 2ch 44100Hz and channel map front-left,front-right
( 0.076| 0.002) I: [lt-pulseaudio] sink.c: device.string = "[192.168.10.20]:1036"
( 0.076| 0.002) I: [lt-pulseaudio] sink.c: device.intended_roles = "music"
( 0.076| 0.002) I: [lt-pulseaudio] sink.c: device.description = "DENON:[AVR-2312]"
( 0.076| 0.002) I: [lt-pulseaudio] sink.c: device.icon_name = "audio-card"
( 0.076| 0.000) D: [lt-pulseaudio] core-subscribe.c: Dropped redundant event due to change event.
( 0.076| 0.000) I: [lt-pulseaudio] source.c: Created source 1 "raop_output.DENON-AVR-2312.local.monitor" with sample spec s16le 2ch 44100Hz and channel map front-left,front-right
( 0.076| 0.000) I: [lt-pulseaudio] source.c: device.description = "Monitor of DENON:[AVR-2312]"
( 0.076| 0.000) I: [lt-pulseaudio] source.c: device.class = "monitor"
( 0.076| 0.000) I: [lt-pulseaudio] source.c: device.icon_name = "audio-input-microphone"
( 0.078| 0.001) D: [raop-sink] module-raop-sink.c: UDP thread starting up
( 0.078| 0.000) D: [raop-sink] module-raop-sink.c: RAOP: IDLE
( 0.078| 0.000) D: [lt-pulseaudio] module-device-restore.c: Could not set format on sink raop_output.DENON-AVR-2312.local
( 0.079| 0.000) D: [lt-pulseaudio] module-suspend-on-idle.c: Sink raop_output.DENON-AVR-2312.local becomes idle, timeout in 5 seconds.
( 0.079| 0.000) I: [lt-pulseaudio] module-always-sink.c: A new sink has been discovered. Unloading null-sink.
( 0.079| 0.000) I: [lt-pulseaudio] module.c: Loaded "module-raop-sink" (index: #27; argument: "server=[192.168.10.20]:1036 sink_name=raop_output.DENON-AVR-2312.local sink_properties='device.description="DENON:[AVR-2312]"' protocol=UDP encryption=none codec=PCM channels=2 format=16 rate=44100").
( 0.079| 0.000) I: [lt-pulseaudio] module.c: Unloading "module-null-sink" (index: #17).
( 0.079| 0.000) D: [lt-pulseaudio] module-rescue-streams.c: No sink inputs to move away.
( 0.079| 0.000) D: [lt-pulseaudio] module-rescue-streams.c: No source outputs to move away.
( 0.079| 0.000) D: [null-sink] module-null-sink.c: Thread shutting down
( 0.080| 0.000) I: [lt-pulseaudio] sink.c: Freeing sink 0 "auto_null"
( 0.080| 0.000) I: [lt-pulseaudio] source.c: Freeing source 0 "auto_null.monitor"
( 0.080| 0.000) I: [lt-pulseaudio] module.c: Unloaded "module-null-sink" (index: #17).
( 5.079| 4.998) I: [lt-pulseaudio] module-suspend-on-idle.c: Sink raop_output.DENON-AVR-2312.local idle for too long, suspending ...
( 5.079| 0.000) D: [lt-pulseaudio] sink.c: Suspend cause of sink raop_output.DENON-AVR-2312.local is 0x0004, suspending
( 5.079| 0.000) D: [raop-sink] module-raop-sink.c: RAOP: SUSPENDED
( 5.079| 0.000) D: [lt-pulseaudio] core.c: Hmm, no streams around, trying to vacuum.
( 6.880| 1.801) I: [lt-pulseaudio] main.c: Got signal SIGUSR2.
( 6.881| 0.001) I: [lt-pulseaudio] module.c: Loaded "module-cli-protocol-unix" (index: #28; argument: "").
( 7.181| 0.299) I: [lt-pulseaudio] client.c: Created 2 "UNIX socket client"
( 7.181| 0.000) D: [lt-pulseaudio] cli.c: CLI got EOF from user.
( 7.181| 0.000) I: [lt-pulseaudio] client.c: Freed 2 "UNIX socket client"
( 33.713| 26.531) I: [lt-pulseaudio] client.c: Created 3 "Native client (UNIX socket client)"
( 33.714| 0.000) D: [lt-pulseaudio] protocol-native.c: Protocol version: remote 28, local 29
( 33.714| 0.000) I: [lt-pulseaudio] protocol-native.c: Got credentials: uid=1006 gid=1006 success=1
( 33.714| 0.000) D: [lt-pulseaudio] protocol-native.c: SHM possible: yes
( 33.714| 0.000) D: [lt-pulseaudio] protocol-native.c: Negotiated SHM: yes
( 33.714| 0.000) D: [lt-pulseaudio] module-augment-properties.c: Looking for .desktop file for pactl
( 33.715| 0.000) D: [lt-pulseaudio] protocol-native.c: Client pactl changes mute of sink raop_output.DENON-AVR-2312.local.
( 33.715| 0.000) D: [lt-pulseaudio] raop_client.c: volume=0 db=-144.000000
( 33.715| 0.000) I: [lt-pulseaudio] module-device-restore.c: Storing volume/mute for device+port sink:raop_output.DENON-AVR-2312.local:null.
( 33.716| 0.000) I: [lt-pulseaudio] client.c: Freed 3 "pactl"
( 33.716| 0.000) I: [lt-pulseaudio] protocol-native.c: Connection died.
( 43.725| 10.009) I: [lt-pulseaudio] module-device-restore.c: Synced.
( 82.978| 39.252) I: [lt-pulseaudio] client.c: Created 4 "Native client (UNIX socket client)"
( 82.978| 0.000) D: [lt-pulseaudio] protocol-native.c: Protocol version: remote 28, local 29
( 82.978| 0.000) I: [lt-pulseaudio] protocol-native.c: Got credentials: uid=1006 gid=1006 success=1
( 82.978| 0.000) D: [lt-pulseaudio] protocol-native.c: SHM possible: yes
( 82.978| 0.000) D: [lt-pulseaudio] protocol-native.c: Negotiated SHM: yes
( 82.979| 0.000) D: [lt-pulseaudio] module-augment-properties.c: Looking for .desktop file for pactl
( 82.979| 0.000) D: [lt-pulseaudio] protocol-native.c: Client pactl changes volume of sink raop_output.DENON-AVR-2312.local.
( 82.980| 0.000) I: [lt-pulseaudio] module-device-restore.c: Storing volume/mute for device+port sink:raop_output.DENON-AVR-2312.local:null.
( 82.980| 0.000) I: [lt-pulseaudio] client.c: Freed 4 "pactl"
( 82.980| 0.000) I: [lt-pulseaudio] protocol-native.c: Connection died.
( 89.959| 6.978) I: [lt-pulseaudio] client.c: Created 5 "Native client (UNIX socket client)"
( 89.959| 0.000) D: [lt-pulseaudio] protocol-native.c: Protocol version: remote 28, local 29
( 89.959| 0.000) I: [lt-pulseaudio] protocol-native.c: Got credentials: uid=1006 gid=1006 success=1
( 89.959| 0.000) D: [lt-pulseaudio] protocol-native.c: SHM possible: yes
( 89.959| 0.000) D: [lt-pulseaudio] protocol-native.c: Negotiated SHM: yes
( 89.960| 0.000) D: [lt-pulseaudio] module-augment-properties.c: Looking for .desktop file for pactl
( 89.960| 0.000) D: [lt-pulseaudio] protocol-native.c: Client pactl changes volume of sink raop_output.DENON-AVR-2312.local.
( 89.960| 0.000) I: [lt-pulseaudio] module-device-restore.c: Storing volume/mute for device+port sink:raop_output.DENON-AVR-2312.local:null.
( 89.960| 0.000) I: [lt-pulseaudio] client.c: Freed 5 "pactl"
( 89.960| 0.000) I: [lt-pulseaudio] protocol-native.c: Connection died.
( 92.982| 3.022) I: [lt-pulseaudio] module-device-restore.c: Synced.
( 116.626| 23.643) I: [lt-pulseaudio] client.c: Created 6 "Native client (UNIX socket client)"
( 116.626| 0.000) D: [lt-pulseaudio] protocol-native.c: Protocol version: remote 28, local 29
( 116.626| 0.000) I: [lt-pulseaudio] protocol-native.c: Got credentials: uid=1006 gid=1006 success=1
( 116.626| 0.000) D: [lt-pulseaudio] protocol-native.c: SHM possible: yes
( 116.626| 0.000) D: [lt-pulseaudio] protocol-native.c: Negotiated SHM: yes
( 116.627| 0.000) D: [lt-pulseaudio] module-augment-properties.c: Looking for .desktop file for pactl
( 116.627| 0.000) D: [lt-pulseaudio] protocol-native.c: Client pactl changes volume of sink raop_output.DENON-AVR-2312.local.
( 116.627| 0.000) I: [lt-pulseaudio] module-device-restore.c: Storing volume/mute for device+port sink:raop_output.DENON-AVR-2312.local:null.
( 116.628| 0.000) I: [lt-pulseaudio] client.c: Freed 6 "pactl"
( 116.628| 0.000) I: [lt-pulseaudio] protocol-native.c: Connection died.
( 126.638| 10.009) I: [lt-pulseaudio] module-device-restore.c: Synced.
( 129.570| 2.931) I: [lt-pulseaudio] client.c: Created 7 "Native client (UNIX socket client)"
( 129.570| 0.000) D: [lt-pulseaudio] protocol-native.c: Protocol version: remote 28, local 29
( 129.570| 0.000) I: [lt-pulseaudio] protocol-native.c: Got credentials: uid=1006 gid=1006 success=1
( 129.570| 0.000) D: [lt-pulseaudio] protocol-native.c: SHM possible: yes
( 129.570| 0.000) D: [lt-pulseaudio] protocol-native.c: Negotiated SHM: yes
( 129.571| 0.000) D: [lt-pulseaudio] module-augment-properties.c: Looking for .desktop file for pactl
( 129.571| 0.000) D: [lt-pulseaudio] protocol-native.c: Client pactl changes mute of sink raop_output.DENON-AVR-2312.local.
( 129.600| 0.028) D: [lt-pulseaudio] module-raop-sink.c: Volume adjusted: orig=4 adjusted=20727
( 129.600| 0.000) D: [lt-pulseaudio] module-raop-sink.c: Requested volume: front-left: 4 / 0%, front-right: 4 / 0%
( 129.600| 0.000) D: [lt-pulseaudio] module-raop-sink.c: Got hardware volume: front-left: 20727 / 32%, front-right: 20727 / 32%
( 129.600| 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
( 129.600| 0.000) D: [lt-pulseaudio] raop_client.c: volume=20727 db=-29.996609
( 129.600| 0.000) I: [lt-pulseaudio] module-device-restore.c: Storing volume/mute for device+port sink:raop_output.DENON-AVR-2312.local:null.
( 129.600| 0.000) I: [lt-pulseaudio] client.c: Freed 7 "pactl"
( 129.601| 0.000) I: [lt-pulseaudio] protocol-native.c: Connection died.
( 136.658| 7.057) I: [lt-pulseaudio] client.c: Created 8 "Native client (UNIX socket client)"
( 136.658| 0.000) D: [lt-pulseaudio] protocol-native.c: Protocol version: remote 28, local 29
( 136.658| 0.000) I: [lt-pulseaudio] protocol-native.c: Got credentials: uid=1006 gid=1006 success=1
( 136.658| 0.000) D: [lt-pulseaudio] protocol-native.c: SHM possible: yes
( 136.658| 0.000) D: [lt-pulseaudio] protocol-native.c: Negotiated SHM: yes
( 136.659| 0.000) D: [lt-pulseaudio] module-augment-properties.c: Looking for .desktop file for pactl
( 136.659| 0.000) D: [lt-pulseaudio] protocol-native.c: Client pactl changes volume of sink raop_output.DENON-AVR-2312.local.
( 136.659| 0.000) D: [lt-pulseaudio] module-raop-sink.c: Volume adjusted: orig=1 adjusted=20724
( 136.660| 0.000) D: [lt-pulseaudio] module-raop-sink.c: Requested volume: front-left: 1 / 0%, front-right: 1 / 0%
( 136.660| 0.000) D: [lt-pulseaudio] module-raop-sink.c: Got hardware volume: front-left: 20724 / 32%, front-right: 20724 / 32%
( 136.660| 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
( 136.660| 0.000) D: [lt-pulseaudio] raop_client.c: volume=20724 db=-30.000381
( 136.660| 0.000) I: [lt-pulseaudio] module-device-restore.c: Storing volume/mute for device+port sink:raop_output.DENON-AVR-2312.local:null.
( 136.660| 0.000) I: [lt-pulseaudio] client.c: Freed 8 "pactl"
( 136.660| 0.000) I: [lt-pulseaudio] protocol-native.c: Connection died.
( 139.457| 2.797) I: [lt-pulseaudio] client.c: Created 9 "Native client (UNIX socket client)"
( 139.458| 0.000) D: [lt-pulseaudio] protocol-native.c: Protocol version: remote 28, local 29
( 139.458| 0.000) I: [lt-pulseaudio] protocol-native.c: Got credentials: uid=1006 gid=1006 success=1
( 139.458| 0.000) D: [lt-pulseaudio] protocol-native.c: SHM possible: yes
( 139.458| 0.000) D: [lt-pulseaudio] protocol-native.c: Negotiated SHM: yes
( 139.458| 0.000) D: [lt-pulseaudio] module-augment-properties.c: Looking for .desktop file for pactl
( 139.459| 0.000) D: [lt-pulseaudio] protocol-native.c: Client pactl changes volume of sink raop_output.DENON-AVR-2312.local.
( 139.459| 0.000) D: [lt-pulseaudio] module-raop-sink.c: Volume adjusted: orig=0 adjusted=20724
( 139.459| 0.000) D: [lt-pulseaudio] module-raop-sink.c: Requested volume: front-left: 0 / 0%, front-right: 0 / 0%
( 139.459| 0.000) D: [lt-pulseaudio] module-raop-sink.c: Got hardware volume: front-left: 20724 / 32%, front-right: 20724 / 32%
( 139.459| 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
( 139.459| 0.000) D: [lt-pulseaudio] raop_client.c: volume=20724 db=-30.000381
( 139.459| 0.000) I: [lt-pulseaudio] module-device-restore.c: Storing volume/mute for device+port sink:raop_output.DENON-AVR-2312.local:null.
( 139.460| 0.000) I: [lt-pulseaudio] client.c: Freed 9 "pactl"
( 139.460| 0.000) I: [lt-pulseaudio] protocol-native.c: Connection died.
( 139.601| 0.140) I: [lt-pulseaudio] module-device-restore.c: Synced.
( 195.491| 55.890) I: [lt-pulseaudio] client.c: Created 10 "Native client (UNIX socket client)"
( 195.492| 0.001) D: [lt-pulseaudio] protocol-native.c: Protocol version: remote 28, local 29
( 195.492| 0.000) I: [lt-pulseaudio] protocol-native.c: Got credentials: uid=1006 gid=1006 success=1
( 195.492| 0.000) D: [lt-pulseaudio] protocol-native.c: SHM possible: yes
( 195.492| 0.000) D: [lt-pulseaudio] protocol-native.c: Negotiated SHM: yes
( 195.492| 0.000) D: [lt-pulseaudio] module-augment-properties.c: Looking for .desktop file for mplayer
( 195.506| 0.013) D: [lt-pulseaudio] module-intended-roles.c: Not setting device for stream audio stream, because it lacks role.
( 195.506| 0.000) D: [lt-pulseaudio] sink-input.c: Negotiated format: pcm, format.sample_format = "\"float32le\"" format.rate = "44100" format.channels = "2" format.channel_map = "\"front-left,front-right\""
( 195.506| 0.000) I: [lt-pulseaudio] sink-input.c: Trying to change sample rate
( 195.506| 0.000) I: [lt-pulseaudio] sink-input.c: Rate changed to 44100 Hz
( 195.506| 0.000) D: [lt-pulseaudio] module-suspend-on-idle.c: Sink raop_output.DENON-AVR-2312.local becomes busy, resuming.
( 195.507| 0.000) D: [lt-pulseaudio] sink.c: Suspend cause of sink raop_output.DENON-AVR-2312.local is 0x0000, resuming
( 195.507| 0.000) D: [raop-sink] module-raop-sink.c: RAOP: IDLE
( 195.507| 0.000) D: [lt-pulseaudio] module-suspend-on-idle.c: Sink raop_output.DENON-AVR-2312.local becomes idle, timeout in 5 seconds.
( 195.507| 0.000) D: [lt-pulseaudio] module-suspend-on-idle.c: Sink raop_output.DENON-AVR-2312.local becomes idle, timeout in 5 seconds.
( 195.507| 0.000) I: [lt-pulseaudio] resampler.c: Forcing resampler 'copy', because of fixed, identical sample rates.
( 195.507| 0.000) D: [lt-pulseaudio] resampler.c: Resampler:
( 195.507| 0.000) D: [lt-pulseaudio] resampler.c: rate 44100 -> 44100 (method copy)
( 195.507| 0.000) D: [lt-pulseaudio] resampler.c: format float32le -> s16le (intermediate s16le)
( 195.507| 0.000) D: [lt-pulseaudio] resampler.c: channels 2 -> 2 (resampling 2)
( 195.507| 0.000) D: [lt-pulseaudio] memblockq.c: memblockq requested: maxlength=33554432, tlength=0, base=4, prebuf=0, minreq=1 maxrewind=0
( 195.507| 0.000) D: [lt-pulseaudio] memblockq.c: memblockq sanitized: maxlength=33554432, tlength=33554432, base=4, prebuf=0, minreq=4 maxrewind=0
( 195.507| 0.000) I: [lt-pulseaudio] sink-input.c: Created input 0 "audio stream" on raop_output.DENON-AVR-2312.local with sample spec float32le 2ch 44100Hz and channel map front-left,front-right
( 195.507| 0.000) I: [lt-pulseaudio] sink-input.c: media.name = "audio stream"
( 195.507| 0.000) I: [lt-pulseaudio] sink-input.c: application.name = "MPlayer"
( 195.507| 0.000) I: [lt-pulseaudio] sink-input.c: native-protocol.peer = "UNIX socket client"
( 195.507| 0.000) I: [lt-pulseaudio] sink-input.c: native-protocol.version = "28"
( 195.507| 0.000) I: [lt-pulseaudio] sink-input.c: application.process.id = "16101"
( 195.507| 0.000) I: [lt-pulseaudio] sink-input.c: application.process.user = "cubox"
( 195.507| 0.000) I: [lt-pulseaudio] sink-input.c: application.process.host = "Thirsty"
( 195.507| 0.000) I: [lt-pulseaudio] sink-input.c: application.process.binary = "mplayer"
( 195.507| 0.000) I: [lt-pulseaudio] sink-input.c: application.language = "C"
( 195.507| 0.000) I: [lt-pulseaudio] sink-input.c: application.process.machine_id = "9953ec36011c0ec18cb31366508ed24d"
( 195.507| 0.000) I: [lt-pulseaudio] sink-input.c: application.process.session_id = "16"
( 195.507| 0.000) I: [lt-pulseaudio] sink-input.c: module-stream-restore.id = "sink-input-by-application-name:MPlayer"
( 195.507| 0.000) I: [lt-pulseaudio] protocol-native.c: Requested tlength=250.00 ms, minreq=20.00 ms
( 195.507| 0.000) D: [lt-pulseaudio] protocol-native.c: Traditional mode enabled, modifying sink usec only for compat with minreq.
( 195.508| 0.000) D: [lt-pulseaudio] protocol-native.c: Requested latency=210.00 ms, Received latency=250.00 ms
( 195.508| 0.000) D: [lt-pulseaudio] memblockq.c: memblockq requested: maxlength=4194304, tlength=102312, base=8, prebuf=95264, minreq=7056 maxrewind=0
( 195.508| 0.000) D: [lt-pulseaudio] memblockq.c: memblockq sanitized: maxlength=4194304, tlength=102312, base=8, prebuf=95264, minreq=7056 maxrewind=0
( 195.508| 0.000) I: [lt-pulseaudio] protocol-native.c: Final latency 540.00 ms = 250.00 ms + 2*20.00 ms + 250.00 ms
( 195.508| 0.000) D: [lt-pulseaudio] module-raop-sink.c: Volume adjusted: orig=0 adjusted=20724
( 195.508| 0.000) D: [lt-pulseaudio] module-raop-sink.c: Requested volume: front-left: 0 / 0%, front-right: 0 / 0%
( 195.508| 0.000) D: [lt-pulseaudio] module-raop-sink.c: Got hardware volume: front-left: 20724 / 32%, front-right: 20724 / 32%
( 195.508| 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
( 195.508| 0.000) D: [lt-pulseaudio] raop_client.c: volume=20724 db=-30.000381
( 195.508| 0.000) D: [raop-sink] module-raop-sink.c: RAOP: RUNNING
( 195.523| 0.014) D: [raop-sink] rtsp_client.c: Attempting to connect to server '192.168.10.20:1036'
( 195.534| 0.011) D: [lt-pulseaudio] core-subscribe.c: Dropped redundant event due to change event.
( 195.534| 0.000) I: [lt-pulseaudio] module-stream-restore.c: Storing volume/mute/device for stream sink-input-by-application-name:MPlayer.
( 195.535| 0.000) D: [lt-pulseaudio] protocol-dbus.c: Interface org.PulseAudio.Ext.StreamRestore1.RestoreEntry added for object /org/pulseaudio/stream_restore1/entry0
( 195.536| 0.000) D: [lt-pulseaudio] rtsp_client.c: Established RTSP connection from local ip 192.168.10.250
( 195.536| 0.000) D: [lt-pulseaudio] rtsp_client.c: Sending command: OPTIONS
( 195.539| 0.003) D: [lt-pulseaudio] rtsp_client.c: Full response received. Dispatching
( 195.539| 0.000) D: [lt-pulseaudio] raop_client.c: RAOP: OPTIONS
( 195.548| 0.008) D: [lt-pulseaudio] rtsp_client.c: Sending command: ANNOUNCE
( 195.548| 0.000) D: [raop-sink] protocol-native.c: Requesting rewind due to end of underrun.
( 195.549| 0.000) D: [lt-pulseaudio] rtsp_client.c: Full response received. Dispatching
( 195.549| 0.000) D: [lt-pulseaudio] raop_client.c: Socket bound to port 6001 (SOCK_DGRAM)
( 195.549| 0.000) D: [lt-pulseaudio] raop_client.c: Socket bound to port 6002 (SOCK_DGRAM)
( 195.549| 0.000) D: [lt-pulseaudio] rtsp_client.c: Sending command: SETUP
( 200.316| 4.766) D: [lt-pulseaudio] module-raop-sink.c: Volume adjusted: orig=0 adjusted=20724
( 200.316| 0.000) D: [lt-pulseaudio] module-raop-sink.c: Requested volume: front-left: 0 / 0%, front-right: 0 / 0%
( 200.316| 0.000) D: [lt-pulseaudio] module-raop-sink.c: Got hardware volume: front-left: 20724 / 32%, front-right: 20724 / 32%
( 200.316| 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
( 200.316| 0.000) D: [lt-pulseaudio] raop_client.c: volume=20724 db=-30.000381
( 200.316| 0.000) D: [lt-pulseaudio] rtsp_client.c: Sending command: SET_PARAMETER
( 200.316| 0.000) D: [lt-pulseaudio] module-suspend-on-idle.c: Sink raop_output.DENON-AVR-2312.local becomes idle, timeout in 5 seconds.
( 200.316| 0.000) D: [raop-sink] module-raop-sink.c: RAOP: IDLE
( 200.316| 0.000) D: [raop-sink] rtsp_client.c: Sending command: FLUSH
( 200.316| 0.000) D: [lt-pulseaudio] module-suspend-on-idle.c: Sink raop_output.DENON-AVR-2312.local becomes idle, timeout in 5 seconds.
( 200.316| 0.000) D: [lt-pulseaudio] core.c: Hmm, no streams around, trying to vacuum.
( 200.316| 0.000) I: [lt-pulseaudio] sink-input.c: Freeing input 0 "audio stream"
( 200.316| 0.000) I: [lt-pulseaudio] client.c: Freed 10 "MPlayer"
( 200.316| 0.000) I: [lt-pulseaudio] protocol-native.c: Connection died.
( 205.321| 5.004) I: [lt-pulseaudio] module-suspend-on-idle.c: Sink raop_output.DENON-AVR-2312.local idle for too long, suspending ...
( 205.321| 0.000) D: [lt-pulseaudio] sink.c: Suspend cause of sink raop_output.DENON-AVR-2312.local is 0x0004, suspending
( 205.321| 0.000) D: [raop-sink] module-raop-sink.c: RAOP: SUSPENDED
( 205.322| 0.000) D: [lt-pulseaudio] core.c: Hmm, no streams around, trying to vacuum.
( 205.535| 0.213) I: [lt-pulseaudio] module-stream-restore.c: Synced.
( 220.552| 15.017) D: [lt-pulseaudio] rtsp_client.c: Full response received. Dispatching
( 220.552| 0.000) D: [lt-pulseaudio] raop_client.c: RAOP: FLUSHED
( 245.564| 25.011) D: [lt-pulseaudio] rtsp_client.c: Full response received. Dispatching
( 245.564| 0.000) D: [lt-pulseaudio] raop_client.c: RAOP: FLUSHED
( 245.565| 0.000) W: [lt-pulseaudio] rtsp_client.c: Unexpected response: RTSP/1.0 455 Method Not Valid In This State
( 245.565| 0.000) W: [lt-pulseaudio] rtsp_client.c: Unexpected response: Server: AirTunes/103.2
( 245.565| 0.000) W: [lt-pulseaudio] rtsp_client.c: Unexpected response: CSeq: 5
( 245.565| 0.000) W: [lt-pulseaudio] rtsp_client.c: Unexpected response:
( 256.941| 11.376) I: [lt-pulseaudio] client.c: Created 11 "Native client (UNIX socket client)"
( 256.941| 0.000) D: [lt-pulseaudio] protocol-native.c: Protocol version: remote 28, local 29
( 256.941| 0.000) I: [lt-pulseaudio] protocol-native.c: Got credentials: uid=1006 gid=1006 success=1
( 256.941| 0.000) D: [lt-pulseaudio] protocol-native.c: SHM possible: yes
( 256.941| 0.000) D: [lt-pulseaudio] protocol-native.c: Negotiated SHM: yes
( 256.942| 0.000) D: [lt-pulseaudio] module-augment-properties.c: Looking for .desktop file for mplayer
( 256.942| 0.000) D: [lt-pulseaudio] module-intended-roles.c: Not setting device for stream audio stream, because it lacks role.
( 256.942| 0.000) D: [lt-pulseaudio] sink-input.c: Negotiated format: pcm, format.sample_format = "\"float32le\"" format.rate = "44100" format.channels = "2" format.channel_map = "\"front-left,front-right\""
( 256.942| 0.000) I: [lt-pulseaudio] sink-input.c: Trying to change sample rate
( 256.942| 0.000) I: [lt-pulseaudio] sink-input.c: Rate changed to 44100 Hz
( 256.942| 0.000) D: [lt-pulseaudio] module-suspend-on-idle.c: Sink raop_output.DENON-AVR-2312.local becomes busy, resuming.
( 256.942| 0.000) D: [lt-pulseaudio] sink.c: Suspend cause of sink raop_output.DENON-AVR-2312.local is 0x0000, resuming
( 256.942| 0.000) D: [raop-sink] module-raop-sink.c: RAOP: IDLE
( 256.942| 0.000) D: [lt-pulseaudio] module-suspend-on-idle.c: Sink raop_output.DENON-AVR-2312.local becomes idle, timeout in 5 seconds.
( 256.942| 0.000) D: [lt-pulseaudio] module-suspend-on-idle.c: Sink raop_output.DENON-AVR-2312.local becomes idle, timeout in 5 seconds.
( 256.942| 0.000) I: [lt-pulseaudio] resampler.c: Forcing resampler 'copy', because of fixed, identical sample rates.
( 256.942| 0.000) D: [lt-pulseaudio] resampler.c: Resampler:
( 256.942| 0.000) D: [lt-pulseaudio] resampler.c: rate 44100 -> 44100 (method copy)
( 256.942| 0.000) D: [lt-pulseaudio] resampler.c: format float32le -> s16le (intermediate s16le)
( 256.942| 0.000) D: [lt-pulseaudio] resampler.c: channels 2 -> 2 (resampling 2)
( 256.943| 0.000) D: [lt-pulseaudio] memblockq.c: memblockq requested: maxlength=33554432, tlength=0, base=4, prebuf=0, minreq=1 maxrewind=0
( 256.943| 0.000) D: [lt-pulseaudio] memblockq.c: memblockq sanitized: maxlength=33554432, tlength=33554432, base=4, prebuf=0, minreq=4 maxrewind=0
( 256.943| 0.000) I: [lt-pulseaudio] sink-input.c: Created input 1 "audio stream" on raop_output.DENON-AVR-2312.local with sample spec float32le 2ch 44100Hz and channel map front-left,front-right
( 256.943| 0.000) I: [lt-pulseaudio] sink-input.c: media.name = "audio stream"
( 256.943| 0.000) I: [lt-pulseaudio] sink-input.c: application.name = "MPlayer"
( 256.943| 0.000) I: [lt-pulseaudio] sink-input.c: native-protocol.peer = "UNIX socket client"
( 256.943| 0.000) I: [lt-pulseaudio] sink-input.c: native-protocol.version = "28"
( 256.943| 0.000) I: [lt-pulseaudio] sink-input.c: application.process.id = "16318"
( 256.943| 0.000) I: [lt-pulseaudio] sink-input.c: application.process.user = "cubox"
( 256.943| 0.000) I: [lt-pulseaudio] sink-input.c: application.process.host = "Thirsty"
( 256.943| 0.000) I: [lt-pulseaudio] sink-input.c: application.process.binary = "mplayer"
( 256.943| 0.000) I: [lt-pulseaudio] sink-input.c: application.language = "C"
( 256.943| 0.000) I: [lt-pulseaudio] sink-input.c: application.process.machine_id = "9953ec36011c0ec18cb31366508ed24d"
( 256.943| 0.000) I: [lt-pulseaudio] sink-input.c: application.process.session_id = "16"
( 256.943| 0.000) I: [lt-pulseaudio] sink-input.c: module-stream-restore.id = "sink-input-by-application-name:MPlayer"
( 256.943| 0.000) I: [lt-pulseaudio] protocol-native.c: Requested tlength=250.00 ms, minreq=20.00 ms
( 256.943| 0.000) D: [lt-pulseaudio] protocol-native.c: Traditional mode enabled, modifying sink usec only for compat with minreq.
( 256.943| 0.000) D: [lt-pulseaudio] protocol-native.c: Requested latency=210.00 ms, Received latency=250.00 ms
( 256.943| 0.000) D: [lt-pulseaudio] memblockq.c: memblockq requested: maxlength=4194304, tlength=102312, base=8, prebuf=95264, minreq=7056 maxrewind=0
( 256.943| 0.000) D: [lt-pulseaudio] memblockq.c: memblockq sanitized: maxlength=4194304, tlength=102312, base=8, prebuf=95264, minreq=7056 maxrewind=0
( 256.943| 0.000) I: [lt-pulseaudio] protocol-native.c: Final latency 540.00 ms = 250.00 ms + 2*20.00 ms + 250.00 ms
( 256.943| 0.000) D: [lt-pulseaudio] module-raop-sink.c: Volume adjusted: orig=0 adjusted=20724
( 256.943| 0.000) D: [lt-pulseaudio] module-raop-sink.c: Requested volume: front-left: 0 / 0%, front-right: 0 / 0%
( 256.943| 0.000) D: [lt-pulseaudio] module-raop-sink.c: Got hardware volume: front-left: 20724 / 32%, front-right: 20724 / 32%
( 256.943| 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
( 256.943| 0.000) D: [lt-pulseaudio] raop_client.c: volume=20724 db=-30.000381
( 256.943| 0.000) D: [lt-pulseaudio] rtsp_client.c: Sending command: SET_PARAMETER
( 256.943| 0.000) D: [raop-sink] module-raop-sink.c: RAOP: RUNNING
( 256.943| 0.000) D: [raop-sink] raop_client.c: Connection already in progress
( 256.943| 0.000) D: [lt-pulseaudio] core-subscribe.c: Dropped redundant event due to change event.
( 256.949| 0.005) D: [raop-sink] protocol-native.c: Requesting rewind due to end of underrun.
( 261.082| 4.133) D: [raop-sink] protocol-native.c: Requesting rewind due to end of underrun.
( 261.421| 0.339) D: [lt-pulseaudio] module-raop-sink.c: Volume adjusted: orig=0 adjusted=20724
( 261.421| 0.000) D: [lt-pulseaudio] module-raop-sink.c: Requested volume: front-left: 0 / 0%, front-right: 0 / 0%
( 261.421| 0.000) D: [lt-pulseaudio] module-raop-sink.c: Got hardware volume: front-left: 20724 / 32%, front-right: 20724 / 32%
( 261.421| 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
( 261.421| 0.000) D: [lt-pulseaudio] raop_client.c: volume=20724 db=-30.000381
( 261.421| 0.000) D: [lt-pulseaudio] rtsp_client.c: Sending command: SET_PARAMETER
( 261.422| 0.000) D: [lt-pulseaudio] module-suspend-on-idle.c: Sink raop_output.DENON-AVR-2312.local becomes idle, timeout in 5 seconds.
( 261.422| 0.000) D: [raop-sink] module-raop-sink.c: RAOP: IDLE
( 261.422| 0.000) D: [raop-sink] rtsp_client.c: Sending command: FLUSH
( 261.422| 0.000) D: [lt-pulseaudio] module-suspend-on-idle.c: Sink raop_output.DENON-AVR-2312.local becomes idle, timeout in 5 seconds.
( 261.422| 0.000) D: [lt-pulseaudio] core.c: Hmm, no streams around, trying to vacuum.
( 261.422| 0.000) I: [lt-pulseaudio] sink-input.c: Freeing input 1 "audio stream"
( 261.422| 0.000) I: [lt-pulseaudio] client.c: Freed 11 "MPlayer"
( 261.422| 0.000) I: [lt-pulseaudio] protocol-native.c: Connection died.
( 266.427| 5.004) I: [lt-pulseaudio] module-suspend-on-idle.c: Sink raop_output.DENON-AVR-2312.local idle for too long, suspending ...
( 266.427| 0.000) D: [lt-pulseaudio] sink.c: Suspend cause of sink raop_output.DENON-AVR-2312.local is 0x0004, suspending
( 266.427| 0.000) D: [raop-sink] module-raop-sink.c: RAOP: SUSPENDED
( 266.427| 0.000) D: [lt-pulseaudio] core.c: Hmm, no streams around, trying to vacuum.
( 281.947| 15.519) D: [lt-pulseaudio] rtsp_client.c: Full response received. Dispatching
( 281.947| 0.000) D: [lt-pulseaudio] raop_client.c: RAOP: FLUSHED
( 306.950| 25.003) D: [lt-pulseaudio] rtsp_client.c: Full response received. Dispatching
( 306.950| 0.000) D: [lt-pulseaudio] raop_client.c: RAOP: FLUSHED
( 306.951| 0.000) W: [lt-pulseaudio] rtsp_client.c: Unexpected response: RTSP/1.0 455 Method Not Valid In This State
( 306.951| 0.000) W: [lt-pulseaudio] rtsp_client.c: Unexpected response: Server: AirTunes/103.2
( 306.951| 0.000) W: [lt-pulseaudio] rtsp_client.c: Unexpected response: CSeq: 8
( 306.951| 0.000) W: [lt-pulseaudio] rtsp_client.c: Unexpected response:
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment