[pkg-wine-party] Bug#807403: wine: Sound doesn't work anymore with Windows games

Thu Dec 10 07:50:20 UTC 2015

Can confirm this with wine-1.8-rc2.
Sound does work in winecfg and windowed applications e.g. installers,
but in games it does not.

Here is a WINEDEBUG=+pulse log from a systemshock2 run:

$ WINEDEBUG=+pulse PULSE_LATENCY_MSEC=150 wine SHOCK2.EXE 
fixme:win:EnumDisplayDevicesW ((null),0,0x32f2f4,0x00000000), stub!
trace:pulse:pulse_test_connect Name: SHOCK2.EXE
trace:pulse:pulse_test_connect libpulse protocol version: 30. API Version 12
trace:pulse:pulse_contextcallback State change to 1
trace:pulse:pulse_contextcallback State change to 2
trace:pulse:pulse_contextcallback State change to 3
trace:pulse:pulse_contextcallback Ready
trace:pulse:pulse_test_connect Test-connected to server /run/user/1000/pulse/native with protocol version: 30.
trace:pulse:pulse_stream_state Stream state changed to 1
trace:pulse:pulse_stream_state Stream state changed to 2
trace:pulse:pulse_stream_state Stream state changed to 4
trace:pulse:pulse_stream_state Stream state changed to 1
trace:pulse:pulse_stream_state Stream state changed to 2
trace:pulse:pulse_stream_state Stream state changed to 4
trace:pulse:AUDDRV_GetPropValue {25da76d0-033c-4235-9002-19f48894ac6f}, ({b3f8fa53-0004-438e-9003-51a46e139bfc},2), 0x32f3a8
trace:pulse:AUDDRV_GetPropValue {25da76d0-033c-4235-9002-19f48894ac6f}, ({1da5d803-d492-4edd-8c23-e0c0ffee7f0e},0), 0x32f3a8
trace:pulse:AUDDRV_GetPropValue {fd47d9cc-4218-4135-9ce2-0c195c87405b}, ({b3f8fa53-0004-438e-9003-51a46e139bfc},2), 0x32f3a8
trace:pulse:AUDDRV_GetPropValue {fd47d9cc-4218-4135-9ce2-0c195c87405b}, ({1da5d803-d492-4edd-8c23-e0c0ffee7f0e},0), 0x32f3a8
trace:pulse:AUDDRV_GetEndpointIDs 0 0x32f470 0x32f478 0x32f47c
trace:pulse:AUDDRV_GetPropValue {fd47d9cc-4218-4135-9ce2-0c195c87405b}, ({b3f8fa53-0004-438e-9003-51a46e139bfc},2), 0x32f338
trace:pulse:AUDDRV_GetPropValue {fd47d9cc-4218-4135-9ce2-0c195c87405b}, ({1da5d803-d492-4edd-8c23-e0c0ffee7f0e},0), 0x32f338
trace:pulse:AUDDRV_GetAudioEndpoint {fd47d9cc-4218-4135-9ce2-0c195c87405b} 0x147718 0x32f480
trace:pulse:AudioClient_AddRef (0x147950) Refcount now 1
trace:pulse:AudioClient_GetMixFormat (0x147950)->(0x32f484)
trace:pulse:dump_fmt wFormatTag: 0xfffe (WAVE_FORMAT_EXTENSIBLE)
trace:pulse:dump_fmt nChannels: 2
trace:pulse:dump_fmt nSamplesPerSec: 48000
trace:pulse:dump_fmt nAvgBytesPerSec: 384000
trace:pulse:dump_fmt nBlockAlign: 8
trace:pulse:dump_fmt wBitsPerSample: 32
trace:pulse:dump_fmt cbSize: 22
trace:pulse:dump_fmt dwChannelMask: 00000003
trace:pulse:dump_fmt Samples: 0020
trace:pulse:dump_fmt SubFormat: {00000003-0000-0010-8000-00aa00389b71}
trace:pulse:AudioClient_Release (0x147950) Refcount now 0
trace:pulse:AUDDRV_GetEndpointIDs 1 0x32f470 0x32f478 0x32f47c
trace:pulse:AUDDRV_GetPropValue {25da76d0-033c-4235-9002-19f48894ac6f}, ({b3f8fa53-0004-438e-9003-51a46e139bfc},2), 0x32f338
trace:pulse:AUDDRV_GetPropValue {25da76d0-033c-4235-9002-19f48894ac6f}, ({1da5d803-d492-4edd-8c23-e0c0ffee7f0e},0), 0x32f338
trace:pulse:AUDDRV_GetAudioEndpoint {25da76d0-033c-4235-9002-19f48894ac6f} 0x147470 0x32f480
trace:pulse:AudioClient_AddRef (0x147950) Refcount now 1
trace:pulse:AudioClient_GetMixFormat (0x147950)->(0x32f484)
trace:pulse:dump_fmt wFormatTag: 0xfffe (WAVE_FORMAT_EXTENSIBLE)
trace:pulse:dump_fmt nChannels: 2
trace:pulse:dump_fmt nSamplesPerSec: 44100
trace:pulse:dump_fmt nAvgBytesPerSec: 352800
trace:pulse:dump_fmt nBlockAlign: 8
trace:pulse:dump_fmt wBitsPerSample: 32
trace:pulse:dump_fmt cbSize: 22
trace:pulse:dump_fmt dwChannelMask: 00000003
trace:pulse:dump_fmt Samples: 0020
trace:pulse:dump_fmt SubFormat: {00000003-0000-0010-8000-00aa00389b71}
trace:pulse:AudioClient_Release (0x147950) Refcount now 0
trace:pulse:AUDDRV_GetAudioEndpoint {fd47d9cc-4218-4135-9ce2-0c195c87405b} 0x147718 0x147b10
trace:pulse:AudioClient_AddRef (0x147b40) Refcount now 1
trace:pulse:AudioClient_GetMixFormat (0x147b40)->(0x32f708)
trace:pulse:dump_fmt wFormatTag: 0xfffe (WAVE_FORMAT_EXTENSIBLE)
trace:pulse:dump_fmt nChannels: 2
trace:pulse:dump_fmt nSamplesPerSec: 48000
trace:pulse:dump_fmt nAvgBytesPerSec: 384000
trace:pulse:dump_fmt nBlockAlign: 8
trace:pulse:dump_fmt wBitsPerSample: 32
trace:pulse:dump_fmt cbSize: 22
trace:pulse:dump_fmt dwChannelMask: 00000003
trace:pulse:dump_fmt Samples: 0020
trace:pulse:dump_fmt SubFormat: {00000003-0000-0010-8000-00aa00389b71}
trace:pulse:AudioClient_IsFormatSupported (0x147b40)->(0, 0x147870, 0x32f704)
trace:pulse:dump_fmt wFormatTag: 0xfffe (WAVE_FORMAT_EXTENSIBLE)
trace:pulse:dump_fmt nChannels: 2
trace:pulse:dump_fmt nSamplesPerSec: 48000
trace:pulse:dump_fmt nAvgBytesPerSec: 384000
trace:pulse:dump_fmt nBlockAlign: 8
trace:pulse:dump_fmt wBitsPerSample: 32
trace:pulse:dump_fmt cbSize: 22
trace:pulse:dump_fmt dwChannelMask: 00000003
trace:pulse:dump_fmt Samples: 0020
trace:pulse:dump_fmt SubFormat: {00000003-0000-0010-8000-00aa00389b71}
trace:pulse:AudioClient_IsFormatSupported returning: 00000000 (nil)
trace:pulse:AudioClient_GetDevicePeriod (0x147b40)->(0x32f6d0, (nil))
trace:pulse:AudioClient_Initialize (0x147b40)->(0, c0000, 1e8480, 0, 0x147870, (null))
trace:pulse:pulse_connect Name: SHOCK2.EXE
trace:pulse:pulse_connect libpulse protocol version: 30. API Version 12
trace:pulse:pulse_contextcallback State change to 1
trace:pulse:pulse_contextcallback State change to 2
trace:pulse:pulse_contextcallback State change to 3
trace:pulse:pulse_contextcallback Ready
trace:pulse:pulse_connect Connected to server /run/user/1000/pulse/native with protocol version: 30.
trace:pulse:AudioClient_Initialize Obtaining format returns 00000000
trace:pulse:dump_fmt wFormatTag: 0xfffe (WAVE_FORMAT_EXTENSIBLE)
trace:pulse:dump_fmt nChannels: 2
trace:pulse:dump_fmt nSamplesPerSec: 48000
trace:pulse:dump_fmt nAvgBytesPerSec: 384000
trace:pulse:dump_fmt nBlockAlign: 8
trace:pulse:dump_fmt wBitsPerSample: 32
trace:pulse:dump_fmt cbSize: 22
trace:pulse:dump_fmt dwChannelMask: 00000003
trace:pulse:dump_fmt Samples: 0020
trace:pulse:dump_fmt SubFormat: {00000003-0000-0010-8000-00aa00389b71}
trace:pulse:dump_attr maxlength: 76800
trace:pulse:dump_attr minreq: 7680
trace:pulse:dump_attr fragsize: 7680
trace:pulse:dump_attr tlength: 76800
trace:pulse:dump_attr prebuf: 8
trace:pulse:pulse_stream_state Stream state changed to 1
trace:pulse:pulse_stream_state Stream state changed to 2
trace:pulse:dump_attr maxlength: 4194304
trace:pulse:dump_attr minreq: 7680
trace:pulse:dump_attr fragsize: 57600
trace:pulse:dump_attr tlength: 57600
trace:pulse:dump_attr prebuf: 49928
trace:pulse:AudioClient_SetEventHandle (0x147b40)->(0xf4)
trace:pulse:AudioClient_GetService (0x147b40)->({f294acfc-3146-4483-a7bf-addca7c260e2}, 0x147b1c)
trace:pulse:AudioClient_AddRef (0x147b40) Refcount now 2
trace:pulse:AudioClient_GetService (0x147b40)->({cd63314f-3fba-4a1b-812c-ef96358728e7}, 0x147b14)
trace:pulse:AudioClient_AddRef (0x147b40) Refcount now 3
trace:pulse:AudioClient_GetService (0x147b40)->({93014887-242d-4068-8a15-cf5e93b90fe3}, 0x147b18)
trace:pulse:AudioClient_AddRef (0x147b40) Refcount now 4
trace:pulse:AudioClient_Start (0x147b40)
trace:pulse:pulse_op_cb Success: 1
trace:pulse:AudioClient_GetStreamLatency (0x147b40)->(0x32f708)
trace:pulse:AudioClient_GetStreamLatency Latency: 20 ms
trace:pulse:AudioClient_IsFormatSupported (0x147b40)->(0, 0x32f72a, 0x32f724)
trace:pulse:dump_fmt wFormatTag: 0x1 (WAVE_FORMAT_PCM)
trace:pulse:dump_fmt nChannels: 1
trace:pulse:dump_fmt nSamplesPerSec: 11025
trace:pulse:dump_fmt nAvgBytesPerSec: 11025
trace:pulse:dump_fmt nBlockAlign: 1
trace:pulse:dump_fmt wBitsPerSample: 8
trace:pulse:dump_fmt cbSize: 0
trace:pulse:AudioClient_IsFormatSupported returning: 00000000 (nil)
trace:pulse:AudioClient_IsFormatSupported (0x147b40)->(0, 0x32f72a, 0x32f724)
trace:pulse:dump_fmt wFormatTag: 0x1 (WAVE_FORMAT_PCM)
trace:pulse:dump_fmt nChannels: 1
trace:pulse:dump_fmt nSamplesPerSec: 11025
trace:pulse:dump_fmt nAvgBytesPerSec: 22050
trace:pulse:dump_fmt nBlockAlign: 2
trace:pulse:dump_fmt wBitsPerSample: 16
trace:pulse:dump_fmt cbSize: 0
trace:pulse:AudioClient_IsFormatSupported returning: 00000000 (nil)
trace:pulse:AudioClient_IsFormatSupported (0x147b40)->(0, 0x32f72a, 0x32f724)
trace:pulse:dump_fmt wFormatTag: 0x1 (WAVE_FORMAT_PCM)
trace:pulse:dump_fmt nChannels: 2
trace:pulse:dump_fmt nSamplesPerSec: 11025
trace:pulse:dump_fmt nAvgBytesPerSec: 22050
trace:pulse:dump_fmt nBlockAlign: 2
trace:pulse:dump_fmt wBitsPerSample: 8
trace:pulse:dump_fmt cbSize: 0
trace:pulse:AudioClient_IsFormatSupported returning: 00000000 (nil)
trace:pulse:AudioClient_IsFormatSupported (0x147b40)->(0, 0x32f72a, 0x32f724)
trace:pulse:dump_fmt wFormatTag: 0x1 (WAVE_FORMAT_PCM)
trace:pulse:dump_fmt nChannels: 2
trace:pulse:dump_fmt nSamplesPerSec: 11025
trace:pulse:dump_fmt nAvgBytesPerSec: 44100
trace:pulse:dump_fmt nBlockAlign: 4
trace:pulse:dump_fmt wBitsPerSample: 16
trace:pulse:dump_fmt cbSize: 0
trace:pulse:AudioClient_IsFormatSupported returning: 00000000 (nil)
trace:pulse:AudioClient_GetDevicePeriod (0x147b40)->(0x32f6e0, (nil))
trace:pulse:AudioClient_GetCurrentPadding (0x147b40)->(0x561e988)
trace:pulse:AudioClient_GetCurrentPadding 0x147b40 Pad: 0 ms (0)
trace:pulse:AudioRenderClient_GetBuffer (0x147b40)->(9600, 0x561e898)
warn:pulse:AudioRenderClient_GetBuffer Wanted to write 9600, but only 7200 available
trace:pulse:AudioClient_Start (0x147b40)
trace:pulse:AudioClient_GetCurrentPadding (0x147b40)->(0x561e988)
trace:pulse:AudioClient_GetCurrentPadding 0x147b40 Pad: 0 ms (0)
trace:pulse:AudioRenderClient_GetBuffer (0x147b40)->(9600, 0x561e898)
warn:pulse:AudioRenderClient_GetBuffer Wanted to write 9600, but only 7200 available
trace:pulse:AudioClient_GetCurrentPadding (0x147b40)->(0x561e988)
trace:pulse:AudioClient_GetCurrentPadding 0x147b40 Pad: 0 ms (0)
trace:pulse:AudioRenderClient_GetBuffer (0x147b40)->(9600, 0x561e898)
warn:pulse:AudioRenderClient_GetBuffer Wanted to write 9600, but only 7200 available
fixme:win:EnumDisplayDevicesW ((null),0,0x32f164,0x00000000), stub!
trace:pulse:AudioClient_GetCurrentPadding (0x147b40)->(0x561e988)
trace:pulse:AudioClient_GetCurrentPadding 0x147b40 Pad: 0 ms (0)
trace:pulse:AudioRenderClient_GetBuffer (0x147b40)->(9600, 0x561e898)
warn:pulse:AudioRenderClient_GetBuffer Wanted to write 9600, but only 7200 available
trace:pulse:AudioClient_GetCurrentPadding (0x147b40)->(0x561e988)
trace:pulse:AudioClient_GetCurrentPadding 0x147b40 Pad: 0 ms (0)
trace:pulse:AudioRenderClient_GetBuffer (0x147b40)->(9600, 0x561e898)
warn:pulse:AudioRenderClient_GetBuffer Wanted to write 9600, but only 7200 available
trace:pulse:AudioClient_GetCurrentPadding (0x147b40)->(0x561e988)
trace:pulse:AudioClient_GetCurrentPadding 0x147b40 Pad: 0 ms (0)
trace:pulse:AudioRenderClient_GetBuffer (0x147b40)->(9600, 0x561e898)
warn:pulse:AudioRenderClient_GetBuffer Wanted to write 9600, but only 7200 available
... [skip] ...
warn:pulse:AudioRenderClient_GetBuffer Wanted to write 9600, but only 7200 available
trace:pulse:AudioClient_GetCurrentPadding (0x147b40)->(0x561e988)
trace:pulse:AudioClient_GetCurrentPadding 0x147b40 Pad: 0 ms (0)
trace:pulse:AudioRenderClient_GetBuffer (0x147b40)->(9600, 0x561e898)
warn:pulse:AudioRenderClient_GetBuffer Wanted to write 9600, but only 7200 available
trace:pulse:AudioClient_GetCurrentPadding (0x147b40)->(0x561e988)
trace:pulse:AudioClient_GetCurrentPadding 0x147b40 Pad: 0 ms (0)
trace:pulse:AudioRenderClient_GetBuffer (0x147b40)->(9600, 0x561e898)
warn:pulse:AudioRenderClient_GetBuffer Wanted to write 9600, but only 7200 available
trace:pulse:AudioClient_Stop (0x147b40)
trace:pulse:pulse_op_cb Success: 1
trace:pulse:AudioClient_Release (0x147b40) Refcount now 3
trace:pulse:AudioClient_Release (0x147b40) Refcount now 2
trace:pulse:AudioClient_Release (0x147b40) Refcount now 1
trace:pulse:AudioClient_Release (0x147b40) Refcount now 0
trace:pulse:pulse_stream_state Stream state changed to 4
fixme:msg:pack_message msg 14 (WM_ERASEBKGND) not supported yet
trace:pulse:pulse_contextcallback State change to 6

I can see SHOCK2.exe's volume meter showing up in pavucontrol, but it doen't
show any signs of life.

If I do 'winetricks dsound' and dsound is set to 'native,builtin' in libraries
wine just loops trying to create audioclient:

trace:pulse:AudioClient_GetService (0x148948)->({cd63314f-3fba-4a1b-812c-ef96358728e7}, 0x148858)
trace:pulse:AudioClient_AddRef (0x148948) Refcount now 2
trace:pulse:AudioClient_SetEventHandle (0x148948)->(0x114)
trace:pulse:AudioClient_GetService (0x148948)->({f294acfc-3146-4483-a7bf-addca7c260e2}, 0x148850)
trace:pulse:AudioClient_AddRef (0x148948) Refcount now 3
trace:pulse:AudioClient_GetService (0x148948)->({93014887-242d-4068-8a15-cf5e93b90fe3}, 0x14885c)
trace:pulse:AudioClient_AddRef (0x148948) Refcount now 4
trace:pulse:AudioClient_Release (0x148948) Refcount now 3
trace:pulse:AudioClient_Release (0x148948) Refcount now 2
trace:pulse:AudioClient_Release (0x148948) Refcount now 1
trace:pulse:AudioClient_Release (0x148948) Refcount now 0
trace:pulse:pulse_stream_state Stream state changed to 4
trace:pulse:AUDDRV_GetAudioEndpoint {fd47d9cc-4218-4135-9ce2-0c195c87405b} 0x147728 0x14884c
trace:pulse:AudioClient_AddRef (0x148bc8) Refcount now 1
trace:pulse:AudioClient_Initialize (0x148bc8)->(0, c0000, f4240, 0, 0x148730, {ed3b6eea-f480-4984-acee-2eb52f9e3ccd})
trace:pulse:AudioClient_Initialize Obtaining format returns 00000000
trace:pulse:dump_fmt wFormatTag: 0x1 (WAVE_FORMAT_PCM)
trace:pulse:dump_fmt nChannels: 2
trace:pulse:dump_fmt nSamplesPerSec: 22050
trace:pulse:dump_fmt nAvgBytesPerSec: 44100
trace:pulse:dump_fmt nBlockAlign: 2
trace:pulse:dump_fmt wBitsPerSample: 8
trace:pulse:dump_fmt cbSize: 0
trace:pulse:dump_attr maxlength: 4410
trace:pulse:dump_attr minreq: 882
trace:pulse:dump_attr fragsize: 882
trace:pulse:dump_attr tlength: 4410
trace:pulse:dump_attr prebuf: 2
trace:pulse:pulse_stream_state Stream state changed to 1
trace:pulse:pulse_stream_state Stream state changed to 2
trace:pulse:dump_attr maxlength: 4194304
trace:pulse:dump_attr minreq: 882
trace:pulse:dump_attr fragsize: 6614
trace:pulse:dump_attr tlength: 6614
trace:pulse:dump_attr prebuf: 5734
trace:pulse:AudioClient_GetService (0x148bc8)->({cd63314f-3fba-4a1b-812c-ef96358728e7}, 0x148858)
trace:pulse:AudioClient_AddRef (0x148bc8) Refcount now 2
trace:pulse:AudioClient_SetEventHandle (0x148bc8)->(0x114)
trace:pulse:AudioClient_GetService (0x148bc8)->({f294acfc-3146-4483-a7bf-addca7c260e2}, 0x148850)
trace:pulse:AudioClient_AddRef (0x148bc8) Refcount now 3
trace:pulse:AudioClient_GetService (0x148bc8)->({93014887-242d-4068-8a15-cf5e93b90fe3}, 0x14885c)
trace:pulse:AudioClient_AddRef (0x148bc8) Refcount now 4
trace:pulse:AudioStreamVolume_GetChannelCount (0x148bc8)->(0x592e968)
trace:pulse:AudioStreamVolume_GetAllVolumes (0x148bc8)->(2, 0x14aae8)
trace:pulse:AudioStreamVolume_GetChannelCount (0x148bc8)->(0x592e968)
trace:pulse:AudioStreamVolume_GetAllVolumes (0x148bc8)->(2, 0x14aae8)
trace:pulse:AudioStreamVolume_SetAllVolumes (0x148bc8)->(2, 0x14aae8)
trace:pulse:AudioClient_GetBufferSize (0x148bc8)->(0x592e8c4)
trace:pulse:AudioClient_GetCurrentPadding (0x148bc8)->(0x592e8c0)
trace:pulse:AudioClient_GetCurrentPadding 0x148bc8 Pad: 0 ms (0)
trace:pulse:AudioClock_GetFrequency (0x148bc8)->(0x592e8c8)
trace:pulse:AudioClock_GetPosition (0x148bc8)->(0x592e8d0, (nil))
trace:pulse:AudioClock_GetPosition 0x148bc8 Position: 0
trace:pulse:AudioRenderClient_GetBuffer (0x148bc8)->(2, 0x592e8d0)
trace:pulse:AudioRenderClient_ReleaseBuffer (0x148bc8)->(2, 0)
trace:pulse:AudioRenderClient_ReleaseBuffer Released 2, pad 2
trace:pulse:AudioClient_Start (0x148bc8)
trace:pulse:pulse_op_cb Success: 1
... [about 5 sec delay here] ...
trace:pulse:AudioClient_Stop (0x148bc8)
trace:pulse:pulse_op_cb Success: 1
trace:pulse:AudioClient_Reset (0x148bc8)
trace:pulse:pulse_op_cb Success: 1
trace:pulse:AudioClient_Stop (0x148bc8)
trace:pulse:AudioClient_Reset (0x148bc8)
trace:pulse:AudioClient_Release (0x148bc8) Refcount now 3
trace:pulse:AudioClient_Release (0x148bc8) Refcount now 2
trace:pulse:AudioClient_Release (0x148bc8) Refcount now 1
trace:pulse:AudioClient_Release (0x148bc8) Refcount now 0
trace:pulse:pulse_stream_state Stream state changed to 4
trace:pulse:AUDDRV_GetAudioEndpoint {fd47d9cc-4218-4135-9ce2-0c195c87405b} 0x147728 0x14884c
trace:pulse:AudioClient_AddRef (0x148bc8) Refcount now 1
trace:pulse:AudioClient_Initialize (0x148bc8)->(0, c0000, f4240, 0, 0x148658, {ed3b6eea-f480-4984-acee-2eb52f9e3ccd})
trace:pulse:AudioClient_Initialize Obtaining format returns 00000000
trace:pulse:dump_fmt wFormatTag: 0x1 (WAVE_FORMAT_PCM)
trace:pulse:dump_fmt nChannels: 2
trace:pulse:dump_fmt nSamplesPerSec: 22050
trace:pulse:dump_fmt nAvgBytesPerSec: 88200
trace:pulse:dump_fmt nBlockAlign: 4
trace:pulse:dump_fmt wBitsPerSample: 16
trace:pulse:dump_fmt cbSize: 0
trace:pulse:dump_attr maxlength: 8820
trace:pulse:dump_attr minreq: 1764
trace:pulse:dump_attr fragsize: 1764
trace:pulse:dump_attr tlength: 8820
trace:pulse:dump_attr prebuf: 4
trace:pulse:pulse_stream_state Stream state changed to 1
trace:pulse:pulse_stream_state Stream state changed to 2
trace:pulse:dump_attr maxlength: 4194304
trace:pulse:dump_attr minreq: 1764
trace:pulse:dump_attr fragsize: 13228
trace:pulse:dump_attr tlength: 13228
trace:pulse:dump_attr prebuf: 11468
trace:pulse:AudioClient_GetService (0x148bc8)->({cd63314f-3fba-4a1b-812c-ef96358728e7}, 0x148858)
trace:pulse:AudioClient_AddRef (0x148bc8) Refcount now 2
trace:pulse:AudioClient_SetEventHandle (0x148bc8)->(0x114)
trace:pulse:AudioClient_GetService (0x148bc8)->({f294acfc-3146-4483-a7bf-addca7c260e2}, 0x148850)
trace:pulse:AudioClient_AddRef (0x148bc8) Refcount now 3
trace:pulse:AudioClient_GetService (0x148bc8)->({93014887-242d-4068-8a15-cf5e93b90fe3}, 0x14885c)
trace:pulse:AudioClient_AddRef (0x148bc8) Refcount now 4
trace:pulse:AudioStreamVolume_GetChannelCount (0x148bc8)->(0x572e968)
trace:pulse:AudioStreamVolume_GetAllVolumes (0x148bc8)->(2, 0x148550)
trace:pulse:AudioStreamVolume_GetChannelCount (0x148bc8)->(0x572e968)
trace:pulse:AudioStreamVolume_GetAllVolumes (0x148bc8)->(2, 0x148550)
trace:pulse:AudioStreamVolume_SetAllVolumes (0x148bc8)->(2, 0x148550)
trace:pulse:AudioClient_GetBufferSize (0x148bc8)->(0x572e8c4)
trace:pulse:AudioClient_GetCurrentPadding (0x148bc8)->(0x572e8c0)
trace:pulse:AudioClient_GetCurrentPadding 0x148bc8 Pad: 0 ms (0)
trace:pulse:AudioClock_GetFrequency (0x148bc8)->(0x572e8c8)
trace:pulse:AudioClock_GetPosition (0x148bc8)->(0x572e8d0, (nil))
trace:pulse:AudioClock_GetPosition 0x148bc8 Position: 0
trace:pulse:AudioRenderClient_GetBuffer (0x148bc8)->(1, 0x572e8d0)
trace:pulse:AudioRenderClient_ReleaseBuffer (0x148bc8)->(1, 0)
trace:pulse:AudioRenderClient_ReleaseBuffer Released 1, pad 1
trace:pulse:AudioClient_Start (0x148bc8)
trace:pulse:pulse_op_cb Success: 1
... [and so on] ...

-- 
Regards,
  Artem Savkov