Page 1 of 1

1.0 RC versions prone to more playback glitches

Posted: 29 Jun 2009 03:13
by kdean
Ever since using the 1.0 RC releases I've noticed the videos tend to glitch a lot whereas I don't recall the 0.9 versions having these issues. Often there's little pauses and occasionally the video will start glitching and then freeze with the audio continuing. Stopping and restarting the video fixes it. I can even replay the same section and it will play through fine. The glitches seem to be due to a large amount of "PTS is out of range" errors.

I'm running 10.5.7 with a Dual 2.7 GHz G5 with 3.5 GB of RAM.

Here's a copy of the messages from one such instance where toward the end it froze up the video.

</list 'hdrl'>
found Chunk fourcc:4c495354 (LIST) size:56 pos:8850
avi debug: found LIST chunk: 'INFO'
avi debug: <list 'INFO'>
avi debug: found Chunk fourcc:49534654 (ISFT) size:44 pos:8862
avi debug: ISFT: software : VirtualDubMod 1.5.10.2 (build 2540/release)
avi debug: </list 'INFO'>
avi debug: found Chunk fourcc:4a554e4b (JUNK) size:1318 pos:8914
avi debug: found Chunk fourcc:4c495354 (LIST) size:364018374 pos:10240
avi debug: skipping movi chunk
avi debug: found Chunk fourcc:69647831 (idx1) size:2523136 pos:364028622
macosx debug: input has changed, refreshing interface
avi debug: idx1: index entry:157696
avi debug: </list 'AVI '>
avi debug: found Chunk fourcc:4a554e4b (JUNK) size:1314 pos:366551766
avi debug: * LIST-root size:366553088 pos:0
avi debug: + RIFF-AVI size:366551758 pos:0
avi debug: | + LIST-hdrl size:8830 pos:12
avi debug: | | + avih size:56 pos:24
avi debug: | | + LIST-strl size:4244 pos:88
avi debug: | | | + strh size:56 pos:100
avi debug: | | | + strf size:40 pos:164
avi debug: | | | + JUNK size:4120 pos:212
avi debug: | | + LIST-strl size:4234 pos:4340
avi debug: | | | + strh size:56 pos:4352
avi debug: | | | + strf size:30 pos:4416
avi debug: | | | + JUNK size:4120 pos:4454
avi debug: | | + LIST-odml size:260 pos:8582
avi debug: | | | + dmlh size:248 pos:8594
avi debug: | + LIST-INFO size:56 pos:8850
avi debug: | | + ISFT size:44 pos:8862
avi debug: | + JUNK size:1318 pos:8914
avi debug: | + LIST-movi size:364018374 pos:10240
avi debug: | + idx1 size:2523136 pos:364028622
avi debug: + JUNK size:1314 pos:366551766
avi debug: AVIH: 2 stream, flags HAS_INDEX IS_INTERLEAVED
avi debug: stream[0] rate:25 scale:1 samplesize:0
avi debug: stream[0] video(XVID) 624x352 12bpp 25.000000fps
main debug: selecting program id=0
avi debug: stream[1] rate:48000 scale:1152 samplesize:0
avi debug: stream[1] audio(0x55) 2 channels 48000Hz 0bits
avi debug: stream[0] created 59136 index entries
avi debug: stream[1] created 98560 index entries
avi debug: stream[0] length:2365 (based on index)
avi debug: stream[1] length:2365 (based on index)
main debug: using demux module "avi"
main debug: TIMER module_need() : 161.458 ms - Total 161.458 ms / 1 intvls (Avg 161.458 ms)
main debug: looking for a subtitle file in /Volumes/Test/
main debug: looking for decoder module: 33 candidates
avcodec debug: libavcodec already initialized
avcodec debug: using direct rendering
avcodec debug: ffmpeg codec (MPEG-4 Video) started
main debug: using decoder module "avcodec"
main debug: TIMER module_need() : 3.778 ms - Total 3.778 ms / 1 intvls (Avg 3.778 ms)
main debug: thread (decoder) created at priority 0 (../../src/input/decoder.c:315)
main debug: thread started
main debug: looking for decoder module: 33 candidates
main debug: using decoder module "mpeg_audio"
main debug: TIMER module_need() : 0.798 ms - Total 0.798 ms / 1 intvls (Avg 0.798 ms)
main debug: thread (decoder) created at priority 22 (../../src/input/decoder.c:315)
main debug: thread started
main debug: `/Volumes/Test/Video.XviD.avi' successfully opened
main debug: Buffering 0%
main debug: Buffering 8%
main debug: Buffering 16%
main debug: Buffering 25%
main debug: Buffering 33%
mpeg_audio debug: MPGA channels:2 samplerate:48000 bitrate:128
main debug: reusing aout
main debug: looking for audio output module: 2 candidates
main debug: Buffering 41%
main debug: Buffering 50%
main debug: no usable vout present, spawning one
main debug: looking for text renderer module: 1 candidate
freetype debug: using fontsize: 2
main debug: using text renderer module "freetype"
main debug: TIMER module_need() : 1.893 ms - Total 1.893 ms / 1 intvls (Avg 1.893 ms)
main debug: looking for video filter2 module: 14 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() : 1.425 ms - Total 1.425 ms / 1 intvls (Avg 1.425 ms)
main debug: Buffering 58%
main debug: looking for video filter2 module: 14 candidates
yuvp debug: YUVP to YUVA converter
main debug: using video filter2 module "yuvp"
main debug: TIMER module_need() : 0.426 ms - Total 0.426 ms / 1 intvls (Avg 0.426 ms)
main debug: window size: 624x352
main debug: looking for video output module: 4 candidates
opengl debug: Texture size: 624x352
main debug: looking for opengl provider module: 2 candidates
macosx debug: display is Quartz Extreme accelerated
main debug: Buffering 66%
main debug: Buffering 75%
main debug: Buffering 83%
main debug: Buffering 91%
main debug: Buffering 100%
main debug: Stream buffering done (325 ms in 25 ms)
main debug: VLC is looking for: 'mpga' 48000 Hz Stereo frame=1152 samples/969 bytes
auhal debug: system has [4] device(s)
auhal debug: DevID: 0x109 DevName: Built-in Audio
auhal debug: supported format: [48000][lpcm][30][4][1][4][2][16]
auhal debug: supported format: [44100][lpcm][30][4][1][4][2][16]
auhal debug: supported format: [32000][lpcm][30][4][1][4][2][16]
auhal debug: supported format: [48000][lpcm][22][8][1][8][2][24]
auhal debug: supported format: [44100][lpcm][22][8][1][8][2][24]
auhal debug: supported format: [32000][lpcm][22][8][1][8][2][24]
auhal debug: supported format: [48000][cac3][94][6144][1536][0][2][16]
auhal debug: supported format: [44100][cac3][94][6144][1536][0][2][16]
auhal debug: supported format: [32000][cac3][94][6144][1536][0][2][16]
auhal debug: DevID: 0x105 DevName: Soundflower (2ch)
auhal debug: supported format: [96000][lpcm][30][8][1][8][2][32]
auhal debug: supported format: [48000][lpcm][30][8][1][8][2][32]
auhal debug: supported format: [44100][lpcm][30][8][1][8][2][32]
auhal debug: DevID: 0x102 DevName: Soundflower (16ch)
auhal debug: supported format: [96000][lpcm][30][64][1][64][16][32]
auhal debug: supported format: [48000][lpcm][30][64][1][64][16][32]
auhal debug: supported format: [44100][lpcm][30][64][1][64][16][32]
auhal debug: DevID: 0x101 DevName: Adobe Media Encoder 4.0
auhal debug: this device is INPUT only. skipping...
auhal debug: current format is: [44100][lpcm][43][4][1][4][2][32]
auhal debug: layout of AUHAL has 2 channels
auhal debug: selected 2 physical channels for device output
auhal debug: VLC will output: Stereo
auhal debug: we set the AU format: [48000][lpcm][11][8][1][8][2][32]
auhal debug: the actual set AU format is [48000][lpcm][11][8][1][8][2][32]
main debug: using audio output module "auhal"
main debug: TIMER module_need() : 64.046 ms - Total 64.046 ms / 1 intvls (Avg 64.046 ms)
main debug: output 'fl32' 48000 Hz Stereo frame=1 samples/8 bytes
main debug: mixer 'fl32' 48000 Hz Stereo frame=1 samples/8 bytes
main debug: no need for any filter
main debug: looking for audio mixer module: 3 candidates
main debug: using audio mixer module "float32_mixer"
main debug: TIMER module_need() : 0.315 ms - Total 0.315 ms / 1 intvls (Avg 0.315 ms)
main debug: using opengl provider module "macosx"
main debug: TIMER module_need() : 48.418 ms - Total 48.418 ms / 1 intvls (Avg 48.418 ms)
main debug: using video output module "opengl"
main debug: TIMER module_need() : 48.859 ms - Total 48.859 ms / 1 intvls (Avg 48.859 ms)
main debug: Deinterlacing available
main debug: got 1 direct buffer(s)
main debug: pic render sz 624x352, of (0,0), vsz 624x352, 4cc I420, ar 382909:216000, sar 1:1, msk r0x0 g0x0 b0x0
main debug: pic in sz 624x352, of (0,0), vsz 624x352, 4cc I420, ar 382909:216000, sar 1:1, msk r0x0 g0x0 b0x0
main debug: pic out sz 624x352, of (0,0), vsz 624x352, 4cc YUY2, ar 382909:216000, sar 1:1, msk r0x0 g0x0 b0x0
main debug: looking for video filter2 module: 14 candidates
main debug: using video filter2 module "i420_yuy2_altivec"
main debug: TIMER module_need() : 0.326 ms - Total 0.326 ms / 1 intvls (Avg 0.326 ms)
main debug: indirect render, mapping render pictures 0-15 to system pictures 1-16
main debug: input 'mpga' 48000 Hz Stereo frame=1152 samples/969 bytes
main debug: looking for audio filter module: 1 candidate
scaletempo warning: bad input or output format
main warning: no audio filter module matching "scaletempo" could be loaded
main debug: TIMER module_need() : 0.554 ms - Total 0.554 ms / 1 intvls (Avg 0.554 ms)
main debug: looking for audio filter module: 1 candidate
scaletempo debug: format: 48000 rate, 2 nch, 4 bps, fl32
scaletempo debug: params: 30 stride, 0.200 overlap, 14 search
scaletempo debug: 1.000 scale, 1440.000 stride_in, 1440 stride_out, 1152 standing, 288 overlap, 672 search, 2400 queue, fl32 mode
main debug: using audio filter module "scaletempo"
main debug: TIMER module_need() : 0.965 ms - Total 0.965 ms / 1 intvls (Avg 0.965 ms)
main debug: filter(s) 'mpga'->'fl32' 48000 Hz->48000 Hz Stereo->Stereo
main debug: looking for audio filter module: 24 candidates
main debug: using audio filter module "mpgatofixed32"
main debug: TIMER module_need() : 0.555 ms - Total 0.555 ms / 1 intvls (Avg 0.555 ms)
main debug: found a filter for the whole conversion
main debug: filter(s) 'fl32'->'fl32' 52800 Hz->48000 Hz Stereo->Stereo
main debug: looking for audio filter module: 24 candidates
main debug: using audio filter module "bandlimited_resampler"
main debug: TIMER module_need() : 0.231 ms - Total 0.231 ms / 1 intvls (Avg 0.231 ms)
main debug: found a filter for the whole conversion
main debug: End of audio preroll
main debug: End of video preroll
main debug: Received first picture
main debug: Decoder buffering done in 60 ms
main debug: Post-processing available
main warning: PTS is out of range (-9115), dropping buffer
main warning: PTS is out of range (-33074), dropping buffer
mpgatofixed32 debug: libmad error: bad main_data_begin pointer
main debug: Destroying the input for 'PreviousVideo.XviD.avi'
main debug: TIMER input launching for 'PreviousVideo.XviD.avi' : 188.387 ms - Total 188.387 ms / 1 intvls (Avg 188.387 ms)
main debug: removing module "blend"
main debug: removing module "freetype"
main debug: removing module "yuvp"
main debug: removing module "swscale"
macosx debug: chosen screen isn't present, using current screen for fullscreen mode
main debug: removing module "float32_mixer"
main debug: looking for audio mixer module: 3 candidates
main debug: using audio mixer module "float32_mixer"
main debug: TIMER module_need() : 0.194 ms - Total 0.194 ms / 1 intvls (Avg 0.194 ms)
main debug: looking for video blending module: 1 candidate
blend debug: chroma: YUVA -> YUY2
main debug: using video blending module "blend"
main debug: TIMER module_need() : 0.343 ms - Total 0.343 ms / 1 intvls (Avg 0.343 ms)
main debug: removing module "float32_mixer"
main debug: looking for audio mixer module: 3 candidates
main debug: using audio mixer module "float32_mixer"
main debug: TIMER module_need() : 0.208 ms - Total 0.208 ms / 1 intvls (Avg 0.208 ms)
main debug: removing module "float32_mixer"
main debug: looking for audio mixer module: 3 candidates
main debug: using audio mixer module "float32_mixer"
main debug: TIMER module_need() : 0.194 ms - Total 0.194 ms / 1 intvls (Avg 0.194 ms)
main debug: removing module "float32_mixer"
main debug: looking for audio mixer module: 3 candidates
main debug: using audio mixer module "float32_mixer"
main debug: TIMER module_need() : 0.201 ms - Total 0.201 ms / 1 intvls (Avg 0.201 ms)
main debug: removing module "float32_mixer"
main debug: looking for audio mixer module: 3 candidates
main debug: using audio mixer module "float32_mixer"
main debug: TIMER module_need() : 0.251 ms - Total 0.251 ms / 1 intvls (Avg 0.251 ms)
main debug: removing module "float32_mixer"
main debug: looking for audio mixer module: 3 candidates
main debug: using audio mixer module "float32_mixer"
main debug: TIMER module_need() : 0.195 ms - Total 0.195 ms / 1 intvls (Avg 0.195 ms)
main debug: control type=7
avi debug: seek requested: 235 seconds 9%
avi debug: old:221480000 < new 235950058
avi debug: old:221544000 < new 235950058
avi debug: seek: 235 seconds
main debug: Buffering 0%
freetype debug: using fontsize: 22
main debug: End of audio preroll
main debug: Buffering 8%
main debug: Buffering 16%
main debug: Buffering 25%
main debug: Buffering 33%
main debug: Buffering 41%
main debug: Buffering 50%
main debug: Buffering 58%
main debug: Buffering 66%
main debug: Buffering 75%
main debug: Buffering 83%
main debug: Buffering 91%
main debug: Buffering 100%
main debug: Stream buffering done (325 ms in 64 ms)
main debug: End of video preroll
main debug: Received first picture
main debug: Decoder buffering done in 69 ms
main warning: PTS is out of range (-27682), dropping buffer
mpgatofixed32 debug: libmad error: bad main_data_begin pointer
main warning: the mixer got a packet in the past (103071)
main warning: the mixer got a packet in the past (79071)
main warning: the mixer got a packet in the past (55071)
main warning: the mixer got a packet in the past (31071)
main warning: the mixer got a packet in the past (7071)
main warning: mixer start isn't output start (2715)
main warning: late picture skipped (56608 > -4741)
main warning: late picture skipped (16608 > -4741)
freetype debug: using fontsize: 22
freetype debug: using fontsize: 22
freetype debug: using fontsize: 22
freetype debug: using fontsize: 22
freetype debug: using fontsize: 22
freetype debug: using fontsize: 22
main warning: computed PTS is out of range (22670), clearing out
main warning: PTS is out of range (22880), dropping buffer
main warning: output PTS is out of range (37156), clearing out
main warning: late picture skipped (128777 > -1019)
main warning: PTS is out of range (6592), dropping buffer
main warning: PTS is out of range (-17356), dropping buffer
main warning: late picture skipped (96875 > -1019)
main warning: PTS is out of range (-32698), dropping buffer
main warning: late picture skipped (65538 > -913)
main warning: late picture skipped (33987 > -913)
main warning: late picture skipped (13143 > -805)
main warning: late picture skipped (40928 > -2086)
main warning: late picture skipped (3685 > -2086)
main warning: computed PTS is out of range (52006), clearing out
main warning: PTS is out of range (52210), dropping buffer
main warning: output PTS is out of range (70892), clearing out
main warning: late picture skipped (151926 > -981)
main warning: PTS is out of range (43441), dropping buffer
main warning: PTS is out of range (19496), dropping buffer
main warning: late picture skipped (126372 > -886)
main warning: PTS is out of range (228914), dropping buffer
main warning: PTS is out of range (207731), dropping buffer
main warning: PTS is out of range (183784), dropping buffer
main warning: late picture skipped (319880 > -726)
main warning: late picture skipped (282830 > -726)
main warning: PTS is out of range (166798), dropping buffer
main warning: PTS is out of range (142849), dropping buffer
main warning: late picture skipped (249546 > -726)
main warning: PTS is out of range (351107), dropping buffer
main warning: PTS is out of range (335999), dropping buffer
main warning: PTS is out of range (312063), dropping buffer
main warning: PTS is out of range (288990), dropping buffer
main warning: PTS is out of range (265037), dropping buffer
main warning: PTS is out of range (258374), dropping buffer
main warning: PTS is out of range (234429), dropping buffer
main warning: PTS is out of range (286866), dropping buffer
main warning: PTS is out of range (262918), dropping buffer
main warning: PTS is out of range (246904), dropping buffer
main warning: PTS is out of range (222964), dropping buffer
main warning: PTS is out of range (198986), dropping buffer
main warning: PTS is out of range (175006), dropping buffer
main warning: PTS is out of range (151026), dropping buffer
main warning: PTS is out of range (127047), dropping buffer
main warning: PTS is out of range (103066), dropping buffer
main warning: PTS is out of range (79086), dropping buffer
main warning: PTS is out of range (55106), dropping buffer
main warning: PTS is out of range (32496), dropping buffer
main warning: PTS is out of range (8547), dropping buffer
main warning: PTS is out of range (-15433), dropping buffer
main warning: PTS is out of range (-39413), dropping buffer
main debug: control type=1

Re: 1.0 RC versions prone to more playback glitches

Posted: 30 Jun 2009 00:32
by kdean
Some more glitches.

main warning: PTS is out of range (-20657), dropping buffer
main warning: the mixer got a packet in the past (9220)
main warning: mixer start isn't output start (3540)
freetype debug: using fontsize: 22
main warning: late picture skipped (21006 > -1379)
main warning: late picture skipped (34453 > -1647)
main warning: late picture skipped (12739 > -1647)
main warning: PTS is out of range (-19685), dropping buffer
mpgatofixed32 debug: libmad error: bad main_data_begin pointer
main warning: late picture skipped (62571 > -1604)
main warning: late picture skipped (41880 > -1604)
main warning: output PTS is out of range (7351), clearing out
main warning: input PTS is out of range (29944), trashing
main warning: input PTS is out of range (6395), trashing
main warning: late picture skipped (253934 > -845)
main warning: computed PTS is out of range (182368), clearing out
main warning: PTS is out of range (158832), dropping buffer
main warning: output PTS is out of range (188016), clearing out
main warning: PTS is out of range (134878), dropping buffer
main warning: late picture skipped (238461 > -756)
main warning: PTS is out of range (135468), dropping buffer
main warning: PTS is out of range (353151), dropping buffer
main warning: PTS is out of range (329204), dropping buffer
main warning: late picture skipped (441659 > -598)
main warning: PTS is out of range (338479), dropping buffer
main warning: PTS is out of range (330789), dropping buffer
main warning: PTS is out of range (306849), dropping buffer
main warning: PTS is out of range (473971), dropping buffer
main warning: PTS is out of range (450030), dropping buffer
main warning: PTS is out of range (450915), dropping buffer
main warning: PTS is out of range (460294), dropping buffer
main warning: PTS is out of range (436358), dropping buffer
main warning: PTS is out of range (453876), dropping buffer
main warning: PTS is out of range (453140), dropping buffer
main warning: PTS is out of range (429209), dropping buffer
main warning: PTS is out of range (450440), dropping buffer
main warning: PTS is out of range (426520), dropping buffer
main warning: PTS is out of range (445213), dropping buffer
main warning: PTS is out of range (446008), dropping buffer
main warning: PTS is out of range (422655), dropping buffer
main warning: PTS is out of range (423824), dropping buffer
main warning: PTS is out of range (399877), dropping buffer
main warning: PTS is out of range (403524), dropping buffer
main warning: PTS is out of range (379584), dropping buffer
main warning: PTS is out of range (385855), dropping buffer
main warning: PTS is out of range (362090), dropping buffer
main warning: PTS is out of range (365055), dropping buffer
main warning: PTS is out of range (369882), dropping buffer
main warning: PTS is out of range (345942), dropping buffer
main warning: PTS is out of range (335651), dropping buffer
main warning: PTS is out of range (339394), dropping buffer
main warning: PTS is out of range (315448), dropping buffer
main warning: PTS is out of range (311399), dropping buffer
main warning: PTS is out of range (287453), dropping buffer
main warning: PTS is out of range (267855), dropping buffer
main warning: PTS is out of range (259075), dropping buffer
main warning: PTS is out of range (235132), dropping buffer
main warning: PTS is out of range (212108), dropping buffer
main warning: PTS is out of range (213020), dropping buffer
main warning: PTS is out of range (189936), dropping buffer
main warning: PTS is out of range (174552), dropping buffer
main warning: PTS is out of range (150596), dropping buffer
main warning: PTS is out of range (127304), dropping buffer
main warning: PTS is out of range (113602), dropping buffer
main warning: PTS is out of range (90446), dropping buffer
main warning: PTS is out of range (67275), dropping buffer
main warning: PTS is out of range (43721), dropping buffer
main warning: PTS is out of range (23946), dropping buffer
main warning: PTS is out of range (17), dropping buffer
main warning: PTS is out of range (-22543), dropping buffer
mpgatofixed32 debug: libmad error: bad main_data_begin pointer

Re: 1.0 RC versions prone to more playback glitches

Posted: 01 Jul 2009 04:09
by snix
i've noticed this also with 1.0 RC4. videos pause while audio continues playing and i have to seek forward or back to get out of it. this didn't occur with 0.9.8.

Re: 1.0 RC versions prone to more playback glitches

Posted: 02 Jul 2009 13:47
by The DJ
Yes we too have noticed this, but we are not entirely sure what is causing it. The initial glitch is nothing new, but it should recover more quickly then it does at this time. We will try and find the cause, but it won't be in time for 1.0.0 I think.

Re: 1.0 RC versions prone to more playback glitches

Posted: 02 Jul 2009 14:50
by kdean
It could be codec or container specific. I watched a 2.5 hour x264 mkv the other day without glitches, whereas the above errors were from Xvid avi files.

Re: 1.0 RC versions prone to more playback glitches

Posted: 02 Jul 2009 21:37
by anonymous2
I have this problem specifically with '.wmv' files.

Re: 1.0 RC versions prone to more playback glitches

Posted: 11 Jul 2009 00:19
by claven
I posted this as a reply to another posting, but thought I'd post it here just in case. I have this same problem, and it happens on both my computers - I have an early 2008 Macbook Pro running 10.5.7 with 4 gbs ram and a new imac running 10.5.7 with 4 gbs of ram. It seems to happen mostly when I'm surfing the internet while there's a video playing (I play mostly .avi files). istat doesn't show any unusually high CPU functions on the part of VLC or Safari, but it acts like there's a CPU overload, with the video freezing or going choppy. I downgraded to 9.9a and haven't had any further problems...