[ask] alsa read overrun (.......>1024) ?

*nix specific usage questions
peyyek
Blank Cone
Blank Cone
Posts: 21
Joined: 02 Mar 2009 11:18

[ask] alsa read overrun (.......>1024) ?

Postby peyyek » 22 Jan 2010 09:20

hi,
when i watched tv from tuner card with vlc 1.0.3, i saw the message from log-verbosity-2 " alsa read overrun (...>1024) ".
i dont understand what's the meaning of this message

Code: Select all

main debug: adding slave input 'alsa://' main debug: `alsa://' gives access `alsa' demux `' path `' main debug: creating demux: access='alsa' demux='' path='' main debug: looking for access_demux module: 1 candidate access_alsa debug: Available alsa capture devices: access_alsa debug: CX8801 (Conexant CX8801) access_alsa debug: hw:0,0 : CX88 Digital (CX88 Digital) access_alsa debug: ICH7 (Intel ICH7) access_alsa debug: hw:1,0 : Intel ICH (Intel ICH7) access_alsa debug: hw:1,1 : Intel ICH - MIC ADC (Intel ICH7 - MIC ADC) access_alsa debug: hw:1,2 : Intel ICH - MIC2 ADC (Intel ICH7 - MIC2 ADC) access_alsa debug: hw:1,3 : Intel ICH - ADC2 (Intel ICH7 - ADC2) access_alsa debug: opening device 'hw' access_alsa debug: 'hw' is an audio device access_alsa debug: opened adev=`hw' stereo 48000Hz access_alsa debug: new audio es 2 channels 48000Hz main debug: using access_demux module "access_alsa" main debug: TIMER module_need() : 3.993 ms - Total 3.993 ms / 1 intvls (Avg 3.993 ms) main debug: looking for decoder module: 38 candidates rawvideo warning: invalid frame rate 0/0, using 25 fps instead main debug: using decoder module "rawvideo" main debug: TIMER module_need() : 0.710 ms - Total 0.710 ms / 1 intvls (Avg 0.710 ms) main debug: thread started main debug: thread (decoder) created at priority 0 (input/decoder.c:315) main debug: looking for decoder module: 38 candidates araw debug: samplerate:48000Hz channels:2 bits/sample:16 main debug: using decoder module "araw" main debug: TIMER module_need() : 0.366 ms - Total 0.366 ms / 1 intvls (Avg 0.366 ms) main debug: thread started main debug: thread (decoder) created at priority 5 (input/decoder.c:315) main debug: `v4l2://' successfully opened main debug: Buffering 0% main debug: no usable vout present, spawning one main debug: looking for text renderer module: 3 candidates main debug: thread (fontlist builder) created at priority 0 (freetype.c:475) freetype debug: using fontsize: 2 main debug: using text renderer module "freetype" main debug: TIMER module_need() : 0.626 ms - Total 0.626 ms / 1 intvls (Avg 0.626 ms) main debug: looking for video filter2 module: 20 candidates swscale debug: 32x32 chroma: YUVA -> 16x16 chroma: YUVA with scaling using Bicubic (good quality) main debug: using video filter2 module "swscale" main debug: TIMER module_need() : 0.773 ms - Total 0.773 ms / 1 intvls (Avg 0.773 ms) main debug: looking for video filter2 module: 20 candidates yuvp debug: YUVP to YUVA converter main debug: using video filter2 module "yuvp" main debug: TIMER module_need() : 0.099 ms - Total 0.099 ms / 1 intvls (Avg 0.099 ms) main debug: window size: 320x240 main debug: looking for video output module: 11 candidates access_alsa warning: ALSA read overrun (6144 > 1024) main debug: Buffering 11% main debug: Buffering 11% main debug: Buffering 13% ................ ................ main warning: audio drift is too big (252862), dropping buffer main warning: audio drift is too big (247538), dropping buffer main warning: output date isn't PTS date, requesting resampling (49017) access_alsa warning: ALSA read overrun (5120 > 1024) access_alsa warning: ALSA read overrun (4096 > 1024) access_alsa warning: ALSA read overrun (3072 > 1024) access_alsa warning: ALSA read overrun (2048 > 1024) .......................................................................
and then, how i can solve this warning ?
thanks

zeefreak
Blank Cone
Blank Cone
Posts: 19
Joined: 26 Sep 2007 00:24

Re: [ask] alsa read overrun (.......>1024) ?

Postby zeefreak » 20 Aug 2010 22:40

for the love of god, is every problem i have with vlc the subject of a single post thread? these forums are useless.

musicalvegan0
New Cone
New Cone
Posts: 1
Joined: 21 Aug 2010 01:20

Re: [ask] alsa read overrun (.......>1024) ?

Postby musicalvegan0 » 21 Aug 2010 01:37

Well, I certainly understand zeefreak's frustration. Let me try providing a little more information though.

Code: Select all

vlc -vvv alsa://hw:0,0 --sout-shout-mp3 --sout-shout-bitrate='112' --sout-mux-caching=1000 --alsa-caching=1000 --sout '#transcode{vcodec=none,acodec=mp3,ab=112,audio-sync} :std{access=shout,mux=dummy,dst=:pass@x.x.x.x:8000}'
Server is a P4 with 768 MB RAM running Ubuntu 10.04.

Output goes something like this:

Code: Select all

[0x8d4f148] main libvlc debug: libvlc was configured with ./configure '--build=i486-linux-gnu' '--config-cache' '--disable-maintainer-mode' '--disable-update-check' '--enable-fast-install' '--enable-release' '--prefix=/usr' '--with-binary-version=1ubuntu1.1' '--disable-atmo' '--disable-fluidsynth' '--disable-gnomevfs' '--disable-kate' '--disable-mtp' '--enable-x264' '--disable-zvbi' '--enable-a52' '--enable-aa' '--enable-bonjour' '--enable-caca' '--enable-dca' '--enable-dvb' '--enable-dvbpsi' '--enable-dvdnav' '--enable-faad' '--enable-flac' '--enable-freetype' '--enable-fribidi' '--enable-ggi' '--enable-gnutls' '--enable-jack' '--enable-libass' '--enable-libmpeg2' '--enable-lirc' '--enable-live555' '--enable-mad' '--enable-mkv' '--enable-mod' '--enable-mozilla' '--enable-mpc' '--enable-ncurses' '--enable-notify' '--enable-ogg' '--enable-pulse' '--enable-qt4' '--enable-realrtsp' '--enable-sdl' '--enable-shout' '--enable-skins2' '--enable-smb' '--enable-speex' '--enable-svg' '--enable-taglib' '--enable-telx' '--enable-theora' '--enable-twolame' '--enable-vcd' '--enable-vcdx' '--enable-vorbis' '--with-mozilla-pkg=libxul' '--enable-alsa' '--enable-dv' '--enable-pvr' '--enable-v4l' '--enable-v4l2' '--enable-svgalib' 'build_alias=i486-linux-gnu' 'CFLAGS=-g -O2' 'LDFLAGS=-Wl,--as-needed' 'CPPFLAGS=' 'CXXFLAGS=-g -O2' [0x8d4f148] main libvlc debug: translation test: code is "C" [0x8d4f148] main libvlc debug: checking plugin modules [0x8d4f148] main libvlc debug: loading plugins cache file /home/administrator/.cache/vlc/plugins-04041e.dat [0x8d4f148] main libvlc debug: recursively browsing `/usr/lib/vlc' [0x8d4f148] main libvlc debug: module bank initialized (380 modules) [0x8d4f148] main libvlc debug: opening config file (/home/administrator/.config/vlc/vlcrc) [0x8d4f148] main libvlc debug: CPU has capabilities 486 586 MMX MMXEXT FPU [0x8d4f148] main libvlc debug: looking for memcpy module: 3 candidates [0x8d4f148] main libvlc debug: using memcpy module "memcpymmxext" [0x8de50d0] main input debug: Creating an input for 'Media Library' [0x8de50d0] main input debug: Input is a meta file: disabling unneeded options [0x8de50d0] main input debug: using timeshift granularity of 50 MBytes [0x8de50d0] main input debug: using timeshift path '/tmp' [0x8de50d0] main input debug: `file/xspf-open:///home/administrator/.local/share/vlc/ml.xspf' gives access `file' demux `xspf-open' path `/home/administrator/.local/share/vlc/ml.xspf' [0x8de50d0] main input debug: creating demux: access='file' demux='xspf-open' path='/home/administrator/.local/share/vlc/ml.xspf' [0x8de87c8] main demux debug: looking for access_demux module: 1 candidate [0x8de87c8] main demux warning: no access_demux module matching "file" could be loaded [0x8de87c8] main demux debug: TIMER module_need() : 1.692 ms - Total 1.692 ms / 1 intvls (Avg 1.692 ms) [0x8de50d0] main input debug: creating access 'file' path='/home/administrator/.local/share/vlc/ml.xspf' [0x8de87c8] main access debug: looking for access module: 3 candidates [0x8de87c8] access_file access debug: opening file `/home/administrator/.local/share/vlc/ml.xspf' [0x8de87c8] main access debug: using access module "access_file" [0x8de87c8] main access debug: TIMER module_need() : 1.346 ms - Total 1.346 ms / 1 intvls (Avg 1.346 ms) [0x8df4eb0] main stream debug: Using AStream*Stream [0x8df4eb0] main stream debug: pre buffering [0x8df4eb0] main stream debug: received first data after 0 ms [0x8df4eb0] main stream debug: pre-buffering done 296 bytes in 0s - 10706 kbytes/s [0x8df43e0] main stream debug: looking for stream_filter module: 5 candidates [0x8df43e0] main stream debug: TIMER module_need() : 0.956 ms - Total 0.956 ms / 1 intvls (Avg 0.956 ms) [0x8df6c48] main stream debug: looking for stream_filter module: 1 candidate [0x8df6c48] main stream debug: using stream_filter module "stream_filter_record" [0x8df6c48] main stream debug: TIMER module_need() : 0.695 ms - Total 0.695 ms / 1 intvls (Avg 0.695 ms) [0x8de50d0] main input debug: creating demux: access='file' demux='xspf-open' path='/home/administrator/.local/share/vlc/ml.xspf' [0x8df7220] main demux debug: looking for demux module: 1 candidate [0x8df7220] playlist demux debug: using XSPF playlist reader [0x8df7220] main demux debug: using demux module "playlist" [0x8df7220] main demux debug: TIMER module_need() : 0.644 ms - Total 0.644 ms / 1 intvls (Avg 0.644 ms) [0x8de50d0] main input debug: `file/xspf-open:///home/administrator/.local/share/vlc/ml.xspf' successfully opened [0x8df7390] main xml debug: looking for xml module: 2 candidates [0x8df7390] main xml debug: using xml module "xml" [0x8df7390] main xml debug: TIMER module_need() : 0.992 ms - Total 0.992 ms / 1 intvls (Avg 0.992 ms) [0x8df7220] playlist demux debug: parsed 0 tracks successfully [0x8df7390] main xml debug: removing module "xml" [0x8de50d0] main input debug: EOF reached [0x8df7220] main demux debug: removing module "playlist" [0x8df6c48] main stream debug: removing module "stream_filter_record" [0x8de87c8] main access debug: removing module "access_file" [0x8de50d0] main input debug: TIMER input launching for 'Media Library' : 17.154 ms - Total 17.154 ms / 1 intvls (Avg 17.154 ms) [0x8de4168] main playlist debug: Activated [0x8df7200] main interface debug: looking for interface module: 1 candidate [0x8df7200] main interface debug: using interface module "hotkeys" [0x8df7200] main interface debug: TIMER module_need() : 0.893 ms - Total 0.893 ms / 1 intvls (Avg 0.893 ms) [0x8df7200] main interface debug: thread (interface) created at priority 0 (interface/interface.c:151) [0x8df4210] main interface debug: looking for interface module: 1 candidate [0x8de4168] main playlist debug: rebuilding array of current - root Playlist [0x8de4168] main playlist debug: rebuild done - 0 items, index -1 [0x8df7200] main interface debug: thread started [0x8df4210] inhibit interface error: Failed to connect to the D-Bus session daemon: /bin/dbus-launch terminated abnormally with the following error: Autolaunch error: X11 initialization failed. [0x8df4210] main interface warning: no interface module matching "inhibit,none" could be loaded [0x8df4210] main interface debug: TIMER module_need() : 4.359 ms - Total 4.359 ms / 1 intvls (Avg 4.359 ms) [0x8df4210] main interface error: no suitable interface module [0x8d4f148] main libvlc error: interface "inhibit,none" initialization failed [0x8df4210] main interface debug: looking for interface module: 1 candidate [0x8df4210] main interface debug: using interface module "screensaver" [0x8df4210] main interface debug: TIMER module_need() : 0.537 ms - Total 0.537 ms / 1 intvls (Avg 0.537 ms) [0x8df4210] main interface debug: thread (interface) created at priority 0 (interface/interface.c:151) [0x8de4168] main playlist debug: adding item `hw:0,0' ( alsa://hw:0,0 ) [0x8de67a8] main interface debug: looking for interface module: 1 candidate [0x8de67a8] main interface debug: using interface module "signals" [0x8de67a8] main interface debug: TIMER module_need() : 0.537 ms - Total 0.537 ms / 1 intvls (Avg 0.537 ms) [0x8de67a8] main interface debug: thread (interface) created at priority 0 (interface/interface.c:151) [0x8de8bc8] main interface debug: looking for interface module: 1 candidate [0x8de8bc8] main interface warning: no interface module matching "globalhotkeys,none" could be loaded [0x8de8bc8] main interface debug: TIMER module_need() : 1.600 ms - Total 1.600 ms / 1 intvls (Avg 1.600 ms) [0x8de8bc8] main interface error: no suitable interface module [0x8d4f148] main libvlc error: interface "globalhotkeys,none" initialization failed [0x8d4f148] main libvlc: Running vlc with the default interface. Use 'cvlc' to use vlc without interface. [0x8de8bc8] main interface debug: looking for interface module: 4 candidates [0x8df4210] main interface debug: thread started [0x8de67a8] main interface debug: thread started [0x8de67a8] main interface debug: thread ended [0x8df4210] screensaver interface warning: failed to connect to the D-BUS daemon: /bin/dbus-launch terminated abnormally with the following error: Autolaunch error: X11 initialization failed. [0x8de8bc8] qt4 interface error: Could not connect to X server [0x8de8bc8] skins2 interface error: Cannot open display [0x8de8bc8] skins2 interface error: cannot initialize OSFactory Remote control interface initialized. Type `help' for help. [0x8de8bc8] main interface debug: using interface module "rc" [0x8de8bc8] main interface debug: TIMER module_need() : 30.141 ms - Total 30.141 ms / 1 intvls (Avg 30.141 ms) [0x8de8bc8] main interface debug: thread (interface) created at priority 0 (interface/interface.c:151) [0x8de4168] main playlist debug: rebuilding array of current - root Playlist [0x8de4168] main playlist debug: rebuild done - 1 items, index -1 [0x8de4168] main playlist debug: processing request item null node Playlist skip 0 [0x8de4168] main playlist debug: starting new item [0x8de4168] main playlist debug: creating new input thread [0x8df9900] main input debug: Creating an input for 'hw:0,0' [0x8de8bc8] main interface debug: thread started [0x8df9900] main input debug: thread (input) created at priority 10 (input/input.c:230) [0x8df9900] main input debug: thread started [0x8e051e0] main stream output debug: stream=`transcode' [0x8e05960] main stream out debug: looking for sout stream module: 1 candidate [0x8e051e0] main stream output debug: stream=`std' [0x8e0a9e8] main stream out debug: looking for sout stream module: 1 candidate [0x8e0a9e8] main stream out debug: set config option: sout-standard-access to shout [0x8e0a9e8] main stream out debug: set config option: sout-standard-mux to dummy [0x8e0a9e8] main stream out debug: set config option: sout-standard-dst to :pass@x.x.x.:8000 [0x8e0a9e8] stream_out_standard stream out debug: creating `shout/dummy://:pass@x.x.x.x:8000' [0x8e0a9e8] stream_out_standard stream out debug: extension is 226:8000 [0x8e0a9e8] stream_out_standard stream out debug: extension -> mux=(null) [0x8e0a9e8] stream_out_standard stream out debug: using `shout/dummy://:pass@x.x.x.x:8000' [0x8e0c460] main access out debug: looking for sout access module: 1 candidate [0x8e0c460] access_output_shout access out debug: connected using 'icy' (shoutcast) protocol [0x8e0c460] access_output_shout access out debug: shout access output opened (@x.x.x.x:8000/) [0x8e0c460] main access out debug: using sout access module "access_output_shout" [0x8e0c460] main access out debug: TIMER module_need() : 19.404 ms - Total 19.404 ms / 1 intvls (Avg 19.404 ms) [0x8e0a9e8] stream_out_standard stream out debug: access opened [0x8e0f478] main mux debug: looking for sout mux module: 1 candidate [0x8e0f478] mux_dummy mux debug: Dummy/Raw muxer opened [0x8e0f478] mux_dummy mux: Open [0x8e0f478] main mux debug: using sout mux module "mux_dummy" [0x8e0f478] main mux debug: TIMER module_need() : 0.620 ms - Total 0.620 ms / 1 intvls (Avg 0.620 ms) [0x8e051e0] main stream output debug: muxer support adding stream at any time [0x8e051e0] main stream output debug: muxer prefers to wait for all ES before starting to mux [0x8e0a9e8] stream_out_standard stream out debug: mux opened [0x8e0a9e8] main stream out debug: using sout stream module "stream_out_standard" [0x8e0a9e8] main stream out debug: TIMER module_need() : 24.501 ms - Total 24.501 ms / 1 intvls (Avg 24.501 ms) [0x8e05960] main stream out debug: set config option: sout-transcode-vcodec to none [0x8e05960] main stream out debug: set config option: sout-transcode-acodec to mp3 [0x8e05960] main stream out debug: set config option: sout-transcode-ab to 112 [0x8e05960] main stream out debug: set config option: sout-transcode-audio-sync to (null) [0x8e05960] stream_out_transcode stream out debug: codec audio=mp3 0Hz 0 channels 112Kb/s [0x8e05960] stream_out_transcode stream out debug: codec video=none 0x0 scaling: 1.000000 800kb/s [0x8e05960] main stream out debug: using sout stream module "stream_out_transcode" [0x8e05960] main stream out debug: TIMER module_need() : 32.757 ms - Total 32.757 ms / 1 intvls (Avg 32.757 ms) [0x8df9900] main input debug: using timeshift granularity of 50 MBytes [0x8df9900] main input debug: using timeshift path '/tmp' [0x8df9900] main input debug: `alsa://hw:0,0' gives access `alsa' demux `' path `hw:0,0' [0x8df9900] main input debug: creating demux: access='alsa' demux='' path='hw:0,0' [0x8e0cc98] main demux debug: looking for access_demux module: 1 candidate [0x8e0cc98] access_alsa demux debug: opening device 'hw:0,0' [0x8e0cc98] access_alsa demux debug: 'hw:0,0' is an audio device [0x8e0cc98] access_alsa demux debug: opened adev=`hw:0,0' stereo 48000Hz [0x8e0cc98] access_alsa demux debug: new audio es 2 channels 48000Hz [0x8df9900] main input debug: selecting program id=0 [0x8e0cc98] main demux debug: using access_demux module "access_alsa" [0x8e0cc98] main demux debug: TIMER module_need() : 12.951 ms - Total 12.951 ms / 1 intvls (Avg 12.951 ms) [0x8e1d120] main packetizer debug: looking for packetizer module: 21 candidates [0x8e1d120] main packetizer debug: using packetizer module "packetizer_copy" [0x8e1d120] main packetizer debug: TIMER module_need() : 6.720 ms - Total 6.720 ms / 1 intvls (Avg 6.720 ms) [0x8e1d120] main packetizer debug: thread (decoder) created at priority 5 (input/decoder.c:315) [0x8e1d120] main packetizer debug: thread started [0x8df9900] main input debug: starting in sync mode [0x8df9900] main input debug: `alsa://hw:0,0' successfully opened [0x8df9900] main input debug: Buffering 0% [0x8df9900] main input debug: switching to async mode [0x8df9900] main input debug: Buffering 8% [0x8e051e0] main stream output debug: adding a new sout input (sout_input:0x8e05130) [0x8e05960] stream_out_transcode stream out debug: creating audio transcoding from fcc=`s16l' to fcc=`mp3 ' [0x8e1e280] main decoder debug: looking for decoder module: 31 candidates [0x8e1e280] araw decoder debug: samplerate:48000Hz channels:2 bits/sample:16 [0x8e1e280] main decoder debug: using decoder module "araw" [0x8e1e280] main decoder debug: TIMER module_need() : 5.789 ms - Total 5.789 ms / 1 intvls (Avg 5.789 ms) [0x8e29c88] main encoder debug: looking for encoder module: 10 candidates [0x8e29c88] avcodec encoder debug: libavcodec initialized (interface 0x341401) [0x8e29c88] avcodec encoder debug: found encoder MPEG Audio layer 1/2/3 [0x8e29c88] main encoder debug: using encoder module "avcodec" [0x8e29c88] main encoder debug: TIMER module_need() : 32.865 ms - Total 32.865 ms / 1 intvls (Avg 32.865 ms) [0x8e0f478] main mux debug: adding a new input [0x8e0f478] mux_dummy mux debug: adding input [0x8df9900] main input debug: Buffering 17% [0x8df9900] main input debug: Buffering 25% [0x8df9900] main input debug: Buffering 34% [0x8df9900] main input debug: Buffering 42% [0x8df9900] main input debug: Buffering 51% [0x8df9900] main input debug: Buffering 59% [0x8df9900] main input debug: Buffering 68% [0x8df9900] main input debug: Buffering 76% [0x8df9900] main input debug: Buffering 85% [0x8df9900] main input debug: Buffering 93% [0x8df9900] main input debug: Stream buffering done (1023 ms in 1023 ms) [0x8df9900] main input debug: Decoder buffering done in 0 ms [0x8e05960] stream_out_transcode stream out debug: drift is too high, resetting master sync
Then, after anywhere from 30 minutes to 4 hours, I start getting ALSA overrun errors for several minutes like the ones below.

Code: Select all

[0x9b0b770] access_alsa demux warning: ALSA read overrun (47584 > 16384) [0x9b0b770] access_alsa demux warning: ALSA read overrun (45024 > 16384) [0x9b0b770] access_alsa demux warning: ALSA read overrun (47072 > 16384) [0x9b0b770] access_alsa demux warning: ALSA read overrun (49120 > 16384) [0x9b0b770] access_alsa demux warning: ALSA read overrun (46560 > 16384) [0x9b0b770] access_alsa demux warning: ALSA read overrun (48608 > 16384) [0x9b0b770] access_alsa demux warning: ALSA read overrun (46048 > 16384) [0x9b0b770] access_alsa demux warning: ALSA read overrun (48096 > 16384) [0x9b0b770] access_alsa demux warning: ALSA read overrun (45536 > 16384) [0x9b0b770] access_alsa demux warning: ALSA read overrun (47584 > 16384) [0x9b0b770] access_alsa demux warning: ALSA read overrun (45024 > 16384) [0x9b0b770] access_alsa demux warning: ALSA read overrun (47104 > 16384)
Finally, VLC breaks the connection with the Shoutcast server until the streams are completely restarted.
These overruns happen for me ONLY when I stream to Shoutcast as I successfully stream Windows Media indefinitely on the same server. Changing the alsa-caching and sout-mux-caching values doesn't seem to have an effect, nor does changing the access mux (I've tried dummy and raw).

I don't know what to do next. I'm assuming it has to be related to the fact that I'm encoding mp3 and streaming to a Shoutcast, but I suppose it could be an issue with my sound card? My plan is to try changing the sound interface to see what happens. I am not hopeful, however. Any additional recommendations would be GREATLY appreciated.

EDIT: Also found this link which may be relevant. But I don't know for sure:
http://www.linuxquestions.org/questions ... er-518988/


Return to “VLC media player for Linux and friends Troubleshooting”

Who is online

Users browsing this forum: No registered users and 11 guests