COM error H.264 WTV QSF in 621c

dlflannery · Jul 24, 2011

In VAP I set up a QSF of an H.264 WTV to the same output type (H.264 WTV profile) using build 621c. I ran it with no dimension filter set and with the new automatic mode (setting to -1,-1).

In both cases the VRD process terminated without processing an output. Here are the two VRD log file sequences:

Code:

           ***** Loading: C:\VAP\Monitor\Late Night_SBS 6_2010_08_17_06_30_47.wtv

2011-07-24 16:52:22 Setting Batch QSF flag.
2011-07-24 16:52:22 H.264, Starting stream open for: C:\VAP\Monitor\Late Night_SBS 6_2010_08_17_06_30_47.wtv
2011-07-24 16:52:22 H.264, opening: C:\VAP\Monitor\Late Night_SBS 6_2010_08_17_06_30_47.wtv in QuickStream Fix Mode.
2011-07-24 16:52:22 H.264, Opening file: C:\VAP\Monitor\Late Night_SBS 6_2010_08_17_06_30_47.wtv, filetype is: H264  PIDs: x280 / x27F 
2011-07-24 16:52:22 COM call: FileSaveProfile: H.264 WTV
2011-07-24 16:52:22 ProfileSupport::SetVideoFrametRate failed - Invalid MPEG-2 frame rate: 0
2011-07-24 16:52:22 COM call: Close
2011-07-24 16:52:22 Destruct CVideoReDoDlgAutoProxy
2011-07-24 16:53:35 Decoder support lib: 6.1 build 137.56, ippvcp8l.lib+
2011-07-24 16:53:35 Image   support lib: 6.1 build 137.56, ippvcp8l.lib+
2011-07-24 16:53:36 VideoReDo TVSuite started. Licensed to: DADAVIDFLANN--, Version: 4.20.6.621 - Jul 12 2011, AVP On (00cf0062-528}
2011-07-24 16:53:36 Starting up with silent and batch: 1  0
2011-07-24 16:53:36 COM call: SetQuietMode
2011-07-24 16:53:36 COM call: GetVersionNumber
2011-07-24 16:53:36 COM call: FileOpenBatch C:\VAP\Monitor\Late Night_SBS 6_2010_08_17_06_30_47.wtv
2011-07-24 16:53:36  
           ***** Loading: C:\VAP\Monitor\Late Night_SBS 6_2010_08_17_06_30_47.wtv

2011-07-24 16:53:36 Setting Batch QSF flag.
2011-07-24 16:53:36 H.264, Starting stream open for: C:\VAP\Monitor\Late Night_SBS 6_2010_08_17_06_30_47.wtv
2011-07-24 16:53:36 H.264, opening: C:\VAP\Monitor\Late Night_SBS 6_2010_08_17_06_30_47.wtv in QuickStream Fix Mode.
2011-07-24 16:53:36 H.264, Opening file: C:\VAP\Monitor\Late Night_SBS 6_2010_08_17_06_30_47.wtv, filetype is: H264  PIDs: x280 / x27F 
2011-07-24 16:53:36 COM call: SetFilterDimensions
2011-07-24 16:53:36 Setting batch filter dimensions to: -1 x -1
2011-07-24 16:53:36 COM call: FileSaveProfile: H.264 WTV
2011-07-24 16:53:36 ProfileSupport::SetVideoFrametRate failed - Invalid MPEG-2 frame rate: 0
2011-07-24 16:53:36 COM call: Close
2011-07-24 16:53:36 Destruct CVideoReDoDlgAutoProxy
2011-07-24 16:57:56 Decoder support lib: 6.1 build 137.56, ippvcp8l.lib+
2011-07-24 16:57:57 Image   support lib: 6.1 build 137.56, ippvcp8l.lib+
2011-07-24 16:57:57 VideoReDo TVSuite started. Licensed to: DADAVIDFLANN--, Version: 4.20.6.621 - Jul 12 2011, AVP On (00cf0062-528}
2011-07-24 16:57:57 Checking reg: 120
2011-07-24 16:59:09

Apparently the error is reflected by this log line:

ProfileSupport::SetVideoFrametRate failed - Invalid MPEG-2 frame rate: 0
This seems strange because neither the input file nor the output profile is MPEG-2.

The identical input file QSF's fine when loaded directly into VRD, whether a dimension filter is used or not. (The dimension estimating system only finds the one dimension set.)
Here is a log sequence for the one with the filter:

Code:

           ***** Loading: C:\VAP\Monitor\Late Night_SBS 6_2010_08_17_06_30_47.wtv

2011-07-24 16:59:09 H.264, Starting stream open for: C:\VAP\Monitor\Late Night_SBS 6_2010_08_17_06_30_47.wtv
2011-07-24 16:59:09 H.264, Opening file: C:\VAP\Monitor\Late Night_SBS 6_2010_08_17_06_30_47.wtv, filetype is: H264  PIDs: x280 / x27F 
2011-07-24 16:59:09 Graph monitoring thread started.
2011-07-24 16:59:09 Adding module to graph: H264 decoder
2011-07-24 16:59:09 Setting graph input port: 0 to module: H264 decoder port: 0 Accepts EOF
2011-07-24 16:59:09 H264 decoder: Starting video, H264 decoder thread.
2011-07-24 16:59:09 Graph monitoring thread started.
2011-07-24 16:59:09 Adding module to graph: H264 decoder
2011-07-24 16:59:09 Setting graph input port: 0 to module: H264 decoder port: 0 Accepts EOF
2011-07-24 16:59:09 H264 decoder: Starting video, H264 decoder thread.
2011-07-24 16:59:09 H.264, Starting stream open for: C:\VAP\Monitor\Late Night_SBS 6_2010_08_17_06_30_47.wtv
2011-07-24 16:59:09 H.264, Opening file: C:\VAP\Monitor\Late Night_SBS 6_2010_08_17_06_30_47.wtv, filetype is: H264  PIDs: x280 / x27F 
2011-07-24 16:59:09 H264 video, using display driver: VMR9
2011-07-24 16:59:10 VMR9 (Windowed), MEDIASUBTYPE_YV12 
2011-07-24 16:59:10 VMR9 (Windowed), MEDIASUBTYPE_YV12 
2011-07-24 16:59:12 H.264, Starting stream open for: C:\VAP\Monitor\Late Night_SBS 6_2010_08_17_06_30_47.wtv
2011-07-24 16:59:12 H.264, Opening file: C:\VAP\Monitor\Late Night_SBS 6_2010_08_17_06_30_47.wtv, filetype is: H264  PIDs: x280 / x27F 
2011-07-24 16:59:13 H.264, Starting stream open for: C:\VAP\Monitor\Late Night_SBS 6_2010_08_17_06_30_47.wtv
2011-07-24 16:59:13 H.264, Opening file: C:\VAP\Monitor\Late Night_SBS 6_2010_08_17_06_30_47.wtv, filetype is: H264  PIDs: x280 / x27F 
2011-07-24 16:59:13 Program Information
  File:                                     Name : C:\VAP\Monitor\Late Night_SBS 6_2010_08_17_06_30_47.wtv
                                           Size : 1.010 GB
                                       Duration : 00:17:34.12
                                       Mux type : WTV
 Video:                                Encoding : H.264
                                  VideoStreamID : x280
                                     Frame rate : 25.00 fps
                                  Encoding size : 1920 x 1080
                                   Aspect ratio : 16:9
                                Header bit rate : 20.000 Mbps
                                     VBV buffer : 380 KBytes
                                        Profile : High/4.0
                                    Progressive : Interlaced
                                         Chroma : 4:2:0
                                   Entropy mode : CABAC
                                       Bit rate : 7.173 Mbps
 Audio Stream: 1 (Primary)                Codec : MPEG
                                      MPEGLayer : Layer 2
                                       Channels : 2.0
                                       Language : dut
                                            PID : x27F
                                  PES Stream Id : xC0
                                       Bit rate : 192 Kbps
                                  Sampling rate : 48000
                                    Sample size : 16 bits

2011-07-24 17:02:35 H.264, Starting stream open for: C:\VAP\Monitor\Late Night_SBS 6_2010_08_17_06_30_47.wtv
2011-07-24 17:02:35 H.264, opening: C:\VAP\Monitor\Late Night_SBS 6_2010_08_17_06_30_47.wtv in QuickStream Fix Mode.
2011-07-24 17:02:35 H.264, Opening file: C:\VAP\Monitor\Late Night_SBS 6_2010_08_17_06_30_47.wtv, filetype is: H264  PIDs: x280 / x27F 
2011-07-24 17:02:36 H.264, Starting stream open for: C:\VAP\Monitor\Late Night_SBS 6_2010_08_17_06_30_47.wtv
2011-07-24 17:02:36 H.264, opening: C:\VAP\Monitor\Late Night_SBS 6_2010_08_17_06_30_47.wtv in QuickStream Fix Mode.
2011-07-24 17:02:36 H.264, Opening file: C:\VAP\Monitor\Late Night_SBS 6_2010_08_17_06_30_47.wtv, filetype is: H264  PIDs: x280 / x27F 
2011-07-24 17:02:36 WTV, Writing filler attributes
2011-07-24 17:02:37 Graph monitoring thread started.
2011-07-24 17:02:37 Adding module to graph: H264 smart editor
2011-07-24 17:02:37 Adding module to graph: H264 decoder
2011-07-24 17:02:37 Adding module to graph: H264 encoder
2011-07-24 17:02:37 Adding module to graph: Audio recoder
2011-07-24 17:02:37 Adding module to graph: Output muxer
2011-07-24 17:02:37 Setting graph input port: 0 to module: H264 smart editor port: 0 Accepts EOF
2011-07-24 17:02:37 Setting graph input port: 3 to module: H264 smart editor port: 2 
2011-07-24 17:02:37 Connecting output of H264 smart editor (2) to input of H264 decoder (0)
2011-07-24 17:02:37 Connecting output of H264 decoder (0) to input of H264 smart editor (2)
2011-07-24 17:02:37 Connecting output of H264 encoder (0) to input of H264 smart editor (3)
2011-07-24 17:02:37 Connecting output of H264 smart editor (3) to input of H264 encoder (0)
2011-07-24 17:02:37 Connecting output of H264 smart editor (0) to input of Output muxer (0)
2011-07-24 17:02:37 Setting graph input port: 1 to module: Audio recoder port: 0 Accepts EOF
2011-07-24 17:02:37 Connecting output of Audio recoder (0) to input of Output muxer (2)
2011-07-24 17:02:37 Graph, passes required: 1
2011-07-24 17:02:37 Graph, Output encoding bitrate: 20.0000 Mbps
2011-07-24 17:02:37 Graph, Encoding dimension:      1920 x 1080
2011-07-24 17:02:37 Graph, Cropping rect:           (0 x 0 ) - (1920 x 1080)
2011-07-24 17:02:37 Graph, Maximum GOP:             0
2011-07-24 17:02:37 H264 smart editor: Starting H.264 smart editing thread.
2011-07-24 17:02:37 H264 decoder: Starting video, H264 decoder thread.
2011-07-24 17:02:37 H264 encoder: Starting video, H264 encoder thread.
2011-07-24 17:02:37 StreamProcess: Stream: 0, Starting audio coding thread.
2011-07-24 17:02:37 StreamProcess: Staring output muxer thread.
2011-07-24 17:02:37 Program Information 
            File Name: C:\VAP\Monitor\Late Night_SBS 6_2010_08_17_06_30_47.wtv
            File Size: 1009778688 ( 0.94 GB )
     Program Duration: 00:00:00.00
            File Type: WTV
             Encoding: H.264
      Video stream Id:  xE0
  Encoding Dimensions:  1920 x 1080
         Display Size:  1920 x 1080
         Aspect Ratio: 16:9
           Frame Rate:  25.00 FPS
             Bit Rate:  20.000 Mbps
           VBV_Buffer:  380 KB
              Profile: High/4.0
          Progressive: Interlaced
               Chroma:  4:2:0
         Audio Format:  Layer 2
      Audio Stream Id:  xC0
       Audio Bit Rate:  192 Kbps
  Audio Sampling Rate:  48000 Hz
    TS Mux Rate (bps): -1

2011-07-24 17:02:37 H.264, Starting new Frame Accurate Output Segment: start:0.000 (00:00:00.00),  end:450359962737.044 (5795:20:33.03), Mux delta:       0.00
2011-07-24 17:02:37 H.264, QuickStream fix flag is ON.
2011-07-24 17:02:37 Preparing to send status to: 0 Audio volume changed
2011-07-24 17:02:37 Sending status: 'Audio volume changed' to module: 'H264 smart editor - 0', Type: Video frame
2011-07-24 17:02:37 Preparing to send status to: 0 Audio volume changed
2011-07-24 17:02:37 Sending status: 'Audio volume changed' to module: 'Audio recoder - 0', Type: Audio frame
2011-07-24 17:02:37 Adding new graph range, Start:          0 (00:00:00.00), End: 450359962737.04 (5795:20:33.03)
2011-07-24 17:02:59 H.264, removed 3 frames due to missing pic_order_cnt_lsb 32803, near original timecode: 00:17:38.16, location 1009.467 MBytes
2011-07-24 17:02:59 H.264, Found last Audio: 1057662.39  00:17:37.16, Video: 450359962737.04  5795:20:33.03
2011-07-24 17:02:59 Changing graph current end range from: 450359962737.04 (5795:20:33.03), to: 1057662.39 (00:17:37.16)
2011-07-24 17:02:59 H264 smart editor, Segment complete, revised end time is: 1057662.39 (00:17:37.16)
2011-07-24 17:02:59 Graph, monitoring thread received terminate signal.
2011-07-24 17:02:59 Graph monitoring thread finished.
2011-07-24 17:02:59 AudioRecoder thread complete. Stream: 0, Audio Frames, In:43902, Out: 43902
2011-07-24 17:02:59 H.264 encoder info: Creating MainConcept (Consumer) H.264/AVC video encoder ...
2011-07-24 17:02:59 H.264 encoder info:   Version:  8.7.0.28412
2011-07-24 17:02:59 H.264 encoder info:   Platform: Windows 32bit
2011-07-24 17:02:59 H.264 MC warning: C061:H.264 Validation Warning: HRD info will not be available in coded bitstream.
2011-07-24 17:03:01 H.264 encoder info: 
H.264 Encoding Done.
2011-07-24 17:03:01 H.264 encoder info: --------------------------------------------------------------------------------
2011-07-24 17:03:01 H.264 encoder info: Frames: 27 incoming, 27 encoded
2011-07-24 17:03:01 H.264 encoder info: Bits written: 19778.22 kbits (2472.28 kbytes)
2011-07-24 17:03:01 H.264 encoder info: Avg. Bitrate: 18313.16 kbits per second
2011-07-24 17:03:01 H.264 encoder info: Time elapsed: 2.20 seconds
2011-07-24 17:03:01 H.264 encoder info: --------------------------------------------------------------------------------
2011-07-24 17:03:01 H264 smart editor: Process thread complete.  Video frames, In: 0,  Out: 0
2011-07-24 17:03:01 H264 encoder: Process thread complete.  Video frames, In: 27,  Out: 27
2011-07-24 17:03:01 H264 decoder: Process thread complete.  Video frames, In: 32,  Out: 32
2011-07-24 17:03:01 Output muxer processing thread complete. Video in: 26342, Out: 26342, Buffer: 0
2011-07-24 17:03:01 Output muxer processing thread complete. Audio stream 0 In: 43902, Out: 43902, Buffer: 0
2011-07-24 17:03:01 Muxer add / delete audio: stream: 0, add: 0  delete 0, sync:     -10.63
2011-07-24 17:03:01 WTV output starting close.
2011-07-24 17:03:01 WTV output file closed.
2011-07-24 17:03:03 WTV Finished writing metadata
2011-07-24 17:03:03 Renaming C:\Videos\VRDoutputs\Late Night_SBS 6_2010_08_17_06_30_47 (02).wtv.tmp to C:\Videos\VRDoutputs\Late Night_SBS 6_2010_08_17_06_30_47 (02).wtv
2011-07-24 17:03:07 Output complete. 
                 Input file: C:\VAP\Monitor\Late Night_SBS 6_2010_08_17_06_30_47.wtv
                Output file: C:\Videos\VRDoutputs\Late Night_SBS 6_2010_08_17_06_30_47 (02).wtv
                       Mode: Frame Accurate
    Video output frames:	26342
    Audio output frames:	43902
    Processing time (secs):	26
    Processed frames/sec:	996.14
    Actual Video Bitrate:   	7.14 Mbps
    * Input Sequence Errors:	3

2011-07-24 17:03:07 Displaying output complete dialog: 0
2011-07-24 17:04:50 H.264, Starting stream open for: C:\VAP\Monitor\Late Night_SBS 6_2010_08_17_06_30_47.wtv
2011-07-24 17:04:50 H.264, opening: C:\VAP\Monitor\Late Night_SBS 6_2010_08_17_06_30_47.wtv in QuickStream Fix Mode.
2011-07-24 17:04:50 H.264, Opening file: C:\VAP\Monitor\Late Night_SBS 6_2010_08_17_06_30_47.wtv, filetype is: H264  PIDs: x280 / x27F 
2011-07-24 17:04:57 H.264, Starting stream open for: C:\VAP\Monitor\Late Night_SBS 6_2010_08_17_06_30_47.wtv
2011-07-24 17:04:57 H.264, opening: C:\VAP\Monitor\Late Night_SBS 6_2010_08_17_06_30_47.wtv in QuickStream Fix Mode.
2011-07-24 17:04:57 H.264, Opening file: C:\VAP\Monitor\Late Night_SBS 6_2010_08_17_06_30_47.wtv, filetype is: H264  PIDs: x280 / x27F 
2011-07-24 17:05:34 H.264, Starting stream open for: C:\VAP\Monitor\Late Night_SBS 6_2010_08_17_06_30_47.wtv
2011-07-24 17:05:34 H.264, opening: C:\VAP\Monitor\Late Night_SBS 6_2010_08_17_06_30_47.wtv in QuickStream Fix Mode.
2011-07-24 17:05:34 H.264, Opening file: C:\VAP\Monitor\Late Night_SBS 6_2010_08_17_06_30_47.wtv, filetype is: H264  PIDs: x280 / x27F 
2011-07-24 17:05:35 H.264, Starting stream open for: C:\VAP\Monitor\Late Night_SBS 6_2010_08_17_06_30_47.wtv
2011-07-24 17:05:35 H.264, opening: C:\VAP\Monitor\Late Night_SBS 6_2010_08_17_06_30_47.wtv in QuickStream Fix Mode.
2011-07-24 17:05:35 H.264, Opening file: C:\VAP\Monitor\Late Night_SBS 6_2010_08_17_06_30_47.wtv, filetype is: H264  PIDs: x280 / x27F 
2011-07-24 17:05:35 WTV, Writing filler attributes
2011-07-24 17:05:35 Graph monitoring thread started.
2011-07-24 17:05:35 Adding module to graph: H264 smart editor
2011-07-24 17:05:35 Adding module to graph: H264 decoder
2011-07-24 17:05:35 Adding module to graph: H264 encoder
2011-07-24 17:05:35 Adding module to graph: Audio recoder
2011-07-24 17:05:36 Adding module to graph: Output muxer
2011-07-24 17:05:36 Setting graph input port: 0 to module: H264 smart editor port: 0 Accepts EOF
2011-07-24 17:05:36 Setting graph input port: 3 to module: H264 smart editor port: 2 
2011-07-24 17:05:36 Connecting output of H264 smart editor (2) to input of H264 decoder (0)
2011-07-24 17:05:36 Connecting output of H264 decoder (0) to input of H264 smart editor (2)
2011-07-24 17:05:36 Connecting output of H264 encoder (0) to input of H264 smart editor (3)
2011-07-24 17:05:36 Connecting output of H264 smart editor (3) to input of H264 encoder (0)
2011-07-24 17:05:36 Connecting output of H264 smart editor (0) to input of Output muxer (0)
2011-07-24 17:05:36 Setting graph input port: 1 to module: Audio recoder port: 0 Accepts EOF
2011-07-24 17:05:36 Connecting output of Audio recoder (0) to input of Output muxer (2)
2011-07-24 17:05:36 Graph, passes required: 1
2011-07-24 17:05:36 Graph, Output encoding bitrate: 20.0000 Mbps
2011-07-24 17:05:36 Graph, Encoding dimension:      1920 x 1080
2011-07-24 17:05:36 Graph, Cropping rect:           (0 x 0 ) - (1920 x 1080)
2011-07-24 17:05:36 Graph, Maximum GOP:             0
2011-07-24 17:05:36 H264 smart editor: Starting H.264 smart editing thread.
2011-07-24 17:05:36 H264 decoder: Starting video, H264 decoder thread.
2011-07-24 17:05:36 H264 encoder: Starting video, H264 encoder thread.
2011-07-24 17:05:36 StreamProcess: Stream: 0, Starting audio coding thread.
2011-07-24 17:05:36 StreamProcess: Staring output muxer thread.
2011-07-24 17:05:36 Program Information 
            File Name: C:\VAP\Monitor\Late Night_SBS 6_2010_08_17_06_30_47.wtv
            File Size: 1009778688 ( 0.94 GB )
     Program Duration: 00:00:00.00
            File Type: WTV
             Encoding: H.264
      Video stream Id:  xE0
  Encoding Dimensions:  1920 x 1080
         Display Size:  1920 x 1080
         Aspect Ratio: 16:9
           Frame Rate:  25.00 FPS
             Bit Rate:  20.000 Mbps
           VBV_Buffer:  380 KB
              Profile: High/4.0
          Progressive: Interlaced
               Chroma:  4:2:0
         Audio Format:  Layer 2
      Audio Stream Id:  xC0
       Audio Bit Rate:  192 Kbps
  Audio Sampling Rate:  48000 Hz
    TS Mux Rate (bps): -1

2011-07-24 17:05:36 H.264, Starting new Frame Accurate Output Segment: start:0.000 (00:00:00.00),  end:450359962737.044 (5795:20:33.03), Mux delta:       0.00
2011-07-24 17:05:36 H.264, QuickStream fix flag is ON.
2011-07-24 17:05:36 H.264, QSF Filter is ON for dimensions: 1920  x  1080
2011-07-24 17:05:36 Preparing to send status to: 0 Audio volume changed
2011-07-24 17:05:36 Sending status: 'Audio volume changed' to module: 'H264 smart editor - 0', Type: Video frame
2011-07-24 17:05:36 Preparing to send status to: 0 Audio volume changed
2011-07-24 17:05:36 Sending status: 'Audio volume changed' to module: 'Audio recoder - 0', Type: Audio frame
2011-07-24 17:05:36 Adding new graph range, Start:          0 (00:00:00.00), End: 450359962737.04 (5795:20:33.03)
2011-07-24 17:05:54 H.264, removed 3 frames due to missing pic_order_cnt_lsb 32803, near original timecode: 00:17:38.16, location 1009.467 MBytes
2011-07-24 17:05:54 H.264, Found last Audio: 1057662.39  00:17:37.16, Video: 450359962737.04  5795:20:33.03
2011-07-24 17:05:54 Changing graph current end range from: 450359962737.04 (5795:20:33.03), to: 1057662.39 (00:17:37.16)
2011-07-24 17:05:54 H264 smart editor, Segment complete, revised end time is: 1057662.39 (00:17:37.16)
2011-07-24 17:05:54 Graph, monitoring thread received terminate signal.
2011-07-24 17:05:54 Graph monitoring thread finished.
2011-07-24 17:05:54 H.264 encoder info: Creating MainConcept (Consumer) H.264/AVC video encoder ...
2011-07-24 17:05:54 H.264 encoder info:   Version:  8.7.0.28412
2011-07-24 17:05:54 H.264 encoder info:   Platform: Windows 32bit
2011-07-24 17:05:54 H.264 MC warning: C061:H.264 Validation Warning: HRD info will not be available in coded bitstream.
2011-07-24 17:05:54 AudioRecoder thread complete. Stream: 0, Audio Frames, In:43902, Out: 43902
2011-07-24 17:05:56 H.264 encoder info: 
H.264 Encoding Done.
2011-07-24 17:05:56 H.264 encoder info: --------------------------------------------------------------------------------
2011-07-24 17:05:56 H.264 encoder info: Frames: 27 incoming, 27 encoded
2011-07-24 17:05:56 H.264 encoder info: Bits written: 19778.22 kbits (2472.28 kbytes)
2011-07-24 17:05:56 H.264 encoder info: Avg. Bitrate: 18313.16 kbits per second
2011-07-24 17:05:56 H.264 encoder info: Time elapsed: 2.17 seconds
2011-07-24 17:05:56 H.264 encoder info: --------------------------------------------------------------------------------
2011-07-24 17:05:56 H264 encoder: Process thread complete.  Video frames, In: 27,  Out: 27
2011-07-24 17:05:56 H264 smart editor: Process thread complete.  Video frames, In: 0,  Out: 0
2011-07-24 17:05:56 H264 decoder: Process thread complete.  Video frames, In: 32,  Out: 32
2011-07-24 17:05:56 Output muxer processing thread complete. Video in: 26342, Out: 26342, Buffer: 0
2011-07-24 17:05:56 Output muxer processing thread complete. Audio stream 0 In: 43902, Out: 43902, Buffer: 0
2011-07-24 17:05:56 Muxer add / delete audio: stream: 0, add: 0  delete 0, sync:     -10.63
2011-07-24 17:05:56 WTV output starting close.
2011-07-24 17:05:56 WTV output file closed.
2011-07-24 17:05:57 WTV Finished writing metadata
2011-07-24 17:05:57 Renaming C:\Videos\VRDoutputs\Late Night_SBS 6_2010_08_17_06_30_47.wtv.tmp to C:\Videos\VRDoutputs\Late Night_SBS 6_2010_08_17_06_30_47.wtv
2011-07-24 17:06:02 Output complete. 
                 Input file: C:\VAP\Monitor\Late Night_SBS 6_2010_08_17_06_30_47.wtv
                Output file: C:\Videos\VRDoutputs\Late Night_SBS 6_2010_08_17_06_30_47.wtv
                       Mode: Frame Accurate
    Video output frames:	26342
    Audio output frames:	43902
    Processing time (secs):	22
    Processed frames/sec:	1180.78
    Actual Video Bitrate:   	7.14 Mbps
    * Input Sequence Errors:	3

2011-07-24 17:06:02 Displaying output complete dialog: 0

Note this log confirms that VRD analyzes the file as H.264, and when the QSF runs it runs very quickly because input and output video type are the same.

I have confirmed apparent proper operation of the auto-dimension mode using other files, but remember the COM failures occurred whether using this or not.

Dan203 · Jul 25, 2011

Are you sure you're running 621? Remember you have to run 621 at least once as admin for it to register with COM on the system.

Dan

dlflannery · Jul 25, 2011

Yes, this is confirmed by the log file excerpts I already posted above:

VideoReDo TVSuite started. Licensed to: DADAVIDFLANN--, Version: 4.20.6.621 - Jul 12 2011, AVP On (00cf0062-528}

My VAP log also confirms it using the VideoReDo.VersionNumber property in the VBSscript:

7/24/2011 2:57:33 PM VideoReDo said: INFO: VideoReDo version 4.20.6.621 - Jul 12 2011

Just to be absolutely sure, I ran it as administrator and retried the file that failed -- exact same result. BTW, my understanding is that on a Win7 install, for which UAC prompts for admin privileges to even run, if you accept the final offering to run VRD, you are then running it as admin, correct? (This experience seems to confirm that.)

Also, as I mentioned, I've processed other files in VAP using the new (-1,-1) arguments for automatic dimension filter setting with no problems -- and this COM feature was only introduced in 621c per the release notes.

I have two other test files that are H.264 in WTV and they both exhibit the exact same type of failure:
ProfileSupport::SetVideoFrametRate failed - Invalid MPEG-2 frame rate: 0
These files processed OK with earlier versions of TVS4.

This raises an important (to me at least) question:
Is the intended behavior of TVS4 that a QSF done via COM functions in a VBSscript should behave exactly like one done from the VRD GUI? Or is this just not possible for some reason(s)?

dlflannery · Jul 25, 2011

Problems on WTV MPEG-2 files too

When VAP attempts to QSF WTV-MPEG2 using the WTV-MPEG2 output profile, there is an immediate failure with a pop up error message from the C++ runtime library saying the app requested to shut down. In this case there is no error shown in the VRD log, it just ends after these last few lines:

Code:

2011-07-25 08:51:43 Starting new Frame Accurate Output Segment: start:0.000 (00:00:00.00),  end:450359962737.044 (125099:52:36.11)
2011-07-25 08:51:43 QuickStream fix flag is ON.
2011-07-25 08:51:43 Preparing to send status to: 0 Audio volume changed
2011-07-25 08:51:43 Sending status: 'Audio volume changed' to module: 'Output muxer - 0', Type: Video frame
2011-07-25 08:51:43 Preparing to send status to: 2 Audio volume changed
2011-07-25 08:52:03 Active module list:
   class CStreamProcessMuxer
      class CVStreamBuffer<class CVideoFrame>, Fill: 0/50, Free: 51 Txn count: 1
      class CVStreamBuffer<class CSubtitleFrame>, Fill: 0/50, Free: 51 Txn count: 0

As before, the same QSF process launched from the VRD GUI runs fine.

Have the syntax or functions required to run QSF from VBScript using COM changed in 621c? VAP is processing other file types OK, so it must not be syntax or functions called (?).

From testing various other input-type/output-profile combos (using VAP), it appears the problems occur only when the input file is WTV, whether it contains MPEG-2 or H.264.

Dan203 · Jul 25, 2011

The syntax has not changed. And the only change we've made for WTV is in the metadata portion of the input/output. Do me a favor try the same process but use WTV as input and TS as output, and then again with TS as input and WTV as output. Do either of these have the issue?

Dan

dlflannery · Jul 25, 2011

wtv-h.264 to h.264 TS -- same error as seen before for WTV files containing H.264 (MPEG-2 Invalid Frame Rate)

wtv-mpeg2 to mpeg2-TS -- immediate crash with same error popup from the C++ Runtime Library as seen before for this input type.

mpeg2-TS to WTV-MPEG2 -- no problem

h.264-TS to WTV-h.264 -- no problem

The pattern seems pretty obvious. As I suspected before, any WTV input causes a problem -- doesn't matter what the Output Profile is.

Dan203 · Jul 25, 2011

And the same test with 619 worked OK?

Dan

dlflannery · Jul 25, 2011

I don't have 619 handy to install and haven't used it for quite a while.
I did have 620a, which was a "special" that either PhD or the other Dan had posted on the FTP site and invited me to try.

620a worked fine for the same files, same processing, that were causing the problems in 621c.

I don't like to run multiple versions of VRD on one computer so I uninstalled 621c then installed 620a and ran as administrator one time.

Dan203 · Jul 25, 2011

That's fine. I just wanted to confirm that whatever is causing this problem was a recent change. We'll look through our source control and see if we can find anything that might be causing this issue.

Dan

Dan203 · Jul 25, 2011

We're not able to reproduce the problem. Can you please try a complete uninstall and then reinstall just to make sure some DLL didn't get corrupted.

Dan

Danr · Jul 25, 2011

620a worked fine for the same files, same processing, that were causing the problems in 621c.

I can't duplicate here. Could it possibly be file related? What settings do you have on the Tools>Options>MCE page?

Perhaps you can upload a file to us to try out here?

dlflannery · Jul 25, 2011

The problems only occur for COM calls from VBscripts as used by VAP, not for QSF's run from the VRD GUI. Is that the way you tried to duplicate it? The problems occur for at least 5 different .wtv files, which were accumulated from different VAP users, some containing h.264 and some containing mpeg2.

Dan203 · Jul 25, 2011

We tried to duplicate it via batch, which also uses COM.

Dan

dlflannery · Jul 25, 2011

Do the MCE settings in Tools/Options affect how the COM functions perform?
Anyway, I have never messed with those settings and I do a complete reinstall of every VRD version, running only one version at a time on this PC.
Here are the settings:
"Preserve Closed Captions" is checked.
"Prompt for metadata" is set to "Non-DVRMS files"
"Clear Database Associations ...." is checked
"Tag" DVR-MS stream types" is checked.

My understanding is VRD batch mode would not necessarily be identical to the VAP scripts.
EDIT: The batch mode (queue to batch, save as CMD) runs OK on my machine with the problem files. But after reviewing how that works, I'm even more convinced this is a different process than what VAP scripts do. Both methods use FileOpenBatch, but vp.vbs is opening a .bprj file that contains umpteen predetermined parameters, while VAP's QSF.vbs uses FileOpenBatch with just the file name. I think the explanation of the problem must be related to that difference.

VAP outputs a one line log file each time it launches a VBscript which has the exact arguments sent to the script. With a little editing this can become a Windows .cmd script to run the VBscript exactly as VAP does. For the attached zip, I've done this but substituted placeholders for the path to the folder containing QSF.vbs, the input file path and output file path.

I've attached a zip file that includes this .cmd file and the QSF.vbs file used by VAP (please ignore the messiness.

). If you just supply your test input file and fill in the correct paths, the .cmd file will emulate how VAP processes the file. I like this approach because it removes any question about the particular input file, i.e., if this runs OK on your test files, then the problem may be my files or my setup of VRD. (Remember to run VRD 621c as admin to get the correct com functions!

)

If this doesn't seem appropriate then I can put a file up on the ftp server.
Or you could put one of your tested .wtv files on the server for me to test with, hopefully not too large.

Edit: I found a test .wtv file already on your server that exibits the problems. It's in folder:
No_WTV_thumbnail_v_4_20_6_614 and the file name is: Late Show With David Letterman_WOIODT_2011_04_29_23_33_00.wtv
Thus no need for me to upload a file -- this is as good an example as any. It's MPEG-2 in WTV container and crashes the QSF with the C++ runtime library error box popping up when run by VAP with 621c COM but runs fine with 620a.

dlflannery · Jul 26, 2011

Dan203 said:
We're not able to reproduce the problem. Can you please try a complete uninstall and then reinstall just to make sure some DLL didn't get corrupted.

Dan

Somehow I missed this post earlier, but just to be clear: I always uninstall then install when I switch versions of VRD. I've gone back and forth between 620a and 621c several times in the last day chasing this problem, each time doing an uninstall. Behavior has been totally consistent: problems with 621c and not-problems with 620a.

dlflannery · Jul 31, 2011

Any resolution on this problem? All you should have to do to duplicate it is open a .wtv file (not a .bprj file) using FileOpenBatch, with any output profile and QSF it (using the 621c COM functions).

Danr · Aug 1, 2011

We've tried to duplicate with our standard programs and scripts, but haven't been able able to so far. Let's escalate this by sending email to support so that this issues gets into our "to do" queue. Please reference topic=28723 in the subject.

However, check out the 623e alpha. There wasn't anything specific in this build to address this issue, but since we couldn't easily duplicate it, perhaps it "magically" got fixed.

dlflannery · Aug 1, 2011

623e exhibited exactly the same problems as 621c.

Support email has been sent as suggested.

Dan203 · Aug 1, 2011

OK I found the problem. But it really shouldn't have worked in 619 either. The problem was that the COM interface wasn't properly updated to support multiple audio streams along with any file type which support a "default stream". (i.e. WTV and MKV) I added the code for the "default stream" at least 3-4 versions back. It should have been broken since then.

In any case it will be fixed in the next release.

Dan

dlflannery · Aug 1, 2011

Dan203 said:
OK I found the problem. But it really shouldn't have worked in 619 either. The problem was that the COM interface wasn't properly updated to support multiple audio streams along with any file type which support a "default stream". (i.e. WTV and MKV) I added the code for the "default stream" at least 3-4 versions back. It should have been broken since then.

In any case it will be fixed in the next release.

Dan

Glad you found it. I never said it worked in 619 BTW. I may never have tried to QSF a WTV in VAP using 619 -- don't remember for sure. As I said, I had been running 620a for quite a while before trying 621c.

Does this mean failure for any WTV or just certain ones that have multiple audio streams?

COM error H.264 WTV QSF in 621c

Moderator

Senior Developer

Moderator

Moderator

Senior Developer

Moderator

Senior Developer

Moderator

Senior Developer

Senior Developer

Administrator

Moderator

Senior Developer

Moderator

Attachments

Moderator

Moderator

Administrator

Moderator

Senior Developer

Moderator