Not all bytes read error playing AVI files

[kfhickel]

Getting the error highlighted below when viewing certain AVI files. Generally speaking some files always work, some always fail. This is GBPVR 0.97.13.

I've tried the three dongle.bin files that come with this version of GB-PVR, no difference.

I can play the files back ont he PC running GB-PVR just fine.

The PC is an AMD 2700 with 1GB RAM, 100mbps NIC into 10/100 switch, which the MVP is also plugged into.

Any ideas?

gbpvr.exe-1.log excerpt:
9/6/2006 7:18:21 PM.155 INFO [12] playFile()
9/6/2006 7:18:21 PM.255 VERBOSE [12] About to play file: V:\Media\BeyondTV\Spiderman\Spiderman (1967) - 02 - Sub-zero For Spidey (TIH).avi
9/6/2006 7:18:21 PM.255 VERBOSE [12] Sending MVP Video Playback Request: V:\Media\BeyondTV\Spiderman\Spiderman (1967) - 02 - Sub-zero For Spidey (TIH).avi
9/6/2006 7:18:21 PM.255 VERBOSE [12] Playback started: V:\Media\BeyondTV\Spiderman\Spiderman (1967) - 02 - Sub-zero For Spidey (TIH).avi
9/6/2006 7:18:21 PM.365 VERBOSE [11] MVP playback requested: V:\Media\BeyondTV\SPIDER~1\SPIDER~2.AVI (shortname)
9/6/2006 7:18:21 PM.365 VERBOSE [11] MVP playback requested: V:\Media\BeyondTV\Spiderman\Spiderman (1967) - 02 - Sub-zero For Spidey (TIH).avi (longname)
9/6/2006 7:18:21 PM.365 VERBOSE [11] getValue() loading new key/value into cache: /settings/RecordingsDirectory
9/6/2006 7:18:21 PM.365 VERBOSE [11] getValue: /settings/RecordingsDirectory : C:\
9/6/2006 7:18:21 PM.365 VERBOSE [11] getValue() loading new key/value into cache: /settings/MVPTranscodeUsingFFmpeg
9/6/2006 7:18:21 PM.365 VERBOSE [11] getValue: /settings/MVPTranscodeUsingFFmpeg : true
9/6/2006 7:18:21 PM.365 VERBOSE [11] getValue() loading new key/value into cache: /settings/MVPFFmpegTranscodeCmdLinePAL
9/6/2006 7:18:21 PM.365 VERBOSE [11] getValue: /settings/MVPFFmpegTranscodeCmdLinePAL : -y -i "{SOURCE_FILE}" -b 2400 -ac 2 -ab 128 -r 25 -s 352x288 -f svcd "{DEST_FILE}"
9/6/2006 7:18:21 PM.365 VERBOSE [11] getValue() loading new key/value into cache: /settings/MVPFFmpegTranscodeCmdLineNTSC
9/6/2006 7:18:21 PM.365 VERBOSE [11] getValue: /settings/MVPFFmpegTranscodeCmdLineNTSC : -y -i "{SOURCE_FILE}" -b 2400 -ac 2 -ab 128 -r 29.97 -s 352x240 -f svcd "{DEST_FILE}"
9/6/2006 7:18:21 PM.365 VERBOSE [11] Starting FFmpeg transcode with: -y -i "V:\Media\BeyondTV\Spiderman\Spiderman (1967) - 02 - Sub-zero For Spidey (TIH).avi" -b 2400 -ac 2 -ab 128 -r 29.97 -s 352x240 -f svcd "C:\MVP000DFE0086641.mpg"
9/6/2006 7:18:21 PM.365 VERBOSE [10] MVP data read: 1 (7)
9/6/2006 7:18:21 PM.365 VERBOSE [10] MVP request processed
9/6/2006 7:18:21 PM.365 VERBOSE [12] MVP not sending frame
9/6/2006 7:18:21 PM.635 VERBOSE [11] Waiting for transcoding to begin
9/6/2006 7:18:21 PM.896 VERBOSE [11] getValue() loading new key/value into cache: /settings/MVPTranscodePrePlayDelay
9/6/2006 7:18:21 PM.896 VERBOSE [11] getValue: /settings/MVPTranscodePrePlayDelay : 5500
9/6/2006 7:18:22 PM.026 VERBOSE [12] Checking if resume prompt needs to be shown
9/6/2006 7:18:22 PM.026 VERBOSE [12] MVPGetCurrentFrameNumber 0
9/6/2006 7:18:22 PM.026 VERBOSE [12] getValue() loading new key/value into cache: /settings/VideoPlugin0
9/6/2006 7:18:22 PM.026 VERBOSE [12] getValue: /settings/VideoPlugin0 : TV Guide
9/6/2006 7:18:22 PM.026 VERBOSE [12] GuideMenuTask created
9/6/2006 7:18:22 PM.026 VERBOSE [12] Loading key mapping: C:\Program Files\devnz\gbpvr\KeyMappings\TVGuide.xml
9/6/2006 7:18:22 PM.026 VERBOSE [12] Adding: Enter GUIDE_ENTER
9/6/2006 7:18:22 PM.026 VERBOSE [12] Adding: Return GUIDE_ENTER
9/6/2006 7:18:22 PM.026 VERBOSE [12] Adding: Up GUIDE_UP
9/6/2006 7:18:22 PM.026 VERBOSE [12] Adding: Down GUIDE_DOWN
9/6/2006 7:18:22 PM.026 VERBOSE [12] Adding: Left GUIDE_LEFT
9/6/2006 7:18:22 PM.026 VERBOSE [12] Adding: Right GUIDE_RIGHT
9/6/2006 7:18:22 PM.026 VERBOSE [12] Adding: ^Right GUIDE_DAY_FORWARD
9/6/2006 7:18:22 PM.026 VERBOSE [12] Adding: ^Left GUIDE_DAY_BACK
9/6/2006 7:18:22 PM.026 VERBOSE [12] Adding: ^F GUIDE_PAGE_FORWARD
9/6/2006 7:18:22 PM.026 VERBOSE [12] Adding: ^D GUIDE_PAGE_BACK
9/6/2006 7:18:22 PM.026 VERBOSE [12] Adding: ^G GUIDE_PAGE_UP
9/6/2006 7:18:22 PM.026 VERBOSE [12] Adding: ^B GUIDE_PAGE_DOWN
9/6/2006 7:18:22 PM.026 VERBOSE [12] Adding: PageUp GUIDE_PAGE_UP
9/6/2006 7:18:22 PM.026 VERBOSE [12] Adding: Next GUIDE_PAGE_DOWN
9/6/2006 7:18:22 PM.026 VERBOSE [12] Adding: ^P GUIDE_PLAY
9/6/2006 7:18:22 PM.026 VERBOSE [12] Adding: ^K GUIDE_RECORD
9/6/2006 7:18:22 PM.026 VERBOSE [12] Adding: F11 GUIDE_NOW
9/6/2006 7:18:22 PM.036 VERBOSE [12] Initializing skin helper for: .\skin\Flat Blue - High Vis\tv guide\live-skin.xml
9/6/2006 7:18:22 PM.056 VERBOSE [12] getValue() loading new key/value into cache: /settings/VideoPlugin1
9/6/2006 7:18:22 PM.056 VERBOSE [12] getValue: /settings/VideoPlugin1 : ProcAmp
9/6/2006 7:18:22 PM.056 VERBOSE [12] getValue() loading new key/value into cache: /settings/VideoPlugin2
9/6/2006 7:18:22 PM.056 VERBOSE [12] getValue: /settings/VideoPlugin2 : OSD Menu
9/6/2006 7:18:22 PM.056 VERBOSE [12] getValue() loading new key/value into cache: /settings/VideoPlugin3
9/6/2006 7:18:22 PM.056 VERBOSE [12] getValue: /settings/VideoPlugin3 : Live Guide
9/6/2006 7:18:22 PM.056 VERBOSE [12] getValue() loading new key/value into cache: /settings/VideoPlugin4
9/6/2006 7:18:22 PM.056 VERBOSE [12] getValue: /settings/VideoPlugin4 :
9/6/2006 7:18:22 PM.056 VERBOSE [12] getValue() loading new key/value into cache: /settings/VideoPlugin5
9/6/2006 7:18:22 PM.056 VERBOSE [12] getValue: /settings/VideoPlugin5 :
9/6/2006 7:18:22 PM.056 VERBOSE [12] getValue() loading new key/value into cache: /settings/VideoPlugin6
9/6/2006 7:18:22 PM.056 VERBOSE [12] getValue: /settings/VideoPlugin6 :
9/6/2006 7:18:22 PM.056 VERBOSE [12] getValue() loading new key/value into cache: /settings/VideoPlugin7
9/6/2006 7:18:22 PM.056 VERBOSE [12] getValue: /settings/VideoPlugin7 :
9/6/2006 7:18:22 PM.056 VERBOSE [12] getValue() loading new key/value into cache: /settings/VideoPlugin8
9/6/2006 7:18:22 PM.056 VERBOSE [12] getValue: /settings/VideoPlugin8 :
9/6/2006 7:18:22 PM.056 VERBOSE [12] getValue() loading new key/value into cache: /settings/VideoPlugin9
9/6/2006 7:18:22 PM.056 VERBOSE [12] getValue: /settings/VideoPlugin9 :
9/6/2006 7:18:23 PM.007 VERBOSE [12] MVPGetCurrentFrameNumber 0
9/6/2006 7:18:24 PM.009 VERBOSE [12] MVPGetCurrentFrameNumber 0
9/6/2006 7:18:25 PM.010 VERBOSE [12] MVPGetCurrentFrameNumber 0
9/6/2006 7:18:25 PM.220 VERBOSE [10] MVP data read: 1 (8)
9/6/2006 7:18:25 PM.220 VERBOSE [10] Responding to ping
9/6/2006 7:18:25 PM.220 VERBOSE [10] getValue cached value: /settings/DisableHauppaugeMVPScreenSaver : true
9/6/2006 7:18:25 PM.220 VERBOSE [10] MVP request processed
9/6/2006 7:18:26 PM.022 VERBOSE [12] MVPGetCurrentFrameNumber 0
9/6/2006 7:18:27 PM.023 VERBOSE [12] MVPGetCurrentFrameNumber 0
9/6/2006 7:18:27 PM.393 VERBOSE [11] Opening media file: C:\MVP000DFE0086641.mpg
9/6/2006 7:18:27 PM.393 VERBOSE [11] bitrate: 262143
9/6/2006 7:18:27 PM.664 VERBOSE [11] Request 200000 bytes (file size:1529856 file location: 38)
9/6/2006 7:18:28 PM.024 VERBOSE [12] mvpVideoDuration: 13
9/6/2006 7:18:28 PM.024 VERBOSE [12] MVPGetCurrentFrameNumber 0
9/6/2006 7:18:28 PM.064 VERBOSE [11] Request 200000 bytes (file size:1722368 file location: 200038)
9/6/2006 7:18:28 PM.215 VERBOSE [11] Request 200000 bytes (file size:1792000 file location: 400038)
9/6/2006 7:18:28 PM.335 VERBOSE [11] Request 200000 bytes (file size:1863680 file location: 600038)
9/6/2006 7:18:28 PM.796 VERBOSE [11] Request 200000 bytes (file size:2082816 file location: 800038)
9/6/2006 7:18:28 PM.946 VERBOSE [11] Request 200000 bytes (file size:2146304 file location: 1000038)
9/6/2006 7:18:29 PM.026 VERBOSE [12] mvpVideoDuration: 15
9/6/2006 7:18:29 PM.026 VERBOSE [12] MVPGetCurrentFrameNumber 269
9/6/2006 7:18:29 PM.096 VERBOSE [11] Request 200000 bytes (file size:2220032 file location: 1200038)
9/6/2006 7:18:29 PM.246 VERBOSE [11] Request 200000 bytes (file size:2277376 file location: 1400038)
9/6/2006 7:18:29 PM.406 VERBOSE [11] Request 200000 bytes (file size:2334720 file location: 1600038)
9/6/2006 7:18:29 PM.527 VERBOSE [11] Request 200000 bytes (file size:2381824 file location: 1800038)
9/6/2006 7:18:29 PM.677 VERBOSE [11] Request 200000 bytes (file size:2453504 file location: 2000038)
9/6/2006 7:18:30 PM.037 VERBOSE [12] mvpVideoDuration: 17
9/6/2006 7:18:30 PM.037 VERBOSE [12] MVPGetCurrentFrameNumber 389
9/6/2006 7:18:30 PM.067 VERBOSE [11] Request 200000 bytes (file size:2607104 file location: 2200038)
9/6/2006 7:18:30 PM.488 VERBOSE [11] Request 200000 bytes (file size:2801664 file location: 2400038)
9/6/2006 7:18:30 PM.648 VERBOSE [11] Request 200000 bytes (file size:2871296 file location: 2600038)
9/6/2006 7:18:30 PM.768 VERBOSE [11] Request 200000 bytes (file size:2934784 file location: 2800038)
9/6/2006 7:18:30 PM.768 VERBOSE [11] Not all bytes read. Got:134746 Filesize now:2934784
9/6/2006 7:18:30 PM.949 VERBOSE [11] MVP Streaming Server received STOP message
9/6/2006 7:18:31 PM.109 VERBOSE [12] MVPGetCurrentFrameNumber 479
9/6/2006 7:18:31 PM.139 VERBOSE [11] Y/Y2 buffer: 95579 bytes
9/6/2006 7:18:31 PM.189 VERBOSE [11] U/V buffer: 39710 bytes
9/6/2006 7:18:31 PM.409 VERBOSE [11] incremental frame sent
9/6/2006 7:18:31 PM.580 VERBOSE [10] MVP data read: 1 (7)
9/6/2006 7:18:31 PM.580 VERBOSE [10] MVP request processed
9/6/2006 7:18:31 PM.700 VERBOSE [10] MVP data read: 1 (7)
9/6/2006 7:18:31 PM.700 VERBOSE [10] MVP request processed
9/6/2006 7:18:34 PM.173 VERBOSE [10] MVP data read: 1 (112)
9/6/2006 7:18:34 PM.173 VERBOSE [10] Graceful disconnect... (0x70, 0x69)
9/6/2006 7:18:34 PM.173 VERBOSE [10] MVP request processed
9/6/2006 7:18:34 PM.173 VERBOSE [10] MVP Control Thread shutting down....

[sub]

This is because your machine is not quite managing to keep up with the on-the-fly transcoding to MPEG2. You could try increasing the 'MVP transcode pre-play delay'. It might help.

[kfhickel]

This is because your machine is not quite managing to keep up with the on-the-fly transcoding to MPEG2. You could try increasing the 'MVP transcode pre-play delay'. It might help.

Thanks for the quick response, I'll give it a try.

-Kelly