Identical Encodes Result in Erratic File Sizes

Support for HandBrake on Linux, Solaris, and other Unix-like platforms
Forum rules
An Activity Log is required for support requests. Please read How-to get an activity log? for details on how and why this should be provided.
Post Reply
joeray
Posts: 4
Joined: Sat May 18, 2019 7:42 pm

Identical Encodes Result in Erratic File Sizes

Post by joeray » Sat May 18, 2019 8:13 pm

Description of problem or question:Repeated encodes of the same source files results in output files that vary by ~12k-25k. I've disabled the VBV in the advanced video tab, as well as set/unset the 'non-deterministic' parameter. I've tested on different source files, machines, presets, GUI, CLI, etc.

MediaInfo reports that the 'Encoding settings' are identical to those from files encoded using ffmpeg. But the files encoded using ffmpeg are consistent across repeated encodes, even on different machines.

I need a consistent, deterministic output. Any help would be greatly appreciated.

Thanks in advance.
Steps to reproduce the problem (If Applicable):




HandBrake version (e.g., 1.0.0):gtkgui: HandBrake 1.2.1 (2019021900) - Linux x86_64 - https://handbrake.fr & HandBrakeCLI 1.2.1




Operating system and version (e.g., Ubuntu 16.04 LTS, macOS 10.13 High Sierra, Windows 10 Creators Update):
Linux Mint 19.1 Cinnamon, kernel 4.15.0-20-generic



HandBrake Activity Log ***required*** (see How-to get an activity log)

Code: Select all

Encoding settings : cabac=1 / ref=2 / deblock=1:0:0 / analyse=0x1:0x111 / me=hex / subme=6 / psy=1 / psy_rd=1.00:0.00 / mixed_ref=1 / me_range=16 / chroma_me=1 / trellis=1 / 8x8dct=0 / cqm=0 / deadzone=21,11 / fast_pskip=1 / chroma_qp_offset=-2 / threads=4 / lookahead_threads=1 / sliced_threads=0 / nr=0 / decimate=1 / interlaced=0 / bluray_compat=0 / constrained_intra=0 / bframes=3 / b_pyramid=2 / b_adapt=1 / b_bias=0 / direct=1 / weightb=1 / open_gop=0 / weightp=1 / keyint=240 / keyint_min=24 / scenecut=40 / intra_refresh=0 / rc_lookahead=40 / rc=crf / mbtree=1 / crf=22.0 / qcomp=0.60 / qpmin=0 / qpmax=69 / qpstep=4 / ip_ratio=1.40 / aq=1:1.00

mduell
Veteran User
Posts: 6674
Joined: Sat Apr 21, 2007 8:54 pm

Re: Identical Encodes Result in Erratic File Sizes

Post by mduell » Sat May 18, 2019 8:43 pm

An Activity Log is required for support requests. Please read How-to get an activity log? for details on how and why this should be provided.

We'd need to see the encode log for two encodes to provide any help here.

joeray
Posts: 4
Joined: Sat May 18, 2019 7:42 pm

Re: Identical Encodes Result in Erratic File Sizes

Post by joeray » Sat May 18, 2019 10:39 pm

Filename "Test 2A 2019-05-15 17-49-57.log"

Code: Select all

Handbrake Version: 1.2.1 (2019021900)
[17:49:57] gtkgui: Custom Preset: /General/Preset Test
[17:49:57] 1 job(s) to process
[17:49:57] json job:
{
    "Audio": {
        "AudioList": [
            {
                "Bitrate": 160,
                "CompressionLevel": -1.0,
                "DRC": 0.0,
                "DitherMethod": "auto",
                "Encoder": "av_aac",
                "Gain": 0.0,
                "Mixdown": "stereo",
                "NormalizeMixLevel": false,
                "PresetEncoder": "av_aac",
                "Quality": -3.0,
                "Samplerate": 0,
                "Track": 0
            }
        ],
        "CopyMask": [
            "copy:aac"
        ],
        "FallbackEncoder": "av_aac"
    },
    "Destination": {
        "AlignAVStart": true,
        "ChapterList": [
            {
                "Name": "Chapter 1"
            },
            {
                "Name": "Chapter 2"
            },
            {
                "Name": "Chapter 3"
            },
            {
                "Name": "Chapter 4"
            },
            {
                "Name": "Chapter 5"
            },
            {
                "Name": "Chapter 6"
            },
            {
                "Name": "Chapter 7"
            },
            {
                "Name": "Chapter 8"
            },
            {
                "Name": "Chapter 9"
            },
            {
                "Name": "Chapter 10"
            },
            {
                "Name": "Chapter 11"
            },
            {
                "Name": "Chapter 12"
            },
            {
                "Name": "Chapter 13"
            },
            {
                "Name": "Chapter 14"
            },
            {
                "Name": "Chapter 15"
            },
            {
                "Name": "Chapter 16"
            },
            {
                "Name": "Chapter 17"
            },
            {
                "Name": "Chapter 18"
            },
            {
                "Name": "Chapter 19"
            },
            {
                "Name": "Chapter 20"
            },
            {
                "Name": "Chapter 21"
            },
            {
                "Name": "Chapter 22"
            },
            {
                "Name": "Chapter 23"
            },
            {
                "Name": "Chapter 24"
            },
            {
                "Name": "Chapter 25"
            },
            {
                "Name": "Chapter 26"
            },
            {
                "Name": "Chapter 27"
            },
            {
                "Name": "Chapter 28"
            },
            {
                "Name": "Chapter 29"
            },
            {
                "Name": "Chapter 30"
            },
            {
                "Name": "Chapter 31"
            }
        ],
        "ChapterMarkers": true,
        "File": "/media/mint/Toshiba/Test/Test 2A.m4v",
        "InlineParameterSets": false,
        "Mp4Options": {
            "IpodAtom": false,
            "Mp4Optimize": false
        },
        "Mux": "m4v"
    },
    "Filters": {
        "FilterList": [
            {
                "ID": 3,
                "Settings": {
                    "block-height": "16",
                    "block-thresh": "40",
                    "block-width": "16",
                    "filter-mode": "2",
                    "mode": "3",
                    "motion-thresh": "1",
                    "spatial-metric": "2",
                    "spatial-thresh": "1"
                }
            },
            {
                "ID": 4,
                "Settings": {
                    "mode": "7"
                }
            },
            {
                "ID": 6,
                "Settings": {
                    "mode": 0
                }
            },
            {
                "ID": 11,
                "Settings": {
                    "crop-bottom": 68,
                    "crop-left": 0,
                    "crop-right": 2,
                    "crop-top": 70,
                    "height": 342,
                    "width": 718
                }
            }
        ]
    },
    "Metadata": {
        "Name": "Test 2A"
    },
    "PAR": {
        "Den": 9,
        "Num": 8
    },
    "SequenceID": 0,
    "Source": {
        "Angle": 0,
        "Path": "/media/mint/Toshiba/DVDs/Test 2A",
        "Range": {
            "End": 31,
            "Start": 1,
            "Type": "chapter"
        },
        "Title": 1
    },
    "Subtitle": {
        "Search": {
            "Burn": true,
            "Default": false,
            "Enable": true,
            "Forced": true
        },
        "SubtitleList": []
    },
    "Video": {
        "ColorMatrix": 6,
        "ColorPrimaries": 6,
        "ColorTransfer": 1,
        "Encoder": "x264",
        "Options": "level=4.0:ref=2:8x8dct=0:weightp=1:subme=6:threads=4",
        "QSV": {
            "AsyncDepth": 4,
            "Decode": false
        },
        "Quality": 22.0,
        "Turbo": false,
        "TwoPass": false
    }
}
[17:49:57] CPU: Intel(R) Core(TM) i5-6500 CPU @ 3.20GHz
[17:49:57]  - Intel microarchitecture Skylake
[17:49:57]  - logical processor count: 4
[17:49:57] hb_scan: path=/media/mint/Toshiba/DVDs/Test 2A, title_index=1
disc.c:424: error opening file BDMV/index.bdmv
disc.c:424: error opening file BDMV/BACKUP/index.bdmv
[17:49:57] bd: not a bd - trying as a stream/file instead
libdvdnav: Using dvdnav version 6.0.0
libdvdread: Couldn't find device name.
libdvdnav: Can't read name block. Probably not a DVD-ROM device.
libdvdnav: vm: dvd_read_name failed
libdvdnav: DVD disk reports itself with Region mask 0x00fe0000. Regions: 1
libdvdread: Couldn't find device name.
[17:49:57] scan: DVD has 1 title(s)
[17:49:57] scan: scanning title 1
[17:49:57] scan: opening IFO for VTS 1
[17:49:57] scan: duration is 01:53:03 (6783400 ms)
[17:49:57] pgc_id: 1, pgn: 1: pgc: 0x7fec0000de40
[17:49:57] scan: vts=1, ttn=1, cells=0->30, blocks=0->1968859, 1968860 blocks
[17:49:57] scan: checking audio 1
[17:49:57] scan: id=0x80bd, lang=English (AC3), 3cc=eng ext=0
[17:49:57] scan: checking audio 2
[17:49:57] scan: id=0x81bd, lang=Francais (AC3), 3cc=fra ext=0
[17:49:57] scan: checking subtitle 1
[17:49:57] scan: id=0x20bd, lang=English (4:3) [VOBSUB], 3cc=eng ext=0
[17:49:57] scan: checking subtitle 2
[17:49:57] scan: id=0x21bd, lang=Francais (4:3) [VOBSUB], 3cc=fra ext=0
[17:49:57] scan: checking subtitle 3
[17:49:57] scan: id=0x22bd, lang=español (4:3) [VOBSUB], 3cc=spa ext=0
[17:49:57] scan: checking subtitle 4
[17:49:57] scan: id=0x23bd, lang=English (4:3) [VOBSUB], 3cc=eng ext=0
[17:49:57] scan: checking subtitle 5
[17:49:57] scan: id=0x24bd, lang=Francais (4:3) [VOBSUB], 3cc=fra ext=0
[17:49:57] scan: checking subtitle 6
[17:49:57] scan: id=0x25bd, lang=español (4:3) [VOBSUB], 3cc=spa ext=0
[17:49:57] scan: title 1 has 31 chapters
[17:49:57] scan: chap 1 c=0->0, b=0->25166 (25167), 91033 ms
[17:49:57] scan: chap 2 c=1->1, b=25167->189639 (164473), 491033 ms
[17:49:57] scan: chap 3 c=2->2, b=189640->205928 (16289), 56000 ms
[17:49:57] scan: chap 4 c=3->3, b=205929->285994 (80066), 278734 ms
[17:49:57] scan: chap 5 c=4->4, b=285995->340024 (54030), 178433 ms
[17:49:57] scan: chap 6 c=5->5, b=340025->459751 (119727), 378834 ms
[17:49:57] scan: chap 7 c=6->6, b=459752->505754 (46003), 173033 ms
[17:49:57] scan: chap 8 c=7->7, b=505755->571320 (65566), 195000 ms
[17:49:57] scan: chap 9 c=8->8, b=571321->630956 (59636), 205400 ms
[17:49:57] scan: chap 10 c=9->9, b=630957->698344 (67388), 207934 ms
[17:49:57] scan: chap 11 c=10->10, b=698345->752375 (54031), 189900 ms
[17:49:57] scan: chap 12 c=11->11, b=752376->816206 (63831), 232233 ms
[17:49:57] scan: chap 13 c=12->12, b=816207->899746 (83540), 305834 ms
[17:49:57] scan: chap 14 c=13->13, b=899747->981381 (81635), 299633 ms
[17:49:57] scan: chap 15 c=14->14, b=981382->1054794 (73413), 263200 ms
[17:49:57] scan: chap 16 c=15->15, b=1054795->1114321 (59527), 213633 ms
[17:49:57] scan: chap 17 c=16->16, b=1114322->1207521 (93200), 272133 ms
[17:49:57] scan: chap 18 c=17->17, b=1207522->1286236 (78715), 261533 ms
[17:49:57] scan: chap 19 c=18->18, b=1286237->1345991 (59755), 227133 ms
[17:49:57] scan: chap 20 c=19->19, b=1345992->1388228 (42237), 159800 ms
[17:49:57] scan: chap 21 c=20->20, b=1388229->1463048 (74820), 282367 ms
[17:49:57] scan: chap 22 c=21->21, b=1463049->1516655 (53607), 201633 ms
[17:49:57] scan: chap 23 c=22->22, b=1516656->1556094 (39439), 147567 ms
[17:49:57] scan: chap 24 c=23->23, b=1556095->1629888 (73794), 285100 ms
[17:49:57] scan: chap 25 c=24->24, b=1629889->1652492 (22604), 78000 ms
[17:49:57] scan: chap 26 c=25->25, b=1652493->1708746 (56254), 214734 ms
[17:49:57] scan: chap 27 c=26->26, b=1708747->1776668 (67922), 246133 ms
[17:49:57] scan: chap 28 c=27->27, b=1776669->1813624 (36956), 135967 ms
[17:49:57] scan: chap 29 c=28->28, b=1813625->1902596 (88972), 285467 ms
[17:49:57] scan: chap 30 c=29->29, b=1902597->1944043 (41447), 136734 ms
[17:49:57] scan: chap 31 c=30->30, b=1944044->1968859 (24816), 89233 ms
[17:49:57] scan: aspect = 4:3
[17:49:57] scan: decoding previews for title 1
libdvdnav: DVD disk reports itself with Region mask 0x00fe0000. Regions: 1
[17:49:57] scan: title angle(s) 1
[ac3 @ 0x7fec0014fb80] frame sync error
[17:49:57] scan: audio 0x81bd: ac3, rate=48000Hz, bitrate=192000 Francais (AC3) (2.0 ch)
[ac3 @ 0x7fec0014fb80] frame sync error
[ac3 @ 0x7fec0014fb80] frame sync error
[17:49:57] scan: audio 0x80bd: ac3, rate=48000Hz, bitrate=384000 English (AC3) (4.0 ch)
[17:49:57] scan: 10 previews, 720x480, 23.976 fps, autocrop = 70/68/0/2, aspect 4:3, PAR 8:9
[17:49:57] libhb: scan thread found 1 valid title(s)
[17:49:57] starting job
[17:49:57] decomb filter thread started for segment 0
[17:49:57] decomb filter thread started for segment 1
[17:49:57] decomb filter thread started for segment 2
[17:49:57] decomb check thread started for segment 2
[17:49:57] decomb check thread started for segment 1
[17:49:57] mask filter thread started for segment 3
[17:49:57] decomb check thread started for segment 0
[17:49:57] mask filter thread started for segment 0
[17:49:57] mask filter thread started for segment 2
[17:49:57] decomb check thread started for segment 3
[17:49:57] decomb filter thread started for segment 3
[17:49:57] mask filter thread started for segment 1
[17:49:57] mask erode thread started for segment 0
[17:49:57] mask erode thread started for segment 1
[17:49:57] mask erode thread started for segment 2
[17:49:57] mask erode thread started for segment 3
[17:49:57] mask dilate thread started for segment 0
[17:49:57] mask dilate thread started for segment 3
[17:49:57] mask dilate thread started for segment 1
[17:49:57] mask dilate thread started for segment 2
[17:49:57] yadif thread started for segment 0
[17:49:57] yadif thread started for segment 1
[17:49:57] yadif thread started for segment 2
[17:49:57] yadif thread started for segment 3
[17:49:57] job configuration:
[17:49:57]  * source
[17:49:57]    + /media/mint/Toshiba/DVDs/Test 2A
[17:49:57]    + title 1, chapter(s) 1 to 31
[17:49:57]  * destination
[17:49:57]    + /media/mint/Toshiba/Test/Test 2A.m4v
[17:49:57]    + container: MPEG-4 (libavformat)
[17:49:57]      + align initial A/V stream timestamps
[17:49:57]      + chapter markers
[17:49:57]  * video track
[17:49:57]    + decoder: mpeg2video
[17:49:57]      + bitrate 200 kbps
[17:49:57]    + filters
[17:49:57]      + Comb Detect (mode=3:spatial-metric=2:motion-thresh=1:spatial-thresh=1:filter-mode=2:block-thresh=40:block-width=16:block-height=16)
[17:49:57]      + Decomb (mode=39)
[17:49:57]      + Framerate Shaper (mode=0)
[17:49:57]        + frame rate: same as source (around 23.976 fps)
[17:49:57]      + Crop and Scale (width=718:height=342:crop-top=70:crop-bottom=68:crop-left=0:crop-right=2)
[17:49:57]        + source: 720 * 480, crop (70/68/0/2): 718 * 342, scale: 718 * 342
[17:49:57]    + Output geometry
[17:49:57]      + storage dimensions: 718 x 342
[17:49:57]      + pixel aspect ratio: 8 : 9
[17:49:57]      + display dimensions: 638 x 342
[17:49:57]  * Foreign Audio Search: Render/Burn-in, Forced Only
[17:49:57]    + subtitle, English (4:3) [VOBSUB] (track 0, id 0x20bd, Picture)
[17:49:57]    + subtitle, English (4:3) [VOBSUB] (track 3, id 0x23bd, Picture)
libdvdnav: Using dvdnav version 6.0.0
libdvdread: Couldn't find device name.
libdvdnav: Can't read name block. Probably not a DVD-ROM device.
libdvdnav: vm: dvd_read_name failed
libdvdnav: DVD disk reports itself with Region mask 0x00fe0000. Regions: 1
libdvdread: Couldn't find device name.
libdvdnav: DVD disk reports itself with Region mask 0x00fe0000. Regions: 1
[17:49:57] sync: expecting 162638 video frames
[17:50:00] reader: done. 1 scr changes
[17:50:00] work: average encoding speed for job is 0.000000 fps
[17:50:00] comb detect: heavy 0 | light 0 | uncombed 0 | total 0
[17:50:00] decomb: deinterlaced 0 | blended 0 | unfiltered 0 | total 0
[17:50:00] vfr: lost time: 0 (0 frames)
[17:50:00] vfr: gained time: 0 (0 frames) (0 not accounted for)
[17:50:00] mpeg2video-decoder done: 0 frames, 1 decoder errors
[17:50:00] sync: got 0 frames, 162638 expected
[17:50:00] Subtitle track 0 (id 0x20bd) 'English (4:3) [VOBSUB]': 1239 hits (0 forced)
[17:50:00] Subtitle track 3 (id 0x23bd) 'English (4:3) [VOBSUB]': 1443 hits (0 forced)
[17:50:00] No candidate detected during subtitle scan
[17:50:00] starting job
[17:50:00] decomb filter thread started for segment 1
[17:50:00] decomb filter thread started for segment 3
[17:50:00] decomb filter thread started for segment 0
[17:50:00] decomb filter thread started for segment 2
[17:50:00] decomb check thread started for segment 0
[17:50:00] decomb check thread started for segment 3
[17:50:00] mask filter thread started for segment 0
[17:50:00] decomb check thread started for segment 2
[17:50:00] mask filter thread started for segment 1
[17:50:00] mask filter thread started for segment 2
[17:50:00] mask filter thread started for segment 3
[17:50:00] mask erode thread started for segment 0
[17:50:00] mask erode thread started for segment 1
[17:50:00] mask erode thread started for segment 2
[17:50:00] mask dilate thread started for segment 1
[17:50:00] mask dilate thread started for segment 2
[17:50:00] mask dilate thread started for segment 3
[17:50:00] yadif thread started for segment 0
[17:50:00] yadif thread started for segment 1
[17:50:00] job configuration:
[17:50:00]  * source
[17:50:00]    + /media/mint/Toshiba/DVDs/Test 2A
[17:50:00]    + title 1, chapter(s) 1 to 31
[17:50:00]  * destination
[17:50:00]    + /media/mint/Toshiba/Test/Test 2A.m4v
[17:50:00]    + container: MPEG-4 (libavformat)
[17:50:00]      + align initial A/V stream timestamps
[17:50:00]      + chapter markers
[17:50:00]  * video track
[17:50:00]    + decoder: mpeg2video
[17:50:00]      + bitrate 200 kbps
[17:50:00]    + filters
[17:50:00]      + Comb Detect (mode=3:spatial-metric=2:motion-thresh=1:spatial-thresh=1:filter-mode=2:block-thresh=40:block-width=16:block-height=16)
[17:50:00]      + Decomb (mode=39)
[17:50:00]      + Framerate Shaper (mode=0)
[17:50:00]        + frame rate: same as source (around 23.976 fps)
[17:50:00]      + Crop and Scale (width=718:height=342:crop-top=70:crop-bottom=68:crop-left=0:crop-right=2)
[17:50:00]        + source: 720 * 480, crop (70/68/0/2): 718 * 342, scale: 718 * 342
[17:50:00]    + Output geometry
[17:50:00]      + storage dimensions: 718 x 342
[17:50:00]      + pixel aspect ratio: 8 : 9
[17:50:00]      + display dimensions: 638 x 342
[17:50:00]    + encoder: H.264 (libx264)
[17:50:00]      + options: level=4.0:ref=2:8x8dct=0:weightp=1:subme=6:threads=4
[17:50:00]      + quality: 22.00 (RF)
[17:50:00]      + color profile: 6-1-6
[17:50:00]  * audio track 1
[17:50:00]    + decoder: English (AC3) (4.0 ch) (track 1, id 0x80bd)
[17:50:00]      + bitrate: 384 kbps, samplerate: 48000 Hz
[17:50:00]    + mixdown: Stereo
[17:50:00]    + dither: triangular
[17:50:00]    + encoder: AAC (libavcodec)
[17:50:00]      + bitrate: 160 kbps, samplerate: 48000 Hz
[17:50:00] yadif thread started for segment 3
[17:50:00] yadif thread started for segment 2
libdvdnav: Using dvdnav version 6.0.0
[17:50:00] decomb check thread started for segment 1
libdvdread: Couldn't find device name.
libdvdnav: Can't read name block. Probably not a DVD-ROM device.
libdvdnav: vm: dvd_read_name failed
libdvdnav: DVD disk reports itself with Region mask 0x00fe0000. Regions: 1
[17:50:00] mask erode thread started for segment 3
libdvdread: Couldn't find device name.
libdvdnav: DVD disk reports itself with Region mask 0x00fe0000. Regions: 1
[17:50:00] sync: expecting 162638 video frames
[17:50:00] mask dilate thread started for segment 0
[17:50:00] encx264: min-keyint: 24, keyint: 240
[17:50:00] encx264: encoding at constant RF 22.000000
[17:50:00] encx264: unparsed options: level=4.0:ref=2:8x8dct=0:weightp=1:subme=6:threads=4
x264 [info]: using SAR=8/9
x264 [info]: using cpu capabilities: MMX2 SSE2Fast SSSE3 SSE4.2 AVX FMA3 BMI2 AVX2
x264 [info]: profile Main, level 4.0
[17:50:00] sync: first pts video is 0
[17:50:00] sync: first pts audio 0x80bd is 0
[17:50:00] sync: "Chapter 1" (1) at frame 3 time 7507
[17:50:00] 2.252244s: Film -> Video
[17:50:00] 2.502500s: Video -> Film
[17:50:01] 10.902555s: Film -> Video
[17:50:01] 10.944266s: Video -> Film
[17:50:02] 19.165133s: Film -> Video
[17:50:03] 23.957277s: Video -> Film
[17:50:06] 37.016300s: Film -> Video
[17:50:06] 37.137112s: Video -> Film
[17:50:13] 90.903458s: Film -> Video
[17:50:14] sync: "Chapter 2" (2) at frame 2320 time 8209453
[17:50:14] 91.357956s: Video -> Film
[17:51:34] 582.361084s: Film -> Video
[17:51:34] sync: "Chapter 3" (3) at frame 14109 time 52446646
[17:51:34] 582.815613s: Video -> Film
[17:51:43] 638.417053s: Film -> Video
[17:51:43] 638.804871s: Video -> Film
[17:51:43] sync: "Chapter 4" (4) at frame 15456 time 57492438
[17:52:22] 917.362427s: Film -> Video
[17:52:22] 917.816956s: Video -> Film
[17:52:22] sync: "Chapter 5" (5) at frame 22149 time 82603525
[17:52:50] 1096.040894s: Film -> Video
[17:52:50] sync: "Chapter 6" (6) at frame 26434 time 98677833
[17:52:50] 1096.495483s: Video -> Film
[17:53:52] 1475.253052s: Film -> Video
[17:53:52] sync: "Chapter 7" (7) at frame 35529 time 132806929
[17:53:52] 1475.707642s: Video -> Film
[17:54:16] 1648.392700s: Film -> Video
[17:54:16] 1648.847290s: Video -> Film
[17:54:16] sync: "Chapter 8" (8) at frame 39686 time 148396254
[17:54:24] 1700.411377s: Film -> Video
[17:54:24] 1700.498901s: Video -> Film
[17:54:25] 1702.513428s: Film -> Video
[17:54:25] 1702.600830s: Video -> Film
[17:54:25] 1704.615601s: Film -> Video
[17:54:25] 1704.703125s: Video -> Film
[17:54:45] 1835.312744s: Film -> Video
[17:54:45] 1835.400391s: Video -> Film
[17:54:46] 1837.414917s: Film -> Video
[17:54:46] 1837.502441s: Video -> Film
[17:54:46] 1839.516968s: Film -> Video
[17:54:46] 1839.604492s: Video -> Film
[17:54:46] 1841.619019s: Film -> Video
[17:54:46] 1841.706665s: Video -> Film
[17:54:47] 1843.721191s: Film -> Video
[17:54:47] 1844.042358s: Video -> Film
[17:54:47] sync: "Chapter 9" (9) at frame 44381 time 165963804
[17:55:17] 2049.293213s: Film -> Video
[17:55:17] sync: "Chapter 10" (10) at frame 49313 time 184467539
[17:55:17] 2049.747803s: Video -> Film
[17:55:50] 2257.468018s: Film -> Video
[17:55:50] sync: "Chapter 11" (11) at frame 54322 time 203200254
[17:55:50] 2257.922607s: Video -> Film
[17:56:18] 2447.490967s: Film -> Video
[17:56:18] sync: "Chapter 12" (12) at frame 58883 time 220308345
[17:56:18] 2447.945557s: Video -> Film
[17:56:49] 2680.023193s: Film -> Video
[17:56:49] 2680.344238s: Video -> Film
[17:56:49] sync: "Chapter 13" (13) at frame 64460 time 241230998
[17:56:49] 2681.191162s: Film -> Video
[17:56:49] 2681.278809s: Video -> Film
[17:56:49] 2681.491455s: Film -> Video
[17:56:49] 2681.579102s: Video -> Film
[17:56:49] 2682.258789s: Film -> Video
[17:56:49] 2682.346436s: Video -> Film
[17:56:49] 2682.559326s: Film -> Video
[17:56:49] 2682.646729s: Video -> Film
[17:56:49] 2683.326660s: Film -> Video
[17:56:49] 2683.414307s: Video -> Film
[17:56:50] 2683.626953s: Film -> Video
[17:56:50] 2683.714600s: Video -> Film
[17:56:50] 2684.394287s: Film -> Video
[17:56:50] 2684.481934s: Video -> Film
[17:56:50] 2684.694824s: Film -> Video
[17:56:50] 2684.782227s: Video -> Film
[17:56:50] 2685.462158s: Film -> Video
[17:56:50] 2685.549805s: Video -> Film
[17:56:50] 2685.762451s: Film -> Video
[17:56:50] 2685.849854s: Video -> Film
[17:56:50] 2686.529785s: Film -> Video
[17:56:50] 2686.617432s: Video -> Film
[17:56:50] 2686.830322s: Film -> Video
[17:56:50] 2686.917725s: Video -> Film
[17:56:50] 2687.597412s: Film -> Video
[17:56:50] 2687.685059s: Video -> Film
[17:56:50] 2687.897949s: Film -> Video
[17:56:50] 2687.985352s: Video -> Film
[17:56:50] 2688.665283s: Film -> Video
[17:56:50] 2688.752930s: Video -> Film
[17:56:50] 2688.965576s: Film -> Video
[17:56:50] 2689.053223s: Video -> Film
[17:57:32] 2986.162598s: Film -> Video
[17:57:32] 2986.483643s: Video -> Film
[17:57:32] sync: "Chapter 14" (14) at frame 71823 time 268783523
[17:57:33] 2989.198975s: Film -> Video
[17:57:33] 2989.286377s: Video -> Film
[17:58:12] 3285.961914s: Film -> Video
[17:58:12] 3286.416748s: Video -> Film
[17:58:12] sync: "Chapter 15" (15) at frame 79018 time 295777490
[17:58:47] 3549.558838s: Film -> Video
[17:58:47] sync: "Chapter 16" (16) at frame 85337 time 319488427
[17:58:47] 3550.013184s: Video -> Film
[17:59:18] 3763.272217s: Film -> Video
[17:59:18] 3763.726562s: Video -> Film
[17:59:18] sync: "Chapter 17" (17) at frame 90468 time 338735405
[17:59:46] 3943.919189s: Film -> Video
[17:59:46] 3944.040283s: Video -> Film
[18:00:01] 4035.677490s: Film -> Video
[18:00:01] 4036.132324s: Video -> Film
[18:00:01] sync: "Chapter 18" (18) at frame 97004 time 363251897
[18:00:41] 4297.605957s: Film -> Video
[18:00:41] sync: "Chapter 19" (19) at frame 103283 time 386812684
[18:00:41] 4298.060547s: Video -> Film
[18:00:56] 4409.217285s: Film -> Video
[18:00:56] 4409.304688s: Video -> Film
[18:01:13] 4524.966309s: Film -> Video
[18:01:13] sync: "Chapter 20" (20) at frame 108738 time 407275126
[18:01:13] 4525.421387s: Video -> Film
[18:01:34] 4684.792969s: Film -> Video
[18:01:34] 4685.247070s: Video -> Film
[18:01:34] sync: "Chapter 21" (21) at frame 112577 time 421672259
[18:02:17] 4967.575195s: Film -> Video
[18:02:17] 4967.895996s: Video -> Film
[18:02:17] sync: "Chapter 22" (22) at frame 119356 time 447110672
[18:02:47] 5169.276855s: Film -> Video
[18:02:47] 5169.730957s: Video -> Film
[18:02:47] sync: "Chapter 23" (23) at frame 124199 time 465275819
[18:03:04] 5297.404785s: Film -> Video
[18:03:04] 5297.492188s: Video -> Film
[18:03:07] 5317.057617s: Film -> Video
[18:03:07] sync: "Chapter 24" (24) at frame 127744 time 478569349
[18:03:07] 5317.512207s: Video -> Film
[18:03:43] 5602.509277s: Film -> Video
[18:03:43] sync: "Chapter 25" (25) at frame 134589 time 504254009
[18:03:43] 5602.964355s: Video -> Film
[18:03:53] 5680.587891s: Film -> Video
[18:03:53] 5680.908691s: Video -> Film
[18:03:53] sync: "Chapter 26" (26) at frame 136464 time 511281780
[18:03:53] 5681.500977s: Film -> Video
[18:03:53] 5681.542969s: Video -> Film
[18:04:22] 5895.468750s: Film -> Video
[18:04:22] 5895.856934s: Video -> Film
[18:04:22] sync: "Chapter 27" (27) at frame 141621 time 530627106
[18:04:59] 6141.881836s: Film -> Video
[18:04:59] sync: "Chapter 28" (28) at frame 147531 time 552800508
[18:04:59] 6142.335938s: Video -> Film
[18:05:17] 6278.017578s: Film -> Video
[18:05:17] sync: "Chapter 29" (29) at frame 150797 time 565049746
[18:05:17] 6278.472656s: Video -> Film
[18:05:50] 6440.613770s: Film -> Video
[18:05:50] 6440.701172s: Video -> Film
[18:05:51] 6441.748047s: Film -> Video
[18:05:51] 6441.835449s: Video -> Film
[18:05:51] 6442.715820s: Film -> Video
[18:05:51] 6442.803223s: Video -> Film
[18:05:51] 6443.850098s: Film -> Video
[18:05:51] 6443.937500s: Video -> Film
[18:05:51] 6444.817871s: Film -> Video
[18:05:51] 6444.905273s: Video -> Film
[18:05:52] 6445.952148s: Film -> Video
[18:05:52] 6446.039551s: Video -> Film
[18:05:52] 6446.919922s: Film -> Video
[18:05:52] 6447.007324s: Video -> Film
[18:05:52] 6448.054199s: Film -> Video
[18:05:52] 6448.141602s: Video -> Film
[18:05:52] 6449.021973s: Film -> Video
[18:05:52] 6449.109375s: Video -> Film
[18:06:15] 6563.636719s: Film -> Video
[18:06:15] 6564.090820s: Video -> Film
[18:06:15] sync: "Chapter 30" (30) at frame 157661 time 590768189
[18:06:40] 6700.606445s: Film -> Video
[18:06:40] 6700.960938s: Video -> Film
[18:06:40] sync: "Chapter 31" (31) at frame 160945 time 603086495
[18:06:48] reader: done. 1 scr changes
[18:06:49] work: average encoding speed for job is 161.619507 fps
[18:06:49] comb detect: heavy 2903 | light 7818 | uncombed 152366 | total 163087
[18:06:49] decomb: deinterlaced 2903 | blended 7818 | unfiltered 152366 | total 163087
[18:06:49] vfr: lost time: 0 (0 frames)
[18:06:49] vfr: gained time: 0 (0 frames) (0 not accounted for)
[18:06:49] ac3-decoder done: 212193 frames, 0 decoder errors
[18:06:49] mpeg2video-decoder done: 163087 frames, 0 decoder errors
[18:06:49] sync: got 163087 frames, 162638 expected
[18:06:49] sync: framerate min 23.981 fps, max 29.970 fps, avg 24.018 fps
x264 [info]: frame I:1811  Avg QP:20.16  size: 20780
x264 [info]: frame P:45885 Avg QP:22.76  size:  6425
x264 [info]: frame B:115391 Avg QP:24.61  size:  2229
x264 [info]: consecutive B-frames:  5.1%  1.0%  1.8% 92.0%
x264 [info]: mb I  I16..4: 25.9%  0.0% 74.1%
x264 [info]: mb P  I16..4:  4.2%  0.0%  7.3%  P16..4: 44.5% 18.9% 10.2%  0.0%  0.0%    skip:14.9%
x264 [info]: mb B  I16..4:  4.5%  0.0%  1.3%  B16..8: 28.0%  8.2%  0.6%  direct:16.7%  skip:40.7%  L0:40.4% L1:47.4% BI:12.2%
x264 [info]: coded y,uvDC,uvAC intra: 52.0% 72.0% 28.8% inter: 16.0% 32.6% 1.2%
x264 [info]: i16 v,h,dc,p: 35% 23% 21% 21%
x264 [info]: i4 v,h,dc,ddl,ddr,vr,hd,vl,hu: 24% 21% 18%  6%  7%  6%  8%  5%  6%
x264 [info]: i8c dc,h,v,p: 55% 18% 22%  5%
x264 [info]: Weighted P-Frames: Y:10.0% UV:2.8%
x264 [info]: ref P L0: 63.3% 36.7%
x264 [info]: ref B L0: 82.1% 17.9%
x264 [info]: ref B L1: 95.0%  5.0%
x264 [info]: kb/s:694.74
[18:06:49] mux: track 0, 163087 frames, 589608264 bytes, 694.65 kbps, fifo 8192
[18:06:49] mux: track 1, 318290 frames, 135986795 bytes, 160.21 kbps, fifo 16384
[18:06:49] libhb: work result = 0
Filename "Test 2B 2019-05-15 18-14-16.log"

Code: Select all

Handbrake Version: 1.2.1 (2019021900)
[18:14:16] gtkgui: Custom Preset: /General/Preset Test
[18:14:16] 1 job(s) to process
[18:14:16] json job:
{
    "Audio": {
        "AudioList": [
            {
                "Bitrate": 160,
                "CompressionLevel": -1.0,
                "DRC": 0.0,
                "DitherMethod": "auto",
                "Encoder": "av_aac",
                "Gain": 0.0,
                "Mixdown": "stereo",
                "NormalizeMixLevel": false,
                "PresetEncoder": "av_aac",
                "Quality": -3.0,
                "Samplerate": 0,
                "Track": 0
            }
        ],
        "CopyMask": [
            "copy:aac"
        ],
        "FallbackEncoder": "av_aac"
    },
    "Destination": {
        "AlignAVStart": true,
        "ChapterList": [
            {
                "Name": "Chapter 1"
            },
            {
                "Name": "Chapter 2"
            },
            {
                "Name": "Chapter 3"
            },
            {
                "Name": "Chapter 4"
            },
            {
                "Name": "Chapter 5"
            },
            {
                "Name": "Chapter 6"
            },
            {
                "Name": "Chapter 7"
            },
            {
                "Name": "Chapter 8"
            },
            {
                "Name": "Chapter 9"
            },
            {
                "Name": "Chapter 10"
            },
            {
                "Name": "Chapter 11"
            },
            {
                "Name": "Chapter 12"
            },
            {
                "Name": "Chapter 13"
            },
            {
                "Name": "Chapter 14"
            },
            {
                "Name": "Chapter 15"
            },
            {
                "Name": "Chapter 16"
            },
            {
                "Name": "Chapter 17"
            },
            {
                "Name": "Chapter 18"
            },
            {
                "Name": "Chapter 19"
            },
            {
                "Name": "Chapter 20"
            },
            {
                "Name": "Chapter 21"
            },
            {
                "Name": "Chapter 22"
            },
            {
                "Name": "Chapter 23"
            },
            {
                "Name": "Chapter 24"
            },
            {
                "Name": "Chapter 25"
            },
            {
                "Name": "Chapter 26"
            },
            {
                "Name": "Chapter 27"
            },
            {
                "Name": "Chapter 28"
            },
            {
                "Name": "Chapter 29"
            },
            {
                "Name": "Chapter 30"
            },
            {
                "Name": "Chapter 31"
            }
        ],
        "ChapterMarkers": true,
        "File": "/media/mint/Toshiba/Test/Test 2B.m4v",
        "InlineParameterSets": false,
        "Mp4Options": {
            "IpodAtom": false,
            "Mp4Optimize": false
        },
        "Mux": "m4v"
    },
    "Filters": {
        "FilterList": [
            {
                "ID": 3,
                "Settings": {
                    "block-height": "16",
                    "block-thresh": "40",
                    "block-width": "16",
                    "filter-mode": "2",
                    "mode": "3",
                    "motion-thresh": "1",
                    "spatial-metric": "2",
                    "spatial-thresh": "1"
                }
            },
            {
                "ID": 4,
                "Settings": {
                    "mode": "7"
                }
            },
            {
                "ID": 6,
                "Settings": {
                    "mode": 0
                }
            },
            {
                "ID": 11,
                "Settings": {
                    "crop-bottom": 68,
                    "crop-left": 0,
                    "crop-right": 2,
                    "crop-top": 70,
                    "height": 342,
                    "width": 718
                }
            }
        ]
    },
    "Metadata": {
        "Name": "Test 2B"
    },
    "PAR": {
        "Den": 9,
        "Num": 8
    },
    "SequenceID": 0,
    "Source": {
        "Angle": 0,
        "Path": "/media/mint/Toshiba/DVDs/Test 2B",
        "Range": {
            "End": 31,
            "Start": 1,
            "Type": "chapter"
        },
        "Title": 1
    },
    "Subtitle": {
        "Search": {
            "Burn": true,
            "Default": false,
            "Enable": true,
            "Forced": true
        },
        "SubtitleList": []
    },
    "Video": {
        "ColorMatrix": 6,
        "ColorPrimaries": 6,
        "ColorTransfer": 1,
        "Encoder": "x264",
        "Options": "level=4.0:ref=2:8x8dct=0:weightp=1:subme=6:threads=4",
        "QSV": {
            "AsyncDepth": 4,
            "Decode": false
        },
        "Quality": 22.0,
        "Turbo": false,
        "TwoPass": false
    }
}
[18:14:16] CPU: Intel(R) Core(TM) i5-6500 CPU @ 3.20GHz
[18:14:16]  - Intel microarchitecture Skylake
[18:14:16]  - logical processor count: 4
[18:14:16] hb_scan: path=/media/mint/Toshiba/DVDs/Test 2B, title_index=1
disc.c:424: error opening file BDMV/index.bdmv
disc.c:424: error opening file BDMV/BACKUP/index.bdmv
[18:14:16] bd: not a bd - trying as a stream/file instead
libdvdnav: Using dvdnav version 6.0.0
libdvdread: Couldn't find device name.
libdvdnav: Can't read name block. Probably not a DVD-ROM device.
libdvdnav: vm: dvd_read_name failed
libdvdnav: DVD disk reports itself with Region mask 0x00fe0000. Regions: 1
libdvdread: Couldn't find device name.
[18:14:16] scan: DVD has 1 title(s)
[18:14:16] scan: scanning title 1
[18:14:16] scan: opening IFO for VTS 1
[18:14:16] scan: duration is 01:53:03 (6783400 ms)
[18:14:16] pgc_id: 1, pgn: 1: pgc: 0x7f91e4019840
[18:14:16] scan: vts=1, ttn=1, cells=0->30, blocks=0->1968859, 1968860 blocks
[18:14:16] scan: checking audio 1
[18:14:16] scan: id=0x80bd, lang=English (AC3), 3cc=eng ext=0
[18:14:16] scan: checking audio 2
[18:14:16] scan: id=0x81bd, lang=Francais (AC3), 3cc=fra ext=0
[18:14:16] scan: checking subtitle 1
[18:14:16] scan: id=0x20bd, lang=English (4:3) [VOBSUB], 3cc=eng ext=0
[18:14:16] scan: checking subtitle 2
[18:14:16] scan: id=0x21bd, lang=Francais (4:3) [VOBSUB], 3cc=fra ext=0
[18:14:16] scan: checking subtitle 3
[18:14:16] scan: id=0x22bd, lang=español (4:3) [VOBSUB], 3cc=spa ext=0
[18:14:16] scan: checking subtitle 4
[18:14:16] scan: id=0x23bd, lang=English (4:3) [VOBSUB], 3cc=eng ext=0
[18:14:16] scan: checking subtitle 5
[18:14:16] scan: id=0x24bd, lang=Francais (4:3) [VOBSUB], 3cc=fra ext=0
[18:14:16] scan: checking subtitle 6
[18:14:16] scan: id=0x25bd, lang=español (4:3) [VOBSUB], 3cc=spa ext=0
[18:14:16] scan: title 1 has 31 chapters
[18:14:16] scan: chap 1 c=0->0, b=0->25166 (25167), 91033 ms
[18:14:16] scan: chap 2 c=1->1, b=25167->189639 (164473), 491033 ms
[18:14:16] scan: chap 3 c=2->2, b=189640->205928 (16289), 56000 ms
[18:14:16] scan: chap 4 c=3->3, b=205929->285994 (80066), 278734 ms
[18:14:16] scan: chap 5 c=4->4, b=285995->340024 (54030), 178433 ms
[18:14:16] scan: chap 6 c=5->5, b=340025->459751 (119727), 378834 ms
[18:14:16] scan: chap 7 c=6->6, b=459752->505754 (46003), 173033 ms
[18:14:16] scan: chap 8 c=7->7, b=505755->571320 (65566), 195000 ms
[18:14:16] scan: chap 9 c=8->8, b=571321->630956 (59636), 205400 ms
[18:14:16] scan: chap 10 c=9->9, b=630957->698344 (67388), 207934 ms
[18:14:16] scan: chap 11 c=10->10, b=698345->752375 (54031), 189900 ms
[18:14:16] scan: chap 12 c=11->11, b=752376->816206 (63831), 232233 ms
[18:14:16] scan: chap 13 c=12->12, b=816207->899746 (83540), 305834 ms
[18:14:16] scan: chap 14 c=13->13, b=899747->981381 (81635), 299633 ms
[18:14:16] scan: chap 15 c=14->14, b=981382->1054794 (73413), 263200 ms
[18:14:16] scan: chap 16 c=15->15, b=1054795->1114321 (59527), 213633 ms
[18:14:16] scan: chap 17 c=16->16, b=1114322->1207521 (93200), 272133 ms
[18:14:16] scan: chap 18 c=17->17, b=1207522->1286236 (78715), 261533 ms
[18:14:16] scan: chap 19 c=18->18, b=1286237->1345991 (59755), 227133 ms
[18:14:16] scan: chap 20 c=19->19, b=1345992->1388228 (42237), 159800 ms
[18:14:16] scan: chap 21 c=20->20, b=1388229->1463048 (74820), 282367 ms
[18:14:16] scan: chap 22 c=21->21, b=1463049->1516655 (53607), 201633 ms
[18:14:16] scan: chap 23 c=22->22, b=1516656->1556094 (39439), 147567 ms
[18:14:16] scan: chap 24 c=23->23, b=1556095->1629888 (73794), 285100 ms
[18:14:16] scan: chap 25 c=24->24, b=1629889->1652492 (22604), 78000 ms
[18:14:16] scan: chap 26 c=25->25, b=1652493->1708746 (56254), 214734 ms
[18:14:16] scan: chap 27 c=26->26, b=1708747->1776668 (67922), 246133 ms
[18:14:16] scan: chap 28 c=27->27, b=1776669->1813624 (36956), 135967 ms
[18:14:16] scan: chap 29 c=28->28, b=1813625->1902596 (88972), 285467 ms
[18:14:16] scan: chap 30 c=29->29, b=1902597->1944043 (41447), 136734 ms
[18:14:16] scan: chap 31 c=30->30, b=1944044->1968859 (24816), 89233 ms
[18:14:16] scan: aspect = 4:3
[18:14:16] scan: decoding previews for title 1
libdvdnav: DVD disk reports itself with Region mask 0x00fe0000. Regions: 1
[18:14:16] scan: title angle(s) 1
[ac3 @ 0x7f91e415fe40] frame sync error
[18:14:16] scan: audio 0x81bd: ac3, rate=48000Hz, bitrate=192000 Francais (AC3) (2.0 ch)
[ac3 @ 0x7f91e415fe40] frame sync error
[ac3 @ 0x7f91e415fe40] frame sync error
[18:14:16] scan: audio 0x80bd: ac3, rate=48000Hz, bitrate=384000 English (AC3) (4.0 ch)
[18:14:16] scan: 10 previews, 720x480, 23.976 fps, autocrop = 70/68/0/2, aspect 4:3, PAR 8:9
[18:14:16] libhb: scan thread found 1 valid title(s)
[18:14:16] starting job
[18:14:16] decomb filter thread started for segment 0
[18:14:16] decomb filter thread started for segment 1
[18:14:16] decomb filter thread started for segment 2
[18:14:16] decomb check thread started for segment 0
[18:14:16] decomb filter thread started for segment 3
[18:14:16] decomb check thread started for segment 2
[18:14:16] decomb check thread started for segment 1
[18:14:16] decomb check thread started for segment 3
[18:14:16] job configuration:
[18:14:16] yadif thread started for segment 1
[18:14:16] mask erode thread started for segment 2
[18:14:16] mask erode thread started for segment 1
[18:14:16] mask erode thread started for segment 3
[18:14:16] mask dilate thread started for segment 0
[18:14:16] mask dilate thread started for segment 1
[18:14:16] mask dilate thread started for segment 2
[18:14:16] mask dilate thread started for segment 3
[18:14:16] yadif thread started for segment 0
[18:14:16] yadif thread started for segment 2
[18:14:16] mask filter thread started for segment 0
[18:14:16] mask filter thread started for segment 1
[18:14:16]  * source
[18:14:16]    + /media/mint/Toshiba/DVDs/Test 2B
[18:14:16] mask erode thread started for segment 0
[18:14:16] mask filter thread started for segment 3
[18:14:16] yadif thread started for segment 3
[18:14:16] mask filter thread started for segment 2
[18:14:16]    + title 1, chapter(s) 1 to 31
[18:14:16]  * destination
[18:14:16]    + /media/mint/Toshiba/Test/Test 2B.m4v
[18:14:16]    + container: MPEG-4 (libavformat)
[18:14:16]      + align initial A/V stream timestamps
[18:14:16]      + chapter markers
[18:14:16]  * video track
[18:14:16]    + decoder: mpeg2video
[18:14:16]      + bitrate 200 kbps
[18:14:16]    + filters
[18:14:16]      + Comb Detect (mode=3:spatial-metric=2:motion-thresh=1:spatial-thresh=1:filter-mode=2:block-thresh=40:block-width=16:block-height=16)
[18:14:16]      + Decomb (mode=39)
[18:14:16]      + Framerate Shaper (mode=0)
[18:14:16]        + frame rate: same as source (around 23.976 fps)
[18:14:16]      + Crop and Scale (width=718:height=342:crop-top=70:crop-bottom=68:crop-left=0:crop-right=2)
[18:14:16]        + source: 720 * 480, crop (70/68/0/2): 718 * 342, scale: 718 * 342
[18:14:16]    + Output geometry
[18:14:16]      + storage dimensions: 718 x 342
[18:14:16]      + pixel aspect ratio: 8 : 9
[18:14:16]      + display dimensions: 638 x 342
[18:14:16]  * Foreign Audio Search: Render/Burn-in, Forced Only
[18:14:16]    + subtitle, English (4:3) [VOBSUB] (track 0, id 0x20bd, Picture)
[18:14:16]    + subtitle, English (4:3) [VOBSUB] (track 3, id 0x23bd, Picture)
libdvdnav: Using dvdnav version 6.0.0
libdvdread: Couldn't find device name.
libdvdnav: Can't read name block. Probably not a DVD-ROM device.
libdvdnav: vm: dvd_read_name failed
libdvdnav: DVD disk reports itself with Region mask 0x00fe0000. Regions: 1
libdvdread: Couldn't find device name.
libdvdnav: DVD disk reports itself with Region mask 0x00fe0000. Regions: 1
[18:14:16] sync: expecting 162638 video frames
[18:14:19] reader: done. 1 scr changes
[18:14:19] work: average encoding speed for job is 0.000000 fps
[18:14:19] comb detect: heavy 0 | light 0 | uncombed 0 | total 0
[18:14:19] decomb: deinterlaced 0 | blended 0 | unfiltered 0 | total 0
[18:14:19] vfr: lost time: 0 (0 frames)
[18:14:19] vfr: gained time: 0 (0 frames) (0 not accounted for)
[18:14:19] mpeg2video-decoder done: 0 frames, 0 decoder errors
[18:14:19] sync: got 0 frames, 162638 expected
[18:14:19] Subtitle track 0 (id 0x20bd) 'English (4:3) [VOBSUB]': 1239 hits (0 forced)
[18:14:19] Subtitle track 3 (id 0x23bd) 'English (4:3) [VOBSUB]': 1443 hits (0 forced)
[18:14:19] No candidate detected during subtitle scan
[18:14:19] starting job
[18:14:19] decomb filter thread started for segment 3
[18:14:19] decomb filter thread started for segment 1
[18:14:19] decomb check thread started for segment 1
[18:14:19] decomb check thread started for segment 0
[18:14:19] decomb check thread started for segment 2
[18:14:19] mask filter thread started for segment 0
[18:14:19] decomb check thread started for segment 3
[18:14:19] mask filter thread started for segment 1
[18:14:19] mask filter thread started for segment 2
[18:14:19] mask filter thread started for segment 3
[18:14:19] mask erode thread started for segment 0
[18:14:19] mask erode thread started for segment 1
[18:14:19] mask erode thread started for segment 3
[18:14:19] mask dilate thread started for segment 0
[18:14:19] mask erode thread started for segment 2
[18:14:19] mask dilate thread started for segment 2
[18:14:19] mask dilate thread started for segment 1
[18:14:19] mask dilate thread started for segment 3
[18:14:19] yadif thread started for segment 0
[18:14:19] yadif thread started for segment 1
[18:14:19] decomb filter thread started for segment 0
[18:14:19] yadif thread started for segment 3
[18:14:19] job configuration:
[18:14:19]  * source
[18:14:19]    + /media/mint/Toshiba/DVDs/Test 2B
[18:14:19]    + title 1, chapter(s) 1 to 31
[18:14:19]  * destination
[18:14:19]    + /media/mint/Toshiba/Test/Test 2B.m4v
[18:14:19]    + container: MPEG-4 (libavformat)
[18:14:19]      + align initial A/V stream timestamps
[18:14:19]      + chapter markers
[18:14:19]  * video track
[18:14:19]    + decoder: mpeg2video
[18:14:19]      + bitrate 200 kbps
[18:14:19]    + filters
[18:14:19]      + Comb Detect (mode=3:spatial-metric=2:motion-thresh=1:spatial-thresh=1:filter-mode=2:block-thresh=40:block-width=16:block-height=16)
[18:14:19]      + Decomb (mode=39)
[18:14:19]      + Framerate Shaper (mode=0)
[18:14:19]        + frame rate: same as source (around 23.976 fps)
[18:14:19]      + Crop and Scale (width=718:height=342:crop-top=70:crop-bottom=68:crop-left=0:crop-right=2)
[18:14:19]        + source: 720 * 480, crop (70/68/0/2): 718 * 342, scale: 718 * 342
[18:14:19]    + Output geometry
[18:14:19]      + storage dimensions: 718 x 342
[18:14:19]      + pixel aspect ratio: 8 : 9
[18:14:19]      + display dimensions: 638 x 342
[18:14:19]    + encoder: H.264 (libx264)
[18:14:19]      + options: level=4.0:ref=2:8x8dct=0:weightp=1:subme=6:threads=4
[18:14:19]      + quality: 22.00 (RF)
[18:14:19]      + color profile: 6-1-6
[18:14:19]  * audio track 1
[18:14:19]    + decoder: English (AC3) (4.0 ch) (track 1, id 0x80bd)
[18:14:19]      + bitrate: 384 kbps, samplerate: 48000 Hz
[18:14:19]    + mixdown: Stereo
[18:14:19]    + dither: triangular
[18:14:19]    + encoder: AAC (libavcodec)
[18:14:19]      + bitrate: 160 kbps, samplerate: 48000 Hz
[18:14:19] yadif thread started for segment 2
libdvdnav: Using dvdnav version 6.0.0
libdvdread: Couldn't find device name.
libdvdnav: Can't read name block. Probably not a DVD-ROM device.
libdvdnav: vm: dvd_read_name failed
libdvdnav: DVD disk reports itself with Region mask 0x00fe0000. Regions: 1
[18:14:19] decomb filter thread started for segment 2
libdvdread: Couldn't find device name.
libdvdnav: DVD disk reports itself with Region mask 0x00fe0000. Regions: 1
[18:14:19] sync: expecting 162638 video frames
[18:14:19] encx264: min-keyint: 24, keyint: 240
[18:14:19] encx264: encoding at constant RF 22.000000
[18:14:19] encx264: unparsed options: level=4.0:ref=2:8x8dct=0:weightp=1:subme=6:threads=4
x264 [info]: using SAR=8/9
x264 [info]: using cpu capabilities: MMX2 SSE2Fast SSSE3 SSE4.2 AVX FMA3 BMI2 AVX2
x264 [info]: profile Main, level 4.0
[18:14:19] sync: first pts video is 0
[18:14:19] sync: first pts audio 0x80bd is 0
[18:14:19] sync: "Chapter 1" (1) at frame 3 time 7507
[18:14:19] 2.252244s: Film -> Video
[18:14:19] 2.502500s: Video -> Film
[18:14:20] 10.902555s: Film -> Video
[18:14:20] 10.944266s: Video -> Film
[18:14:22] 19.165133s: Film -> Video
[18:14:23] 23.953234s: Video -> Film
[18:14:25] 37.016300s: Film -> Video
[18:14:25] 37.133068s: Video -> Film
[18:14:34] 90.903458s: Film -> Video
[18:14:34] sync: "Chapter 2" (2) at frame 2320 time 8209089
[18:14:35] 91.353912s: Video -> Film
[18:16:01] 582.361084s: Film -> Video
[18:16:01] sync: "Chapter 3" (3) at frame 14109 time 52446282
[18:16:01] 582.811584s: Video -> Film
[18:16:11] 638.417053s: Film -> Video
[18:16:11] 638.800781s: Video -> Film
[18:16:11] sync: "Chapter 4" (4) at frame 15456 time 57492074
[18:16:53] 917.362427s: Film -> Video
[18:16:53] 917.812866s: Video -> Film
[18:16:53] sync: "Chapter 5" (5) at frame 22149 time 82603161
[18:17:23] 1096.040894s: Film -> Video
[18:17:23] sync: "Chapter 6" (6) at frame 26434 time 98677469
[18:17:23] 1096.491333s: Video -> Film
[18:18:26] 1475.253052s: Film -> Video
[18:18:26] sync: "Chapter 7" (7) at frame 35529 time 132806565
[18:18:27] 1475.703613s: Video -> Film
[18:18:51] 1648.392700s: Film -> Video
[18:18:51] 1648.843140s: Video -> Film
[18:18:51] sync: "Chapter 8" (8) at frame 39686 time 148395890
[18:19:01] 1700.411377s: Film -> Video
[18:19:01] 1700.494751s: Video -> Film
[18:19:01] 1702.513428s: Film -> Video
[18:19:01] 1702.596924s: Video -> Film
[18:19:01] 1704.615601s: Film -> Video
[18:19:02] 1704.698975s: Video -> Film
[18:19:23] 1835.312744s: Film -> Video
[18:19:23] 1835.396240s: Video -> Film
[18:19:23] 1837.414917s: Film -> Video
[18:19:23] 1837.498291s: Video -> Film
[18:19:24] 1839.516968s: Film -> Video
[18:19:24] 1839.600586s: Video -> Film
[18:19:24] 1841.619019s: Film -> Video
[18:19:24] 1841.702637s: Video -> Film
[18:19:24] 1843.721191s: Film -> Video
[18:19:25] 1844.038208s: Video -> Film
[18:19:25] sync: "Chapter 9" (9) at frame 44381 time 165963440
[18:19:57] 2049.293213s: Film -> Video
[18:19:57] sync: "Chapter 10" (10) at frame 49313 time 184467175
[18:19:57] 2049.743652s: Video -> Film
[18:20:32] 2257.468018s: Film -> Video
[18:20:32] sync: "Chapter 11" (11) at frame 54322 time 203199890
[18:20:32] 2257.918457s: Video -> Film
[18:21:01] 2447.490967s: Film -> Video
[18:21:01] sync: "Chapter 12" (12) at frame 58883 time 220307981
[18:21:01] 2447.941406s: Video -> Film
[18:21:34] 2680.023193s: Film -> Video
[18:21:34] 2680.340332s: Video -> Film
[18:21:34] sync: "Chapter 13" (13) at frame 64460 time 241230629
[18:21:34] 2681.191162s: Film -> Video
[18:21:34] 2681.274658s: Video -> Film
[18:21:34] 2681.491455s: Film -> Video
[18:21:35] 2681.574951s: Video -> Film
[18:21:35] 2682.258789s: Film -> Video
[18:21:35] 2682.342285s: Video -> Film
[18:21:35] 2682.559326s: Film -> Video
[18:21:35] 2682.642578s: Video -> Film
[18:21:35] 2683.326660s: Film -> Video
[18:21:35] 2683.410156s: Video -> Film
[18:21:35] 2683.626953s: Film -> Video
[18:21:35] 2683.710449s: Video -> Film
[18:21:35] 2684.394287s: Film -> Video
[18:21:35] 2684.477783s: Video -> Film
[18:21:35] 2684.694824s: Film -> Video
[18:21:35] 2684.778076s: Video -> Film
[18:21:35] 2685.462158s: Film -> Video
[18:21:35] 2685.545654s: Video -> Film
[18:21:35] 2685.762451s: Film -> Video
[18:21:35] 2685.845947s: Video -> Film
[18:21:35] 2686.529785s: Film -> Video
[18:21:35] 2686.613281s: Video -> Film
[18:21:35] 2686.830322s: Film -> Video
[18:21:35] 2686.913574s: Video -> Film
[18:21:35] 2687.597412s: Film -> Video
[18:21:35] 2687.681152s: Video -> Film
[18:21:35] 2687.897949s: Film -> Video
[18:21:35] 2687.981445s: Video -> Film
[18:21:36] 2688.665283s: Film -> Video
[18:21:36] 2688.748779s: Video -> Film
[18:21:36] 2688.965576s: Film -> Video
[18:21:36] 2689.049072s: Video -> Film
[18:22:18] 2986.162598s: Film -> Video
[18:22:18] 2986.479736s: Video -> Film
[18:22:18] sync: "Chapter 14" (14) at frame 71823 time 268783154
[18:22:18] 2989.198975s: Film -> Video
[18:22:18] 2989.282227s: Video -> Film
[18:22:57] 3285.961914s: Film -> Video
[18:22:57] 3286.412354s: Video -> Film
[18:22:57] sync: "Chapter 15" (15) at frame 79018 time 295777121
[18:23:36] 3549.558838s: Film -> Video
[18:23:36] sync: "Chapter 16" (16) at frame 85337 time 319488058
[18:23:36] 3550.009277s: Video -> Film
[18:24:09] 3763.272217s: Film -> Video
[18:24:09] 3763.722656s: Video -> Film
[18:24:09] sync: "Chapter 17" (17) at frame 90468 time 338735036
[18:24:39] 3943.919189s: Film -> Video
[18:24:39] 3944.036377s: Video -> Film
[18:24:54] 4035.677490s: Film -> Video
[18:24:54] 4036.127930s: Video -> Film
[18:24:54] sync: "Chapter 18" (18) at frame 97004 time 363251528
[18:25:32] 4297.605957s: Film -> Video
[18:25:32] sync: "Chapter 19" (19) at frame 103283 time 386812315
[18:25:32] 4298.056641s: Video -> Film
[18:25:47] 4409.217285s: Film -> Video
[18:25:47] 4409.300781s: Video -> Film
[18:26:03] 4524.966309s: Film -> Video
[18:26:03] sync: "Chapter 20" (20) at frame 108738 time 407274757
[18:26:03] 4525.416992s: Video -> Film
[18:26:24] 4684.792969s: Film -> Video
[18:26:24] 4685.243164s: Video -> Film
[18:26:24] sync: "Chapter 21" (21) at frame 112577 time 421671890
[18:27:08] 4967.575195s: Film -> Video
[18:27:08] 4967.892090s: Video -> Film
[18:27:08] sync: "Chapter 22" (22) at frame 119356 time 447110303
[18:27:40] 5169.276855s: Film -> Video
[18:27:40] 5169.727051s: Video -> Film
[18:27:40] sync: "Chapter 23" (23) at frame 124199 time 465275450
[18:27:58] 5297.404785s: Film -> Video
[18:27:58] 5297.488281s: Video -> Film
[18:28:01] 5317.057617s: Film -> Video
[18:28:01] sync: "Chapter 24" (24) at frame 127744 time 478568980
[18:28:01] 5317.508301s: Video -> Film
[18:28:39] 5602.509277s: Film -> Video
[18:28:39] sync: "Chapter 25" (25) at frame 134589 time 504253640
[18:28:39] 5602.959961s: Video -> Film
[18:28:51] 5680.587891s: Film -> Video
[18:28:51] 5680.904297s: Video -> Film
[18:28:51] sync: "Chapter 26" (26) at frame 136464 time 511281411
[18:28:51] 5681.497070s: Film -> Video
[18:28:51] 5681.538574s: Video -> Film
[18:29:19] 5895.468750s: Film -> Video
[18:29:19] 5895.853027s: Video -> Film
[18:29:19] sync: "Chapter 27" (27) at frame 141621 time 530626737
[18:29:56] 6141.881836s: Film -> Video
[18:29:56] sync: "Chapter 28" (28) at frame 147531 time 552800139
[18:29:56] 6142.332520s: Video -> Film
[18:30:14] 6278.017578s: Film -> Video
[18:30:14] sync: "Chapter 29" (29) at frame 150797 time 565049377
[18:30:14] 6278.468262s: Video -> Film
[18:30:39] 6440.613770s: Film -> Video
[18:30:39] 6440.696777s: Video -> Film
[18:30:39] 6441.748047s: Film -> Video
[18:30:39] 6441.831055s: Video -> Film
[18:30:39] 6442.715820s: Film -> Video
[18:30:39] 6442.798828s: Video -> Film
[18:30:40] 6443.850098s: Film -> Video
[18:30:40] 6443.933105s: Video -> Film
[18:30:40] 6444.817871s: Film -> Video
[18:30:40] 6444.900879s: Video -> Film
[18:30:40] 6445.952148s: Film -> Video
[18:30:40] 6446.036133s: Video -> Film
[18:30:40] 6446.919922s: Film -> Video
[18:30:40] 6447.002930s: Video -> Film
[18:30:40] 6448.054199s: Film -> Video
[18:30:40] 6448.138184s: Video -> Film
[18:30:41] 6449.021973s: Film -> Video
[18:30:41] 6449.104980s: Video -> Film
[18:30:58] 6563.636719s: Film -> Video
[18:30:58] 6564.086914s: Video -> Film
[18:30:58] sync: "Chapter 30" (30) at frame 157661 time 590767816
[18:31:20] 6700.606445s: Film -> Video
[18:31:20] 6700.957031s: Video -> Film
[18:31:20] sync: "Chapter 31" (31) at frame 160945 time 603086122
[18:31:28] reader: done. 1 scr changes
[18:31:29] work: average encoding speed for job is 158.303879 fps
[18:31:29] comb detect: heavy 2903 | light 7818 | uncombed 152366 | total 163087
[18:31:29] decomb: deinterlaced 2903 | blended 7818 | unfiltered 152366 | total 163087
[18:31:29] vfr: lost time: 0 (0 frames)
[18:31:29] vfr: gained time: 0 (0 frames) (0 not accounted for)
[18:31:29] ac3-decoder done: 212193 frames, 0 decoder errors
[18:31:29] mpeg2video-decoder done: 163087 frames, 0 decoder errors
[18:31:29] sync: got 163087 frames, 162638 expected
[18:31:29] sync: framerate min 23.981 fps, max 47.619 fps, avg 24.018 fps
[aac @ 0x7f91e801af80] Qavg: 384.214
x264 [info]: frame I:1811  Avg QP:20.16  size: 20782
x264 [info]: frame P:45885 Avg QP:22.76  size:  6424
x264 [info]: frame B:115391 Avg QP:24.61  size:  2229
x264 [info]: consecutive B-frames:  5.1%  1.0%  1.8% 92.0%
x264 [info]: mb I  I16..4: 25.9%  0.0% 74.1%
x264 [info]: mb P  I16..4:  4.2%  0.0%  7.3%  P16..4: 44.5% 18.9% 10.2%  0.0%  0.0%    skip:14.9%
x264 [info]: mb B  I16..4:  4.5%  0.0%  1.3%  B16..8: 28.0%  8.2%  0.6%  direct:16.7%  skip:40.7%  L0:40.4% L1:47.4% BI:12.2%
x264 [info]: coded y,uvDC,uvAC intra: 52.1% 72.0% 28.7% inter: 16.0% 32.6% 1.2%
x264 [info]: i16 v,h,dc,p: 35% 23% 21% 21%
x264 [info]: i4 v,h,dc,ddl,ddr,vr,hd,vl,hu: 24% 21% 18%  6%  7%  6%  8%  5%  6%
x264 [info]: i8c dc,h,v,p: 55% 18% 22%  6%
x264 [info]: Weighted P-Frames: Y:10.0% UV:2.8%
x264 [info]: ref P L0: 63.3% 36.7%
x264 [info]: ref B L0: 82.1% 17.9%
x264 [info]: ref B L1: 95.0%  5.0%
x264 [info]: kb/s:694.72
[18:31:29] mux: track 0, 163087 frames, 589595166 bytes, 694.64 kbps, fifo 8192
[18:31:29] mux: track 1, 318290 frames, 135986795 bytes, 160.21 kbps, fifo 16384
[18:31:29] libhb: work result = 0

mduell
Veteran User
Posts: 6674
Joined: Sat Apr 21, 2007 8:54 pm

Re: Identical Encodes Result in Erratic File Sizes

Post by mduell » Sat May 18, 2019 10:47 pm

Your sources are different names, I hope you just copied the source but I'm not sure why you would.

I don't see anything super obvious, but maybe 1 thread instead of 4. AFAIK that should only matter with vbv, which you don't have on, but that's my best guess.

Also maybe try without any video filtering, I wonder if one of them is non-deterministic.

Woodstock
Veteran User
Posts: 3217
Joined: Tue Aug 27, 2013 6:39 am

Re: Identical Encodes Result in Erratic File Sizes

Post by Woodstock » Sun May 19, 2019 12:06 am

I stripped the time codes and compared the two logs, and the job configuration is identical.

I found slight differences in when it switched from Video to Film tune (Film to Video switches matched), and these output statistic differences:

sync: framerate min 23.981 fps, max 29.970 fps, avg 24.018 fps
x264 [info]: frame I:1811 Avg QP:20.16 size: 20780
x264 [info]: frame P:45885 Avg QP:22.76 size: 6425
x264 [info]: kb/s:694.74
mux: track 0, 163087 frames, 589608264 bytes, 694.65 kbps, fifo 8192

sync: framerate min 23.981 fps, max 47.619 fps, avg 24.018 fps
x264 [info]: frame I:1811 Avg QP:20.16 size: 20782
x264 [info]: frame P:45885 Avg QP:22.76 size: 6424
x264 [info]: kb/s:694.72
mux: track 0, 163087 frames, 589595166 bytes, 694.64 kbps, fifo 8192

The comb detect and decomb statistics were identical between runs. When the various filter threads started varied a bit, but the same number were started on each run.

It would appear to me that the jump in peak frame rate accounts for the size differences, but why did it happen?

joeray
Posts: 4
Joined: Sat May 18, 2019 7:42 pm

Re: Identical Encodes Result in Erratic File Sizes

Post by joeray » Tue May 21, 2019 7:13 pm

The source files are the same; I changed the filenames and edited the logs for clarity.

I ran back-to-back encodes with just the video stream; no audio, subtitles, or chapter markers. The 2 output files were the same size.

Next, I added a single audio stream(AC3 passthru) and the output file sizes differed.

Then I changed the output frame rate from 'Peak Framerate (VBR)' to 'Constant Framerate', and the output files were again the same size.

There seems to be a framerate issue. Handbrake reports the source framerate as 23.976, but both mediainfo and ffprobe report it as 29.970. Here's an excerpt from mediainfo:

Code: Select all

Frame rate                               : 29.970 (30000/1001) FPS
Standard                                 : NTSC
Color space                              : YUV
Chroma subsampling                       : 4:2:0
Bit depth                                : 8 bits
Compression mode                         : Lossy
I've checked the encode logs of similar sources(i.e. Handbrake=23.976, mediainfo=29.970) and found results similar to those above. Some excerpts:

[06:05:51] sync: framerate min 23.981 fps, max 40.197 fps, avg 24.024 fps

[00:44:48] sync: framerate min 19.978 fps, max 113.350 fps, avg 24.006 fps

[23:46:10] sync: framerate min 14.985 fps, max 39.964 fps, avg 23.970 fps

But some source files are indeed encoded at 23.976fps. Again, from mediainfo:

Code: Select all

Frame rate                               : 23.976 (24000/1001) FPS
Color space                              : YUV
Chroma subsampling                       : 4:2:0
Bit depth                                : 8 bits
Scan type                                : Progressive
Scan order                               : 2:3 Pulldown
Compression mode                         : Lossy
Here are some excerpts from encode logs of sources similar to above(i.e. Handbrake=23.976, mediainfo=23.976):

[20:37:27] sync: framerate min 19.982 fps, max 29.970 fps, avg 23.984 fps

[02:49:54] sync: framerate min 23.981 fps, max 29.970 fps, avg 23.978 fps

[01:30:56] sync: framerate min 23.981 fps, max 29.970 fps, avg 23.996 fps

All encodes were done with stock 'General' presets, i.e. "Peak Framerate(VFR)" and "Framerate = 30"

mduell
Veteran User
Posts: 6674
Joined: Sat Apr 21, 2007 8:54 pm

Re: Identical Encodes Result in Erratic File Sizes

Post by mduell » Wed May 22, 2019 12:55 am

Is the content telecined?

joeray
Posts: 4
Joined: Sat May 18, 2019 7:42 pm

Re: Identical Encodes Result in Erratic File Sizes

Post by joeray » Sat May 25, 2019 7:00 pm

The source of all my encodes are DVDs which were backed-up to HDD. If I'm not mistaken they would be telecined(i.e. 3:2 pull down?). If I encode at 'same as source' constant rate, I get 30 fps(ffmpeg reports 'over 10,000 duplicate frames). But if I use a variable frame rate, it drops to about 24 fps(no duplicates).

Post Reply