Re: [xine-user] problems with xine losing sound

SourceForge Headquarters 225 Broadway Suite 1600 San Diego, CA 92101 +1 (858) 454-5900

Hi Michael,

On Thu, 13 Feb 2003, Michael Roitzsch wrote:

> > > > softsync is the only method that will work on PPC.  I tried
> > > > probebuffer and it just hangs xine.
> > >
> > > That should not happen. Could you compile a debug version of
> > > xine-lib to see where it gets stuck?
> >
> > OK, I did a "make clean", "make debug", and 'make install-debug" of
> > a February 2nd CVS version of xine-lib.  I uncommented LOG in
> > xine-engine/audio_out.c and audio_out/audio_oss_out.c.  But the
> > xine log output isn't very interesting.  I've attached the whole
> > log, but it just ends with:
> >
> > audio_oss_out: Opening audio device...
> > audio_oss_out: using device >/dev/dsp<
> > audio_oss_out: Audio driver realtime sync disabled...
> >
> > This is where xine hangs, and I have to <control-C> out of xine.
> >
> > If you want me to use gdb to get more info, you'll have to instruct
> > me how to do this for a hang situation.
> 
> You could just launch xine inside gdb (with 'gdb xine'), exit with 
> Ctrl-c when it hangs and type 'thread apply all bt' at the prompt to 
> get traces of all thread's stacks.
> But from the output your provided, I can already guess where it hangs: 
> right in the buffer probing (of course). xine tries to determine the 
> length of the buffer by writing data blocks to the OSS device until the 
> write fails or is incomplete (the buffer is full). This somehow never 
> happens on your PPC, so you either have an unlimited buffer (then 
> softsync really is your only chance) or the write is blocking (although 
> told not to do so) until enough buffer space is available.
> Could you apply the attached patch and send the output here?

The full xine log output is attached, but here are some interesting
bits.

It begins with:

audio_oss_out: DEBUG: buffer write took 734 usecs
audio_oss_out: DEBUG: buffer write took 357 usecs
audio_oss_out: DEBUG: buffer write took 360 usecs
audio_oss_out: DEBUG: buffer write took 349 usecs
audio_oss_out: DEBUG: buffer write took 357 usecs
...

This continues for 105 lines, with an occasional longer time interval
such as:

audio_oss_out: DEBUG: buffer write took 2749 usecs

After this initial stage, the time interval drops down to:

audio_oss_out: DEBUG: buffer write took 55 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
...

And there is an occasional much longer time interval such as:

audio_oss_out: DEBUG: buffer write took 152380 usecs

The very end of the log has:

...
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 32 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 32 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs

This is where I <control-C> out of xine since it is hung and these
types of messages would just continue ad infinitum.

						-Bill

gwiz% xine -p ~/menace_480.mov
This is xine (X11 gui) - a free video player v0.9.18
(c) 2000-2003 by G. Bartsch and the xine project team.
Built with xine library 1.0.0 (1-beta4)
Found xine library version: 1.0.0 (1-cvs).
XServer Vendor: The XFree86 Project, Inc. Release: 40299002,
        Protocol Version: 11, Revision: 0,
        Available Screen(s): 1, using 0
        Depth: 24.
        XShmQueryVersion: 1.1.
-[ xiTK version 0.10.1 ]-
-[ xiTK will use XShm ]-
-[ WM type: (EWMH) KWIN {KWin} ]-
Display is not using Xinerama.
load_plugins: skipping unreadable plugin directory /me/bill/.xine/plugins.
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_ao_out_oss.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_ao_out_arts.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_ao_out_esd.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_vo_out_xshm.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_vo_out_xv.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_vo_out_aa.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_vo_out_fb.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_vo_out_sdl.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_vo_out_syncfb.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_vo_out_none.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_inp_file.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_inp_http.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_inp_dvd.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_inp_vcd.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_inp_v4l.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_inp_mms.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_inp_stdin_fifo.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_inp_pnm.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_inp_rtsp.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_inp_net.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_inp_dvb.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_inp_cdda.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_dmx_asf.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_dmx_games.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_dmx_games.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_dmx_games.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_dmx_games.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_dmx_games.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_dmx_games.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_dmx_games.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_dmx_games.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_dmx_games.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_dmx_audio.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_dmx_audio.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_dmx_audio.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_dmx_audio.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_dmx_audio.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_dmx_audio.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_dmx_audio.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_dmx_audio.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_dmx_audio.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_dmx_audio.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_dmx_audio.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_dmx_mpeg_ts.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_dmx_avi.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_dmx_mpeg_block.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_dmx_mpeg.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_dmx_mpeg_elem.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_dmx_qt.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_dmx_fli.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_dmx_yuv4mpeg2.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_dmx_real.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_dmx_rawdv.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_dmx_pva.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_dmx_yuv_frames.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_decode_ff.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_decode_ff.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_decode_mpeg2.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_decode_a52.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_decode_spu.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_decode_spucc.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_decode_sputext.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_dmx_sputext.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_decode_dts.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_decode_mad.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_decode_lpcm.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_decode_cinepak.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_decode_cyuv.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_decode_fli.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_decode_idcinvideo.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_decode_msrle.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_decode_msvc.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_decode_qtsmc.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_decode_roqvideo.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_decode_rgb.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_decode_svq1.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_decode_yuv.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_decode_qtrpza.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_decode_wc3video.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_decode_qtrle.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_decode_interplayvideo.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_decode_yuv_frames.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/post/xineplug_post_invert.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/post/xineplug_post_goom.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/post/xineplug_post_visualizations.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/post/xineplug_post_visualizations.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_decode_adpcm.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_decode_logpcm.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_decode_roqaudio.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_decode_gsm610.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_decode_interplayaudio.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_decode_nsf.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_decode_real.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_decode_real_audio.so found
load_plugins: plugin /usr/local/install/xine-cvs/lib/xine/plugins/1.0.0/xineplug_decode_faad.so found
demux_sputext: initializing
video_out_xv: using Xv port 61 from adaptor ATI Rage128 Video Overlay for hardware colorspace conversion and scaling.
video_out_xv: open_plugin
video_out_xv: port attribute XV_COLORKEY (6) value is 30
video_out_xv: port attribute XV_BRIGHTNESS (5) value is -1
video_out_xv: port attribute XV_SATURATION (3) value is 15
video_out_xv: double buffering mode = 1
video_out_xv: this adaptor supports the yuy2 format.
video_out_xv: this adaptor supports the yv12 format.
video_out_xv: property #11 = 0
video_out: thread created
audio_oss_out: Opening audio device...
audio_oss_out: using device >/dev/dsp<
audio_oss_out: Audio driver realtime sync disabled...
audio_oss_out: ...probing output buffer size: audio_oss_out: DEBUG: buffer write took 117 usecs
audio_oss_out: DEBUG: buffer write took 734 usecs
audio_oss_out: DEBUG: buffer write took 357 usecs
audio_oss_out: DEBUG: buffer write took 360 usecs
audio_oss_out: DEBUG: buffer write took 349 usecs
audio_oss_out: DEBUG: buffer write took 357 usecs
audio_oss_out: DEBUG: buffer write took 348 usecs
audio_oss_out: DEBUG: buffer write took 360 usecs
audio_oss_out: DEBUG: buffer write took 358 usecs
audio_oss_out: DEBUG: buffer write took 351 usecs
audio_oss_out: DEBUG: buffer write took 356 usecs
audio_oss_out: DEBUG: buffer write took 359 usecs
audio_oss_out: DEBUG: buffer write took 352 usecs
audio_oss_out: DEBUG: buffer write took 353 usecs
audio_oss_out: DEBUG: buffer write took 354 usecs
audio_oss_out: DEBUG: buffer write took 6681 usecs
audio_oss_out: DEBUG: buffer write took 414 usecs
audio_oss_out: DEBUG: buffer write took 360 usecs
audio_oss_out: DEBUG: buffer write took 354 usecs
audio_oss_out: DEBUG: buffer write took 356 usecs
audio_oss_out: DEBUG: buffer write took 354 usecs
audio_oss_out: DEBUG: buffer write took 355 usecs
audio_oss_out: DEBUG: buffer write took 510 usecs
audio_oss_out: DEBUG: buffer write took 353 usecs
audio_oss_out: DEBUG: buffer write took 356 usecs
audio_oss_out: DEBUG: buffer write took 350 usecs
audio_oss_out: DEBUG: buffer write took 351 usecs
audio_oss_out: DEBUG: buffer write took 351 usecs
audio_oss_out: DEBUG: buffer write took 351 usecs
audio_oss_out: DEBUG: buffer write took 351 usecs
audio_oss_out: DEBUG: buffer write took 352 usecs
audio_oss_out: DEBUG: buffer write took 354 usecs
audio_oss_out: DEBUG: buffer write took 352 usecs
audio_oss_out: DEBUG: buffer write took 353 usecs
audio_oss_out: DEBUG: buffer write took 352 usecs
audio_oss_out: DEBUG: buffer write took 352 usecs
audio_oss_out: DEBUG: buffer write took 352 usecs
audio_oss_out: DEBUG: buffer write took 350 usecs
audio_oss_out: DEBUG: buffer write took 701 usecs
audio_oss_out: DEBUG: buffer write took 370 usecs
audio_oss_out: DEBUG: buffer write took 2749 usecs
audio_oss_out: DEBUG: buffer write took 400 usecs
audio_oss_out: DEBUG: buffer write took 360 usecs
audio_oss_out: DEBUG: buffer write took 358 usecs
audio_oss_out: DEBUG: buffer write took 356 usecs
audio_oss_out: DEBUG: buffer write took 356 usecs
audio_oss_out: DEBUG: buffer write took 357 usecs
audio_oss_out: DEBUG: buffer write took 358 usecs
audio_oss_out: DEBUG: buffer write took 355 usecs
audio_oss_out: DEBUG: buffer write took 354 usecs
audio_oss_out: DEBUG: buffer write took 357 usecs
audio_oss_out: DEBUG: buffer write took 358 usecs
audio_oss_out: DEBUG: buffer write took 354 usecs
audio_oss_out: DEBUG: buffer write took 356 usecs
audio_oss_out: DEBUG: buffer write took 357 usecs
audio_oss_out: DEBUG: buffer write took 355 usecs
audio_oss_out: DEBUG: buffer write took 354 usecs
audio_oss_out: DEBUG: buffer write took 356 usecs
audio_oss_out: DEBUG: buffer write took 444 usecs
audio_oss_out: DEBUG: buffer write took 363 usecs
audio_oss_out: DEBUG: buffer write took 353 usecs
audio_oss_out: DEBUG: buffer write took 355 usecs
audio_oss_out: DEBUG: buffer write took 355 usecs
audio_oss_out: DEBUG: buffer write took 357 usecs
audio_oss_out: DEBUG: buffer write took 354 usecs
audio_oss_out: DEBUG: buffer write took 1468 usecs
audio_oss_out: DEBUG: buffer write took 391 usecs
audio_oss_out: DEBUG: buffer write took 359 usecs
audio_oss_out: DEBUG: buffer write took 353 usecs
audio_oss_out: DEBUG: buffer write took 353 usecs
audio_oss_out: DEBUG: buffer write took 353 usecs
audio_oss_out: DEBUG: buffer write took 352 usecs
audio_oss_out: DEBUG: buffer write took 351 usecs
audio_oss_out: DEBUG: buffer write took 351 usecs
audio_oss_out: DEBUG: buffer write took 351 usecs
audio_oss_out: DEBUG: buffer write took 353 usecs
audio_oss_out: DEBUG: buffer write took 352 usecs
audio_oss_out: DEBUG: buffer write took 350 usecs
audio_oss_out: DEBUG: buffer write took 350 usecs
audio_oss_out: DEBUG: buffer write took 352 usecs
audio_oss_out: DEBUG: buffer write took 353 usecs
audio_oss_out: DEBUG: buffer write took 350 usecs
audio_oss_out: DEBUG: buffer write took 351 usecs
audio_oss_out: DEBUG: buffer write took 1020 usecs
audio_oss_out: DEBUG: buffer write took 385 usecs
audio_oss_out: DEBUG: buffer write took 353 usecs
audio_oss_out: DEBUG: buffer write took 350 usecs
audio_oss_out: DEBUG: buffer write took 351 usecs
audio_oss_out: DEBUG: buffer write took 352 usecs
audio_oss_out: DEBUG: buffer write took 350 usecs
audio_oss_out: DEBUG: buffer write took 1551 usecs
audio_oss_out: DEBUG: buffer write took 394 usecs
audio_oss_out: DEBUG: buffer write took 363 usecs
audio_oss_out: DEBUG: buffer write took 354 usecs
audio_oss_out: DEBUG: buffer write took 356 usecs
audio_oss_out: DEBUG: buffer write took 356 usecs
audio_oss_out: DEBUG: buffer write took 356 usecs
audio_oss_out: DEBUG: buffer write took 354 usecs
audio_oss_out: DEBUG: buffer write took 354 usecs
audio_oss_out: DEBUG: buffer write took 355 usecs
audio_oss_out: DEBUG: buffer write took 354 usecs
audio_oss_out: DEBUG: buffer write took 357 usecs
audio_oss_out: DEBUG: buffer write took 482 usecs
audio_oss_out: DEBUG: buffer write took 361 usecs
audio_oss_out: DEBUG: buffer write took 356 usecs
audio_oss_out: DEBUG: buffer write took 371 usecs
audio_oss_out: DEBUG: buffer write took 55 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 40 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 40 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 40 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 40 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 152380 usecs
audio_oss_out: DEBUG: buffer write took 81 usecs
audio_oss_out: DEBUG: buffer write took 42 usecs
audio_oss_out: DEBUG: buffer write took 40 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 40 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 40 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 40 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 40 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 40 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 40 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 40 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 40 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 40 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 40 usecs
audio_oss_out: DEBUG: buffer write took 184452 usecs
audio_oss_out: DEBUG: buffer write took 76 usecs
audio_oss_out: DEBUG: buffer write took 42 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 40 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 40 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 40 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 40 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 40 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 40 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 45 usecs
audio_oss_out: DEBUG: buffer write took 42 usecs
audio_oss_out: DEBUG: buffer write took 40 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 144 usecs
audio_oss_out: DEBUG: buffer write took 54 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 40 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 40 usecs
audio_oss_out: DEBUG: buffer write took 184345 usecs
audio_oss_out: DEBUG: buffer write took 90 usecs
audio_oss_out: DEBUG: buffer write took 43 usecs
audio_oss_out: DEBUG: buffer write took 40 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 40 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 40 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs
audio_oss_out: DEBUG: buffer write took 41 usecs

[1195 lines snipped]

audio_oss_out: DEBUG: buffer write took 32 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 32 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 32 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 32 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 32 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 184718 usecs
audio_oss_out: DEBUG: buffer write took 64 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 32 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 32 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 32 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 32 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 32 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 32 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 32 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 32 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 32 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 184720 usecs
audio_oss_out: DEBUG: buffer write took 73 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 32 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 32 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 32 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 38 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 32 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 32 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 32 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 32 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 32 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 32 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 184699 usecs
audio_oss_out: DEBUG: buffer write took 69 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 32 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 32 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 32 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 32 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 32 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 32 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 32 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 32 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 32 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 32 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 32 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 32 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 32 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs
audio_oss_out: DEBUG: buffer write took 32 usecs
audio_oss_out: DEBUG: buffer write took 33 usecs

[keeps going and going and going...]