How do I interpret this error log?

[jbhomer]

Description of problem or question:
First DVD encoded fine. Next couple I am getting errors. Brand new DVDs, seem to play fine.


HandBrake version (e.g., 1.0.0):
1.6.0



Operating system and version (e.g., Ubuntu 16.04 LTS, macOS 10.13 High Sierra, Windows 10 Creators Update):
Windows 11 Home



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

Code: Select all

HandBrake 1.6.0 (2022122800)
OS: Microsoft Windows NT 10.0.22621.0
CPU: Intel(R) Core(TM) i5-10210U CPU @ 1.60GHz
Ram: 7995 MB, 
GPU Information:
  Intel(R) UHD Graphics - 27.20.100.8935
Screen: 1366x768
Temp Dir: C:\Users\jbhom\AppData\Local\Temp\
Install Dir: D:\Program Files\HandBrake\
Data Dir: C:\Users\jbhom\AppData\Roaming\HandBrake

-------------------------------------------

 # Starting Encode ...

[15:14:30] base preset: Fast 1080p30 (Modified)
[15:14:30] Remote Process started with Process ID: 24160 using port: 8037. Max Allowed Instances: 1
[15:14:30] Worker: Starting HandBrake Engine ...
[15:14:30] Worker: Starting Web Server on port 8037 ...
[15:14:31] Worker: Disconnected worker monitoring enabled!
[15:14:31] Compile-time hardening features are enabled
[15:14:31] qsv: is available on this system
[15:14:31] vcn: not available on this system
Cannot load nvEncodeAPI64.dll
[15:14:31] hb_init: starting libhb thread
[15:14:31] Starting work at: Thu Dec 29 15:14:31 2022
[15:14:31] 1 job(s) to process
[15:14:31] json job:
{
  "Audio": {
    "AudioList": [
      {
        "Bitrate": 160,
        "DRC": 0,
        "Encoder": "av_aac",
        "Gain": 0,
        "Mixdown": 4,
        "NormalizeMixLevel": false,
        "Samplerate": 0,
        "Track": 0,
        "DitherMethod": 0
      }
    ],
    "CopyMask": [
      "copy:aac"
    ]
  },
  "Destination": {
    "ChapterList": [
      {
        "Name": "Chapter 1"
      },
      {
        "Name": "Chapter 2"
      },
      {
        "Name": "Chapter 3"
      },
      {
        "Name": "Chapter 4"
      },
      {
        "Name": "Chapter 5"
      },
      {
        "Name": "Chapter 6"
      },
      {
        "Name": "Chapter 7"
      },
      {
        "Name": "Chapter 8"
      },
      {
        "Name": "Chapter 9"
      },
      {
        "Name": "Chapter 10"
      },
      {
        "Name": "Chapter 11"
      },
      {
        "Name": "Chapter 12"
      },
      {
        "Name": "Chapter 13"
      },
      {
        "Name": "Chapter 14"
      },
      {
        "Name": "Chapter 15"
      },
      {
        "Name": "Chapter 16"
      },
      {
        "Name": "Chapter 17"
      },
      {
        "Name": "Chapter 18"
      },
      {
        "Name": "Chapter 19"
      }
    ],
    "ChapterMarkers": true,
    "AlignAVStart": true,
    "File": "D:\\Videos\\Movies\\GoodFellas.mp4",
    "Mp4Options": {
      "IpodAtom": false,
      "Mp4Optimize": false
    },
    "Mux": "av_mp4"
  },
  "Filters": {
    "FilterList": [
      {
        "ID": 4,
        "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": 14,
        "Settings": {
          "crop-bottom": "78",
          "crop-left": "20",
          "crop-right": "16",
          "crop-top": "70",
          "height": "332",
          "width": "684"
        }
      },
      {
        "ID": 7,
        "Settings": {
          "mode": "0"
        }
      }
    ]
  },
  "PAR": {
    "Num": 8,
    "Den": 9
  },
  "Metadata": {},
  "SequenceID": 0,
  "Source": {
    "Angle": 1,
    "Range": {
      "Type": "chapter",
      "Start": 1,
      "End": 19
    },
    "Title": 5,
    "Path": "E:\\"
  },
  "Subtitle": {
    "Search": {
      "Burn": false,
      "Default": false,
      "Enable": false,
      "Forced": false
    },
    "SubtitleList": [
      {
        "Burn": false,
        "Default": false,
        "Forced": false,
        "ID": 1,
        "Offset": 0,
        "Track": 0
      }
    ]
  },
  "Video": {
    "Encoder": "x264",
    "Level": "4.0",
    "TwoPass": false,
    "Turbo": false,
    "ColorMatrixCode": 0,
    "Options": "",
    "Preset": "fast",
    "Profile": "main",
    "Quality": 20,
    "QSV": {
      "Decode": false
    },
    "HardwareDecode": 0
  }
}
[15:14:31] CPU: Intel(R) Core(TM) i5-10210U CPU @ 1.60GHz
[15:14:31]  - Intel microarchitecture Kaby Lake
[15:14:31]  - logical processor count: 8
[15:14:31] Intel Quick Sync Video support: yes, gpu list: 0
[15:14:31] Intel Quick Sync Video integrated adapter with index 0
[15:14:31] Impl mfxhw64 library path: C:\Windows\System32\DriverStore\FileRepository\iigd_dch.inf_amd64_2b1d9e395a05d1c9\libmfxhw64.dll
[15:14:31]  - Intel Media SDK hardware: API 1.34 (minimum: 1.3)
[15:14:31]  - Decode support:  h264 hevc (8bit: yes, 10bit: yes)
[15:14:31]  - H.264 encoder: yes
[15:14:31]     - preferred implementation: hardware (1) via D3D11
[15:14:31]     - capabilities (hardware):  breftype icq+la+i+downs vsinfo chromalocinfo opt1 opt2+mbbrc+extbrc+trellis+repeatpps+ib_adapt+nmpslice
[15:14:31]  - H.265 encoder: yes (8bit: yes, 10bit: yes)
[15:14:31]     - preferred implementation: hardware (1) via D3D11
[15:14:31]     - capabilities (hardware):  bpyramid icq vsinfo masteringinfo cllinfo opt1
[15:14:31]  - AV1 encoder: no
[15:14:31] hb_scan: path=E:\, title_index=5
src/libbluray/disc/disc.c:437: error opening file BDMV\index.bdmv
src/libbluray/disc/disc.c:437: error opening file BDMV\BACKUP\index.bdmv
[15:14:31] bd: not a bd - trying as a stream/file instead
libdvdnav: vm: dvd_readlibdvdnav: Unable to open device file E:\.
_name failed
libdvdnav: DVD disk reports itself with Region mask 0x00fe0000. Regions: 01
libdvdread: Attempting to retrieve all CSS keys
libdvdread: This can take a _long_ time, please be patient
libdvdread: Get key for /VIDEO_TS/VIDEO_TS.VOB at 0x0000013c
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_01_0.VOB at 0x00000188
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_01_1.VOB at 0x000001a4
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_02_0.VOB at 0x00001706
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_02_1.VOB at 0x0000173f
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_03_0.VOB at 0x00002085
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_03_1.VOB at 0x000020be
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_04_0.VOB at 0x0000cbcb
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_04_1.VOB at 0x0000cc04
libdvdread: Elapsed time 0
libdvdread: Found 4 VTS's
libdvdread: Elapsed time 0
[15:14:35] scan: DVD has 5 title(s)
[15:14:35] scan: scanning title 5
[15:14:36] scan: duration is 02:25:27 (8727800 ms)
[15:14:36] pgc_id: 1, pgn: 1: pgc: 000001ed7deeb1d0
[15:14:36] scan: checking audio 1
[15:14:36] scan: id=0x80bd, lang=English (AC3), 3cc=eng ext=0
[15:14:36] scan: checking subtitle 1
[15:14:36] scan: id=0x20bd, lang=English (4:3) [VOBSUB], 3cc=eng ext=0
[15:14:36] scan: checking subtitle 2
[15:14:36] scan: id=0x21bd, lang=espaol (4:3) [VOBSUB], 3cc=spa ext=0
[15:14:36] scan: title 5 has 19 chapters
[15:14:36] scan: chap 1, 487100 ms
[15:14:36] scan: chap 2, 434400 ms
[15:14:36] scan: chap 3, 502934 ms
[15:14:36] scan: chap 4, 466266 ms
[15:14:36] scan: chap 5, 460233 ms
[15:14:36] scan: chap 6, 585967 ms
[15:14:36] scan: chap 7, 486734 ms
[15:14:36] scan: chap 8, 398600 ms
[15:14:36] scan: chap 9, 531834 ms
[15:14:36] scan: chap 10, 450500 ms
[15:14:36] scan: chap 11, 491066 ms
[15:14:36] scan: chap 12, 523166 ms
[15:14:36] scan: chap 13, 328000 ms
[15:14:36] scan: chap 14, 583233 ms
[15:14:36] scan: chap 15, 404266 ms
[15:14:36] scan: chap 16, 634033 ms
[15:14:36] scan: chap 17, 331934 ms
[15:14:36] scan: chap 18, 331700 ms
[15:14:36] scan: chap 19, 295667 ms
[15:14:36] scan: aspect = 4:3
[15:14:36] scan: decoding previews for title 5
libdvdnav: DVD disk reports itself with Region mask 0x00fe0000. Regions: 01
[15:14:36] scan: title angle(s) 1
[15:14:36] scan: audio 0x80bd: ac3, rate=48000Hz, bitrate=384000 English (AC3) (5.1 ch) (384 kbps)
[15:14:39] scan: 10 previews, 720x480, 23.976 fps, autocrop = 70/78/20/16, aspect 4:3, PAR 8:9, color profile: 6-1-6, chroma location: left
[15:14:39] libhb: scan thread found 1 valid title(s)
[15:14:39] qsv: integrated qsv adapter with index 0 has been selected
[15:14:39] Starting Task: Encoding Pass
[15:14:39] Skipping vfr filter
[15:14:39] work: track 1, dithering not supported by codec
[15:14:39] job configuration:
[15:14:39]  * source
[15:14:39]    + E:\
[15:14:39]    + title 5, chapter(s) 1 to 19
[15:14:39]  * destination
[15:14:39]    + D:\Videos\Movies\GoodFellas.mp4
[15:14:39]    + container: MPEG-4 (libavformat)
[15:14:39]      + align initial A/V stream timestamps
[15:14:39]      + chapter markers
[15:14:39]  * video track
[15:14:39]    + decoder: mpeg2video 8-bit (yuv420p)
[15:14:39]      + bitrate 200 kbps
[15:14:39]    + filters
[15:14:39]      + 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)
[15:14:39]      + Decomb (mode=39)
[15:14:39]      + Crop and Scale (width=684:height=332:crop-top=70:crop-bottom=78:crop-left=20:crop-right=16)
[15:14:39]        + source: 720 * 480, crop (70/78/20/16): 684 * 332, scale: 684 * 332
[15:14:39]    + Output geometry
[15:14:39]      + storage dimensions: 684 x 332
[15:14:39]      + pixel aspect ratio: 8 : 9
[15:14:39]      + display dimensions: 608 x 332
[15:14:39]    + encoder: H.264 (libx264)
[15:14:39]      + preset:  fast
[15:14:39]      + profile: main
[15:14:39]      + level:   4.0
[15:14:39]      + quality: 20.00 (RF)
[15:14:39]      + color profile: 6-1-6
[15:14:39]      + chroma location: left
[15:14:39]  * subtitle track 1, English (4:3) [VOBSUB] (track 0, id 0x20bd, Picture) -> Passthrough
[15:14:39]  * audio track 1
[15:14:39]    + decoder: English (AC3) (5.1 ch) (384 kbps) (track 1, id 0x80bd)
[15:14:39]      + bitrate: 384 kbps, samplerate: 48000 Hz
[15:14:39]    + mixdown: Stereo
[15:14:39]    + encoder: AAC (libavcodec)
[15:14:39]      + bitrate: 160 kbps, samplerate: 48000 Hz
libdvdnav: vm: dvdlibdvdnav: Unable to open device file E:\.
_read_name failed
libdvdnav: DVD disk reports itself with Region mask 0x00fe0000. Regions: 01
libdvdread: Attempting to retrieve all CSS keys
libdvdread: This can take a _long_ time, please be patient
libdvdread: Get key for /VIDEO_TS/VIDEO_TS.VOB at 0x0000013c
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_01_0.VOB at 0x00000188
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_01_1.VOB at 0x000001a4
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_02_0.VOB at 0x00001706
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_02_1.VOB at 0x0000173f
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_03_0.VOB at 0x00002085
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_03_1.VOB at 0x000020be
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_04_0.VOB at 0x0000cbcb
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_04_1.VOB at 0x0000cc04
libdvdread: Elapsed time 0
libdvdread: Found 4 VTS's
libdvdread: Elapsed time 0
libdvdnav: DVD disk reports itself with Region mask 0x00fe0000. Regions: 01
[15:14:40] sync: expecting 209257 video frames
[15:14:41] encx264: min-keyint: 24, keyint: 240
[15:14:41] encx264: encoding at constant RF 20.000000
[15:14:41] encx264: unparsed options: level=4.0:ref=2:8x8dct=0:weightp=1:subme=6:vbv-bufsize=25000:vbv-maxrate=20000:rc-lookahead=30
x264 [info]: using SAR=8/9
x264 [info]: using cpu capabilities: MMX2 SSE2Fast SSSE3 SSE4.2 AVX FMA3 BMI2 AVX2 UnalignedStack
x264 [info]: profile Main, level 4.0, 4:2:0, 8-bit
[15:14:41] sync: first pts video is 0
[15:14:41] sync: "Chapter 1" (1) at frame 1 time 0
[15:14:41] sync: first pts audio 0x80bd is 0
[15:14:54] 44.135757s: Film -> Video
[15:14:54] 44.177467s: Video -> Film
[15:15:00] sync: first pts subtitle 0x20bd is 5798793
[15:15:27] 162.011841s: Film -> Video
[15:15:27] 162.395569s: Video -> Film
[15:15:53] 254.437515s: Film -> Video
[15:15:53] 254.887955s: Video -> Film
[15:16:53] 455.805328s: Film -> Video
[15:16:53] 456.255829s: Video -> Film
[15:17:02] sync: "Chapter 2" (2) at frame 11704 time 43893349
[15:17:34] 603.619690s: Film -> Video
[15:17:34] 604.070129s: Video -> Film
[15:17:46] 648.164185s: Film -> Video
[15:17:46] 648.614624s: Video -> Film
[15:18:26] 807.823669s: Film -> Video
[15:18:26] 808.274109s: Video -> Film
[15:18:50] 901.083557s: Film -> Video
[15:18:50] 901.533936s: Video -> Film
[15:18:55] sync: "Chapter 3" (3) at frame 22142 time 83029947
[15:19:14] 997.846863s: Film -> Video
[15:19:14] 998.297363s: Video -> Film
[15:20:53] 1425.674194s: Film -> Video
[15:20:53] sync: "Chapter 4" (4) at frame 34218 time 128338460
[15:20:53] 1426.124756s: Video -> Film
[15:21:52] 1718.967285s: Film -> Video
[15:21:52] 1719.417725s: Video -> Film
[15:22:24] 1879.627686s: Film -> Video
[15:22:24] 1879.911255s: Video -> Film
[15:22:27] 1891.973389s: Film -> Video
[15:22:27] 1892.423828s: Video -> Film
[15:22:27] sync: "Chapter 5" (5) at frame 45418 time 170348178
[15:23:02] 2077.959229s: Film -> Video
[15:23:02] 2078.042725s: Video -> Film
[15:23:03] 2080.061279s: Film -> Video
[15:23:03] 2080.144775s: Video -> Film
[15:23:03] 2082.163330s: Film -> Video
[15:23:03] 2082.246826s: Video -> Film
[15:23:04] 2084.265625s: Film -> Video
[15:23:04] 2084.348877s: Video -> Film
[15:23:04] 2086.367676s: Film -> Video
[15:23:04] 2086.450928s: Video -> Film
[15:23:33] 2240.488281s: Film -> Video
[15:23:33] 2240.938721s: Video -> Film
[15:23:56] sync: "Chapter 6" (6) at frame 56476 time 211810601
[15:24:03] 2388.202393s: Film -> Video
[15:24:03] 2388.285889s: Video -> Film
[15:24:03] 2389.303711s: Film -> Video
[15:24:03] 2389.386963s: Video -> Film
[15:24:03] 2390.871826s: Film -> Video
[15:24:03] 2390.955078s: Video -> Film
[15:24:03] 2391.972900s: Film -> Video
[15:24:03] 2392.056396s: Video -> Film
[15:24:03] 2392.439941s: Film -> Video
[15:24:03] 2392.523438s: Video -> Film
[15:24:04] 2393.549561s: Film -> Video
[15:24:04] 2393.591309s: Video -> Film
[15:24:04] 2396.143799s: Film -> Video
[15:24:04] 2396.427490s: Video -> Film
[15:24:16] 2457.371582s: Film -> Video
[15:24:16] 2457.788574s: Video -> Film
[15:25:03] 2716.430420s: Film -> Video
[15:25:03] 2716.813965s: Video -> Film
[15:25:35] 2905.619385s: Film -> Video
[15:25:35] 2906.069824s: Video -> Film
[15:25:41] sync: "Chapter 7" (7) at frame 70559 time 264601837
[15:26:12] 3123.670410s: Film -> Video
[15:26:13] 3124.120850s: Video -> Film
[15:27:36] sync: "Chapter 8" (8) at frame 82244 time 308453144
[15:28:50] 3669.249023s: Film -> Video
[15:28:51] 3669.699219s: Video -> Film
[15:29:36] sync: "Chapter 9" (9) at frame 91815 time 344364521
[15:30:46] 4062.475098s: Film -> Video
[15:30:47] 4062.925537s: Video -> Film
[15:32:11] 4356.268555s: Film -> Video
[15:32:11] 4356.652344s: Video -> Film
[15:32:12] sync: "Chapter 10" (10) at frame 104585 time 392278136
dvdnav: Read Error, Expected NAV packet but none found.
[15:32:12] reader: done. 2 scr changes
[ac3 @ 000001ed24360980] expacc 126 is out-of-range
[15:32:13] work: average encoding speed for job is 99.517082 fps
[15:32:13] comb detect: heavy 534 | light 998 | uncombed 103098 | total 104630
[15:32:13] decomb: deinterlaced 534 | blended 998 | unfiltered 103098 | total 104630
[15:32:13] ac3-decoder done: 136259 frames, 0 decoder errors
[15:32:13] mpeg2video-decoder done: 104630 frames, 0 decoder errors
[15:32:13] sync: got 104630 frames, 209257 expected
[15:32:13] sync: framerate min 23.976 fps, max 40.018 fps, avg 23.995 fps
[aac @ 000001ed24022740] Ignoring attempt to flush encoder that doesn't support it
[aac @ 000001ed24022740] Qavg: 693.521
x264 [info]: frame I:987   Avg QP:17.82  size: 27435
x264 [info]: frame P:28086 Avg QP:20.71  size:  8529
x264 [info]: frame B:75557 Avg QP:22.61  size:  2629
x264 [info]: consecutive B-frames:  3.2%  0.8%  1.7% 94.2%
x264 [info]: mb I  I16..4: 21.3%  0.0% 78.7%
x264 [info]: mb P  I16..4:  2.1%  0.0%  6.8%  P16..4: 42.7% 25.0% 14.0%  0.0%  0.0%    skip: 9.4%
x264 [info]: mb B  I16..4:  4.1%  0.0%  1.0%  B16..8: 31.0% 10.6%  0.9%  direct:20.2%  skip:32.2%  L0:38.5% L1:44.3% BI:17.3%
x264 [info]: coded y,uvDC,uvAC intra: 64.1% 82.3% 46.3% inter: 21.6% 39.2% 2.2%
x264 [info]: i16 v,h,dc,p: 35% 20% 26% 18%
x264 [info]: i4 v,h,dc,ddl,ddr,vr,hd,vl,hu: 21% 18% 20%  6%  8%  7%  7%  6%  6%
x264 [info]: i8c dc,h,v,p: 53% 18% 22%  7%
x264 [info]: Weighted P-Frames: Y:4.4% UV:1.1%
x264 [info]: ref P L0: 62.6% 37.4%
x264 [info]: ref B L0: 82.4% 17.6%
x264 [info]: ref B L1: 95.4%  4.6%
x264 [info]: kb/s:853.56
[15:32:13] mux: track 0, 104630 frames, 465208694 bytes, 853.48 kbps, fifo 4096
[15:32:13] mux: track 1, 204389 frames, 88830674 bytes, 162.97 kbps, fifo 8192
[15:32:13] mux: track 2, 1024 frames, 2928380 bytes, 5.37 kbps, fifo 64
[15:32:13] Finished work at: Thu Dec 29 15:32:13 2022
[15:32:13] libhb: work result = 5

 # Job Failed (5)

[mduell]

HB doesn't support commercial DVDs; hasn't for a decade+.

Rip with MakeMKV.

[jbhomer]

I am using the decoding DLLs from MakeMKV and it works, except for this one part. I just tried it again with the default Subtitles settings and it works great. Apparently, something is happening when I change from "Foreign Audio Scan" to "English [VOBSUB]" that is screwing it up.

[mduell]

So yea, as I said, that's not supported.

[jbhomer]

So yea, as I said, that's not supported.

Ok, super helpful, thanks.

If anyone has any thoughts about why changing subtitle settings might cause this type of issue I would love to hear them.

[Deleted User 11865]

There's a bad or otherwise unexpected packet in the data for that subtitle track that appears to cause dvdnav to believe a read error has occurred.

What's odd is, Foreign Audio Search should be scanning the subtitle track even if it's not selecting it; can we please have the log for that attempt as well?

[jbhomer]

Sure thing. Here is the log for the next run that worked, but no subtitles...

Code: Select all

HandBrake 1.6.0 (2022122800)
OS: Microsoft Windows NT 10.0.22621.0
CPU: Intel(R) Core(TM) i5-10210U CPU @ 1.60GHz
Ram: 7995 MB, 
GPU Information:
  Intel(R) UHD Graphics - 27.20.100.8935
Screen: 1366x768
Temp Dir: C:\Users\jbhom\AppData\Local\Temp\
Install Dir: D:\Program Files\HandBrake\
Data Dir: C:\Users\jbhom\AppData\Roaming\HandBrake

-------------------------------------------

 # Starting Encode ...

[15:50:25] base preset: Fast 1080p30 (Modified)
[15:50:25] Remote Process started with Process ID: 32456 using port: 8037. Max Allowed Instances: 1
[15:50:25] Worker: Starting HandBrake Engine ...
[15:50:25] Worker: Starting Web Server on port 8037 ...
[15:50:26] Worker: Disconnected worker monitoring enabled!
[15:50:26] Compile-time hardening features are enabled
[15:50:27] qsv: is available on this system
[15:50:27] vcn: not available on this system
Cannot load nvEncodeAPI64.dll
[15:50:27] hb_init: starting libhb thread
[15:50:27] Starting work at: Thu Dec 29 15:50:27 2022
[15:50:27] 1 job(s) to process
[15:50:27] json job:
{
  "Audio": {
    "AudioList": [
      {
        "Bitrate": 160,
        "DRC": 0,
        "Encoder": "av_aac",
        "Gain": 0,
        "Mixdown": 4,
        "NormalizeMixLevel": false,
        "Samplerate": 0,
        "Track": 0,
        "DitherMethod": 0
      }
    ],
    "CopyMask": [
      "copy:aac"
    ]
  },
  "Destination": {
    "ChapterList": [
      {
        "Name": "Chapter 1"
      },
      {
        "Name": "Chapter 2"
      },
      {
        "Name": "Chapter 3"
      },
      {
        "Name": "Chapter 4"
      },
      {
        "Name": "Chapter 5"
      },
      {
        "Name": "Chapter 6"
      },
      {
        "Name": "Chapter 7"
      },
      {
        "Name": "Chapter 8"
      },
      {
        "Name": "Chapter 9"
      },
      {
        "Name": "Chapter 10"
      },
      {
        "Name": "Chapter 11"
      },
      {
        "Name": "Chapter 12"
      },
      {
        "Name": "Chapter 13"
      },
      {
        "Name": "Chapter 14"
      },
      {
        "Name": "Chapter 15"
      },
      {
        "Name": "Chapter 16"
      },
      {
        "Name": "Chapter 17"
      },
      {
        "Name": "Chapter 18"
      },
      {
        "Name": "Chapter 19"
      }
    ],
    "ChapterMarkers": true,
    "AlignAVStart": true,
    "File": "D:\\Videos\\Movies\\GoodFellas.mp4",
    "Mp4Options": {
      "IpodAtom": false,
      "Mp4Optimize": false
    },
    "Mux": "av_mp4"
  },
  "Filters": {
    "FilterList": [
      {
        "ID": 4,
        "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": 14,
        "Settings": {
          "crop-bottom": "78",
          "crop-left": "20",
          "crop-right": "16",
          "crop-top": "70",
          "height": "332",
          "width": "684"
        }
      },
      {
        "ID": 7,
        "Settings": {
          "mode": "0"
        }
      }
    ]
  },
  "PAR": {
    "Num": 8,
    "Den": 9
  },
  "Metadata": {},
  "SequenceID": 0,
  "Source": {
    "Angle": 1,
    "Range": {
      "Type": "chapter",
      "Start": 1,
      "End": 19
    },
    "Title": 5,
    "Path": "E:\\"
  },
  "Subtitle": {
    "Search": {
      "Burn": true,
      "Default": false,
      "Enable": true,
      "Forced": true
    },
    "SubtitleList": []
  },
  "Video": {
    "Encoder": "x264",
    "Level": "4.0",
    "TwoPass": false,
    "Turbo": false,
    "ColorMatrixCode": 0,
    "Options": "",
    "Preset": "fast",
    "Profile": "main",
    "Quality": 20,
    "QSV": {
      "Decode": false
    },
    "HardwareDecode": 0
  }
}
[15:50:27] CPU: Intel(R) Core(TM) i5-10210U CPU @ 1.60GHz
[15:50:27]  - Intel microarchitecture Kaby Lake
[15:50:27]  - logical processor count: 8
[15:50:27] Intel Quick Sync Video support: yes, gpu list: 0
[15:50:27] Intel Quick Sync Video integrated adapter with index 0
[15:50:27] Impl mfxhw64 library path: C:\Windows\System32\DriverStore\FileRepository\iigd_dch.inf_amd64_2b1d9e395a05d1c9\libmfxhw64.dll
[15:50:27]  - Intel Media SDK hardware: API 1.34 (minimum: 1.3)
[15:50:27]  - Decode support:  h264 hevc (8bit: yes, 10bit: yes)
[15:50:27]  - H.264 encoder: yes
[15:50:27]     - preferred implementation: hardware (1) via D3D11
[15:50:27]     - capabilities (hardware):  breftype icq+la+i+downs vsinfo chromalocinfo opt1 opt2+mbbrc+extbrc+trellis+repeatpps+ib_adapt+nmpslice
[15:50:27]  - H.265 encoder: yes (8bit: yes, 10bit: yes)
[15:50:27]     - preferred implementation: hardware (1) via D3D11
[15:50:27]     - capabilities (hardware):  bpyramid icq vsinfo masteringinfo cllinfo opt1
[15:50:27]  - AV1 encoder: no
[15:50:27] hb_scan: path=E:\, title_index=5
src/libbluray/disc/disc.c:437: error opening file BDMV\index.bdmv
src/libbluray/disc/disc.c:437: error opening file BDMV\BACKUP\index.bdmv
[15:50:29] bd: not a bd - trying as a stream/file instead
libdvdnav: vm: dvd_read_name flibdvdnav: Unable to open device file E:\.
ailed
libdvdnav: DVD disk reports itself with Region mask 0x00fe0000. Regions: 01
libdvdread: Attempting to retrieve all CSS keys
libdvdread: This can take a _long_ time, please be patient
libdvdread: Get key for /VIDEO_TS/VIDEO_TS.VOB at 0x0000013c
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_01_0.VOB at 0x00000188
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_01_1.VOB at 0x000001a4
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_02_0.VOB at 0x00001706
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_02_1.VOB at 0x0000173f
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_03_0.VOB at 0x00002085
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_03_1.VOB at 0x000020be
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_04_0.VOB at 0x0000cbcb
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_04_1.VOB at 0x0000cc04
libdvdread: Elapsed time 0
libdvdread: Found 4 VTS's
libdvdread: Elapsed time 0
[15:50:31] scan: DVD has 5 title(s)
[15:50:31] scan: scanning title 5
[15:50:31] scan: duration is 02:25:27 (8727800 ms)
[15:50:31] pgc_id: 1, pgn: 1: pgc: 00000228f0dfad50
[15:50:31] scan: checking audio 1
[15:50:31] scan: id=0x80bd, lang=English (AC3), 3cc=eng ext=0
[15:50:31] scan: checking subtitle 1
[15:50:31] scan: id=0x20bd, lang=English (4:3) [VOBSUB], 3cc=eng ext=0
[15:50:31] scan: checking subtitle 2
[15:50:31] scan: id=0x21bd, lang=espaol (4:3) [VOBSUB], 3cc=spa ext=0
[15:50:31] scan: title 5 has 19 chapters
[15:50:31] scan: chap 1, 487100 ms
[15:50:31] scan: chap 2, 434400 ms
[15:50:31] scan: chap 3, 502934 ms
[15:50:31] scan: chap 4, 466266 ms
[15:50:31] scan: chap 5, 460233 ms
[15:50:31] scan: chap 6, 585967 ms
[15:50:31] scan: chap 7, 486734 ms
[15:50:31] scan: chap 8, 398600 ms
[15:50:31] scan: chap 9, 531834 ms
[15:50:31] scan: chap 10, 450500 ms
[15:50:31] scan: chap 11, 491066 ms
[15:50:31] scan: chap 12, 523166 ms
[15:50:31] scan: chap 13, 328000 ms
[15:50:31] scan: chap 14, 583233 ms
[15:50:31] scan: chap 15, 404266 ms
[15:50:31] scan: chap 16, 634033 ms
[15:50:31] scan: chap 17, 331934 ms
[15:50:31] scan: chap 18, 331700 ms
[15:50:31] scan: chap 19, 295667 ms
[15:50:31] scan: aspect = 4:3
[15:50:31] scan: decoding previews for title 5
libdvdnav: DVD disk reports itself with Region mask 0x00fe0000. Regions: 01
[15:50:32] scan: title angle(s) 1
[15:50:32] scan: audio 0x80bd: ac3, rate=48000Hz, bitrate=384000 English (AC3) (5.1 ch) (384 kbps)
[15:50:34] scan: 10 previews, 720x480, 23.976 fps, autocrop = 70/78/20/16, aspect 4:3, PAR 8:9, color profile: 6-1-6, chroma location: left
[15:50:35] libhb: scan thread found 1 valid title(s)
[15:50:35] qsv: integrated qsv adapter with index 0 has been selected
[15:50:35] Starting Task: Subtitle Scan
[15:50:35] Skipping vfr filter
[15:50:35] job configuration:
[15:50:35]  * source
[15:50:35]    + E:\
[15:50:35]    + title 5, chapter(s) 1 to 19
[15:50:35]  * destination
[15:50:35]    + D:\Videos\Movies\GoodFellas.mp4
[15:50:35]    + container: MPEG-4 (libavformat)
[15:50:35]      + align initial A/V stream timestamps
[15:50:35]      + chapter markers
[15:50:35]  * video track
[15:50:35]    + decoder: mpeg2video 8-bit (yuv420p)
[15:50:35]      + bitrate 200 kbps
[15:50:35]    + filters
[15:50:35]      + 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)
[15:50:35]      + Decomb (mode=39)
[15:50:35]      + Crop and Scale (width=684:height=332:crop-top=70:crop-bottom=78:crop-left=20:crop-right=16)
[15:50:35]        + source: 720 * 480, crop (70/78/20/16): 684 * 332, scale: 684 * 332
[15:50:35]    + Output geometry
[15:50:35]      + storage dimensions: 684 x 332
[15:50:35]      + pixel aspect ratio: 8 : 9
[15:50:35]      + display dimensions: 608 x 332
[15:50:35]  * Foreign Audio Search: Render/Burn-in, Forced Only
[15:50:35]    + subtitle, English (4:3) [VOBSUB] (track 0, id 0x20bd, Picture)
libdvdnlibdvdnav: Unable to open device file E:\.
av: vm: dvd_read_name failed
libdvdnav: DVD disk reports itself with Region mask 0x00fe0000. Regions: 01
libdvdread: Attempting to retrieve all CSS keys
libdvdread: This can take a _long_ time, please be patient
libdvdread: Get key for /VIDEO_TS/VIDEO_TS.VOB at 0x0000013c
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_01_0.VOB at 0x00000188
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_01_1.VOB at 0x000001a4
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_02_0.VOB at 0x00001706
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_02_1.VOB at 0x0000173f
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_03_0.VOB at 0x00002085
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_03_1.VOB at 0x000020be
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_04_0.VOB at 0x0000cbcb
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_04_1.VOB at 0x0000cc04
libdvdread: Elapsed time 0
libdvdread: Found 4 VTS's
libdvdread: Elapsed time 0
libdvdnav: DVD disk reports itself with Region mask 0x00fe0000. Regions: 01
[15:50:36] sync: expecting 209257 video frames
[16:20:03] reader: done. 1 scr changes
[16:20:03] work: average encoding speed for job is 0.000000 fps
[16:20:03] comb detect: heavy 0 | light 0 | uncombed 0 | total 0
[16:20:03] mpeg2video-decoder done: 0 frames, 1 decoder errors
[16:20:03] sync: got 0 frames, 209257 expected
[16:20:03] Subtitle track 0 (id 0x20bd) 'English (4:3) [VOBSUB]': 1943 hits (0 forced)
[16:20:03] No candidate detected during subtitle scan
[16:20:03] Starting Task: Encoding Pass
[16:20:03] Skipping vfr filter
[16:20:03] work: track 1, dithering not supported by codec
[16:20:03] job configuration:
[16:20:03]  * source
[16:20:03]    + E:\
[16:20:03]    + title 5, chapter(s) 1 to 19
[16:20:03]  * destination
[16:20:03]    + D:\Videos\Movies\GoodFellas.mp4
[16:20:03]    + container: MPEG-4 (libavformat)
[16:20:03]      + align initial A/V stream timestamps
[16:20:03]      + chapter markers
[16:20:03]  * video track
[16:20:03]    + decoder: mpeg2video 8-bit (yuv420p)
[16:20:03]      + bitrate 200 kbps
[16:20:03]    + filters
[16:20:03]      + 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:20:03]      + Decomb (mode=39)
[16:20:03]      + Crop and Scale (width=684:height=332:crop-top=70:crop-bottom=78:crop-left=20:crop-right=16)
[16:20:03]        + source: 720 * 480, crop (70/78/20/16): 684 * 332, scale: 684 * 332
[16:20:03]    + Output geometry
[16:20:03]      + storage dimensions: 684 x 332
[16:20:03]      + pixel aspect ratio: 8 : 9
[16:20:03]      + display dimensions: 608 x 332
[16:20:03]    + encoder: H.264 (libx264)
[16:20:03]      + preset:  fast
[16:20:03]      + profile: main
[16:20:03]      + level:   4.0
[16:20:03]      + quality: 20.00 (RF)
[16:20:03]      + color profile: 6-1-6
[16:20:03]      + chroma location: left
[16:20:03]  * audio track 1
[16:20:03]    + decoder: English (AC3) (5.1 ch) (384 kbps) (track 1, id 0x80bd)
[16:20:03]      + bitrate: 384 kbps, samplerate: 48000 Hz
[16:20:03]    + mixdown: Stereo
[16:20:03]    + encoder: AAC (libavcodec)
[16:20:03]      + bitrate: 160 kbps, samplerate: 48000 Hz
libdvdnlibdvdnav: Unable to open device file E:\.
av: vm: dvd_read_name failed
libdvdnav: DVD disk reports itself with Region mask 0x00fe0000. Regions: 01
libdvdread: Attempting to retrieve all CSS keys
libdvdread: This can take a _long_ time, please be patient
libdvdread: Get key for /VIDEO_TS/VIDEO_TS.VOB at 0x0000013c
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_01_0.VOB at 0x00000188
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_01_1.VOB at 0x000001a4
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_02_0.VOB at 0x00001706
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_02_1.VOB at 0x0000173f
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_03_0.VOB at 0x00002085
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_03_1.VOB at 0x000020be
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_04_0.VOB at 0x0000cbcb
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_04_1.VOB at 0x0000cc04
libdvdread: Elapsed time 0
libdvdread: Found 4 VTS's
libdvdread: Elapsed time 0
libdvdnav: DVD disk reports itself with Region mask 0x00fe0000. Regions: 01
[16:20:04] sync: expecting 209257 video frames
[16:20:04] encx264: min-keyint: 24, keyint: 240
[16:20:04] encx264: encoding at constant RF 20.000000
[16:20:04] encx264: unparsed options: level=4.0:ref=2:8x8dct=0:weightp=1:subme=6:vbv-bufsize=25000:vbv-maxrate=20000:rc-lookahead=30
x264 [info]: using SAR=8/9
x264 [info]: using cpu capabilities: MMX2 SSE2Fast SSSE3 SSE4.2 AVX FMA3 BMI2 AVX2 UnalignedStack
x264 [info]: profile Main, level 4.0, 4:2:0, 8-bit
[16:20:05] sync: first pts video is 0
[16:20:05] sync: "Chapter 1" (1) at frame 1 time 0
[16:20:05] sync: first pts audio 0x80bd is 0
[16:20:20] 44.135757s: Film -> Video
[16:20:20] 44.177467s: Video -> Film
[16:21:13] 162.011841s: Film -> Video
[16:21:13] 162.395569s: Video -> Film
[16:21:51] 254.437515s: Film -> Video
[16:21:51] 254.887955s: Video -> Film
[16:22:57] 455.805328s: Film -> Video
[16:22:57] 456.255829s: Video -> Film
[16:23:08] sync: "Chapter 2" (2) at frame 11704 time 43893349
[16:23:48] 603.619690s: Film -> Video
[16:23:48] 604.070129s: Video -> Film
[16:24:01] 648.164185s: Film -> Video
[16:24:01] 648.614624s: Video -> Film
[16:24:51] 807.823669s: Film -> Video
[16:24:52] 808.274109s: Video -> Film
[16:25:20] 901.083557s: Film -> Video
[16:25:20] 901.533936s: Video -> Film
[16:25:26] sync: "Chapter 3" (3) at frame 22142 time 83029947
[16:25:47] 997.846863s: Film -> Video
[16:25:48] 998.297363s: Video -> Film
[16:27:45] 1425.674194s: Film -> Video
[16:27:45] sync: "Chapter 4" (4) at frame 34218 time 128338460
[16:27:45] 1426.124756s: Video -> Film
[16:29:05] 1718.967285s: Film -> Video
[16:29:05] 1719.417603s: Video -> Film
[16:29:49] 1879.627686s: Film -> Video
[16:29:49] 1879.911255s: Video -> Film
[16:29:52] 1891.973389s: Film -> Video
[16:29:52] 1892.423828s: Video -> Film
[16:29:52] sync: "Chapter 5" (5) at frame 45418 time 170348177
[16:30:47] 2077.959229s: Film -> Video
[16:30:47] 2078.042725s: Video -> Film
[16:30:47] 2080.061279s: Film -> Video
[16:30:47] 2080.144775s: Video -> Film
[16:30:48] 2082.163330s: Film -> Video
[16:30:48] 2082.246826s: Video -> Film
[16:30:48] 2084.265625s: Film -> Video
[16:30:48] 2084.348877s: Video -> Film
[16:30:49] 2086.367676s: Film -> Video
[16:30:49] 2086.450928s: Video -> Film
[16:31:34] 2240.488281s: Film -> Video
[16:31:34] 2240.938721s: Video -> Film
[16:32:07] sync: "Chapter 6" (6) at frame 56476 time 211810600
[16:32:19] 2388.202393s: Film -> Video
[16:32:19] 2388.285889s: Video -> Film
[16:32:19] 2389.303711s: Film -> Video
[16:32:19] 2389.386963s: Video -> Film
[16:32:20] 2390.871826s: Film -> Video
[16:32:20] 2390.955078s: Video -> Film
[16:32:20] 2391.972900s: Film -> Video
[16:32:20] 2392.056396s: Video -> Film
[16:32:20] 2392.439941s: Film -> Video
[16:32:20] 2392.523438s: Video -> Film
[16:32:20] 2393.549561s: Film -> Video
[16:32:21] 2393.591309s: Video -> Film
[16:32:21] 2396.143799s: Film -> Video
[16:32:22] 2396.427490s: Video -> Film
[16:32:40] 2457.371582s: Film -> Video
[16:32:40] 2457.788574s: Video -> Film
[16:33:56] 2716.430420s: Film -> Video
[16:33:56] 2716.813965s: Video -> Film
[16:34:49] 2905.619385s: Film -> Video
[16:34:49] 2906.069824s: Video -> Film
[16:35:01] sync: "Chapter 7" (7) at frame 70559 time 264601840
[16:35:54] 3123.670410s: Film -> Video
[16:35:54] 3124.120850s: Video -> Film
[16:37:21] sync: "Chapter 8" (8) at frame 82244 time 308453147
[16:38:28] 3669.249023s: Film -> Video
[16:38:28] 3669.699463s: Video -> Film
[16:39:09] sync: "Chapter 9" (9) at frame 91815 time 344364524
[16:40:17] 4062.475098s: Film -> Video
[16:40:17] 4062.925537s: Video -> Film
[16:41:37] 4356.268555s: Film -> Video
[16:41:37] 4356.652344s: Video -> Film
[16:41:37] sync: "Chapter 10" (10) at frame 104585 time 392278140
[16:43:27] 4765.393555s: Film -> Video
[16:43:27] 4765.477539s: Video -> Film
[16:43:39] 4808.737305s: Film -> Video
[16:43:39] 4809.187988s: Video -> Film
[16:43:40] sync: "Chapter 11" (11) at frame 115401 time 432864436
[16:45:12] 5143.738770s: Film -> Video
[16:45:12] 5144.122070s: Video -> Film
[16:45:22] 5183.377930s: Film -> Video
[16:45:22] 5183.461914s: Video -> Film
[16:45:23] 5185.479980s: Film -> Video
[16:45:23] 5185.563965s: Video -> Film
[16:45:23] 5187.582031s: Film -> Video
[16:45:23] 5187.666016s: Video -> Film
[16:45:54] 5300.395020s: Film -> Video
[16:45:54] 5300.845703s: Video -> Film
[16:45:54] sync: "Chapter 12" (12) at frame 127199 time 477106136
[16:46:32] 5435.529785s: Film -> Video
[16:46:32] 5435.980957s: Video -> Film
[16:48:23] sync: "Chapter 13" (13) at frame 139759 time 524238221
[16:48:32] 5853.781250s: Film -> Video
[16:48:32] 5853.897949s: Video -> Film
[16:49:14] 6007.601562s: Film -> Video
[16:49:14] 6008.051758s: Video -> Film
[16:49:54] sync: "Chapter 14" (14) at frame 147635 time 553787735
[16:51:13] 6439.199219s: Film -> Video
[16:51:13] 6439.716797s: Video -> Film
[16:51:47] 6560.053223s: Film -> Video
[16:51:47] 6560.504395s: Video -> Film
[16:52:36] sync: "Chapter 15" (15) at frame 161639 time 606331226
[16:52:55] 6807.467285s: Film -> Video
[16:52:55] 6808.017578s: Video -> Film
[16:54:39] sync: "Chapter 16" (16) at frame 171345 time 642751610
[16:56:08] 7441.868164s: Film -> Video
[16:56:08] 7442.318359s: Video -> Film
[16:57:06] 7644.570312s: Film -> Video
[16:57:06] 7645.020508s: Video -> Film
[16:57:41] 7775.534180s: Film -> Video
[16:57:41] 7775.984863s: Video -> Film
[16:57:41] sync: "Chapter 17" (17) at frame 186571 time 699872424
[16:58:22] 7926.685059s: Film -> Video
[16:58:22] 7927.236328s: Video -> Film
[16:59:16] 8107.799316s: Film -> Video
[16:59:16] 8108.250488s: Video -> Film
[16:59:16] sync: "Chapter 18" (18) at frame 194544 time 729776299
[17:00:05] 8284.342773s: Film -> Video
[17:00:05] 8284.425781s: Video -> Film
[17:00:06] 8286.444336s: Film -> Video
[17:00:06] 8286.528320s: Video -> Film
[17:00:06] 8287.721680s: Film -> Video
[17:00:06] 8287.762695s: Video -> Film
[17:00:29] 8368.726562s: Film -> Video
[17:00:29] 8369.177734s: Video -> Film
[17:00:48] sync: "Chapter 19" (19) at frame 202513 time 759659903
[17:02:24] reader: done. 1 scr changes
[17:02:24] 8736.161133s: Film -> Video
[17:02:24] work: average encoding speed for job is 82.542320 fps
[17:02:24] comb detect: heavy 712 | light 1564 | uncombed 207333 | total 209609
[17:02:24] decomb: deinterlaced 712 | blended 1564 | unfiltered 207333 | total 209609
[17:02:24] ac3-decoder done: 273016 frames, 0 decoder errors
[17:02:24] mpeg2video-decoder done: 209609 frames, 0 decoder errors
[17:02:24] sync: got 209609 frames, 209257 expected
[17:02:24] sync: framerate min 23.976 fps, max 40.071 fps, avg 23.992 fps
x264 [info]: frame I:1845  Avg QP:17.89  size: 28568
x264 [info]: frame P:55554 Avg QP:20.75  size:  8648
x264 [info]: frame B:152210 Avg QP:22.76  size:  2511
x264 [info]: consecutive B-frames:  2.7%  0.8%  1.7% 94.7%
x264 [info]: mb I  I16..4: 21.7%  0.0% 78.3%
x264 [info]: mb P  I16..4:  2.1%  0.0%  6.6%  P16..4: 42.3% 24.9% 14.0%  0.0%  0.0%    skip:10.0%
x264 [info]: mb B  I16..4:  3.8%  0.0%  0.9%  B16..8: 30.2% 10.2%  0.9%  direct:19.7%  skip:34.3%  L0:38.2% L1:43.8% BI:18.0%
x264 [info]: coded y,uvDC,uvAC intra: 66.0% 82.8% 47.4% inter: 21.2% 37.8% 2.1%
x264 [info]: i16 v,h,dc,p: 35% 21% 26% 18%
x264 [info]: i4 v,h,dc,ddl,ddr,vr,hd,vl,hu: 22% 19% 19%  6%  8%  7%  7%  6%  6%
x264 [info]: i8c dc,h,v,p: 53% 18% 23%  6%
x264 [info]: Weighted P-Frames: Y:4.6% UV:0.9%
x264 [info]: ref P L0: 61.9% 38.1%
x264 [info]: ref B L0: 81.9% 18.1%
x264 [info]: ref B L1: 95.1%  4.9%
x264 [info]: kb/s:838.24
[17:02:25] mux: track 0, 209609 frames, 915333339 bytes, 838.16 kbps, fifo 4096
[17:02:25] mux: track 1, 409525 frames, 178134508 bytes, 163.12 kbps, fifo 8192
[17:02:25] Finished work at: Thu Dec 29 17:02:25 2022
[17:02:25] libhb: work result = 0

 # Job Completed!

[Deleted User 11865]

Well this is odd indeed. I'm almost thinking the read error was unrelated and probably just an issue with reading the physical disc that one time.

If it's actually reproducible and you need the subtitle track, you'll have to use different software to copy the disc anyway (e.g. MakeMKV), as this kind of bug isn't really easy to fix nor a priority nowadays, sorry.

[jbhomer]

The problem seems to have sorted itself. I had the same issue with 2 different DVDs and since then I have successfully completed six in a row, with removable subtitles.

Thanks for the help Rodeo, persistence was the solution!

[Deleted User 11865]

Optical disc drives are somewhat prone to read errors, and HandBrake sadly does not always handle those well.