Postby DJ » 24 Jan 2006 21:24
The following are the messages obtained while playing the first 10 seconds of the same movie. In the VCD and DAT mode the disk and file was called from within VLC. The image (bin) was called external to VLC (through the Windows interface). While I have files that play slightlly better or worse, this disk is about middle of the road for performance. None of the VCDs I have had any problems in VLC 0.8.2 or in any other player that supports VCDs properly. The problems started with VLC 0.8.4 and continue through the most recent nightly build (1/21/06).
In the case of the .DAT file, there are no reported messages for 15 to 20 min at a time and no precieved problems in watching the movie. In the other two methods of playing the movie the messages continue on and the movie is unwatchable.
1. Calling the disk in VLC to play a VCD:
main debug: adding playlist item `vcd://F:' ( vcd://F: )
main debug: creating new input thread
main debug: waiting for thread completion
main debug: thread 4452 (input) created at priority 1 (src/input/input.c:252)
main debug: `vcd://F:' gives access `vcd' demux `' path `F:'
main debug: creating demux: access='vcd' demux='' path='F:'
main debug: looking for access_demux module: 0 candidates
main warning: no access_demux module matched "vcd"
main debug: creating access 'vcd' path='F:'
main debug: looking for access2 module: 5 candidates
vcd debug: using winNT/2K/XP ioctl layer
vcd debug: p_sectors: 0, 0
vcd debug: p_sectors: 1, 450
vcd debug: p_sectors: 2, 348485
vcd debug: Entry[0] title=0 sector=450
skins2 warning: Cannot find node with id 4
vcd debug: Entry[1] title=0 sector=14813
vcd debug: Entry[2] title=0 sector=32039
vcd debug: Entry[3] title=0 sector=45581
vcd debug: Entry[4] title=0 sector=60038
vcd debug: Entry[5] title=0 sector=76405
vcd debug: Entry[6] title=0 sector=93401
vcd debug: Entry[7] title=0 sector=111059
vcd debug: Entry[8] title=0 sector=125930
vcd debug: Entry[9] title=0 sector=140430
vcd debug: Entry[10] title=0 sector=155473
vcd debug: Entry[11] title=0 sector=171574
vcd debug: Entry[12] title=0 sector=185662
vcd debug: Entry[13] title=0 sector=201309
vcd debug: Entry[14] title=0 sector=216951
vcd debug: Entry[15] title=0 sector=231621
vcd debug: Entry[16] title=0 sector=246725
vcd debug: Entry[17] title=0 sector=265568
vcd debug: Entry[18] title=0 sector=278856
vcd debug: Entry[19] title=0 sector=291847
vcd debug: Entry[20] title=0 sector=306211
vcd debug: Entry[21] title=0 sector=322406
vcd debug: Entry[22] title=0 sector=335891
main debug: using access2 module "vcd"
main debug: pre buffering
main debug: received first data for our buffer
main debug: prebuffering done 46480 bytes in 0s - 4866 kbytes/s
main debug: creating demux: access='vcd' demux='ps' path='F:'
main debug: looking for demux2 module: 2 candidates
ps warning: this does not look like an MPEG PS stream, continuing anyway
main debug: using demux2 module "ps"
vcd warning: unimplemented query in control
main debug: `vcd://F:' successfully opened
ps warning: garbage at input, trying to resync...
ps warning: found sync code
main debug: selecting program id=0
main debug: looking for decoder module: 26 candidates
main debug: using decoder module "libmpeg2"
main debug: thread 3716 (decoder) created at priority 0 (src/input/decoder.c:159)
main debug: looking for decoder module: 26 candidates
main debug: using decoder module "mpeg_audio"
main debug: thread 3772 (decoder) created at priority 2 (src/input/decoder.c:159)
libmpeg2 debug: 352x288 (display 352,288), aspect 563200, sar 16:15, 25.000 fps
main debug: no usable vout present, spawning one
main debug: Registering subpicture channel, ID: 2
main debug: Registering subpicture channel, ID: 3
main debug: Registering subpicture channel, ID: 4
main debug: Registering subpicture channel, ID: 5
mpeg_audio debug: MPGA channels:2 samplerate:48000 bitrate:112
main debug: looking for audio output module: 3 candidates
aout_directx debug: OpenAudio
aout_directx debug: found device: Primary Sound Driver
aout_directx debug: found device: Conexant AMC Audio
aout_directx debug: found device: Modem #0 Line Playback (emulated)
aout_directx debug: device supports 2 channels
aout_directx debug: device supports 1 channel
aout_directx debug: creating DirectSoundThread
main debug: thread 4328 (DirectSound Notification Thread) created at priority 15 (directx.c:374)
aout_directx debug: DirectSoundThread ready
main debug: using audio output module "aout_directx"
main debug: output 's16l' 48000 Hz Stereo frame=1 samples/4 bytes
main debug: mixer 'fl32' 48000 Hz Stereo frame=1 samples/8 bytes
main debug: filter(s) 'fl32'->'s16l' 48000 Hz->48000 Hz Stereo->Stereo
main debug: looking for audio filter module: 24 candidates
main debug: using audio filter module "float32tos16"
main debug: found a filter for the whole conversion
main debug: looking for audio mixer module: 3 candidates
main debug: using audio mixer module "trivial_mixer"
main debug: input 'mpga' 48000 Hz Stereo frame=1152 samples/1161 bytes
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: 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: found a filter for the whole conversion
main debug: window size: 781x331
main debug: looking for video output module: 5 candidates
vout_directx debug: creating DirectXEventThread
main debug: waiting for thread completion
vout_directx debug: DirectXCreateWindow
vout_directx debug: Created video sub-window
main debug: thread 4420 (DirectX Events Thread) created at priority 0 (directx.c:263)
vout_directx debug: DirectXEventThread running
vout_directx debug: DirectXInitDDraw
vout_directx debug: directx-device:
vout_directx debug: DirectXEnumCallback: Primary Display Driver, display
vout_directx debug: DirectXEnumCallback: RADEON IGP 345M, \\.\DISPLAY1
vout_directx debug: selecting RADEON IGP 345M, \\.\DISPLAY1
vout_directx debug: screen dimensions (0x0,1024x768)
vout_directx debug: DirectDraw Capabilities: overlay=1 yuvoverlay=1 can_deinterlace_overlay=1 colorkey=1 stretch=1 bltfourcc=1
vout_directx debug: End DirectXInitDDraw
vout_directx debug: DirectXCreateDisplay
vout_directx debug: DirectXCreateClipper
skins2 debug: control query not supported
vout_directx debug: disabling screen saver
main debug: using video output module "vout_directx"
vout_directx debug: NewPictureVec overlay:yes chroma:YV12
vout_directx debug: YUV overlay created successfully
vout_directx debug: End NewPictureVec (succeeded)
main debug: got 1 direct buffer(s)
main debug: picture in 352x288 (0,0,352x288), chroma I420, ar 176:135, sar 16:15
main debug: picture user 352x288 (0,0,352x288), chroma I420, ar 176:135, sar 16:15
main debug: picture out 352x288 (0,0,352x288), chroma I420, ar 176:135, sar 16:15
main debug: direct render, mapping render pictures 0-6 to system pictures 1-7
main debug: waiting for thread completion
main debug: thread 3932 (video output) created at priority 1 (src/video_output/video_output.c:420)
main warning: dts != current_pts (87814)
main warning: vout synchro warning: pts != current_date (-40000)
main warning: output date isn't PTS date, requesting resampling (90238)
main warning: buffer is 90238 late, triggering upsampling
main warning: PTS is out of range (1425), dropping buffer
main warning: PTS is out of range (37516), dropping buffer
main warning: PTS is out of range (13605), dropping buffer
main warning: PTS is out of range (-10365), dropping buffer
main warning: PTS is out of range (-34326), dropping buffer
main warning: late picture skipped (37601)
main warning: late picture skipped (118453)
main warning: late picture skipped (78837)
main warning: late picture skipped (39161)
main warning: output PTS is out of range (29469), clearing out
main warning: input PTS is out of range (29556), trashing
main warning: input PTS is out of range (5720), trashing
main warning: output date isn't PTS date, requesting resampling (46723)
main warning: late picture skipped (17310)
main warning: output date isn't PTS date, requesting resampling (49998)
main warning: PTS is out of range (1828), dropping buffer
main warning: PTS is out of range (-21420), dropping buffer
main warning: output date isn't PTS date, requesting resampling (50026)
main warning: buffer is 65005 late, triggering upsampling
main warning: PTS is out of range (-39751), dropping buffer
main warning: buffer is 40818 late, triggering upsampling
main warning: output date isn't PTS date, requesting resampling (50029)
main warning: timing screwed, stopping resampling
main warning: buffer is 90305 late, triggering upsampling
main debug: decoded 117/120 pictures
main warning: PTS is out of range (-28282), dropping buffer
main warning: buffer is 58784 late, triggering upsampling
main warning: PTS is out of range (-26524), dropping buffer
main warning: output date isn't PTS date, requesting resampling (50256)
main warning: buffer is 73020 late, triggering upsampling
main warning: PTS is out of range (-35474), dropping buffer
main warning: output date isn't PTS date, requesting resampling (50108)
main warning: buffer is 90003 late, triggering upsampling
main warning: PTS is out of range (-33957), dropping buffer
main warning: buffer is 59982 late, triggering upsampling
main warning: PTS is out of range (-21554), dropping buffer
main warning: output date isn't PTS date, requesting resampling (50273)
main warning: buffer is 74234 late, triggering upsampling
main warning: PTS is out of range (-31464), dropping buffer
main warning: buffer is 41859 late, triggering upsampling
main warning: output date isn't PTS date, requesting resampling (55572)
main warning: timing screwed, stopping resampling
main warning: buffer is 83139 late, triggering upsampling
main warning: output date isn't PTS date, requesting resampling (44902)
main warning: output date isn't PTS date, requesting resampling (50116)
main warning: output date isn't PTS date, requesting resampling (50122)
main warning: resampling stopped after 20024633 usec (drift: -54571)
main warning: buffer is 54738 late, triggering upsampling
main debug: control type=1
2. Calling the .DAT file on the disk from within VLC:
main debug: adding playlist item `F:\MPEGAV\AVSEQ01.DAT' ( F:\MPEGAV\AVSEQ01.DAT )
main debug: creating new input thread
main debug: waiting for thread completion
main debug: thread 3736 (input) created at priority 1 (src/input/input.c:252)
main warning: drive letter F: found in source
main debug: `F:\MPEGAV\AVSEQ01.DAT' gives access `' demux `' path `F:\MPEGAV\AVSEQ01.DAT'
main debug: creating demux: access='' demux='' path='F:\MPEGAV\AVSEQ01.DAT'
main debug: looking for access_demux module: 1 candidate
skins2 warning: Cannot find node with id 5
main debug: creating access '' path='F:\MPEGAV\AVSEQ01.DAT'
main debug: looking for access2 module: 5 candidates
vcd debug: trying .cue file: F:\MPEGAV\AVSEQ01.cue
access_file debug: opening file `F:\MPEGAV\AVSEQ01.DAT'
main debug: using access2 module "access_file"
main debug: pre buffering
main debug: received first data for our buffer
main debug: prebuffering done 1408981 bytes in 0s - 14696 kbytes/s
main debug: creating demux: access='' demux='' path='F:\MPEGAV\AVSEQ01.DAT'
main debug: looking for demux2 module: 42 candidates
ps warning: this does not look like an MPEG PS stream, continuing anyway
main debug: using demux2 module "ps"
main debug: looking for a subtitle file in F:\MPEGAV\
main debug: `F:\MPEGAV\AVSEQ01.DAT' successfully opened
ps warning: garbage at input, trying to resync...
ps warning: found sync code
main debug: selecting program id=0
main debug: looking for decoder module: 26 candidates
main debug: using decoder module "libmpeg2"
main debug: thread 4692 (decoder) created at priority 0 (src/input/decoder.c:159)
main debug: looking for decoder module: 26 candidates
main debug: using decoder module "mpeg_audio"
main debug: thread 4668 (decoder) created at priority 2 (src/input/decoder.c:159)
libmpeg2 debug: 352x288 (display 352,288), aspect 563200, sar 16:15, 25.000 fps
main debug: no usable vout present, spawning one
main debug: window size: 781x331
main debug: looking for video output module: 5 candidates
main debug: Registering subpicture channel, ID: 2
main debug: Registering subpicture channel, ID: 3
main debug: Registering subpicture channel, ID: 4
main debug: Registering subpicture channel, ID: 5
mpeg_audio debug: MPGA channels:2 samplerate:48000 bitrate:112
main debug: looking for audio output module: 3 candidates
aout_directx debug: OpenAudio
aout_directx debug: found device: Primary Sound Driver
aout_directx debug: found device: Conexant AMC Audio
aout_directx debug: found device: Modem #0 Line Playback (emulated)
aout_directx debug: device supports 2 channels
aout_directx debug: device supports 1 channel
aout_directx debug: creating DirectSoundThread
main debug: thread 5044 (DirectSound Notification Thread) created at priority 15 (directx.c:374)
aout_directx debug: DirectSoundThread ready
main debug: using audio output module "aout_directx"
main debug: output 's16l' 48000 Hz Stereo frame=1 samples/4 bytes
main debug: mixer 'fl32' 48000 Hz Stereo frame=1 samples/8 bytes
main debug: filter(s) 'fl32'->'s16l' 48000 Hz->48000 Hz Stereo->Stereo
main debug: looking for audio filter module: 24 candidates
main debug: using audio filter module "float32tos16"
main debug: found a filter for the whole conversion
main debug: looking for audio mixer module: 3 candidates
main debug: using audio mixer module "trivial_mixer"
main debug: input 'mpga' 48000 Hz Stereo frame=1152 samples/1161 bytes
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: 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: found a filter for the whole conversion
vout_directx debug: creating DirectXEventThread
main debug: waiting for thread completion
vout_directx debug: DirectXCreateWindow
vout_directx debug: Created video sub-window
main debug: thread 5096 (DirectX Events Thread) created at priority 0 (directx.c:263)
vout_directx debug: DirectXEventThread running
vout_directx debug: DirectXInitDDraw
vout_directx debug: directx-device:
vout_directx debug: DirectXEnumCallback: Primary Display Driver, display
vout_directx debug: DirectXEnumCallback: RADEON IGP 345M, \\.\DISPLAY1
vout_directx debug: selecting RADEON IGP 345M, \\.\DISPLAY1
vout_directx debug: screen dimensions (0x0,1024x768)
vout_directx debug: DirectDraw Capabilities: overlay=1 yuvoverlay=1 can_deinterlace_overlay=1 colorkey=1 stretch=1 bltfourcc=1
vout_directx debug: End DirectXInitDDraw
vout_directx debug: DirectXCreateDisplay
vout_directx debug: DirectXCreateClipper
skins2 debug: control query not supported
vout_directx debug: disabling screen saver
main debug: using video output module "vout_directx"
vout_directx debug: NewPictureVec overlay:yes chroma:YV12
vout_directx debug: YUV overlay created successfully
vout_directx debug: End NewPictureVec (succeeded)
main debug: got 1 direct buffer(s)
main debug: picture in 352x288 (0,0,352x288), chroma I420, ar 176:135, sar 16:15
main debug: picture user 352x288 (0,0,352x288), chroma I420, ar 176:135, sar 16:15
main debug: picture out 352x288 (0,0,352x288), chroma I420, ar 176:135, sar 16:15
main debug: direct render, mapping render pictures 0-6 to system pictures 1-7
main debug: waiting for thread completion
main debug: thread 5124 (video output) created at priority 1 (src/video_output/video_output.c:420)
main warning: dts != current_pts (-240819)
main warning: vout synchro warning: pts != current_date (-40000)
main warning: late picture skipped (-6607)
main warning: late picture skipped (132805)
main warning: late picture skipped (93201)
main warning: late picture skipped (53531)
main warning: late picture skipped (13859)
main warning: late picture skipped (50806)
main warning: late picture skipped (35505)
main debug: decoded 115/120 pictures
main debug: control type=1
3. Clicking on the .BIN file to open VLC:
main warning: PTS is out of range (-38746), dropping buffer
main warning: output date isn't PTS date, requesting resampling (44900)
main warning: buffer is 71973 late, triggering upsampling
main warning: PTS is out of range (-26712), dropping buffer
main warning: buffer is 47785 late, triggering upsampling
main warning: output date isn't PTS date, requesting resampling (50120)
main warning: timing screwed, stopping resampling
main warning: buffer is 86780 late, triggering upsampling
main warning: PTS is out of range (-19875), dropping buffer
main warning: buffer is 62613 late, triggering upsampling
main warning: PTS is out of range (-28623), dropping buffer
main warning: output date isn't PTS date, requesting resampling (50145)
main warning: buffer is 76738 late, triggering upsampling
main warning: PTS is out of range (-35107), dropping buffer
main warning: buffer is 44363 late, triggering upsampling
main warning: output date isn't PTS date, requesting resampling (50227)
main warning: PTS is out of range (-20521), dropping buffer
main warning: buffer is 58402 late, triggering upsampling
main warning: PTS is out of range (-24414), dropping buffer
main warning: output date isn't PTS date, requesting resampling (50147)
main warning: buffer is 72528 late, triggering upsampling
main warning: output date isn't PTS date, requesting resampling (50228)
main warning: resampling stopped after 12860634 usec (drift: -49715)
main warning: buffer is 49881 late, triggering upsampling
main warning: output date isn't PTS date, requesting resampling (50300)
main warning: timing screwed, stopping resampling
main warning: buffer is 92598 late, triggering upsampling
main warning: output date isn't PTS date, requesting resampling (50290)
main debug: control type=1
I should also mention that changing DirectX float32 option or changing the resampling option has no effect on this problem. Also I am experiencing no problems with other modules or formats within VLC.