Handbrake: Custom preset doesn't generate files

Created on 30 Jan 2017 · 15Comments · Source: HandBrake/HandBrake

Please describe the problem or feature request in detail:

When using the following custom preset no files are generated. The path used does exist. I'm aware the preset is a little unusual given the output avg bitrate, but this is an old animation & the quality isn't great.

        {
            "AudioCopyMask": [
                "copy:aac"
            ],
            "AudioEncoderFallback": "av_aac",
            "AudioLanguageList": [
                "und"
            ],
            "AudioList": [
                {
                    "AudioBitrate": 160,
                    "AudioCompressionLevel": -1.0,
                    "AudioDitherMethod": "auto",
                    "AudioEncoder": "av_aac",
                    "AudioMixdown": "dpl2",
                    "AudioNormalizeMixLevel": false,
                    "AudioSamplerate": "auto",
                    "AudioTrackDRCSlider": 0.0,
                    "AudioTrackGainSlider": 0.0,
                    "AudioTrackQuality": 1.0,
                    "AudioTrackQualityEnable": false
                }
            ],
            "AudioSecondaryEncoderMode": true,
            "AudioTrackSelectionBehavior": "all",
            "ChapterMarkers": true,
            "ChildrenArray": [],
            "Default": false,
            "FileFormat": "av_mkv",
            "Folder": false,
            "FolderOpen": false,
            "Mp4HttpOptimize": false,
            "Mp4iPodCompatible": false,
            "PictureAutoCrop": true,
            "PictureBottomCrop": 0,
            "PictureCombDetectCustom": "",
            "PictureCombDetectPreset": "default",
            "PictureDARWidth": 0,
            "PictureDeblock": 0,
            "PictureDeblockCustom": "qp=0:mode=2",
            "PictureDeinterlaceCustom": "",
            "PictureDeinterlaceFilter": "deinterlace",
            "PictureDeinterlacePreset": "bob",
            "PictureDenoiseCustom": "",
            "PictureDenoiseFilter": "nlmeans",
            "PictureDenoisePreset": "medium",
            "PictureDenoiseTune": "animation",
            "PictureDetelecine": "default",
            "PictureDetelecineCustom": "",
            "PictureForceHeight": 0,
            "PictureForceWidth": 0,
            "PictureHeight": 0,
            "PictureItuPAR": false,
            "PictureKeepRatio": true,
            "PictureLeftCrop": 0,
            "PictureLooseCrop": false,
            "PictureModulus": 2,
            "PicturePAR": "auto",
            "PicturePARHeight": 45,
            "PicturePARWidth": 64,
            "PictureRightCrop": 0,
            "PictureRotate": "disable=1",
            "PictureTopCrop": 0,
            "PictureWidth": 0,
            "PresetDescription": "",
            "PresetName": "500k",
            "SubtitleAddCC": true,
            "SubtitleAddForeignAudioSearch": true,
            "SubtitleAddForeignAudioSubtitle": false,
            "SubtitleBurnBDSub": false,
            "SubtitleBurnBehavior": "foreign",
            "SubtitleBurnDVDSub": false,
            "SubtitleLanguageList": [
                "und"
            ],
            "SubtitleTrackSelectionBehavior": "all",
            "Type": 1,
            "UsesPictureFilters": true,
            "UsesPictureSettings": 2,
            "VideoAvgBitrate": 500,
            "VideoColorMatrixCode": 0,
            "VideoEncoder": "x264",
            "VideoFramerate": "auto",
            "VideoFramerateMode": "cfr",
            "VideoGrayScale": false,
            "VideoLevel": "4.1",
            "VideoOptionExtra": "",
            "VideoPreset": "veryslow",
            "VideoProfile": "main",
            "VideoQSVAsyncDepth": 4,
            "VideoQSVDecode": false,
            "VideoQualitySlider": 28.0,
            "VideoQualityType": 1,
            "VideoScaler": "swscale",
            "VideoTune": "animation",
            "VideoTurboTwoPass": false,
            "VideoTwoPass": true,
            "x264Option": "analyse=all:merange=24:level=4.1:8x8dct=0:bframes=10:ref=9:b-adapt=2:deblock=1,1:psy-rd=0.4,0:direct=auto:me=umh:subme=10:trellis=2:vbv-bufsize=62500:vbv-maxrate=50000:aq-strength=0.6:rc-lookahead=60",
            "x264UseAdvancedOptions": false
        }

filter

video

What are the steps to reproduce this problem:

Attempt to encode old DVD with above preset.

What version of HandBrake you are running:

HandBrake 1.0.2 (2017012400)

What operating system and version and you running (e.g. OSX 10.11, Windows 7, Ubuntu 14):

Ubuntu 16.04

Was there any error message or error dialog, if so please detail or provide screenshots:

No error, just no files!

Please provide the full activity log for the encode or scan attempt. You may attach the log as a file, post a pastebin URL to the log, or place the log inline below:

``` [11:00:40] gtkgui: HandBrake 1.0.2 (2017012400) - Linux x86_64 - https://handbrake.fr
[11:00:40] hb_init: starting libhb thread
[11:00:40] hb_init: starting libhb thread
[11:00:40] hb_init: starting libhb thread
[11:00:43] CPU: Intel(R) Pentium(R) CPU G3220 @ 3.00GHz
[11:00:43] - Intel microarchitecture Haswell
[11:00:43] - logical processor count: 2
[11:00:43] hb_scan: path=/dev/sr0, title_index=0
disc.c:352: error opening file BDMV/index.bdmv
disc.c:352: error opening file BDMV/BACKUP/index.bdmv
[11:00:43] bd: not a bd - trying as a stream/file instead
[11:00:43] dvd: Region mask 0xff
[11:00:43] dvd: Warning, DVD device has no region set
libdvdnav: Using dvdnav version 5.0.1
libdvdnav: DVD Title: DVD_NAME_S1_DISC1
libdvdnav: DVD Serial Number: XXXXXXXX
libdvdnav: DVD Title (Alternative): DVD_NAME_S1_DISC1
libdvdnav: DVD disk reports itself with Region mask 0x00fd0000. Regions: 2
[11:00:44] scan: DVD has 11 title(s)
[11:00:44] scan: scanning title 1
[11:00:44] scan: opening IFO for VTS 1
[11:00:44] scan: duration is 00:00:10 (10000 ms)
[11:00:44] pgc_id: 1, pgn: 1: pgc: 0x7f7438011220
[11:00:44] scan: vts=1, ttn=1, cells=0->0, blocks=0->70, 71 blocks
[11:00:44] scan: title 1 has 1 chapters
[11:00:44] scan: chap 1 c=0->0, b=0->70 (71), 10000 ms
[11:00:44] scan: aspect = 16:9
[11:00:44] scan: scanning title 2
[11:00:44] scan: opening IFO for VTS 2
[11:00:44] scan: duration is 00:22:32 (1352000 ms)
[11:00:44] pgc_id: 1, pgn: 1: pgc: 0x7f74380123c0
[11:00:44] scan: vts=2, ttn=1, cells=0->4, blocks=0->527571, 527572 blocks
[11:00:44] scan: checking audio 1
[11:00:44] scan: id=0x80bd, lang=English (AC3), 3cc=eng ext=0
[11:00:44] scan: checking subtitle 1
[11:00:44] scan: id=0x20bd, lang=English, 3cc=eng ext=0
[11:00:44] scan: title 2 has 5 chapters
[11:00:44] scan: chap 1 c=0->0, b=0->87492 (87493), 225800 ms
[11:00:44] scan: chap 2 c=1->1, b=87493->173918 (86426), 203840 ms
[11:00:44] scan: chap 3 c=2->2, b=173919->349649 (175731), 442800 ms
[11:00:44] scan: chap 4 c=3->3, b=349650->378907 (29258), 72440 ms
[11:00:44] scan: chap 5 c=4->4, b=378908->527571 (148664), 407120 ms
[11:00:44] scan: aspect = 4:3
[11:00:44] scan: scanning title 3
[11:00:44] scan: opening IFO for VTS 2
[11:00:44] scan: duration is 00:22:27 (1347000 ms)
[11:00:44] pgc_id: 2, pgn: 1: pgc: 0x7f74380132b0
[11:00:44] scan: vts=2, ttn=2, cells=0->4, blocks=527572->1046836, 519265 blocks
[11:00:44] scan: checking audio 1
[11:00:44] scan: id=0x80bd, lang=English (AC3), 3cc=eng ext=0
[11:00:44] scan: checking subtitle 1
[11:00:44] scan: id=0x20bd, lang=English, 3cc=eng ext=0
[11:00:44] scan: title 3 has 5 chapters
[11:00:44] scan: chap 1 c=0->0, b=527572->618307 (90736), 225520 ms
[11:00:44] scan: chap 2 c=1->1, b=618308->666240 (47933), 126040 ms
[11:00:44] scan: chap 3 c=2->2, b=666241->748714 (82474), 221080 ms
[11:00:44] scan: chap 4 c=3->3, b=748715->919951 (171237), 454160 ms
[11:00:44] scan: chap 5 c=4->4, b=919952->1046836 (126885), 320200 ms
[11:00:44] scan: aspect = 4:3
[11:00:44] scan: scanning title 4
[11:00:44] scan: opening IFO for VTS 2
[11:00:44] scan: duration is 00:22:28 (1348840 ms)
[11:00:44] pgc_id: 3, pgn: 1: pgc: 0x7f7438012a70
[11:00:44] scan: vts=2, ttn=3, cells=0->4, blocks=1046837->1556501, 509665 blocks
[11:00:44] scan: checking audio 1
[11:00:44] scan: id=0x80bd, lang=English (AC3), 3cc=eng ext=0
[11:00:44] scan: checking subtitle 1
[11:00:44] scan: id=0x20bd, lang=English, 3cc=eng ext=0
[11:00:44] scan: title 4 has 5 chapters
[11:00:44] scan: chap 1 c=0->0, b=1046837->1129863 (83027), 203640 ms
[11:00:44] scan: chap 2 c=1->1, b=1129864->1249526 (119663), 312800 ms
[11:00:44] scan: chap 3 c=2->2, b=1249527->1371182 (121656), 337240 ms
[11:00:44] scan: chap 4 c=3->3, b=1371183->1403570 (32388), 85800 ms
[11:00:44] scan: chap 5 c=4->4, b=1403571->1556501 (152931), 409360 ms
[11:00:44] scan: aspect = 4:3
[11:00:44] scan: scanning title 5
[11:00:44] scan: opening IFO for VTS 2
[11:00:44] scan: duration is 00:22:33 (1353960 ms)
[11:00:44] pgc_id: 4, pgn: 1: pgc: 0x7f7438013680
[11:00:44] scan: vts=2, ttn=4, cells=0->4, blocks=1556502->2008515, 452014 blocks
[11:00:44] scan: checking audio 1
[11:00:44] scan: id=0x80bd, lang=English (AC3), 3cc=eng ext=0
[11:00:44] scan: checking subtitle 1
[11:00:44] scan: id=0x20bd, lang=English, 3cc=eng ext=0
[11:00:44] scan: title 5 has 5 chapters
[11:00:44] scan: chap 1 c=0->0, b=1556502->1628898 (72397), 211400 ms
[11:00:44] scan: chap 2 c=1->1, b=1628899->1718782 (89884), 255200 ms
[11:00:44] scan: chap 3 c=2->2, b=1718783->1829861 (111079), 335960 ms
[11:00:44] scan: chap 4 c=3->3, b=1829862->1955050 (125189), 372280 ms
[11:00:44] scan: chap 5 c=4->4, b=1955051->2008515 (53465), 179120 ms
[11:00:44] scan: aspect = 4:3
[11:00:44] scan: scanning title 6
[11:00:44] scan: opening IFO for VTS 2
[11:00:44] scan: duration is 00:22:32 (1352560 ms)
[11:00:44] pgc_id: 5, pgn: 1: pgc: 0x7f74380493f0
[11:00:44] scan: vts=2, ttn=5, cells=0->4, blocks=2008516->2536187, 527672 blocks
[11:00:44] scan: checking audio 1
[11:00:44] scan: id=0x80bd, lang=English (AC3), 3cc=eng ext=0
[11:00:44] scan: checking subtitle 1
[11:00:44] scan: id=0x20bd, lang=English, 3cc=eng ext=0
[11:00:44] scan: title 6 has 5 chapters
[11:00:44] scan: chap 1 c=0->0, b=2008516->2085833 (77318), 193000 ms
[11:00:44] scan: chap 2 c=1->1, b=2085834->2163199 (77366), 190200 ms
[11:00:44] scan: chap 3 c=2->2, b=2163200->2286281 (123082), 308560 ms
[11:00:44] scan: chap 4 c=3->3, b=2286282->2372200 (85919), 237320 ms
[11:00:44] scan: chap 5 c=4->4, b=2372201->2536187 (163987), 423480 ms
[11:00:44] scan: aspect = 4:3
[11:00:44] scan: scanning title 7
[11:00:44] scan: opening IFO for VTS 2
[11:00:44] scan: duration is 00:22:13 (1333760 ms)
[11:00:44] pgc_id: 6, pgn: 1: pgc: 0x7f7438049da0
[11:00:44] scan: vts=2, ttn=6, cells=0->4, blocks=2536188->2983179, 446992 blocks
[11:00:44] scan: checking audio 1
[11:00:44] scan: id=0x80bd, lang=English (AC3), 3cc=eng ext=0
[11:00:44] scan: checking subtitle 1
[11:00:44] scan: id=0x20bd, lang=English, 3cc=eng ext=0
[11:00:44] scan: title 7 has 5 chapters
[11:00:44] scan: chap 1 c=0->0, b=2536188->2595625 (59438), 169240 ms
[11:00:44] scan: chap 2 c=1->1, b=2595626->2707990 (112365), 321840 ms
[11:00:44] scan: chap 3 c=2->2, b=2707991->2875356 (167366), 471320 ms
[11:00:44] scan: chap 4 c=3->3, b=2875357->2943264 (67908), 236880 ms
[11:00:44] scan: chap 5 c=4->4, b=2943265->2983179 (39915), 134480 ms
[11:00:44] scan: aspect = 4:3
[11:00:44] scan: scanning title 8
[11:00:44] scan: opening IFO for VTS 2
[11:00:44] scan: duration is 00:22:31 (1351280 ms)
[11:00:44] pgc_id: 7, pgn: 1: pgc: 0x7f7438049270
[11:00:44] scan: vts=2, ttn=7, cells=0->4, blocks=2983180->3515250, 532071 blocks
[11:00:44] scan: checking audio 1
[11:00:44] scan: id=0x80bd, lang=English (AC3), 3cc=eng ext=0
[11:00:44] scan: checking subtitle 1
[11:00:44] scan: id=0x20bd, lang=English, 3cc=eng ext=0
[11:00:44] scan: title 8 has 5 chapters
[11:00:44] scan: chap 1 c=0->0, b=2983180->3052292 (69113), 164320 ms
[11:00:44] scan: chap 2 c=1->1, b=3052293->3176983 (124691), 313120 ms
[11:00:44] scan: chap 3 c=2->2, b=3176984->3302648 (125665), 320000 ms
[11:00:44] scan: chap 4 c=3->3, b=3302649->3437976 (135328), 347080 ms
[11:00:44] scan: chap 5 c=4->4, b=3437977->3515250 (77274), 206760 ms
[11:00:44] scan: aspect = 4:3
[11:00:44] scan: scanning title 9
[11:00:44] scan: opening IFO for VTS 2
[11:00:44] scan: duration is 00:00:00 (480 ms)
[11:00:44] scan: ignoring title (too short)
[11:00:44] scan: scanning title 10
[11:00:44] scan: opening IFO for VTS 2
[11:00:44] scan: duration is 00:00:00 (480 ms)
[11:00:44] scan: ignoring title (too short)
[11:00:44] scan: scanning title 11
[11:00:44] scan: opening IFO for VTS 3
[11:00:44] scan: duration is 00:00:26 (26840 ms)
[11:00:44] pgc_id: 1, pgn: 1: pgc: 0x7f7438065fb0
[11:00:44] scan: vts=3, ttn=1, cells=0->0, blocks=0->9772, 9773 blocks
[11:00:44] scan: checking audio 1
[11:00:44] scan: id=0x80bd, lang=English (AC3), 3cc=eng ext=0
[11:00:44] scan: title 11 has 1 chapters
[11:00:44] scan: chap 1 c=0->0, b=0->9772 (9773), 26840 ms
[11:00:44] scan: aspect = 16:9
libdvdnav: DVD disk reports itself with Region mask 0x00fd0000. Regions: 2

libdvdread: Attempting to retrieve all CSS keys
libdvdread: This can take a _long_ time, please be patient

libdvdread: Get key for /VIDEO_TS/VTS_01_1.VOB at 0x0000013e
libdvdread: Error cracking CSS key for /VIDEO_TS/VTS_01_1.VOB (0x0000013e)!!
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_02_0.VOB at 0x000001c7
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_02_1.VOB at 0x0000ce9c
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_03_1.VOB at 0x00367256
libdvdread: Error cracking CSS key for /VIDEO_TS/VTS_03_1.VOB (0x00367256)!!
libdvdread: Elapsed time 0
libdvdread: Found 3 VTS's
libdvdread: Elapsed time 0
[11:00:44] scan: decoding previews for title 1
libdvdnav: DVD disk reports itself with Region mask 0x00fd0000. Regions: 2
[11:00:44] scan: title angle(s) 1
[11:00:44] Warning: Could not read data for preview 1, skipped
[11:00:44] scan: decoding previews for title 1
libdvdnav: DVD disk reports itself with Region mask 0x00fd0000. Regions: 2
[11:00:44] scan: title angle(s) 1
[11:00:44] Warning: Could not read data for preview 1, skipped
[11:00:44] scan: decoding previews for title 2
libdvdnav: DVD disk reports itself with Region mask 0x00fd0000. Regions: 2
[11:00:44] scan: title angle(s) 1
[ac3 @ 0x7f7438015800] frame sync error
[11:00:44] scan: audio 0x80bd: ac3, rate=48000Hz, bitrate=192000 English (AC3) (2.0 ch)
[11:00:44] scan: 10 previews, 720x576, 25.000 fps, autocrop = 0/0/10/8, aspect 4:3, PAR 16:15
[11:00:44] scan: decoding previews for title 3
libdvdnav: DVD disk reports itself with Region mask 0x00fd0000. Regions: 2
[11:00:44] scan: title angle(s) 1
[ac3 @ 0x7f743836b0e0] frame sync error
[11:00:44] scan: audio 0x80bd: ac3, rate=48000Hz, bitrate=192000 English (AC3) (2.0 ch)
[11:00:44] scan: 10 previews, 720x576, 25.000 fps, autocrop = 0/0/10/8, aspect 4:3, PAR 16:15
[11:00:44] scan: decoding previews for title 4
libdvdnav: DVD disk reports itself with Region mask 0x00fd0000. Regions: 2
[11:00:44] scan: title angle(s) 1
[ac3 @ 0x7f7438369d00] frame sync error
[11:00:44] scan: audio 0x80bd: ac3, rate=48000Hz, bitrate=192000 English (AC3) (2.0 ch)
[11:00:44] scan: 10 previews, 720x576, 25.000 fps, autocrop = 0/0/10/8, aspect 4:3, PAR 16:15
[11:00:44] scan: decoding previews for title 5
libdvdnav: DVD disk reports itself with Region mask 0x00fd0000. Regions: 2
[11:00:44] scan: title angle(s) 1
[ac3 @ 0x7f7438403840] frame sync error
[11:00:44] scan: audio 0x80bd: ac3, rate=48000Hz, bitrate=192000 English (AC3) (2.0 ch)
[11:00:44] scan: 10 previews, 720x576, 25.000 fps, autocrop = 0/0/4/2, aspect 4:3, PAR 16:15
[11:00:44] scan: decoding previews for title 6
libdvdnav: DVD disk reports itself with Region mask 0x00fd0000. Regions: 2
[11:00:44] scan: title angle(s) 1
[ac3 @ 0x7f74383f7340] frame sync error
[11:00:44] scan: audio 0x80bd: ac3, rate=48000Hz, bitrate=192000 English (AC3) (2.0 ch)
[11:00:44] scan: 10 previews, 720x576, 25.000 fps, autocrop = 0/0/10/8, aspect 4:3, PAR 16:15
[11:00:44] scan: decoding previews for title 7
libdvdnav: DVD disk reports itself with Region mask 0x00fd0000. Regions: 2
[11:00:44] scan: title angle(s) 1
[ac3 @ 0x7f743840d840] frame sync error
[11:00:44] scan: audio 0x80bd: ac3, rate=48000Hz, bitrate=192000 English (AC3) (2.0 ch)
[11:00:45] scan: 10 previews, 720x576, 25.000 fps, autocrop = 0/0/0/0, aspect 4:3, PAR 16:15
[11:00:45] scan: decoding previews for title 8
libdvdnav: DVD disk reports itself with Region mask 0x00fd0000. Regions: 2
[11:00:45] scan: title angle(s) 1
[ac3 @ 0x7f743840d320] frame sync error
[11:00:45] scan: audio 0x80bd: ac3, rate=48000Hz, bitrate=192000 English (AC3) (2.0 ch)
[11:00:45] scan: 10 previews, 720x576, 25.000 fps, autocrop = 0/0/10/8, aspect 4:3, PAR 16:15
[11:00:45] scan: decoding previews for title 11
libdvdnav: DVD disk reports itself with Region mask 0x00fd0000. Regions: 2
[11:00:45] scan: title angle(s) 1
[ac3 @ 0x7f7438019f60] frame sync error
[ac3 @ 0x7f7438019f60] frame sync error
[11:00:45] scan: audio 0x80bd: ac3, rate=48000Hz, bitrate=384000 English (AC3) (5.1 ch)
[11:00:45] scan: 10 previews, 720x576, 25.000 fps, autocrop = 0/0/0/0, aspect 16:9, PAR 64:45
[11:00:45] Title is likely interlaced or telecined (8 out of 10 previews). You should do something about that.
[11:00:45] libhb: scan thread found 8 valid title(s)
[11:00:51] CPU: Intel(R) Pentium(R) CPU G3220 @ 3.00GHz
[11:00:51] - Intel microarchitecture Haswell
[11:00:51] - logical processor count: 2
[11:00:51] hb_scan: path=/dev/sr0, title_index=0
disc.c:352: error opening file BDMV/index.bdmv
disc.c:352: error opening file BDMV/BACKUP/index.bdmv
[11:00:51] bd: not a bd - trying as a stream/file instead
[11:00:51] dvd: Region mask 0xff
[11:00:51] dvd: Warning, DVD device has no region set
libdvdnav: Using dvdnav version 5.0.1
libdvdnav: DVD Title: DVD_NAME_S1_DISC1
libdvdnav: DVD Serial Number: XXXXXXXX
libdvdnav: DVD Title (Alternative): DVD_NAME_S1_DISC1
libdvdnav: DVD disk reports itself with Region mask 0x00fd0000. Regions: 2
[11:00:51] scan: DVD has 11 title(s)
[11:00:51] scan: scanning title 1
[11:00:51] scan: opening IFO for VTS 1
[11:00:51] scan: duration is 00:00:10 (10000 ms)
[11:00:51] pgc_id: 1, pgn: 1: pgc: 0x7f74280108e0
[11:00:51] scan: vts=1, ttn=1, cells=0->0, blocks=0->70, 71 blocks
[11:00:51] scan: title 1 has 1 chapters
[11:00:51] scan: chap 1 c=0->0, b=0->70 (71), 10000 ms
[11:00:51] scan: aspect = 16:9
[11:00:51] scan: scanning title 2
[11:00:51] scan: opening IFO for VTS 2
[11:00:51] scan: duration is 00:22:32 (1352000 ms)
[11:00:51] pgc_id: 1, pgn: 1: pgc: 0x7f7428011a80
[11:00:51] scan: vts=2, ttn=1, cells=0->4, blocks=0->527571, 527572 blocks
[11:00:51] scan: checking audio 1
[11:00:51] scan: id=0x80bd, lang=English (AC3), 3cc=eng ext=0
[11:00:51] scan: checking subtitle 1
[11:00:51] scan: id=0x20bd, lang=English, 3cc=eng ext=0
[11:00:51] scan: title 2 has 5 chapters
[11:00:51] scan: chap 1 c=0->0, b=0->87492 (87493), 225800 ms
[11:00:51] scan: chap 2 c=1->1, b=87493->173918 (86426), 203840 ms
[11:00:51] scan: chap 3 c=2->2, b=173919->349649 (175731), 442800 ms
[11:00:51] scan: chap 4 c=3->3, b=349650->378907 (29258), 72440 ms
[11:00:51] scan: chap 5 c=4->4, b=378908->527571 (148664), 407120 ms
[11:00:51] scan: aspect = 4:3
[11:00:51] scan: scanning title 3
[11:00:51] scan: opening IFO for VTS 2
[11:00:51] scan: duration is 00:22:27 (1347000 ms)
[11:00:51] pgc_id: 2, pgn: 1: pgc: 0x7f7428012970
[11:00:51] scan: vts=2, ttn=2, cells=0->4, blocks=527572->1046836, 519265 blocks
[11:00:51] scan: checking audio 1
[11:00:51] scan: id=0x80bd, lang=English (AC3), 3cc=eng ext=0
[11:00:51] scan: checking subtitle 1
[11:00:51] scan: id=0x20bd, lang=English, 3cc=eng ext=0
[11:00:51] scan: title 3 has 5 chapters
[11:00:51] scan: chap 1 c=0->0, b=527572->618307 (90736), 225520 ms
[11:00:51] scan: chap 2 c=1->1, b=618308->666240 (47933), 126040 ms
[11:00:51] scan: chap 3 c=2->2, b=666241->748714 (82474), 221080 ms
[11:00:51] scan: chap 4 c=3->3, b=748715->919951 (171237), 454160 ms
[11:00:51] scan: chap 5 c=4->4, b=919952->1046836 (126885), 320200 ms
[11:00:51] scan: aspect = 4:3
[11:00:51] scan: scanning title 4
[11:00:51] scan: opening IFO for VTS 2
[11:00:51] scan: duration is 00:22:28 (1348840 ms)
[11:00:51] pgc_id: 3, pgn: 1: pgc: 0x7f7428012130
[11:00:51] scan: vts=2, ttn=3, cells=0->4, blocks=1046837->1556501, 509665 blocks
[11:00:51] scan: checking audio 1
[11:00:51] scan: id=0x80bd, lang=English (AC3), 3cc=eng ext=0
[11:00:51] scan: checking subtitle 1
[11:00:51] scan: id=0x20bd, lang=English, 3cc=eng ext=0
[11:00:51] scan: title 4 has 5 chapters
[11:00:51] scan: chap 1 c=0->0, b=1046837->1129863 (83027), 203640 ms
[11:00:51] scan: chap 2 c=1->1, b=1129864->1249526 (119663), 312800 ms
[11:00:51] scan: chap 3 c=2->2, b=1249527->1371182 (121656), 337240 ms
[11:00:51] scan: chap 4 c=3->3, b=1371183->1403570 (32388), 85800 ms
[11:00:51] scan: chap 5 c=4->4, b=1403571->1556501 (152931), 409360 ms
[11:00:51] scan: aspect = 4:3
[11:00:51] scan: scanning title 5
[11:00:51] scan: opening IFO for VTS 2
[11:00:51] scan: duration is 00:22:33 (1353960 ms)
[11:00:51] pgc_id: 4, pgn: 1: pgc: 0x7f7428012d40
[11:00:51] scan: vts=2, ttn=4, cells=0->4, blocks=1556502->2008515, 452014 blocks
[11:00:51] scan: checking audio 1
[11:00:51] scan: id=0x80bd, lang=English (AC3), 3cc=eng ext=0
[11:00:51] scan: checking subtitle 1
[11:00:51] scan: id=0x20bd, lang=English, 3cc=eng ext=0
[11:00:51] scan: title 5 has 5 chapters
[11:00:51] scan: chap 1 c=0->0, b=1556502->1628898 (72397), 211400 ms
[11:00:51] scan: chap 2 c=1->1, b=1628899->1718782 (89884), 255200 ms
[11:00:51] scan: chap 3 c=2->2, b=1718783->1829861 (111079), 335960 ms
[11:00:51] scan: chap 4 c=3->3, b=1829862->1955050 (125189), 372280 ms
[11:00:51] scan: chap 5 c=4->4, b=1955051->2008515 (53465), 179120 ms
[11:00:51] scan: aspect = 4:3
[11:00:51] scan: scanning title 6
[11:00:51] scan: opening IFO for VTS 2
[11:00:51] scan: duration is 00:22:32 (1352560 ms)
[11:00:51] pgc_id: 5, pgn: 1: pgc: 0x7f7428048ab0
[11:00:51] scan: vts=2, ttn=5, cells=0->4, blocks=2008516->2536187, 527672 blocks
[11:00:51] scan: checking audio 1
[11:00:51] scan: id=0x80bd, lang=English (AC3), 3cc=eng ext=0
[11:00:51] scan: checking subtitle 1
[11:00:51] scan: id=0x20bd, lang=English, 3cc=eng ext=0
[11:00:51] scan: title 6 has 5 chapters
[11:00:51] scan: chap 1 c=0->0, b=2008516->2085833 (77318), 193000 ms
[11:00:51] scan: chap 2 c=1->1, b=2085834->2163199 (77366), 190200 ms
[11:00:51] scan: chap 3 c=2->2, b=2163200->2286281 (123082), 308560 ms
[11:00:51] scan: chap 4 c=3->3, b=2286282->2372200 (85919), 237320 ms
[11:00:51] scan: chap 5 c=4->4, b=2372201->2536187 (163987), 423480 ms
[11:00:51] scan: aspect = 4:3
[11:00:51] scan: scanning title 7
[11:00:51] scan: opening IFO for VTS 2
[11:00:51] scan: duration is 00:22:13 (1333760 ms)
[11:00:51] pgc_id: 6, pgn: 1: pgc: 0x7f7428049460
[11:00:51] scan: vts=2, ttn=6, cells=0->4, blocks=2536188->2983179, 446992 blocks
[11:00:51] scan: checking audio 1
[11:00:51] scan: id=0x80bd, lang=English (AC3), 3cc=eng ext=0
[11:00:51] scan: checking subtitle 1
[11:00:51] scan: id=0x20bd, lang=English, 3cc=eng ext=0
[11:00:51] scan: title 7 has 5 chapters
[11:00:51] scan: chap 1 c=0->0, b=2536188->2595625 (59438), 169240 ms
[11:00:51] scan: chap 2 c=1->1, b=2595626->2707990 (112365), 321840 ms
[11:00:51] scan: chap 3 c=2->2, b=2707991->2875356 (167366), 471320 ms
[11:00:51] scan: chap 4 c=3->3, b=2875357->2943264 (67908), 236880 ms
[11:00:51] scan: chap 5 c=4->4, b=2943265->2983179 (39915), 134480 ms
[11:00:51] scan: aspect = 4:3
[11:00:51] scan: scanning title 8
[11:00:51] scan: opening IFO for VTS 2
[11:00:51] scan: duration is 00:22:31 (1351280 ms)
[11:00:51] pgc_id: 7, pgn: 1: pgc: 0x7f7428048930
[11:00:51] scan: vts=2, ttn=7, cells=0->4, blocks=2983180->3515250, 532071 blocks
[11:00:51] scan: checking audio 1
[11:00:51] scan: id=0x80bd, lang=English (AC3), 3cc=eng ext=0
[11:00:51] scan: checking subtitle 1
[11:00:51] scan: id=0x20bd, lang=English, 3cc=eng ext=0
[11:00:51] scan: title 8 has 5 chapters
[11:00:51] scan: chap 1 c=0->0, b=2983180->3052292 (69113), 164320 ms
[11:00:51] scan: chap 2 c=1->1, b=3052293->3176983 (124691), 313120 ms
[11:00:51] scan: chap 3 c=2->2, b=3176984->3302648 (125665), 320000 ms
[11:00:51] scan: chap 4 c=3->3, b=3302649->3437976 (135328), 347080 ms
[11:00:51] scan: chap 5 c=4->4, b=3437977->3515250 (77274), 206760 ms
[11:00:51] scan: aspect = 4:3
[11:00:51] scan: scanning title 9
[11:00:51] scan: opening IFO for VTS 2
[11:00:51] scan: duration is 00:00:00 (480 ms)
[11:00:51] scan: ignoring title (too short)
[11:00:51] scan: scanning title 10
[11:00:51] scan: opening IFO for VTS 2
[11:00:51] scan: duration is 00:00:00 (480 ms)
[11:00:51] scan: ignoring title (too short)
[11:00:51] scan: scanning title 11
[11:00:51] scan: opening IFO for VTS 3
[11:00:51] scan: duration is 00:00:26 (26840 ms)
[11:00:51] pgc_id: 1, pgn: 1: pgc: 0x7f7428065670
[11:00:51] scan: vts=3, ttn=1, cells=0->0, blocks=0->9772, 9773 blocks
[11:00:51] scan: checking audio 1
[11:00:51] scan: id=0x80bd, lang=English (AC3), 3cc=eng ext=0
[11:00:51] scan: title 11 has 1 chapters
[11:00:51] scan: chap 1 c=0->0, b=0->9772 (9773), 26840 ms
[11:00:51] scan: aspect = 16:9
libdvdnav: DVD disk reports itself with Region mask 0x00fd0000. Regions: 2

libdvdread: Attempting to retrieve all CSS keys
libdvdread: This can take a _long_ time, please be patient

Bug

Source

mpmc

All 15 comments

You won't see a file created until the 2nd pass. Your log shows looks like it's still processing pass 1, so it's just doing analysis on the source and record a stats file to a tempory directory. It's not actually encoding anything yet. (Note, you have foreign audio scan turned on, so you may see it doing 3 passes, not 2)

sr55 on 30 Jan 2017

@sr55 Yep, I know, but even when it hits the third pass there is still no file created. The reason for the log missing the next stage is because it takes several hours to complete. I don't mind how long it takes it's just after all that wait & I get nothing :rofl:

As I write this reply, I did another profile using roughly the same settings (taking note of the foreign audio scan you mentioned) with video preset on medium rather than veryslow & the file is created! I can only assume that veryslow is a little too slow & something gives up waiting along the line. Very strange, could just be a bad combo of settings.

~~If I can, I'll try & do another encode using the "broken" settings & post the full log at a later date. This can be closed if needed.~~

I'm back, now with a full log of an encode, looks like something is broken!

Notice the lines..

x264 [info]: using SAR=16/15
x264 [info]: using cpu capabilities: MMX2 SSE2Fast SSSE3 SSE4.2 LZCNT
x264 [error]: timebase mismatch with 1st pass (1/100 vs 1/50)
[16:40:43] encx264: x264_encoder_open failed.
[16:40:43] Failure to initialise thread 'H.264/AVC encoder (libx264)'
[16:40:43] comb detect: heavy 0 | light 0 | uncombed 0 | total 0

[11:25:19] gtkgui: HandBrake 1.0.2 (2017012400) - Linux x86_64 - https://handbrake.fr
[11:25:19] hb_init: starting libhb thread
[11:25:19] hb_init: starting libhb thread
[11:25:19] hb_init: starting libhb thread
[11:25:27] CPU: Intel(R) Pentium(R) CPU G3220 @ 3.00GHz
[11:25:27]  - Intel microarchitecture Haswell
[11:25:27]  - logical processor count: 2
[11:25:27] hb_scan: path=/dev/sr0, title_index=0
disc.c:352: error opening file BDMV/index.bdmv
disc.c:352: error opening file BDMV/BACKUP/index.bdmv
[11:25:27] bd: not a bd - trying as a stream/file instead
[11:25:27] dvd: Region mask 0xff
[11:25:27] dvd: Warning, DVD device has no region set
libdvdnav: Using dvdnav version 5.0.1
libdvdnav: DVD Title: DVD_NAME_S1_DISC1
libdvdnav: DVD Serial Number: XXXXXXXX
libdvdnav: DVD Title (Alternative): DVD_NAME_S1_DISC1
libdvdnav: DVD disk reports itself with Region mask 0x00fd0000. Regions: 2
[11:25:27] scan: DVD has 11 title(s)
[11:25:27] scan: scanning title 1
[11:25:27] scan: opening IFO for VTS 1
[11:25:27] scan: duration is 00:00:10 (10000 ms)
[11:25:27] pgc_id: 1, pgn: 1: pgc: 0x7f1ec800f100
[11:25:27] scan: vts=1, ttn=1, cells=0->0, blocks=0->70, 71 blocks
[11:25:27] scan: title 1 has 1 chapters
[11:25:27] scan: chap 1 c=0->0, b=0->70 (71), 10000 ms
[11:25:27] scan: aspect = 16:9
[11:25:27] scan: scanning title 2
[11:25:27] scan: opening IFO for VTS 2
[11:25:27] scan: duration is 00:22:32 (1352000 ms)
[11:25:27] pgc_id: 1, pgn: 1: pgc: 0x7f1ec80102a0
[11:25:27] scan: vts=2, ttn=1, cells=0->4, blocks=0->527571, 527572 blocks
[11:25:27] scan: checking audio 1
[11:25:27] scan: id=0x80bd, lang=English (AC3), 3cc=eng ext=0
[11:25:27] scan: checking subtitle 1
[11:25:27] scan: id=0x20bd, lang=English, 3cc=eng ext=0
[11:25:27] scan: title 2 has 5 chapters
[11:25:27] scan: chap 1 c=0->0, b=0->87492 (87493), 225800 ms
[11:25:27] scan: chap 2 c=1->1, b=87493->173918 (86426), 203840 ms
[11:25:27] scan: chap 3 c=2->2, b=173919->349649 (175731), 442800 ms
[11:25:27] scan: chap 4 c=3->3, b=349650->378907 (29258), 72440 ms
[11:25:27] scan: chap 5 c=4->4, b=378908->527571 (148664), 407120 ms
[11:25:27] scan: aspect = 4:3
[11:25:27] scan: scanning title 3
[11:25:27] scan: opening IFO for VTS 2
[11:25:27] scan: duration is 00:22:27 (1347000 ms)
[11:25:27] pgc_id: 2, pgn: 1: pgc: 0x7f1ec8011190
[11:25:27] scan: vts=2, ttn=2, cells=0->4, blocks=527572->1046836, 519265 blocks
[11:25:27] scan: checking audio 1
[11:25:27] scan: id=0x80bd, lang=English (AC3), 3cc=eng ext=0
[11:25:27] scan: checking subtitle 1
[11:25:27] scan: id=0x20bd, lang=English, 3cc=eng ext=0
[11:25:27] scan: title 3 has 5 chapters
[11:25:27] scan: chap 1 c=0->0, b=527572->618307 (90736), 225520 ms
[11:25:27] scan: chap 2 c=1->1, b=618308->666240 (47933), 126040 ms
[11:25:27] scan: chap 3 c=2->2, b=666241->748714 (82474), 221080 ms
[11:25:27] scan: chap 4 c=3->3, b=748715->919951 (171237), 454160 ms
[11:25:27] scan: chap 5 c=4->4, b=919952->1046836 (126885), 320200 ms
[11:25:27] scan: aspect = 4:3
[11:25:27] scan: scanning title 4
[11:25:27] scan: opening IFO for VTS 2
[11:25:27] scan: duration is 00:22:28 (1348840 ms)
[11:25:27] pgc_id: 3, pgn: 1: pgc: 0x7f1ec8010950
[11:25:27] scan: vts=2, ttn=3, cells=0->4, blocks=1046837->1556501, 509665 blocks
[11:25:27] scan: checking audio 1
[11:25:27] scan: id=0x80bd, lang=English (AC3), 3cc=eng ext=0
[11:25:27] scan: checking subtitle 1
[11:25:27] scan: id=0x20bd, lang=English, 3cc=eng ext=0
[11:25:27] scan: title 4 has 5 chapters
[11:25:27] scan: chap 1 c=0->0, b=1046837->1129863 (83027), 203640 ms
[11:25:27] scan: chap 2 c=1->1, b=1129864->1249526 (119663), 312800 ms
[11:25:27] scan: chap 3 c=2->2, b=1249527->1371182 (121656), 337240 ms
[11:25:27] scan: chap 4 c=3->3, b=1371183->1403570 (32388), 85800 ms
[11:25:27] scan: chap 5 c=4->4, b=1403571->1556501 (152931), 409360 ms
[11:25:27] scan: aspect = 4:3
[11:25:27] scan: scanning title 5
[11:25:27] scan: opening IFO for VTS 2
[11:25:27] scan: duration is 00:22:33 (1353960 ms)
[11:25:27] pgc_id: 4, pgn: 1: pgc: 0x7f1ec8011560
[11:25:27] scan: vts=2, ttn=4, cells=0->4, blocks=1556502->2008515, 452014 blocks
[11:25:27] scan: checking audio 1
[11:25:27] scan: id=0x80bd, lang=English (AC3), 3cc=eng ext=0
[11:25:27] scan: checking subtitle 1
[11:25:27] scan: id=0x20bd, lang=English, 3cc=eng ext=0
[11:25:27] scan: title 5 has 5 chapters
[11:25:27] scan: chap 1 c=0->0, b=1556502->1628898 (72397), 211400 ms
[11:25:27] scan: chap 2 c=1->1, b=1628899->1718782 (89884), 255200 ms
[11:25:27] scan: chap 3 c=2->2, b=1718783->1829861 (111079), 335960 ms
[11:25:27] scan: chap 4 c=3->3, b=1829862->1955050 (125189), 372280 ms
[11:25:27] scan: chap 5 c=4->4, b=1955051->2008515 (53465), 179120 ms
[11:25:27] scan: aspect = 4:3
[11:25:27] scan: scanning title 6
[11:25:27] scan: opening IFO for VTS 2
[11:25:27] scan: duration is 00:22:32 (1352560 ms)
[11:25:27] pgc_id: 5, pgn: 1: pgc: 0x7f1ec80472d0
[11:25:27] scan: vts=2, ttn=5, cells=0->4, blocks=2008516->2536187, 527672 blocks
[11:25:27] scan: checking audio 1
[11:25:27] scan: id=0x80bd, lang=English (AC3), 3cc=eng ext=0
[11:25:27] scan: checking subtitle 1
[11:25:27] scan: id=0x20bd, lang=English, 3cc=eng ext=0
[11:25:27] scan: title 6 has 5 chapters
[11:25:27] scan: chap 1 c=0->0, b=2008516->2085833 (77318), 193000 ms
[11:25:27] scan: chap 2 c=1->1, b=2085834->2163199 (77366), 190200 ms
[11:25:27] scan: chap 3 c=2->2, b=2163200->2286281 (123082), 308560 ms
[11:25:27] scan: chap 4 c=3->3, b=2286282->2372200 (85919), 237320 ms
[11:25:27] scan: chap 5 c=4->4, b=2372201->2536187 (163987), 423480 ms
[11:25:27] scan: aspect = 4:3
[11:25:27] scan: scanning title 7
[11:25:27] scan: opening IFO for VTS 2
[11:25:27] scan: duration is 00:22:13 (1333760 ms)
[11:25:27] pgc_id: 6, pgn: 1: pgc: 0x7f1ec8047c80
[11:25:27] scan: vts=2, ttn=6, cells=0->4, blocks=2536188->2983179, 446992 blocks
[11:25:27] scan: checking audio 1
[11:25:27] scan: id=0x80bd, lang=English (AC3), 3cc=eng ext=0
[11:25:27] scan: checking subtitle 1
[11:25:27] scan: id=0x20bd, lang=English, 3cc=eng ext=0
[11:25:27] scan: title 7 has 5 chapters
[11:25:27] scan: chap 1 c=0->0, b=2536188->2595625 (59438), 169240 ms
[11:25:27] scan: chap 2 c=1->1, b=2595626->2707990 (112365), 321840 ms
[11:25:27] scan: chap 3 c=2->2, b=2707991->2875356 (167366), 471320 ms
[11:25:27] scan: chap 4 c=3->3, b=2875357->2943264 (67908), 236880 ms
[11:25:27] scan: chap 5 c=4->4, b=2943265->2983179 (39915), 134480 ms
[11:25:27] scan: aspect = 4:3
[11:25:27] scan: scanning title 8
[11:25:27] scan: opening IFO for VTS 2
[11:25:27] scan: duration is 00:22:31 (1351280 ms)
[11:25:27] pgc_id: 7, pgn: 1: pgc: 0x7f1ec8047150
[11:25:27] scan: vts=2, ttn=7, cells=0->4, blocks=2983180->3515250, 532071 blocks
[11:25:27] scan: checking audio 1
[11:25:27] scan: id=0x80bd, lang=English (AC3), 3cc=eng ext=0
[11:25:27] scan: checking subtitle 1
[11:25:27] scan: id=0x20bd, lang=English, 3cc=eng ext=0
[11:25:27] scan: title 8 has 5 chapters
[11:25:27] scan: chap 1 c=0->0, b=2983180->3052292 (69113), 164320 ms
[11:25:27] scan: chap 2 c=1->1, b=3052293->3176983 (124691), 313120 ms
[11:25:27] scan: chap 3 c=2->2, b=3176984->3302648 (125665), 320000 ms
[11:25:27] scan: chap 4 c=3->3, b=3302649->3437976 (135328), 347080 ms
[11:25:27] scan: chap 5 c=4->4, b=3437977->3515250 (77274), 206760 ms
[11:25:27] scan: aspect = 4:3
[11:25:27] scan: scanning title 9
[11:25:27] scan: opening IFO for VTS 2
[11:25:27] scan: duration is 00:00:00 (480 ms)
[11:25:27] scan: ignoring title (too short)
[11:25:27] scan: scanning title 10
[11:25:27] scan: opening IFO for VTS 2
[11:25:27] scan: duration is 00:00:00 (480 ms)
[11:25:27] scan: ignoring title (too short)
[11:25:27] scan: scanning title 11
[11:25:27] scan: opening IFO for VTS 3
[11:25:27] scan: duration is 00:00:26 (26840 ms)
[11:25:27] pgc_id: 1, pgn: 1: pgc: 0x7f1ec8063e90
[11:25:27] scan: vts=3, ttn=1, cells=0->0, blocks=0->9772, 9773 blocks
[11:25:27] scan: checking audio 1
[11:25:27] scan: id=0x80bd, lang=English (AC3), 3cc=eng ext=0
[11:25:27] scan: title 11 has 1 chapters
[11:25:27] scan: chap 1 c=0->0, b=0->9772 (9773), 26840 ms
[11:25:27] scan: aspect = 16:9
libdvdnav: DVD disk reports itself with Region mask 0x00fd0000. Regions: 2

libdvdread: Attempting to retrieve all CSS keys
libdvdread: This can take a _long_ time, please be patient

libdvdread: Get key for /VIDEO_TS/VTS_01_1.VOB at 0x0000013e
libdvdread: Error cracking CSS key for /VIDEO_TS/VTS_01_1.VOB (0x0000013e)!!
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_02_0.VOB at 0x000001c7
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_02_1.VOB at 0x0000ce9c
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_03_1.VOB at 0x00367256
libdvdread: Error cracking CSS key for /VIDEO_TS/VTS_03_1.VOB (0x00367256)!!
libdvdread: Elapsed time 1
libdvdread: Found 3 VTS's
libdvdread: Elapsed time 1
[11:25:28] scan: decoding previews for title 1
libdvdnav: DVD disk reports itself with Region mask 0x00fd0000. Regions: 2
[11:25:28] scan: title angle(s) 1
[11:25:28] Warning: Could not read data for preview 1, skipped
[11:25:28] scan: decoding previews for title 1
libdvdnav: DVD disk reports itself with Region mask 0x00fd0000. Regions: 2
[11:25:28] scan: title angle(s) 1
[11:25:28] Warning: Could not read data for preview 1, skipped
[11:25:28] scan: decoding previews for title 2
libdvdnav: DVD disk reports itself with Region mask 0x00fd0000. Regions: 2
[11:25:28] scan: title angle(s) 1
[ac3 @ 0x7f1ec80136e0] frame sync error
[11:25:28] scan: audio 0x80bd: ac3, rate=48000Hz, bitrate=192000 English (AC3) (2.0 ch)
[11:25:28] scan: 10 previews, 720x576, 25.000 fps, autocrop = 0/0/10/8, aspect 4:3, PAR 16:15
[11:25:28] scan: decoding previews for title 3
libdvdnav: DVD disk reports itself with Region mask 0x00fd0000. Regions: 2
[11:25:28] scan: title angle(s) 1
[ac3 @ 0x7f1ec8368fc0] frame sync error
[11:25:28] scan: audio 0x80bd: ac3, rate=48000Hz, bitrate=192000 English (AC3) (2.0 ch)
[11:25:28] scan: 10 previews, 720x576, 25.000 fps, autocrop = 0/0/10/8, aspect 4:3, PAR 16:15
[11:25:28] scan: decoding previews for title 4
libdvdnav: DVD disk reports itself with Region mask 0x00fd0000. Regions: 2
[11:25:28] scan: title angle(s) 1
[ac3 @ 0x7f1ec8367be0] frame sync error
[11:25:28] scan: audio 0x80bd: ac3, rate=48000Hz, bitrate=192000 English (AC3) (2.0 ch)
[11:25:28] scan: 10 previews, 720x576, 25.000 fps, autocrop = 0/0/10/8, aspect 4:3, PAR 16:15
[11:25:28] scan: decoding previews for title 5
libdvdnav: DVD disk reports itself with Region mask 0x00fd0000. Regions: 2
[11:25:28] scan: title angle(s) 1
[ac3 @ 0x7f1ec8401720] frame sync error
[11:25:28] scan: audio 0x80bd: ac3, rate=48000Hz, bitrate=192000 English (AC3) (2.0 ch)
[11:25:28] scan: 10 previews, 720x576, 25.000 fps, autocrop = 0/0/4/2, aspect 4:3, PAR 16:15
[11:25:28] scan: decoding previews for title 6
libdvdnav: DVD disk reports itself with Region mask 0x00fd0000. Regions: 2
[11:25:28] scan: title angle(s) 1
[ac3 @ 0x7f1ec83f5220] frame sync error
[11:25:28] scan: audio 0x80bd: ac3, rate=48000Hz, bitrate=192000 English (AC3) (2.0 ch)
[11:25:28] scan: 10 previews, 720x576, 25.000 fps, autocrop = 0/0/10/8, aspect 4:3, PAR 16:15
[11:25:28] scan: decoding previews for title 7
libdvdnav: DVD disk reports itself with Region mask 0x00fd0000. Regions: 2
[11:25:28] scan: title angle(s) 1
[ac3 @ 0x7f1ec840b720] frame sync error
[11:25:28] scan: audio 0x80bd: ac3, rate=48000Hz, bitrate=192000 English (AC3) (2.0 ch)
[11:25:28] scan: 10 previews, 720x576, 25.000 fps, autocrop = 0/0/0/0, aspect 4:3, PAR 16:15
[11:25:28] scan: decoding previews for title 8
libdvdnav: DVD disk reports itself with Region mask 0x00fd0000. Regions: 2
[11:25:28] scan: title angle(s) 1
[ac3 @ 0x7f1ec840b200] frame sync error
[11:25:28] scan: audio 0x80bd: ac3, rate=48000Hz, bitrate=192000 English (AC3) (2.0 ch)
[11:25:28] scan: 10 previews, 720x576, 25.000 fps, autocrop = 0/0/10/8, aspect 4:3, PAR 16:15
[11:25:28] scan: decoding previews for title 11
libdvdnav: DVD disk reports itself with Region mask 0x00fd0000. Regions: 2
[11:25:28] scan: title angle(s) 1
[ac3 @ 0x7f1ec8017e40] frame sync error
[ac3 @ 0x7f1ec8017e40] frame sync error
[11:25:29] scan: audio 0x80bd: ac3, rate=48000Hz, bitrate=384000 English (AC3) (5.1 ch)
[11:25:29] scan: 10 previews, 720x576, 25.000 fps, autocrop = 0/0/0/0, aspect 16:9, PAR 64:45
[11:25:29] Title is likely interlaced or telecined (8 out of 10 previews). You should do something about that.
[11:25:29] libhb: scan thread found 8 valid title(s)
[11:26:03] gtkgui: Custom Preset: /Animation - Slow
[11:26:03] 1 job(s) to process
[11:26:03] 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": "auto",
                "Track": 0
            }
        ],
        "CopyMask": [
            "copy:aac"
        ],
        "FallbackEncoder": "av_aac"
    },
    "Destination": {
        "ChapterList": [
            {
                "Name": "Chapter 1"
            },
            {
                "Name": "Chapter 2"
            },
            {
                "Name": "Chapter 3"
            },
            {
                "Name": "Chapter 4"
            },
            {
                "Name": "Chapter 5"
            }
        ],
        "ChapterMarkers": true,
        "File": "/media/mark/c8f825a8-c3a9-4e7b-a9fa-4cfb2b6d432b/DVD/FGD1S1/DVD NAME S1 Disc1 - 2 - 1-5 - 500kbps.mkv",
        "Mp4Options": {
            "IpodAtom": false,
            "Mp4Optimize": false
        },
        "Mux": "mkv"
    },
    "Filters": {
        "FilterList": [
            {
                "ID": 2,
                "Settings": {
                    "plane": "0",
                    "skip-bottom": "4",
                    "skip-left": "1",
                    "skip-right": "1",
                    "skip-top": "4"
                }
            },
            {
                "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": 5,
                "Settings": {
                    "mode": "7"
                }
            },
            {
                "ID": 6,
                "Settings": {
                    "mode": 1
                }
            },
            {
                "ID": 9,
                "Settings": {
                    "cb-frame-count": 4,
                    "cb-origin-tune": 0.14999999999999999,
                    "cb-patch-size": 5,
                    "cb-prefilter": 0,
                    "cb-range": 7,
                    "cb-strength": 4.0,
                    "y-frame-count": 4,
                    "y-origin-tune": 0.14999999999999999,
                    "y-patch-size": 5,
                    "y-prefilter": 0,
                    "y-range": 7,
                    "y-strength": 5.0
                }
            },
            {
                "ID": 11,
                "Settings": {
                    "crop-bottom": 0,
                    "crop-left": 10,
                    "crop-right": 8,
                    "crop-top": 0,
                    "height": 576,
                    "width": 702
                }
            }
        ]
    },
    "Metadata": {
        "Name": "DVD_NAME_S1_DISC1"
    },
    "PAR": {
        "Den": 15,
        "Num": 16
    },
    "SequenceID": 0,
    "Source": {
        "Angle": 0,
        "Path": "/dev/sr0",
        "Range": {
            "End": 5,
            "Start": 1,
            "Type": "chapter"
        },
        "Title": 2
    },
    "Subtitle": {
        "Search": {
            "Burn": true,
            "Default": false,
            "Enable": false,
            "Forced": false
        },
        "SubtitleList": [
            {
                "Burn": false,
                "Default": false,
                "Forced": false,
                "Track": 0
            }
        ]
    },
    "Video": {
        "Bitrate": 500,
        "ColorMatrixCode": 0,
        "Encoder": "x264",
        "Level": "4.0",
        "OpenCL": false,
        "Options": "",
        "Preset": "slower",
        "Profile": "main",
        "QSV": {
            "AsyncDepth": 4,
            "Decode": false
        },
        "Tune": "animation",
        "Turbo": false,
        "TwoPass": true
    }
}
[11:26:03] CPU: Intel(R) Pentium(R) CPU G3220 @ 3.00GHz
[11:26:03]  - Intel microarchitecture Haswell
[11:26:03]  - logical processor count: 2
[11:26:03] hb_scan: path=/dev/sr0, title_index=2
disc.c:352: error opening file BDMV/index.bdmv
disc.c:352: error opening file BDMV/BACKUP/index.bdmv
[11:26:03] bd: not a bd - trying as a stream/file instead
[11:26:03] dvd: Region mask 0xff
[11:26:03] dvd: Warning, DVD device has no region set
libdvdnav: Using dvdnav version 5.0.1
libdvdnav: DVD Title: DVD_NAME_S1_DISC1
libdvdnav: DVD Serial Number: XXXXXXXX
libdvdnav: DVD Title (Alternative): DVD_NAME_S1_DISC1
libdvdnav: DVD disk reports itself with Region mask 0x00fd0000. Regions: 2
[11:26:03] scan: DVD has 11 title(s)
[11:26:03] scan: scanning title 2
[11:26:03] scan: opening IFO for VTS 2
[11:26:03] scan: duration is 00:22:32 (1352000 ms)
[11:26:03] pgc_id: 1, pgn: 1: pgc: 0x7f1ebc010d60
[11:26:03] scan: vts=2, ttn=1, cells=0->4, blocks=0->527571, 527572 blocks
[11:26:03] scan: checking audio 1
[11:26:03] scan: id=0x80bd, lang=English (AC3), 3cc=eng ext=0
[11:26:03] scan: checking subtitle 1
[11:26:03] scan: id=0x20bd, lang=English, 3cc=eng ext=0
[11:26:03] scan: title 2 has 5 chapters
[11:26:03] scan: chap 1 c=0->0, b=0->87492 (87493), 225800 ms
[11:26:03] scan: chap 2 c=1->1, b=87493->173918 (86426), 203840 ms
[11:26:03] scan: chap 3 c=2->2, b=173919->349649 (175731), 442800 ms
[11:26:03] scan: chap 4 c=3->3, b=349650->378907 (29258), 72440 ms
[11:26:03] scan: chap 5 c=4->4, b=378908->527571 (148664), 407120 ms
[11:26:03] scan: aspect = 4:3
[11:26:03] scan: decoding previews for title 2
libdvdnav: DVD disk reports itself with Region mask 0x00fd0000. Regions: 2
[11:26:03] scan: title angle(s) 1

libdvdread: Attempting to retrieve all CSS keys
libdvdread: This can take a _long_ time, please be patient

libdvdread: Get key for /VIDEO_TS/VTS_01_1.VOB at 0x0000013e
libdvdread: Error cracking CSS key for /VIDEO_TS/VTS_01_1.VOB (0x0000013e)!!
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_02_0.VOB at 0x000001c7
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_02_1.VOB at 0x0000ce9c
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_03_1.VOB at 0x00367256
libdvdread: Error cracking CSS key for /VIDEO_TS/VTS_03_1.VOB (0x00367256)!!
libdvdread: Elapsed time 0
libdvdread: Found 3 VTS's
libdvdread: Elapsed time 0
[11:26:03] scan: audio 0x80bd: ac3, rate=48000Hz, bitrate=192000 English (AC3) (2.0 ch)
[11:26:03] scan: 10 previews, 720x576, 25.000 fps, autocrop = 0/0/10/8, aspect 4:3, PAR 16:15
[11:26:04] libhb: scan thread found 1 valid title(s)
[11:26:04] starting job
[11:26:04] decomb filter thread started for segment 0
[11:26:04] decomb filter thread started for segment 1
[11:26:04] mask dilate thread started for segment 0
[11:26:04] NLMeans using SSE2 optimizations
[11:26:04] job configuration:
[11:26:04]  * source
[11:26:04]    + /dev/sr0
[11:26:04]    + title 2, chapter(s) 1 to 5
[11:26:04]  * destination
[11:26:04]    + /media/mark/c8f825a8-c3a9-4e7b-a9fa-4cfb2b6d432b/DVD/FGD1S1/DVD NAME S1 Disc1 - 2 - 1-5 - 500kbps.mkv
[11:26:04]    + container: Matroska (libavformat)
[11:26:04]      + chapter markers
[11:26:04]  * video track
[11:26:04]    + decoder: mpeg2video
[11:26:04]      + bitrate 8000 kbps
[11:26:04]    + filters
[11:26:04]      + Detelecine (pullup) (skip-left=1:skip-right=1:skip-top=4:skip-bottom=4:plane=0)
[11:26:04]      + 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)
[11:26:04]      + avfilter (yadif='mode=1:auto=1')
[11:26:04]        + yadif: mode=1, auto=1
[11:26:04]      + Framerate Shaper (mode=1)
[11:26:04]        + frame rate: 50.000 fps -> constant 50.000 fps
[11:26:04]      + Denoise (nlmeans) (y-strength=5:y-origin-tune=0.15:y-patch-size=5:y-range=7:y-frame-count=4:y-prefilter=0:cb-strength=4:cb-origin-tune=0.15:cb-patch-size=5:cb-range=7:cb-frame-count=4:cb-prefilter=0)
[11:26:04]      + Crop and Scale (width=702:height=576:crop-top=0:crop-bottom=0:crop-left=10:crop-right=8)
[11:26:04]        + source: 720 * 576, crop (0/0/10/8): 702 * 576, scale: 702 * 576
[11:26:04]    + Output geometry
[11:26:04]      + storage dimensions: 702 x 576
[11:26:04]      + pixel aspect ratio: 16 : 15
[11:26:04]      + display dimensions: 748 x 576
[11:26:04]    + encoder: H.264 (libx264)
[11:26:04]      + preset:  slower
[11:26:04]      + tune:    animation
[11:26:04]      + profile: main
[11:26:04]      + level:   4.0
[11:26:04]      + bitrate: 500 kbps, pass: 1
[11:26:04]  * subtitle track 1, English (track 0, id 0x20bd) Picture [VOBSUB] -> Passthrough
[11:26:04]  * audio track 1
[11:26:04]    + decoder: English (AC3) (2.0 ch) (track 1, id 0x80bd)
[11:26:04]      + bitrate: 192 kbps, samplerate: 48000 Hz
[11:26:04]    + mixdown: Stereo
[11:26:04]    + encoder: AAC (libavcodec)
[11:26:04]      + bitrate: 160 kbps, samplerate: 48000 Hz
[11:26:04] decomb check thread started for segment 1
[11:26:04] mask filter thread started for segment 0
[11:26:04] mask erode thread started for segment 0
[11:26:04] mask filter thread started for segment 1
[11:26:04] mask erode thread started for segment 1
[11:26:04] decomb check thread started for segment 0
[11:26:04] mask dilate thread started for segment 1
[11:26:04] NLMeans thread started for segment 0
[11:26:04] NLMeans thread started for segment 1
[11:26:04] dvd: Region mask 0xff
[11:26:04] dvd: Warning, DVD device has no region set
libdvdnav: Using dvdnav version 5.0.1
libdvdnav: DVD Title: DVD_NAME_S1_DISC1
libdvdnav: DVD Serial Number: XXXXXXXX
libdvdnav: DVD Title (Alternative): DVD_NAME_S1_DISC1
libdvdnav: DVD disk reports itself with Region mask 0x00fd0000. Regions: 2
libdvdnav: DVD disk reports itself with Region mask 0x00fd0000. Regions: 2
[11:26:04] sync: expecting 33800 video frames
[11:26:04] encx264: encoding at average bitrate 500
[11:26:04] encx264: unparsed options: direct=auto:8x8dct=0:level=4.0:aq-strength=0.6:me=umh:ref=16:bframes=5:analyse=all:b-adapt=2:deblock=1,1:subme=9:rc-lookahead=60:trellis=2:psy-rd=0.4,0:vbv-bufsize=25000:vbv-maxrate=20000
x264 [info]: using SAR=16/15
x264 [info]: using cpu capabilities: MMX2 SSE2Fast SSSE3 SSE4.2 LZCNT
x264 [info]: profile Main, level 4.0

libdvdread: Attempting to retrieve all CSS keys
libdvdread: This can take a _long_ time, please be patient

libdvdread: Get key for /VIDEO_TS/VTS_01_1.VOB at 0x0000013e
libdvdread: Error cracking CSS key for /VIDEO_TS/VTS_01_1.VOB (0x0000013e)!!
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_02_0.VOB at 0x000001c7
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_02_1.VOB at 0x0000ce9c
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_03_1.VOB at 0x00367256
libdvdread: Error cracking CSS key for /VIDEO_TS/VTS_03_1.VOB (0x00367256)!!
libdvdread: Elapsed time 0
libdvdread: Found 3 VTS's
libdvdread: Elapsed time 0
[11:26:04] sync: first pts audio 0x80bd is 0
[11:26:04] sync: first pts video is 7200
[11:26:04] sync: "Chapter 1" (1) at frame 1 time 7200
[11:27:21] sync: first pts subtitle 0x20bd is 622800
[12:19:43] sync: "Chapter 2" (2) at frame 5644 time 20322000
[13:05:37] sync: "Chapter 3" (3) at frame 10740 time 38667600
[14:47:22] sync: "Chapter 4" (4) at frame 21810 time 78519600
[15:04:26] sync: "Chapter 5" (5) at frame 23621 time 85039200
[16:39:41] reader: done. 1 scr changes
[16:40:42] work: average encoding speed for job is 1.792582 fps
[16:40:42] comb detect: heavy 25701 | light 2574 | uncombed 1687 | total 29962
[16:40:42] vfr: 67596 frames output, 0 dropped and 9360 duped for CFR/PFR
[16:40:42] vfr: lost time: 0 (0 frames)
[16:40:42] vfr: gained time: 0 (0 frames) (0 not accounted for)
[16:40:42] ac3-decoder done: 42249 frames, 0 decoder errors
[16:40:42] mpeg2video-decoder done: 33799 frames, 0 decoder errors
[16:40:42] sync: got 33797 frames, 33800 expected
[16:40:42] sync: framerate min 25.000 fps, max 25.000 fps, avg 25.000 fps
x264 [info]: frame I:476   Avg QP:28.75  size: 19414
x264 [info]: frame P:15382 Avg QP:33.28  size:  2833
x264 [info]: frame B:51738 Avg QP:40.63  size:   573
x264 [info]: consecutive B-frames:  1.7%  3.1%  5.4% 35.5% 15.5% 38.8%
x264 [info]: mb I  I16..4: 57.1%  0.0% 42.9%
x264 [info]: mb P  I16..4:  2.0%  0.0%  1.1%  P16..4: 20.9%  3.4%  2.4%  0.1%  0.0%    skip:70.1%
x264 [info]: mb B  I16..4:  0.1%  0.0%  0.0%  B16..8: 15.7%  0.8%  0.1%  direct: 0.6%  skip:82.7%  L0:58.6% L1:39.6% BI: 1.8%
x264 [info]: final ratefactor: 30.52
x264 [info]: direct mvs  spatial:99.9% temporal:0.1%
x264 [info]: coded y,uvDC,uvAC intra: 28.8% 39.4% 25.4% inter: 1.7% 5.1% 1.9%
x264 [info]: i16 v,h,dc,p: 61% 31%  6%  2%
x264 [info]: i4 v,h,dc,ddl,ddr,vr,hd,vl,hu: 24% 19% 23%  6%  6%  5%  5%  5%  6%
x264 [info]: i8c dc,h,v,p: 50% 28% 18%  5%
x264 [info]: Weighted P-Frames: Y:1.3% UV:0.5%
x264 [info]: ref P L0: 37.0%  4.2% 16.3%  9.8%  5.7%  5.6%  5.4%  2.4%  2.1%  2.1%  1.8%  1.7%  1.6%  1.6%  1.7%  1.0%
x264 [info]: ref B L0: 39.4% 14.2% 13.7%  8.4%  3.7%  4.5%  4.8%  1.9%  1.7%  1.8%  1.5%  1.5%  1.5%  0.9%  0.5%
x264 [info]: ref B L1: 86.7% 13.3%
x264 [info]: kb/s:488.11
[16:40:42] work: correcting framerate, 27000000/1080000 -> 27000000/540000
[16:40:42] starting job
[16:40:42] decomb filter thread started for segment 0
[16:40:42] mask erode thread started for segment 1
[16:40:42] mask dilate thread started for segment 0
[16:40:42] mask dilate thread started for segment 1
[16:40:42] NLMeans using SSE2 optimizations
[16:40:42] job configuration:
[16:40:42]  * source
[16:40:42]    + /dev/sr0
[16:40:42]    + title 2, chapter(s) 1 to 5
[16:40:42]  * destination
[16:40:42]    + /media/mark/c8f825a8-c3a9-4e7b-a9fa-4cfb2b6d432b/DVD/FGD1S1/DVD NAME S1 Disc1 - 2 - 1-5 - 500kbps.mkv
[16:40:42]    + container: Matroska (libavformat)
[16:40:42]      + chapter markers
[16:40:42]  * video track
[16:40:42]    + decoder: mpeg2video
[16:40:42]      + bitrate 8000 kbps
[16:40:42]    + filters
[16:40:42]      + Detelecine (pullup) (skip-left=1:skip-right=1:skip-top=4:skip-bottom=4:plane=0)
[16:40:42]      + 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)
[16:40:42]      + avfilter (yadif='mode=1:auto=1')
[16:40:42]        + yadif: mode=1, auto=1
[16:40:42]      + Framerate Shaper (mode=1)
[16:40:42]        + frame rate: 100.000 fps -> constant 100.000 fps
[16:40:42]      + Denoise (nlmeans) (y-strength=5:y-origin-tune=0.15:y-patch-size=5:y-range=7:y-frame-count=4:y-prefilter=0:cb-strength=4:cb-origin-tune=0.15:cb-patch-size=5:cb-range=7:cb-frame-count=4:cb-prefilter=0)
[16:40:42]      + Crop and Scale (width=702:height=576:crop-top=0:crop-bottom=0:crop-left=10:crop-right=8)
[16:40:42]        + source: 720 * 576, crop (0/0/10/8): 702 * 576, scale: 702 * 576
[16:40:42]    + Output geometry
[16:40:42]      + storage dimensions: 702 x 576
[16:40:42]      + pixel aspect ratio: 16 : 15
[16:40:42]      + display dimensions: 748 x 576
[16:40:42]    + encoder: H.264 (libx264)
[16:40:42]      + preset:  slower
[16:40:42]      + tune:    animation
[16:40:42]      + profile: main
[16:40:42]      + level:   4.0
[16:40:42]      + bitrate: 500 kbps, pass: 2
[16:40:42]  * subtitle track 1, English (track 0, id 0x20bd) Picture [VOBSUB] -> Passthrough
[16:40:42]  * audio track 1
[16:40:42]    + decoder: English (AC3) (2.0 ch) (track 1, id 0x80bd)
[16:40:42]      + bitrate: 192 kbps, samplerate: 48000 Hz
[16:40:42]    + mixdown: Stereo
[16:40:42]    + encoder: AAC (libavcodec)
[16:40:42]      + bitrate: 160 kbps, samplerate: 48000 Hz
[16:40:42] mask erode thread started for segment 0
[16:40:42] mask filter thread started for segment 1
[16:40:42] mask filter thread started for segment 0
[16:40:42] decomb check thread started for segment 1
[16:40:42] decomb check thread started for segment 0
[16:40:42] decomb filter thread started for segment 1
[16:40:42] NLMeans thread started for segment 0
[16:40:42] NLMeans thread started for segment 1
[16:40:42] dvd: Region mask 0xff
[16:40:42] dvd: Warning, DVD device has no region set
libdvdnav: Using dvdnav version 5.0.1
libdvdnav: DVD Title: DVD_NAME_S1_DISC1
libdvdnav: DVD Serial Number: XXXXXXXX
libdvdnav: DVD Title (Alternative): DVD_NAME_S1_DISC1
libdvdnav: DVD disk reports itself with Region mask 0x00fd0000. Regions: 2
libdvdnav: DVD disk reports itself with Region mask 0x00fd0000. Regions: 2
[16:40:43] sync: expecting 33797 video frames
[16:40:43] encx264: encoding at average bitrate 500
[16:40:43] encx264: unparsed options: direct=auto:8x8dct=0:level=4.0:aq-strength=0.6:me=umh:ref=16:bframes=5:analyse=all:b-adapt=2:deblock=1,1:subme=9:rc-lookahead=60:trellis=2:psy-rd=0.4,0:vbv-bufsize=25000:vbv-maxrate=20000
x264 [info]: using SAR=16/15
x264 [info]: using cpu capabilities: MMX2 SSE2Fast SSSE3 SSE4.2 LZCNT
x264 [error]: timebase mismatch with 1st pass (1/100 vs 1/50)
[16:40:43] encx264: x264_encoder_open failed.
[16:40:43] Failure to initialise thread 'H.264/AVC encoder (libx264)'
[16:40:43] comb detect: heavy 0 | light 0 | uncombed 0 | total 0
[16:40:43] vfr: 0 frames output, 0 dropped and 0 duped for CFR/PFR
[16:40:43] vfr: lost time: 0 (0 frames)
[16:40:43] vfr: gained time: 0 (0 frames) (0 not accounted for)
[16:40:43] ac3-decoder done: 0 frames, 0 decoder errors
[16:40:43] sync: got 0 frames, 33797 expected
[16:40:43] libhb: work result = 3
[16:40:43] gtkgui: Custom Preset: /Animation - Slow
[16:40:43] 1 job(s) to process
[16:40:43] 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": "auto",
                "Track": 0
            }
        ],
        "CopyMask": [
            "copy:aac"
        ],
        "FallbackEncoder": "av_aac"
    },
    "Destination": {
        "ChapterList": [
            {
                "Name": "Chapter 1"
            },
            {
                "Name": "Chapter 2"
            },
            {
                "Name": "Chapter 3"
            },
            {
                "Name": "Chapter 4"
            },
            {
                "Name": "Chapter 5"
            }
        ],
        "ChapterMarkers": true,
        "File": "/media/mark/c8f825a8-c3a9-4e7b-a9fa-4cfb2b6d432b/DVD/FGD1S1/DVD NAME S1 Disc1 - 3 - 1-5 - 500kbps.mkv",
        "Mp4Options": {
            "IpodAtom": false,
            "Mp4Optimize": false
        },
        "Mux": "mkv"
    },
    "Filters": {
        "FilterList": [
            {
                "ID": 2,
                "Settings": {
                    "plane": "0",
                    "skip-bottom": "4",
                    "skip-left": "1",
                    "skip-right": "1",
                    "skip-top": "4"
                }
            },
            {
                "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": 5,
                "Settings": {
                    "mode": "7"
                }
            },
            {
                "ID": 6,
                "Settings": {
                    "mode": 1
                }
            },
            {
                "ID": 9,
                "Settings": {
                    "cb-frame-count": 4,
                    "cb-origin-tune": 0.14999999999999999,
                    "cb-patch-size": 5,
                    "cb-prefilter": 0,
                    "cb-range": 7,
                    "cb-strength": 4.0,
                    "y-frame-count": 4,
                    "y-origin-tune": 0.14999999999999999,
                    "y-patch-size": 5,
                    "y-prefilter": 0,
                    "y-range": 7,
                    "y-strength": 5.0
                }
            },
            {
                "ID": 11,
                "Settings": {
                    "crop-bottom": 0,
                    "crop-left": 10,
                    "crop-right": 8,
                    "crop-top": 0,
                    "height": 576,
                    "width": 702
                }
            }
        ]
    },
    "Metadata": {
        "Name": "DVD_NAME_S1_DISC1"
    },
    "PAR": {
        "Den": 15,
        "Num": 16
    },
    "SequenceID": 0,
    "Source": {
        "Angle": 0,
        "Path": "/dev/sr0",
        "Range": {
            "End": 5,
            "Start": 1,
            "Type": "chapter"
        },
        "Title": 3
    },
    "Subtitle": {
        "Search": {
            "Burn": true,
            "Default": false,
            "Enable": false,
            "Forced": false
        },
        "SubtitleList": [
            {
                "Burn": false,
                "Default": false,
                "Forced": false,
                "Track": 0
            }
        ]
    },
    "Video": {
        "Bitrate": 500,
        "ColorMatrixCode": 0,
        "Encoder": "x264",
        "Level": "4.0",
        "OpenCL": false,
        "Options": "",
        "Preset": "slower",
        "Profile": "main",
        "QSV": {
            "AsyncDepth": 4,
            "Decode": false
        },
        "Tune": "animation",
        "Turbo": false,
        "TwoPass": true
    }
}
[16:40:43] CPU: Intel(R) Pentium(R) CPU G3220 @ 3.00GHz
[16:40:43]  - Intel microarchitecture Haswell
[16:40:43]  - logical processor count: 2
[16:40:43] hb_scan: path=/dev/sr0, title_index=3
disc.c:352: error opening file BDMV/index.bdmv
disc.c:352: error opening file BDMV/BACKUP/index.bdmv
[16:40:43] bd: not a bd - trying as a stream/file instead
[16:40:43] dvd: Region mask 0xff
[16:40:43] dvd: Warning, DVD device has no region set
libdvdnav: Using dvdnav version 5.0.1
libdvdnav: DVD Title: DVD_NAME_S1_DISC1
libdvdnav: DVD Serial Number: XXXXXXXX
libdvdnav: DVD Title (Alternative): DVD_NAME_S1_DISC1
libdvdnav: DVD disk reports itself with Region mask 0x00fd0000. Regions: 2
[16:40:43] scan: DVD has 11 title(s)
[16:40:43] scan: scanning title 3
[16:40:43] scan: opening IFO for VTS 2
[16:40:43] scan: duration is 00:22:27 (1347000 ms)
[16:40:43] pgc_id: 2, pgn: 1: pgc: 0x7f1e9c00ba20
[16:40:43] scan: vts=2, ttn=2, cells=0->4, blocks=527572->1046836, 519265 blocks
[16:40:43] scan: checking audio 1
[16:40:43] scan: id=0x80bd, lang=English (AC3), 3cc=eng ext=0
[16:40:43] scan: checking subtitle 1
[16:40:43] scan: id=0x20bd, lang=English, 3cc=eng ext=0
[16:40:43] scan: title 3 has 5 chapters
[16:40:43] scan: chap 1 c=0->0, b=527572->618307 (90736), 225520 ms
[16:40:43] scan: chap 2 c=1->1, b=618308->666240 (47933), 126040 ms
[16:40:43] scan: chap 3 c=2->2, b=666241->748714 (82474), 221080 ms
[16:40:43] scan: chap 4 c=3->3, b=748715->919951 (171237), 454160 ms
[16:40:43] scan: chap 5 c=4->4, b=919952->1046836 (126885), 320200 ms
[16:40:43] scan: aspect = 4:3
[16:40:43] scan: decoding previews for title 3
libdvdnav: DVD disk reports itself with Region mask 0x00fd0000. Regions: 2
[16:40:43] scan: title angle(s) 1

libdvdread: Attempting to retrieve all CSS keys
libdvdread: This can take a _long_ time, please be patient

libdvdread: Get key for /VIDEO_TS/VTS_01_1.VOB at 0x0000013e
libdvdread: Error cracking CSS key for /VIDEO_TS/VTS_01_1.VOB (0x0000013e)!!
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_02_0.VOB at 0x000001c7
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_02_1.VOB at 0x0000ce9c
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_03_1.VOB at 0x00367256
libdvdread: Error cracking CSS key for /VIDEO_TS/VTS_03_1.VOB (0x00367256)!!
libdvdread: Elapsed time 6
libdvdread: Found 3 VTS's
libdvdread: Elapsed time 6
[16:40:49] scan: audio 0x80bd: ac3, rate=48000Hz, bitrate=192000 English (AC3) (2.0 ch)
[16:40:51] scan: 10 previews, 720x576, 25.000 fps, autocrop = 0/0/10/8, aspect 4:3, PAR 16:15
[16:40:51] libhb: scan thread found 1 valid title(s)
[16:40:51] starting job
[16:40:51] decomb filter thread started for segment 0
[16:40:51] decomb filter thread started for segment 1
[16:40:51] decomb check thread started for segment 0
[16:40:51] decomb check thread started for segment 1
[16:40:51] mask filter thread started for segment 0
[16:40:51] mask filter thread started for segment 1
[16:40:51] mask erode thread started for segment 0
[16:40:51] mask erode thread started for segment 1
[16:40:51] mask dilate thread started for segment 0
[16:40:51] mask dilate thread started for segment 1
[16:40:51] NLMeans using SSE2 optimizations
[16:40:51] job configuration:
[16:40:51]  * source
[16:40:51]    + /dev/sr0
[16:40:51]    + title 3, chapter(s) 1 to 5
[16:40:51]  * destination
[16:40:51]    + /media/mark/c8f825a8-c3a9-4e7b-a9fa-4cfb2b6d432b/DVD/FGD1S1/DVD NAME S1 Disc1 - 3 - 1-5 - 500kbps.mkv
[16:40:51]    + container: Matroska (libavformat)
[16:40:51]      + chapter markers
[16:40:51]  * video track
[16:40:51]    + decoder: mpeg2video
[16:40:51]      + bitrate 8000 kbps
[16:40:51]    + filters
[16:40:51]      + Detelecine (pullup) (skip-left=1:skip-right=1:skip-top=4:skip-bottom=4:plane=0)
[16:40:51]      + 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)
[16:40:51]      + avfilter (yadif='mode=1:auto=1')
[16:40:51]        + yadif: mode=1, auto=1
[16:40:51]      + Framerate Shaper (mode=1)
[16:40:51]        + frame rate: 50.000 fps -> constant 50.000 fps
[16:40:51]      + Denoise (nlmeans) (y-strength=5:y-origin-tune=0.15:y-patch-size=5:y-range=7:y-frame-count=4:y-prefilter=0:cb-strength=4:cb-origin-tune=0.15:cb-patch-size=5:cb-range=7:cb-frame-count=4:cb-prefilter=0)
[16:40:51]      + Crop and Scale (width=702:height=576:crop-top=0:crop-bottom=0:crop-left=10:crop-right=8)
[16:40:51]        + source: 720 * 576, crop (0/0/10/8): 702 * 576, scale: 702 * 576
[16:40:51]    + Output geometry
[16:40:51]      + storage dimensions: 702 x 576
[16:40:51]      + pixel aspect ratio: 16 : 15
[16:40:51]      + display dimensions: 748 x 576
[16:40:51]    + encoder: H.264 (libx264)
[16:40:51]      + preset:  slower
[16:40:51]      + tune:    animation
[16:40:51]      + profile: main
[16:40:51]      + level:   4.0
[16:40:51]      + bitrate: 500 kbps, pass: 1
[16:40:51]  * subtitle track 1, English (track 0, id 0x20bd) Picture [VOBSUB] -> Passthrough
[16:40:51]  * audio track 1
[16:40:51]    + decoder: English (AC3) (2.0 ch) (track 1, id 0x80bd)
[16:40:51]      + bitrate: 192 kbps, samplerate: 48000 Hz
[16:40:51]    + mixdown: Stereo
[16:40:51]    + encoder: AAC (libavcodec)
[16:40:51]      + bitrate: 160 kbps, samplerate: 48000 Hz
[16:40:51] NLMeans thread started for segment 0
[16:40:51] NLMeans thread started for segment 1
[16:40:51] dvd: Region mask 0xff
[16:40:51] dvd: Warning, DVD device has no region set
libdvdnav: Using dvdnav version 5.0.1
libdvdnav: DVD Title: DVD_NAME_S1_DISC1
libdvdnav: DVD Serial Number: XXXXXXXX
libdvdnav: DVD Title (Alternative): DVD_NAME_S1_DISC1
libdvdnav: DVD disk reports itself with Region mask 0x00fd0000. Regions: 2
libdvdnav: DVD disk reports itself with Region mask 0x00fd0000. Regions: 2
[16:40:51] sync: expecting 33675 video frames
[16:40:51] encx264: encoding at average bitrate 500
[16:40:51] encx264: unparsed options: direct=auto:8x8dct=0:level=4.0:aq-strength=0.6:me=umh:ref=16:bframes=5:analyse=all:b-adapt=2:deblock=1,1:subme=9:rc-lookahead=60:trellis=2:psy-rd=0.4,0:vbv-bufsize=25000:vbv-maxrate=20000
x264 [info]: using SAR=16/15
x264 [info]: using cpu capabilities: MMX2 SSE2Fast SSSE3 SSE4.2 LZCNT
x264 [info]: profile Main, level 4.0

libdvdread: Attempting to retrieve all CSS keys
libdvdread: This can take a _long_ time, please be patient

libdvdread: Get key for /VIDEO_TS/VTS_01_1.VOB at 0x0000013e
libdvdread: Error cracking CSS key for /VIDEO_TS/VTS_01_1.VOB (0x0000013e)!!
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_02_0.VOB at 0x000001c7
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_02_1.VOB at 0x0000ce9c
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_03_1.VOB at 0x00367256
libdvdread: Error cracking CSS key for /VIDEO_TS/VTS_03_1.VOB (0x00367256)!!
libdvdread: Elapsed time 0
libdvdread: Found 3 VTS's
libdvdread: Elapsed time 0
[16:40:52] sync: first pts video is 0
[16:40:52] sync: "Chapter 1" (1) at frame 1 time 0
[16:40:52] sync: first pts audio 0x80bd is 5760
[16:41:30] sync: first pts subtitle 0x20bd is 417600
[17:32:40] sync: "Chapter 2" (2) at frame 5641 time 20304000
[18:01:59] sync: "Chapter 3" (3) at frame 8790 time 31640400

mpmc on 31 Jan 2017

Does "/media/mark/c8f825a8-c3a9-4e7b-a9fa-4cfb2b6d432b/DVD/FGD1S1/" exist on the filesystem?

What version of x264 do you have installed? It could be an incompatible or broken system version.

sr55 on 31 Jan 2017

Yes the folder does exist, I used handbrake to locate it (see screenie).

X264 version installed
```ark@mark-desktop2:~$ sudo apt-cache show x264
[sudo] password for mark:
Package: x264
Priority: optional
Section: universe/graphics
Installed-Size: 194
Maintainer: Ubuntu Developers ubuntu-devel-discuss@lists.ubuntu.com
Original-Maintainer: Debian Multimedia Maintainers pkg-multimedia-maintainers@lists.alioth.debian.org
Architecture: amd64
Version: 2:0.148.2643+git5c65704-1
Depends: libavcodec-ffmpeg56 (>= 7:2.4) | libavcodec-ffmpeg-extra56 (>= 7:2.4), libavformat-ffmpeg56 (>= 7:2.4), libavutil-ffmpeg54 (>= 7:2.4), libc6 (>= 2.15), libffms2-4 (>= 2.19), libgpac4 (>= 0.5.2), libswscale-ffmpeg3 (>= 7:2.4), libx264-148
Filename: pool/universe/x/x264/x264_0.148.2643+git5c65704-1_amd64.deb
Size: 75090
MD5sum: 0c1f3eb2010c0b2570f8684c4e60a62b
SHA1: 9800caef9967c33f7d3ccdbb32c7083da1464575
SHA256: 5ca4e44a359a362045c834a9bc0b70375dca3b7465073f5fc5acbc1a69abe9eb
Description-en_GB: video encoder for the H.264/MPEG-4 AVC standard
x264 is an advanced commandline encoder for creating H.264 (MPEG-4 AVC)
video streams.
.
x264 supports the following features:

CABAC (context-based adaptive binary arithmetic coding) and CAVLC
(context-based adaptive variable length coding
multiple reference frames
16x16, 8x8 and 4x4 intra-predicted macroblocks
all P-frame inter-predicted macroblock types
B-Inter-predicted macroblock types from 16x16 down to 8x8
rate distortion optimization
multiple rate control modes (constant quantizer, constant quality, single
or multipass ABR with the option of VBV)
scene cut detection
adaptive B-frame placement, with the option of keeping B-frames as
references / arbitrary frame order
8x8 and 4x4 adaptive spatial transform (high profile)
lossless mode (high 4:4:4 profile)
custom quantization matrices (high profile)
parallel encoding on multiple CPUs
interlaced streams
Description-md5: c8b0af6be32fb079afa76f8ff014d453
Homepage: http://www.videolan.org/developers/x264.html
Bugs: https://bugs.launchpad.net/ubuntu/+filebug
Origin: Ubuntu
```

desktop

mpmc on 1 Feb 2017

when using loose in presets it wont allow save 1920 * 1080 even as a custom preset

thatsmoi on 3 Feb 2017

😕1

@thatsmoi Please start a new issue for this, and include an activity log as requested.

bradleysepos on 3 Feb 2017

Hey folks. To make sure it wasn't my slower Linux system I tried the latest windows nightly on my other (faster) desktop & the same "timebase" error happens.

```HandBrake Nightly 20170129183038-56aca27-master (2017020201) - 64bit
OS: Microsoft Windows NT 10.0.14393.0 - 64bit
CPU: Intel(R) Core(TM) i3-4130 CPU @ 3.40GHz
Ram: 8130 MB,
GPU Information:
NVIDIA GeForce GTX 1050 Ti - 21.21.13.7633
Screen: 1920x1080
Temp Dir: C:\Users\Mark\AppData\Local\Temp\
Install Dir: C:\Program Files\HandBrake Nightly
Data Dir: C:\Users\Mark\AppData\Roaming\HandBrake Team\HandBrake\1.0.3.0

Starting Encode ...

[19:47:03] hb_init: starting libhb thread
[19:47:03] 1 job(s) to process
[19:47:03] json job:
{
"Audio": {
"AudioList": [
{
"Bitrate": 160,
"DRC": 0.0,
"Encoder": 65536,
"Gain": 0.0,
"Mixdown": 4,
"NormalizeMixLevel": false,
"Samplerate": 0,
"Track": 0,
"DitherMethod": 0
}
],
"CopyMask": [
1073807360,
1073743872,
1074003968,
1073750016,
1090519040,
1074790400,
1074266112,
1107296256
],
"FallbackEncoder": 2048
},
"Destination": {
"ChapterList": [
{
"Name": "Chapter 1"
},
{
"Name": "Chapter 2"
},
{
"Name": "Chapter 3"
},
{
"Name": "Chapter 4"
},
{
"Name": "Chapter 5"
}
],
"ChapterMarkers": true,
"File": "A:\DVD\FG - S1D1T1.mkv",
"Mp4Options": {
"IpodAtom": false,
"Mp4Optimize": false
},
"Mux": 2097152
},
"Filters": {
"FilterList": [
{
"ID": 2,
"Settings": {}
},
{
"ID": 5,
"Settings": {
"mode": "7"
}
},
{
"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": 9,
"Settings": {
"cb-frame-count": 4,
"cb-origin-tune": 0.15,
"cb-patch-size": 5,
"cb-prefilter": 0,
"cb-range": 7,
"cb-strength": 4.0,
"y-frame-count": 4,
"y-origin-tune": 0.15,
"y-patch-size": 5,
"y-prefilter": 0,
"y-range": 7,
"y-strength": 5.0
}
},
{
"ID": 11,
"Settings": {
"crop-bottom": "0",
"crop-left": "10",
"crop-right": "8",
"crop-top": "0",
"height": "576",
"width": "702"
}
},
{
"ID": 6,
"Settings": {
"mode": "1"
}
}
]
},
"PAR": {
"Num": 16,
"Den": 15
},
"Metadata": {},
"SequenceID": 0,
"Source": {
"Angle": 1,
"Range": {
"Type": "chapter",
"Start": 1,
"End": 5
},
"Title": 2,
"Path": "D:\"
},
"Subtitle": {
"Search": {
"Burn": false,
"Default": false,
"Enable": true,
"Forced": true
},
"SubtitleList": [
{
"Burn": false,
"Default": false,
"Forced": false,
"ID": 1,
"Offset": 0,
"Track": 0
}
]
},
"Video": {
"Encoder": 65536,
"Level": "4.0",
"Bitrate": 500,
"TwoPass": true,
"Turbo": false,
"ColorMatrixCode": 0,
"Options": "",
"Preset": "veryslow",
"Profile": "main",
"Tune": "animation",
"OpenCL": false,
"HWDecode": false,
"QSV": {
"Decode": false,
"AsyncDepth": 0
}
}
}
[19:47:03] CPU: Intel(R) Core(TM) i3-4130 CPU @ 3.40GHz
[19:47:03] - Intel microarchitecture Haswell
[19:47:03] - logical processor count: 4
[19:47:03] Intel Quick Sync Video support: no
[19:47:03] hb_scan: path=D:\, title_index=2
src/libbluray/disc/disc.c:352: error opening file BDMV\index.bdmv
src/libbluray/disc/disc.c:352: error opening file BDMV\BACKUP\index.bdmv
[19:47:03] bd: not a bd - trying as a stream/file instead
[19:47:04] scan: DVD has 11 title(s)
[19:47:04] scan: scanning title 2
[19:47:05] scan: opening IFO for VTS 2
[19:47:05] pgc_id: 1, pgn: 1: pgc: 000001FD36D7D6E0
[19:47:05] scan: vts=2, ttn=1, cells=0->4, blocks=0->527571, 527572 blocks
[19:47:05] scan: duration is 00:22:32 (1352000 ms)
[19:47:05] scan: checking audio 1
[19:47:05] scan: id=0x80bd, lang=English (AC3), 3cc=eng ext=0
[19:47:05] scan: checking subtitle 1
[19:47:05] scan: id=0x20bd, lang=English, 3cc=eng ext=0
[19:47:05] scan: title 2 has 5 chapters
[19:47:05] scan: chap 1 c=0->0, b=0->87492 (87493), 225800 ms
[19:47:05] scan: chap 2 c=1->1, b=87493->173918 (86426), 203840 ms
[19:47:05] scan: chap 3 c=2->2, b=173919->349649 (175731), 442800 ms
[19:47:05] scan: chap 4 c=3->3, b=349650->378907 (29258), 72440 ms
[19:47:05] scan: chap 5 c=4->4, b=378908->527571 (148664), 407120 ms
[19:47:05] scan: aspect = 4:3
[19:47:05] scan: decoding previews for title 2
libdvdread: Attempting to retrieve all CSS keys
libdvdread: This can take a _long_ time, please be patient
libdvdread: Get key for /VIDEO_TS/VTS_01_1.VOB at 0x0000013e
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_02_0.VOB at 0x000001c7
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_02_1.VOB at 0x0000ce9c
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_03_1.VOB at 0x00367256
libdvdread: Elapsed time 0
libdvdread: Found 3 VTS's
libdvdread: Elapsed time 0
[19:47:05] scan: title angle(s) 1
[ac3 @ 000001fd3739ed00] frame sync error
[19:47:05] scan: audio 0x80bd: ac3, rate=48000Hz, bitrate=192000 English (AC3) (2.0 ch)
[19:47:07] scan: 10 previews, 720x576, 25.000 fps, autocrop = 0/0/10/8, aspect 4:3, PAR 16:15
[19:47:07] libhb: scan thread found 1 valid title(s)
[19:47:07] starting job
[19:47:07] decomb filter thread started for segment 0
[19:47:07] decomb filter thread started for segment 1
[19:47:07] decomb filter thread started for segment 2
[19:47:07] decomb filter thread started for segment 3
[19:47:07] decomb check thread started for segment 0
[19:47:07] decomb check thread started for segment 1
[19:47:07] decomb check thread started for segment 2
[19:47:07] decomb check thread started for segment 3
[19:47:07] mask filter thread started for segment 0
[19:47:07] mask filter thread started for segment 1
[19:47:07] mask filter thread started for segment 2
[19:47:07] mask filter thread started for segment 3
[19:47:07] mask erode thread started for segment 0
[19:47:07] mask erode thread started for segment 2
[19:47:07] mask erode thread started for segment 3
[19:47:07] mask dilate thread started for segment 0
[19:47:07] mask dilate thread started for segment 1
[19:47:07] mask dilate thread started for segment 2
[19:47:07] mask dilate thread started for segment 3
[19:47:07] mask erode thread started for segment 1
[19:47:07] NLMeans using SSE2 optimizations
[19:47:07] NLMeans thread started for segment 0
[19:47:07] job configuration:
[19:47:07] * source
[19:47:07] + D:\
[19:47:07] NLMeans thread started for segment 1
[19:47:07] + title 2, chapter(s) 1 to 5
[19:47:07] * destination
[19:47:07] + A:\DVD\FG - S1D1T1.mkv
[19:47:07] + container: Matroska (libavformat)
[19:47:07] NLMeans thread started for segment 2
[19:47:07] + chapter markers
[19:47:07] * video track
[19:47:07] + decoder: mpeg2video
[19:47:07] + bitrate 8000 kbps
[19:47:07] NLMeans thread started for segment 3
[19:47:07] + filters
[19:47:07] + Detelecine (pullup) ()
[19:47:07] + 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)
[19:47:07] + avfilter (yadif='mode=1:auto=1')
[19:47:07] + yadif: mode=1, auto=1
[19:47:07] + Framerate Shaper (mode=1)
[19:47:07] + frame rate: 50.000 fps -> constant 50.000 fps
[19:47:07] + Denoise (nlmeans) (y-strength=5:y-origin-tune=0.15:y-patch-size=5:y-range=7:y-frame-count=4:y-prefilter=0:cb-strength=4:cb-origin-tune=0.15:cb-patch-size=5:cb-range=7:cb-frame-count=4:cb-prefilter=0)
[19:47:07] + Crop and Scale (width=702:height=576:crop-top=0:crop-bottom=0:crop-left=10:crop-right=8)
[19:47:07] + source: 720 * 576, crop (0/0/10/8): 702 * 576, scale: 702 * 576
[19:47:07] + Output geometry
[19:47:07] + storage dimensions: 702 x 576
[19:47:07] + pixel aspect ratio: 16 : 15
[19:47:07] + display dimensions: 748 x 576
[19:47:07] * Foreign Audio Search: Passthrough, Forced Only
[19:47:07] + subtitle, English (track 0, id 0x20bd) Picture [VOBSUB]
libdvdread: Attempting to retrieve all CSS keys
libdvdread: This can take a _long_ time, please be patient
libdvdread: Get key for /VIDEO_TS/VTS_01_1.VOB at 0x0000013e
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_02_0.VOB at 0x000001c7
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_02_1.VOB at 0x0000ce9c
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_03_1.VOB at 0x00367256
libdvdread: Elapsed time 0
libdvdread: Found 3 VTS's
libdvdread: Elapsed time 0
[19:47:07] sync: expecting 33800 video frames
[19:50:57] dvd: Skipping multi-angle cells 5-5
[19:50:57] reader: done. 1 scr changes
[19:50:57] work: average encoding speed for job is 0.000000 fps
[19:50:57] comb detect: heavy 0 | light 0 | uncombed 0 | total 0
[19:50:57] vfr: 0 frames output, 0 dropped and 0 duped for CFR/PFR
[19:50:57] vfr: lost time: 0 (0 frames)
[19:50:57] vfr: gained time: 0 (0 frames) (0 not accounted for)
[19:50:58] sync: got 0 frames, 33800 expected
[19:50:58] Subtitle track 0 (id 0x20bd) 'English': 363 hits (0 forced)
[19:50:58] No candidate detected during subtitle scan
[19:50:58] starting job
[19:50:58] decomb filter thread started for segment 0
[19:50:58] decomb check thread started for segment 3
[19:50:58] decomb filter thread started for segment 2
[19:50:58] decomb filter thread started for segment 3
[19:50:58] mask filter thread started for segment 1
[19:50:58] decomb check thread started for segment 1
[19:50:58] decomb check thread started for segment 2
[19:50:58] decomb filter thread started for segment 1
[19:50:58] mask filter thread started for segment 0
[19:50:58] decomb check thread started for segment 0
[19:50:58] mask filter thread started for segment 2
[19:50:58] mask filter thread started for segment 3
[19:50:58] mask erode thread started for segment 0
[19:50:58] mask erode thread started for segment 1
[19:50:58] mask erode thread started for segment 2
[19:50:58] mask erode thread started for segment 3
[19:50:58] mask dilate thread started for segment 0
[19:50:58] mask dilate thread started for segment 1
[19:50:58] mask dilate thread started for segment 2
[19:50:58] mask dilate thread started for segment 3
[19:50:58] NLMeans using SSE2 optimizations
[19:50:58] NLMeans thread started for segment 0
[19:50:58] NLMeans thread started for segment 1
[19:50:58] work: track 1, dithering not supported by codec
[19:50:58] NLMeans thread started for segment 2
[19:50:58] NLMeans thread started for segment 3
[19:50:58] job configuration:
[19:50:58] * source
[19:50:58] + D:\
[19:50:58] + title 2, chapter(s) 1 to 5
[19:50:58] * destination
[19:50:58] + A:\DVD\FG - S1D1T1.mkv
[19:50:58] + container: Matroska (libavformat)
[19:50:58] + chapter markers
[19:50:58] * video track
[19:50:58] + decoder: mpeg2video
[19:50:58] + bitrate 8000 kbps
[19:50:58] + filters
[19:50:58] + Detelecine (pullup) ()
[19:50:58] + 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)
[19:50:58] + avfilter (yadif='mode=1:auto=1')
[19:50:58] + yadif: mode=1, auto=1
[19:50:58] + Framerate Shaper (mode=1)
[19:50:58] + frame rate: 50.000 fps -> constant 50.000 fps
[19:50:58] + Denoise (nlmeans) (y-strength=5:y-origin-tune=0.15:y-patch-size=5:y-range=7:y-frame-count=4:y-prefilter=0:cb-strength=4:cb-origin-tune=0.15:cb-patch-size=5:cb-range=7:cb-frame-count=4:cb-prefilter=0)
[19:50:58] + Crop and Scale (width=702:height=576:crop-top=0:crop-bottom=0:crop-left=10:crop-right=8)
[19:50:58] + source: 720 * 576, crop (0/0/10/8): 702 * 576, scale: 702 * 576
[19:50:58] + Output geometry
[19:50:58] + storage dimensions: 702 x 576
[19:50:58] + pixel aspect ratio: 16 : 15
[19:50:58] + display dimensions: 748 x 576
[19:50:58] + encoder: H.264 (libx264)
[19:50:58] + preset: veryslow
[19:50:58] + tune: animation
[19:50:58] + profile: main
[19:50:58] + level: 4.0
[19:50:58] + bitrate: 500 kbps, pass: 1
[19:50:58] * subtitle track 1, English (track 0, id 0x20bd) Picture [VOBSUB] -> Passthrough
[19:50:58] * audio track 1
[19:50:58] + decoder: English (AC3) (2.0 ch) (track 1, id 0x80bd)
[19:50:58] + bitrate: 192 kbps, samplerate: 48000 Hz
[19:50:58] + mixdown: Stereo
[19:50:58] + encoder: AAC (libavcodec)
[19:50:58] + bitrate: 160 kbps, samplerate: 48000 Hz
libdvdread: Attempting to retrieve all CSS keys
libdvdread: This can take a _long_ time, please be patient
libdvdread: Get key for /VIDEO_TS/VTS_01_1.VOB at 0x0000013e
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_02_0.VOB at 0x000001c7
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_02_1.VOB at 0x0000ce9c
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_03_1.VOB at 0x00367256
libdvdread: Elapsed time 0
libdvdread: Found 3 VTS's
libdvdread: Elapsed time 0
[19:50:58] sync: expecting 33800 video frames
[19:50:58] encx264: encoding at average bitrate 500
[19:50:58] encx264: unparsed options: level=4.0:analyse=all:ref=16:8x8dct=0:bframes=10:vbv-maxrate=20000:deblock=1,1:b-adapt=2:direct=auto:me=umh:aq-strength=0.6:merange=24:subme=10:trellis=2:rc-lookahead=60:psy-rd=0.4,0:vbv-bufsize=25000
x264 [info]: using SAR=16/15
x264 [info]: using cpu capabilities: MMX2 SSE2Fast SSSE3 SSE4.2 AVX FMA3 AVX2 LZCNT BMI2
x264 [info]: profile Main, level 4.0
[19:50:58] sync: first pts audio 0x80bd is 0
[19:50:58] sync: first pts video is 7200
[19:50:58] sync: "Chapter 1" (1) at frame 1 time 7200
[19:52:01] sync: first pts subtitle 0x20bd is 622800
[20:34:39] sync: "Chapter 2" (2) at frame 5644 time 20322000
[21:14:29] sync: "Chapter 3" (3) at frame 10740 time 38667600
[22:40:56] sync: "Chapter 4" (4) at frame 21810 time 78519600
[22:55:04] sync: "Chapter 5" (5) at frame 23621 time 85039200
[00:14:11] dvd: Skipping multi-angle cells 5-5
[00:14:28] reader: done. 1 scr changes
[00:15:20] work: average encoding speed for job is 2.133595 fps
[00:15:20] comb detect: heavy 25701 | light 2574 | uncombed 1687 | total 29962
[00:15:20] vfr: 67596 frames output, 0 dropped and 9360 duped for CFR/PFR
[00:15:20] vfr: lost time: 0 (0 frames)
[00:15:20] vfr: gained time: 0 (0 frames) (0 not accounted for)
[00:15:20] ac3-decoder done: 42249 frames, 0 decoder errors
[00:15:20] mpeg2video-decoder done: 33799 frames, 0 decoder errors
[00:15:20] sync: got 33797 frames, 33800 expected
[00:15:20] sync: framerate min 25.000 fps, max 25.000 fps, avg 25.000 fps
x264 [info]: frame I:470 Avg QP:28.92 size: 19612
x264 [info]: frame P:12854 Avg QP:33.69 size: 3155
x264 [info]: frame B:54272 Avg QP:40.14 size: 603
x264 [info]: consecutive B-frames: 1.5% 2.6% 4.6% 23.1% 9.0% 18.5% 6.1% 15.2% 5.0% 12.6% 1.9%
x264 [info]: mb I I16..4: 55.9% 0.0% 44.1%
x264 [info]: mb P I16..4: 2.4% 0.0% 1.3% P16..4: 20.6% 4.0% 2.9% 0.2% 0.0% skip:68.6%
x264 [info]: mb B I16..4: 0.1% 0.0% 0.1% B16..8: 16.1% 0.9% 0.1% direct: 0.6% skip:82.1% L0:59.4% L1:38.2% BI: 2.3%
x264 [info]: final ratefactor: 29.97
x264 [info]: direct mvs spatial:99.9% temporal:0.1%
x264 [info]: coded y,uvDC,uvAC intra: 28.0% 35.6% 24.6% inter: 1.6% 4.3% 2.0%
x264 [info]: i16 v,h,dc,p: 62% 30% 6% 2%
x264 [info]: i4 v,h,dc,ddl,ddr,vr,hd,vl,hu: 24% 20% 23% 6% 5% 5% 5% 5% 6%
x264 [info]: i8c dc,h,v,p: 47% 30% 18% 5%
x264 [info]: Weighted P-Frames: Y:1.3% UV:0.5%
x264 [info]: ref P L0: 38.4% 4.7% 16.4% 8.0% 6.2% 5.3% 5.3% 2.5% 2.2% 1.9% 1.7% 1.6% 1.5% 1.5% 1.7% 1.0%
x264 [info]: ref B L0: 41.8% 15.4% 12.4% 6.3% 4.8% 4.5% 4.1% 2.1% 1.7% 1.6% 1.4% 1.4% 1.3% 0.9% 0.4%
x264 [info]: ref B L1: 87.8% 12.2%
x264 [info]: kb/s:488.19
[00:15:20] work: correcting framerate, 27000000/1080000 -> 27000000/540000
[00:15:20] starting job
[00:15:20] decomb filter thread started for segment 0
[00:15:20] decomb filter thread started for segment 1
[00:15:20] decomb check thread started for segment 1
[00:15:20] decomb check thread started for segment 0
[00:15:20] decomb filter thread started for segment 3
[00:15:20] decomb filter thread started for segment 2
[00:15:20] decomb check thread started for segment 2
[00:15:20] decomb check thread started for segment 3
[00:15:20] mask filter thread started for segment 0
[00:15:20] mask filter thread started for segment 1
[00:15:20] mask filter thread started for segment 2
[00:15:20] mask filter thread started for segment 3
[00:15:20] mask erode thread started for segment 0
[00:15:20] mask erode thread started for segment 1
[00:15:20] mask erode thread started for segment 2
[00:15:20] mask dilate thread started for segment 1
[00:15:20] mask dilate thread started for segment 0
[00:15:20] mask dilate thread started for segment 2
[00:15:20] mask dilate thread started for segment 3
[00:15:20] mask erode thread started for segment 3
[00:15:20] NLMeans using SSE2 optimizations
[00:15:20] NLMeans thread started for segment 0
[00:15:20] NLMeans thread started for segment 1
[00:15:20] NLMeans thread started for segment 2
[00:15:20] work: track 1, dithering not supported by codec
[00:15:20] NLMeans thread started for segment 3
[00:15:20] job configuration:
[00:15:20] * source
[00:15:20] + D:\
[00:15:20] + title 2, chapter(s) 1 to 5
[00:15:20] * destination
[00:15:20] + A:\DVD\FG - S1D1T1.mkv
[00:15:20] + container: Matroska (libavformat)
[00:15:20] + chapter markers
[00:15:20] * video track
[00:15:20] + decoder: mpeg2video
[00:15:20] + bitrate 8000 kbps
[00:15:20] + filters
[00:15:20] + Detelecine (pullup) ()
[00:15:20] + 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)
[00:15:20] + avfilter (yadif='mode=1:auto=1')
[00:15:20] + yadif: mode=1, auto=1
[00:15:20] + Framerate Shaper (mode=1)
[00:15:20] + frame rate: 100.000 fps -> constant 100.000 fps
[00:15:20] + Denoise (nlmeans) (y-strength=5:y-origin-tune=0.15:y-patch-size=5:y-range=7:y-frame-count=4:y-prefilter=0:cb-strength=4:cb-origin-tune=0.15:cb-patch-size=5:cb-range=7:cb-frame-count=4:cb-prefilter=0)
[00:15:20] + Crop and Scale (width=702:height=576:crop-top=0:crop-bottom=0:crop-left=10:crop-right=8)
[00:15:20] + source: 720 * 576, crop (0/0/10/8): 702 * 576, scale: 702 * 576
[00:15:20] + Output geometry
[00:15:20] + storage dimensions: 702 x 576
[00:15:20] + pixel aspect ratio: 16 : 15
[00:15:20] + display dimensions: 748 x 576
[00:15:20] + encoder: H.264 (libx264)
[00:15:20] + preset: veryslow
[00:15:20] + tune: animation
[00:15:20] + profile: main
[00:15:20] + level: 4.0
[00:15:20] + bitrate: 500 kbps, pass: 2
[00:15:20] * subtitle track 1, English (track 0, id 0x20bd) Picture [VOBSUB] -> Passthrough
[00:15:20] * audio track 1
[00:15:20] + decoder: English (AC3) (2.0 ch) (track 1, id 0x80bd)
[00:15:20] + bitrate: 192 kbps, samplerate: 48000 Hz
[00:15:20] + mixdown: Stereo
[00:15:20] + encoder: AAC (libavcodec)
[00:15:20] + bitrate: 160 kbps, samplerate: 48000 Hz
libdvdread: Attempting to retrieve all CSS keys
libdvdread: This can take a _long_ time, please be patient
libdvdread: Get key for /VIDEO_TS/VTS_01_1.VOB at 0x0000013e
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_02_0.VOB at 0x000001c7
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_02_1.VOB at 0x0000ce9c
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_03_1.VOB at 0x00367256
libdvdread: Elapsed time 0
libdvdread: Found 3 VTS's
libdvdread: Elapsed time 0
[00:15:20] sync: expecting 33797 video frames
[00:15:20] encx264: encoding at average bitrate 500
[00:15:20] encx264: unparsed options: level=4.0:analyse=all:ref=16:8x8dct=0:bframes=10:vbv-maxrate=20000:deblock=1,1:b-adapt=2:direct=auto:me=umh:aq-strength=0.6:merange=24:subme=10:trellis=2:rc-lookahead=60:psy-rd=0.4,0:vbv-bufsize=25000
x264 [info]: using SAR=16/15
x264 [info]: using cpu capabilities: MMX2 SSE2Fast SSSE3 SSE4.2 AVX FMA3 AVX2 LZCNT BMI2
x264 [error]: timebase mismatch with 1st pass (1/100 vs 1/50)
[00:15:20] comb detect: heavy 0 | light 0 | uncombed 0 | total 0
[00:15:20] vfr: 0 frames output, 0 dropped and 0 duped for CFR/PFR
[00:15:20] vfr: lost time: 0 (0 frames)
[00:15:20] vfr: gained time: 0 (0 frames) (0 not accounted for)
[00:15:20] ac3-decoder done: 0 frames, 0 decoder errors
[00:15:20] sync: got 0 frames, 33797 expected
[00:15:21] libhb: work result = 3

Encode Completed ...

```

mpmc on 3 Feb 2017

I wonder whether this is an issue with CFR Auto and Bob.

bradleysepos on 4 Feb 2017

@bradleysepos I'll try without CFR & Bob & post the log ASAP.

Edit:

With VFR & no Bob I get a file!

```
[10:00:10] 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": "auto",
"Track": 0
}
],
"CopyMask": [
"copy:mp3",
"copy:aac",
"copy:ac3",
"copy:dts",
"copy:dtshd",
"copy:eac3",
"copy:flac",
"copy:truehd"
],
"FallbackEncoder": "ac3"
},
"Destination": {
"ChapterList": [
{
"Name": "Chapter 1"
},
{
"Name": "Chapter 2"
},
{
"Name": "Chapter 3"
},
{
"Name": "Chapter 4"
},
{
"Name": "Chapter 5"
}
],
"ChapterMarkers": true,
"File": "/media/mark/c8f825a8-c3a9-4e7b-a9fa-4cfb2b6d432b/DVD/FGD1S1/DVD - 2 - 1-5 - 500kbps.mkv",
"Mp4Options": {
"IpodAtom": false,
"Mp4Optimize": false
},
"Mux": "mkv"
},
"Filters": {
"FilterList": [
{
"ID": 2,
"Settings": {
"plane": "0",
"skip-bottom": "4",
"skip-left": "1",
"skip-right": "1",
"skip-top": "4"
}
},
{
"ID": 6,
"Settings": {
"mode": 0
}
},
{
"ID": 11,
"Settings": {
"crop-bottom": 0,
"crop-left": 10,
"crop-right": 8,
"crop-top": 0,
"height": 576,
"width": 702
}
}
]
},
"Metadata": {
"Name": "DVD_S1_DISC1"
},
"PAR": {
"Den": 15,
"Num": 16
},
"SequenceID": 0,
"Source": {
"Angle": 0,
"Path": "/dev/sr0",
"Range": {
"End": 5,
"Start": 1,
"Type": "chapter"
},
"Title": 2
},
"Subtitle": {
"Search": {
"Burn": true,
"Default": false,
"Enable": false,
"Forced": false
},
"SubtitleList": []
},
"Video": {
"Bitrate": 500,
"ColorMatrixCode": 0,
"Encoder": "x264",
"Level": "4.0",
"OpenCL": false,
"Options": "",
"Preset": "veryslow",
"Profile": "main",
"QSV": {
"AsyncDepth": 4,
"Decode": false
},
"Tune": "animation",
"Turbo": false,
"TwoPass": true
}
}

mpmc on 4 Feb 2017

@jstebbins Seems bob + cfr may be causing a frame rate mismatch between first and second encode passes. Please take a look when you have time.

bradleysepos on 5 Feb 2017

Could you please post the text of the preset you are using? The presets can be found in the file ~/.config/ghb/presets.json on linux. I think the preset is broken or being read incorrectly somehow. The filter settings are missing the "rate" key that would tell it what CFR to use.

            {
                "ID": 6,
                "Settings": {
                    "mode": 0
                }
            },

jstebbins on 9 Feb 2017

Oh, nevermind. I'll bet you are using CFR and framerate "Same as Source".

Aside from being buggy, this isn't really what you want when using bob deinterlacing. Bob doubles the framerate of the source. So (if the code wasn't buggy) you are generating twice as many frames as the original source, and then dropping every other frame in the conversion to CFR.

jstebbins on 9 Feb 2017

@jstebbins

Aside from being buggy, this isn't really what you want when using bob deinterlacing. Bob doubles the framerate of the source. So (if the code wasn't buggy) you are generating twice as many frames as the original source, and then dropping every other frame in the conversion to CFR.

Thanks for the info! I think I'll stick with decomb from now on, as it's obvious that bob isn't as good on some sources as I was lead to believe!

I compared an old encode of the same programme/episode which I used decomb rather than bob, the difference is night & day. I was actually shocked at how much better it looked, and this is at a lower bitrate :rofl:

mpmc on 9 Feb 2017

The objective of bobbing is to sacrifice some visual resolution to better preserve motion. Since bob can increase framerate, you will need a little more data to encode those extra frames.

A very simplistic comparison would be, do you want your interlaced content to look more like a film or the 6 o'clock news? 25/30 fps progressive or ultra smooth 50/60 fps? I generally prefer the former, but depending on the source content the latter (bob) may be preferable. Sometimes it makes things look a bit hokey, so watch out for that.

bradleysepos on 9 Feb 2017

Thanks for the additional info @bradleysepos !

What was really jarring was the weird motion blur I noticed in certain scenes, it just looked strange & horrible! So, "it makes things look a bit hokey" indeed! :rofl:

mpmc on 9 Feb 2017

😄1

Was this page helpful?

0 / 5 - 0 ratings