Errors in Encodes from MakeMKV/Bluray

Archive of historical bug reports.
Please use the GitHub link above to report issues.
Forum rules
*******************************
Please be aware we are now using GitHub for issue tracking and feature requests.
- This section of the forum is now closed to new topics.

*******************************
Post Reply
Starhawk
Experienced
Posts: 90
Joined: Sun Feb 24, 2008 8:27 pm

Errors in Encodes from MakeMKV/Bluray

Post by Starhawk »

I recently started encoding my Blurays using MakeMKV and then sending the file through handbrake, but I've noticed errors in almost all of my encodes. Most of them are reproducible, and an error is showing up in the logs. Here are two examples with a MakeMKV extraction for Kill Bill Vol. 1 and Star Trek: Generations.

Kill Bill Vol. 1 (Encode of Chapter 4) with Handbrake SVN3849

Code: Select all

HandBrake Activity Log for /Volumes/HD/Video Encodes/Kill Bill Vol 1 chap4 test.m4v: 2011-03-30 14:49:45 -0400
Handbrake Version: svn3849 x86_64 (2011031501)

[14:49:45] macgui: Rip: Pending queue count is 0
[14:49:45] macgui: getNextPendingQueueIndex next pending encode index is:0
[14:49:45] macgui: scanning specifically for title: 1
[14:49:45] hb_scan: path=/Volumes/HD/Feature Extractions/Kill Bill Vol 1.mkv, title_index=1
[14:49:45] thread 11f316000 started ("scan")
libbluray/bdnav/index_parse.c:157: indx_parse(): error opening /Volumes/HD/Feature Extractions/Kill Bill Vol 1.mkv/BDMV/index.bdmv
libbluray/bluray.c:1376: nav_get_title_list(/Volumes/HD/Feature Extractions/Kill Bill Vol 1.mkv) failed (0x11c593000)
[14:49:45] bd: not a bd - trying as a stream/file instead
libdvdnav: Using dvdnav version 4.1.3
libdvdread: Using libdvdcss version 1.2.10 for DVD access
libdvdnav:DVDOpenFileUDF:UDFFindFile /VIDEO_TS/VIDEO_TS.IFO failed
libdvdnav:DVDOpenFileUDF:UDFFindFile /VIDEO_TS/VIDEO_TS.BUP failed
libdvdread: Can't open file VIDEO_TS.IFO.
libdvdnav: vm: failed to read VIDEO_TS.IFO
[14:49:45] dvd: not a dvd - trying as a stream/file instead
Input #0, matroska,webm, from '/Volumes/HD/Feature Extractions/Kill Bill Vol 1.mkv':
  Duration: 01:50:43.64, start: 0.000000, bitrate: 5248 kb/s
    Chapter #0.0: start 0.000000, end 147.856022
    Metadata:
      title           : Chapter 00
    Chapter #0.1: start 147.856022, end 308.141156
    Metadata:
      title           : Chapter 01
    Chapter #0.2: start 308.141156, end 590.214600
    Metadata:
      title           : Chapter 02
    Chapter #0.3: start 590.214600, end 968.592578
    Metadata:
      title           : Chapter 03
    Chapter #0.4: start 968.592578, end 1192.024111
    Metadata:
      title           : Chapter 04
    Chapter #0.5: start 1192.024111, end 1512.135556
    Metadata:
      title           : Chapter 05
    Chapter #0.6: start 1512.135556, end 1939.062044
    Metadata:
      title           : Chapter 06
    Chapter #0.7: start 1939.062044, end 2157.655422
    Metadata:
      title           : Chapter 07
    Chapter #0.8: start 2157.655422, end 2702.407933
    Metadata:
      title           : Chapter 08
    Chapter #0.9: start 2702.407933, end 3030.861044
    Metadata:
      title           : Chapter 09
    Chapter #0.10: start 3030.861044, end 3519.724400
    Metadata:
      title           : Chapter 10
    Chapter #0.11: start 3519.724400, end 3875.121111
    Metadata:
      title           : Chapter 11
    Chapter #0.12: start 3875.121111, end 4392.221022
    Metadata:
      title           : Chapter 12
    Chapter #0.13: start 4392.221022, end 4899.436044
    Metadata:
      title           : Chapter 13
    Chapter #0.14: start 4899.436044, end 5405.733489
    Metadata:
      title           : Chapter 14
    Chapter #0.15: start 5405.733489, end 5917.077644
    Metadata:
      title           : Chapter 15
    Chapter #0.16: start 5917.077644, end 6106.099800
    Metadata:
      title           : Chapter 16
    Chapter #0.17: start 6106.099800, end 6199.401333
    Metadata:
      title           : Chapter 17
    Chapter #0.18: start 6199.401333, end 6642.635800
    Metadata:
      title           : Chapter 18
    Chapter #0.19: start 6642.635800, end 6643.640000
    Metadata:
      title           : Chapter 19
    Stream #0.0(eng): Video: h264 (High), yuv420p, 1920x1080 [PAR 1:1 DAR 16:9], 23.98 fps, 23.98 tbr, 1k tbn, 47.95 tbc (default)
    Stream #0.1(eng): Audio: pcm_s16le, 48000 Hz, 5.1, s16, 4608 kb/s (default)
    Metadata:
      title           : 3/2+1
    Stream #0.2(eng): Audio: ac3, 48000 Hz, 5.1, s16, 640 kb/s
    Metadata:
      title           : 3/2+1
    Stream #0.3(eng): Subtitle: pgssub (default)
    Stream #0.4(eng): Subtitle: pgssub
[14:49:45] add_ffmpeg_subtitle: unknown subtitle stream type: 0x17006
[14:49:45] add_ffmpeg_subtitle: unknown subtitle stream type: 0x17006
[14:49:45] Found ffmpeg 20 chapters, container=matroska,webm
[14:49:45] Added chapter 1, name='Chapter 00', dur=13307041, (00:02:27)
[14:49:45] Added chapter 2, name='Chapter 01', dur=14425662, (00:02:40)
[14:49:45] Added chapter 3, name='Chapter 02', dur=25386611, (00:04:42)
[14:49:45] Added chapter 4, name='Chapter 03', dur=34054017, (00:06:18)
[14:49:45] Added chapter 5, name='Chapter 04', dur=20108838, (00:03:43)
[14:49:45] Added chapter 6, name='Chapter 05', dur=28810030, (00:05:20)
[14:49:45] Added chapter 7, name='Chapter 06', dur=38423384, (00:07:06)
[14:49:45] Added chapter 8, name='Chapter 07', dur=19673404, (00:03:38)
[14:49:45] Added chapter 9, name='Chapter 08', dur=49027726, (00:09:04)
[14:49:45] Added chapter 10, name='Chapter 09', dur=29560780, (00:05:28)
[14:49:45] Added chapter 11, name='Chapter 10', dur=43997703, (00:08:08)
[14:49:45] Added chapter 12, name='Chapter 11', dur=31985703, (00:05:55)
[14:49:45] Added chapter 13, name='Chapter 12', dur=46538992, (00:08:37)
[14:49:45] Added chapter 14, name='Chapter 13', dur=45649352, (00:08:27)
[14:49:45] Added chapter 15, name='Chapter 14', dur=45566770, (00:08:26)
[14:49:45] Added chapter 16, name='Chapter 15', dur=46020974, (00:08:31)
[14:49:45] Added chapter 17, name='Chapter 16', dur=17011995, (00:03:09)
[14:49:45] Added chapter 18, name='Chapter 17', dur=8397137, (00:01:33)
[14:49:45] Added chapter 19, name='Chapter 18', dur=39891103, (00:07:23)
[14:49:45] Added chapter 20, name='Chapter 19', dur=90378, (00:00:01)
[14:49:45] scan: decoding previews for title 1
[14:49:45] scan: preview 1
[14:49:45] fifo_close: trashing 0 buffer(s)
[14:49:45] scan: audio 0x2: AC-3, rate=48000Hz, bitrate=640000 English (AC3) (5.1 ch)
[14:49:46] scan: preview 2
[14:49:46] scan: preview 3
[14:49:47] scan: preview 4
[14:49:47] scan: preview 5
[14:49:48] scan: preview 6
[14:49:48] scan: preview 7
[14:49:49] scan: preview 8
[14:49:49] scan: preview 9
[14:49:49] scan: preview 10
[14:49:50] scan: 10 previews, 1920x1080, 23.976 fps, autocrop = 128/136/0/0, aspect 16:9, PAR 1:1
[14:49:50] scan: title (0) job->width:1920, job->height:816
[14:49:50] thread 11f316000 exited ("scan")
[14:49:50] thread 11f316000 joined ("scan")
[14:49:50] libhb: scan thread found 1 valid title(s)
[14:49:50] macgui: ScanDone state received from fQueueEncodeLibhb
[14:49:50] macgui: Preset: Custom
[14:49:50] macgui: processNewQueueEncode number of passes expected is: 1
[14:49:50] macgui: Start / Stop set to chapters
[14:49:50] macgui: prepareJob exiting
[14:49:50] thread 116b9d000 started ("work")
[14:49:50] 1 job(s) to process
[14:49:50] starting job
[14:49:50] sync: expecting 9095 video frames
[14:49:50] job configuration:
[14:49:50]  * source
[14:49:50]    + /Volumes/HD/Feature Extractions/Kill Bill Vol 1.mkv
[14:49:50]    + title 1, chapter(s) 4 to 4
[14:49:50]    + container: matroska,webm
[14:49:50]    + data rate: 5248 kbps
[14:49:50]  * destination
[14:49:50]    + /Volumes/HD/Video Encodes/Kill Bill Vol 1 chap4 test.m4v
[14:49:50]    + container: MPEG-4 (.mp4 and .m4v)
[14:49:50]  * video track
[14:49:50]    + decoder: h264
[14:49:50]    + frame rate: 23.976 fps -> peak rate limited to 29.970 fps
[14:49:50]    + loose anamorphic
[14:49:50]      + storage dimensions: 1920 * 1080 -> 1280 * 536, crop 138/138/0/0, mod 2
[14:49:50]      + pixel aspect ratio: 1 / 1
[14:49:50]      + display dimensions: 1280 * 536
[14:49:50]    + encoder: x264
[14:49:50]      + options: b-adapt=2:rc-lookahead=50:psy-rd=1.0,0.15:deblock=-1,-1
[14:49:50]      + quality: 19.50 (RF)
[14:49:50]  * audio track 0
[14:49:50]    + decoder: English (AC3) (5.1 ch) (track 1, id 2)
[14:49:50]      + bitrate: 640 kbps, samplerate: 48000 Hz
[14:49:50]    + mixdown: Dolby Pro Logic II
[14:49:50]    + dynamic range compression: 1.500000
[14:49:50]    + encoder: ca_aac
[14:49:50]      + bitrate: 192 kbps, samplerate: 48000 Hz
[14:49:50]  * audio track 1
[14:49:50]    + decoder: English (AC3) (5.1 ch) (track 1, id 2)
[14:49:50]      + bitrate: 640 kbps, samplerate: 48000 Hz
[14:49:50]    + AC3 passthrough
[14:49:50] thread 11bcc6000 started ("reader")
[14:49:50] thread 11bddf000 started ("AudioSynchronization")
[14:49:50] thread 11be62000 started ("AudioSynchronization")
[14:49:50] thread 11bee5000 started ("Video decoder (ffmpeg streams)")
[14:49:50] thread 116c20000 started ("Renderer")
[14:49:50] encx264: min-keyint: 24, keyint: 240
[14:49:50] encx264: encoding with stored aspect 1/1
[14:49:50] encx264: Encoding at constant RF 19.500000
[14:49:50] encx264: opening libx264 (pass 0)
x264 [info]: using SAR=1/1
x264 [info]: using cpu capabilities: MMX2 SSE2Fast SSSE3 Cache64
[14:49:50] Seeking to chapter 4: starts 53119314, ends 87173331, AV pos 590214600
x264 [info]: profile High, level 3.1
[14:49:50] thread 120778000 started ("H.264/AVC encoder (libx264)")
No accelerated IMDCT transform found
[14:49:50] thread 1207fb000 started ("AC3 decoder")
[14:49:50] reader: first SCR 57184560 id 0 DTS 57184560
[14:49:50] thread 1233e4000 started ("AAC encoder (Apple)")
No accelerated IMDCT transform found
[14:49:50] thread 123467000 started ("AC3 decoder")
[14:49:50] thread 1234ea000 started ("Video Synchronization")
[14:49:50] muxmp4: track 0, chunk duration 15015
[14:49:50] muxmp4: track 1, chunk duration 8008
[14:49:50] muxmp4: track 2, chunk duration 8008
[14:49:50] muxmp4: disabled extra audio track 2
[14:49:50] thread 123ded000 started ("Muxer")
[14:49:50] thread 123e70000 started ("Muxer")
[h264 @ 0x10219b400] top block unavailable for requested intra4x4 mode -1 at 35 34
[h264 @ 0x10219b400] error while decoding MB 35 34, bytestream (151223)
[15:08:06] ffmpeg_read starting chapter 5 at 87184530
[15:08:07] reader: end of chapter 4 (media 4) reached at media chapter 5
[15:08:07] reader: done. 1 scr changes
[15:08:07] thread 11bcc6000 exited ("reader")
[15:08:21] work: average encoding speed for job is 7.239014 fps
[15:08:21] thread 1233e4000 exited ("AAC encoder (Apple)")
[15:08:21] thread 123ded000 exited ("Muxer")
[15:08:21] thread 123e70000 exited ("Muxer")
[15:08:21] thread 11bee5000 exited ("Video decoder (ffmpeg streams)")
[15:08:21] thread 11bddf000 exited ("AudioSynchronization")
[15:08:21] thread 11be62000 exited ("AudioSynchronization")
[15:08:21] thread 116c20000 exited ("Renderer")
[15:08:21] thread 1207fb000 exited ("AC3 decoder")
[15:08:21] thread 1234ea000 exited ("Video Synchronization")
[15:08:21] thread 1234ea000 joined ("Video Synchronization")
[15:08:21] sync: got 7993 frames, 9095 expected
[15:08:21] thread 11bddf000 joined ("AudioSynchronization")
[15:08:21] thread 11be62000 joined ("AudioSynchronization")
[15:08:21] thread 11bee5000 joined ("Video decoder (ffmpeg streams)")
[15:08:21] h264-decoder done: 7993 frames, 0 decoder errors, 0 drops
[15:08:21] thread 116c20000 joined ("Renderer")
[15:08:21] render: 7993 frames output, 0 dropped and 0 duped for CFR/PFR
[15:08:21] render: lost time: 0 (0 frames)
[15:08:21] render: gained time: 0 (0 frames) (0 not accounted for)
[15:08:21] fifo_close: trashing 0 buffer(s)
[15:08:21] fifo_close: trashing 0 buffer(s)
[15:08:21] thread 120778000 exited ("H.264/AVC encoder (libx264)")
[15:08:21] thread 120778000 joined ("H.264/AVC encoder (libx264)")
x264 [info]: frame I:66    Avg QP:18.39  size:132924  PSNR Mean Y:44.05 U:48.30 V:49.49 Avg:45.13 Global:44.75
x264 [info]: frame P:2121  Avg QP:20.89  size: 40506  PSNR Mean Y:42.36 U:47.23 V:48.37 Avg:43.53 Global:42.80
x264 [info]: frame B:5806  Avg QP:23.32  size: 11039  PSNR Mean Y:40.39 U:46.22 V:47.48 Avg:41.68 Global:41.51
x264 [info]: consecutive B-frames:  1.6%  1.3%  9.7% 87.4%
x264 [info]: mb I  I16..4:  9.2% 66.8% 24.0%
x264 [info]: mb P  I16..4:  0.9%  5.6%  1.1%  P16..4: 36.2% 27.8% 18.8%  0.0%  0.0%    skip: 9.6%
x264 [info]: mb B  I16..4:  0.1%  0.8%  0.1%  B16..8: 41.2%  5.0%  1.7%  direct: 6.4%  skip:44.7%  L0:41.4% L1:45.6% BI:13.0%
x264 [info]: 8x8 transform intra:73.0% inter:56.6%
x264 [info]: coded y,uvDC,uvAC intra: 85.1% 84.6% 56.7% inter: 31.9% 27.0% 3.1%
x264 [info]: i16 v,h,dc,p: 52% 27%  5% 16%
x264 [info]: i8 v,h,dc,ddl,ddr,vr,hd,vl,hu: 16% 12% 30%  6%  7%  8%  6%  8%  7%
x264 [info]: i4 v,h,dc,ddl,ddr,vr,hd,vl,hu: 22% 19% 13%  6%  9%  9%  7%  8%  7%
x264 [info]: i8c dc,h,v,p: 47% 21% 23%  9%
x264 [info]: Weighted P-Frames: Y:3.0% UV:1.8%
x264 [info]: ref P L0: 41.1% 14.5% 33.1% 11.3%  0.1%
x264 [info]: ref B L0: 81.6% 13.8%  4.5%
x264 [info]: ref B L1: 96.8%  3.2%
x264 [info]: SSIM Mean Y:0.9590132 (13.874db)
x264 [info]: PSNR Mean Y:40.946 U:46.502 V:47.731 Avg:42.198 Global:41.838 kb/s:3808.36
[15:08:21] thread 123467000 exited ("AC3 decoder")
[15:08:21] thread 1207fb000 joined ("AC3 decoder")
[15:08:21] thread 1233e4000 joined ("AAC encoder (Apple)")
[15:08:21] thread 123467000 joined ("AC3 decoder")
[15:08:21] thread 123ded000 joined ("Muxer")
[15:08:21] thread 123e70000 joined ("Muxer")
[15:08:21] mux: file size, 192876219 bytes
[15:08:21] mux: track 0, 7993 frames, 158777772 bytes, 3809.24 kbps, fifo 8
[15:08:21] mux: video bitrate error, +158777772 bytes
[15:08:21] mux: track 1, 15625 frames, 7194648 bytes, 172.61 kbps, fifo 512
[15:08:21] mux: track 2, 10416 frames, 26664960 bytes, 639.72 kbps, fifo 256
[15:08:21] mux: overhead, 7.02 bytes per frame
[15:08:21] thread 11bcc6000 joined ("reader")
[15:08:21] fifo_close: trashing 0 buffer(s)
[15:08:21] fifo_close: trashing 0 buffer(s)
[15:08:21] fifo_close: trashing 0 buffer(s)
[15:08:21] fifo_close: trashing 0 buffer(s)
[15:08:21] fifo_close: trashing 0 buffer(s)
[15:08:21] fifo_close: trashing 0 buffer(s)
[15:08:21] fifo_close: trashing 0 buffer(s)
[15:08:21] fifo_close: trashing 0 buffer(s)
[15:08:21] fifo_close: trashing 0 buffer(s)
[15:08:21] fifo_close: trashing 0 buffer(s)
[15:08:21] fifo_close: trashing 0 buffer(s)
[15:08:21] fifo_close: trashing 0 buffer(s)
[15:08:21] fifo_close: trashing 0 buffer(s)
[15:08:21] Freed 32 buffers of size 2048
[15:08:21] Freed 32 buffers of size 4096
[15:08:21] Freed 1 buffers of size 8192
[15:08:21] Freed 29 buffers of size 16384
[15:08:21] Freed 32 buffers of size 524288
[15:08:21] Freed 32 buffers of size 1048576
[15:08:21] Freed 32 buffers of size 4194304
[15:08:21] Allocated 185229312 bytes of buffers on this pass and Freed 185229312 bytes, 0 bytes leaked
[15:08:21] thread 116b9d000 exited ("work")
[15:08:21] thread 116b9d000 joined ("work")
[15:08:21] libhb: work result = 0
This is what stood out to me:

Code: Select all

[h264 @ 0x10219b400] top block unavailable for requested intra4x4 mode -1 at 35 34
[h264 @ 0x10219b400] error while decoding MB 35 34, bytestream (151223)
Image


Star Trek: Generations (Full Encode) with Handbrake 0.9.5 just to see if a different version of x264 made a difference

Code: Select all

HandBrake Activity Log for /Volumes/HD/Video Encodes/Star Trek GenerationsA.m4v: 2011-03-26 18:35:04 -0400
Handbrake Version: 0.9.5 x86_64 (2011010300)

[18:35:04] macgui: Rip: Pending queue count is 0
[18:35:04] macgui: getNextPendingQueueIndex next pending encode index is:0
[18:35:04] macgui: scanning specifically for title: 1
[18:35:04] hb_scan: path=/Volumes/HD/Feature Extractions/Star Trek Generations.mkv, title_index=1
[18:35:04] thread 1148b4000 started ("scan")
libbluray/bdnav/index_parse.c:157: indx_parse(): error opening /Volumes/HD/Feature Extractions/Star Trek Generations.mkv/BDMV/index.bdmv
libbluray/bluray.c:960: nav_get_title_list(/Volumes/HD/Feature Extractions/Star Trek Generations.mkv) failed (0x102a12400)
[18:35:04] bd: not a bd - trying as a stream/file instead
libdvdnav: Using dvdnav version 4.1.3
libdvdread: Using libdvdcss version 1.2.10 for DVD access
libdvdnav:DVDOpenFileUDF:UDFFindFile /VIDEO_TS/VIDEO_TS.IFO failed
libdvdnav:DVDOpenFileUDF:UDFFindFile /VIDEO_TS/VIDEO_TS.BUP failed
libdvdread: Can't open file VIDEO_TS.IFO.
libdvdnav: vm: failed to read VIDEO_TS.IFO
[18:35:05] dvd: not a dvd - trying as a stream/file instead
Input #0, matroska,webm, from '/Volumes/HD/Feature Extractions/Star Trek Generations.mkv':
  Duration: 01:57:59.44, start: 0.000000, bitrate: 640 kb/s
    Chapter #0.0: start 0.000000, end 434.142022
    Metadata:
      title           : Chapter 00
    Chapter #0.1: start 434.142022, end 1095.677911
    Metadata:
      title           : Chapter 01
    Chapter #0.2: start 1095.677911, end 1473.388578
    Metadata:
      title           : Chapter 02
    Chapter #0.3: start 1473.388578, end 1665.163489
    Metadata:
      title           : Chapter 03
    Chapter #0.4: start 1665.163489, end 1927.258667
    Metadata:
      title           : Chapter 04
    Chapter #0.5: start 1927.258667, end 2596.594000
    Metadata:
      title           : Chapter 05
    Chapter #0.6: start 2596.594000, end 2749.329911
    Metadata:
      title           : Chapter 06
    Chapter #0.7: start 2749.329911, end 3105.060289
    Metadata:
      title           : Chapter 07
    Chapter #0.8: start 3105.060289, end 3466.921778
    Metadata:
      title           : Chapter 08
    Chapter #0.9: start 3466.921778, end 3977.348356
    Metadata:
      title           : Chapter 09
    Chapter #0.10: start 3977.348356, end 4249.995733
    Metadata:
      title           : Chapter 10
    Chapter #0.11: start 4249.995733, end 4798.001533
    Metadata:
      title           : Chapter 11
    Chapter #0.12: start 4798.001533, end 5343.880200
    Metadata:
      title           : Chapter 12
    Chapter #0.13: start 5343.880200, end 5984.228244
    Metadata:
      title           : Chapter 13
    Chapter #0.14: start 5984.228244, end 6599.217622
    Metadata:
      title           : Chapter 14
    Chapter #0.15: start 6599.217622, end 7079.447000
    Metadata:
      title           : Chapter 15
    Stream #0.0(eng): Video: h264, yuv420p, 1920x1080 [PAR 1:1 DAR 16:9], 23.98 fps, 23.98 tbr, 1k tbn, 47.95 tbc
    Stream #0.1(eng): Audio: truehd, 48000 Hz, 6 channels, s32
    Metadata:
      title           : 5.1
    Stream #0.2(eng): Audio: ac3, 48000 Hz, 5.1, s16, 640 kb/s
    Metadata:
      title           : 3/2+1
[18:35:05] Channels reported by ffmpeg (6) != computed layout channels (2).
[18:35:05] Found ffmpeg 16 chapters, container=matroska,webm
[18:35:05] Added chapter 1, name='Chapter 00', dur=39072781, (00:07:14)
[18:35:05] Added chapter 2, name='Chapter 01', dur=59538230, (00:11:01)
[18:35:05] Added chapter 3, name='Chapter 02', dur=33993960, (00:06:17)
[18:35:05] Added chapter 4, name='Chapter 03', dur=17259742, (00:03:11)
[18:35:05] Added chapter 5, name='Chapter 04', dur=23588566, (00:04:22)
[18:35:05] Added chapter 6, name='Chapter 05', dur=60240181, (00:11:09)
[18:35:05] Added chapter 7, name='Chapter 06', dur=13746231, (00:02:32)
[18:35:05] Added chapter 8, name='Chapter 07', dur=32015734, (00:05:55)
[18:35:05] Added chapter 9, name='Chapter 08', dur=32567534, (00:06:01)
[18:35:05] Added chapter 10, name='Chapter 09', dur=45938392, (00:08:30)
[18:35:05] Added chapter 11, name='Chapter 10', dur=24538264, (00:04:32)
[18:35:05] Added chapter 12, name='Chapter 11', dur=49320522, (00:09:08)
[18:35:05] Added chapter 13, name='Chapter 12', dur=49129080, (00:09:05)
[18:35:05] Added chapter 14, name='Chapter 13', dur=57631324, (00:10:40)
[18:35:05] Added chapter 15, name='Chapter 14', dur=55349044, (00:10:14)
[18:35:05] Added chapter 16, name='Chapter 15', dur=43220645, (00:08:00)
[18:35:05] scan: decoding previews for title 1
[18:35:05] scan: preview 1
[18:35:05] fifo_close: trashing 0 buffer(s)
[18:35:05] scan: audio 0x2: AC-3, rate=48000Hz, bitrate=640000 English (AC3) (5.1 ch)
[18:35:05] scan: preview 2
[18:35:05] scan: preview 3
[18:35:06] scan: preview 4
[18:35:06] scan: preview 5
[18:35:07] scan: preview 6
[18:35:08] scan: preview 7
[18:35:08] scan: preview 8
[18:35:09] scan: preview 9
[18:35:09] scan: preview 10
[18:35:10] scan: 10 previews, 1920x1080, 23.976 fps, autocrop = 0/0/0/0, aspect 16:9, PAR 1:1
[18:35:10] scan: title (0) job->width:1920, job->height:1072
[18:35:10] thread 1148b4000 exited ("scan")
[18:35:10] thread 1148b4000 joined ("scan")
[18:35:10] libhb: scan thread found 1 valid title(s)
[18:35:10] macgui: ScanDone state received from fQueueEncodeLibhb
[18:35:10] macgui: Preset: Blu-ray (Film)
[18:35:10] macgui: processNewQueueEncode number of passes expected is: 1
[18:35:11] macgui: Start / Stop set to chapters
[18:35:11] macgui: prepareJob exiting
[18:35:11] thread 114831000 started ("work")
[18:35:11] 1 job(s) to process
[18:35:11] starting job
[18:35:11] sync: expecting 169761 video frames
[18:35:11] job configuration:
[18:35:11]  * source
[18:35:11]    + /Volumes/HD/Feature Extractions/Star Trek Generations.mkv
[18:35:11]    + title 1, chapter(s) 1 to 16
[18:35:11]    + container: matroska,webm
[18:35:11]    + data rate: 640 kbps
[18:35:11]  * destination
[18:35:11]    + /Volumes/HD/Video Encodes/Star Trek GenerationsA.m4v
[18:35:11]    + container: MPEG-4 (.mp4 and .m4v)
[18:35:11]      + 64-bit formatting
[18:35:11]      + chapter markers
[18:35:11]  * video track
[18:35:11]    + decoder: h264
[18:35:11]    + frame rate: same as source (around 23.976 fps)
[18:35:11]    + loose anamorphic
[18:35:11]      + storage dimensions: 1920 * 1080 -> 1280 * 528, crop 138/138/0/0, mod 16
[18:35:11]      + pixel aspect ratio: 66 / 67
[18:35:11]      + display dimensions: 1260 * 528
[18:35:11]    + encoder: x264
[18:35:11]      + options: b-adapt=2:rc-lookahead=50:psy-rd=1.0,0.15:deblock=-1,-1
[18:35:11]      + quality: 19.00 (RF)
[18:35:11]  * audio track 0
[18:35:11]    + decoder: English (AC3) (5.1 ch) (track 1, id 2)
[18:35:11]      + bitrate: 640 kbps, samplerate: 48000 Hz
[18:35:11]    + mixdown: Dolby Pro Logic II
[18:35:11]    + dynamic range compression: 1.500000
[18:35:11]    + encoder: ca_aac
[18:35:11]      + bitrate: 192 kbps, samplerate: 48000 Hz
[18:35:11]  * audio track 1
[18:35:11]    + decoder: English (AC3) (5.1 ch) (track 1, id 2)
[18:35:11]      + bitrate: 640 kbps, samplerate: 48000 Hz
[18:35:11]    + AC3 passthrough
[18:35:11] thread 1148b4000 started ("reader")
[18:35:11] thread 114bb6000 started ("AudioSynchronization")
[18:35:11] thread 114c39000 started ("AudioSynchronization")
[18:35:11] thread 119180000 started ("Video decoder (ffmpeg streams)")
[18:35:11] thread 118b86000 started ("Renderer")
[18:35:11] encx264: min-keyint: auto (23), keyint: 240
[18:35:11] encx264: encoding with stored aspect 66/67
[18:35:11] encx264: Encoding at constant RF 19.000000
[18:35:11] encx264: opening libx264 (pass 0)
x264 [info]: using SAR=66/67
x264 [info]: using cpu capabilities: MMX2 SSE2Fast SSSE3 Cache64
[18:35:11] Seeking to chapter 1: starts 0, ends 39072781, AV pos 0
[18:35:11] reader: first SCR 0 id 2 DTS 0
x264 [info]: profile High, level 3.1
[18:35:11] thread 11caf7000 started ("H.264/AVC encoder (libx264)")
No accelerated IMDCT transform found
[18:35:11] thread 11f30a000 started ("AC3 decoder")
[18:35:13] thread 1244a0000 started ("AAC encoder (Apple)")
No accelerated IMDCT transform found
[18:35:13] thread 124523000 started ("AC3 decoder")
[18:35:13] thread 1245a6000 started ("Video Synchronization")
[18:35:13] muxmp4: using 64-bit MP4 formatting.
[18:35:13] muxmp4: track 0, chunk duration 15015
[18:35:13] muxmp4: track 1, chunk duration 8008
[18:35:13] muxmp4: track 2, chunk duration 8008
[18:35:13] muxmp4: disabled extra audio track 2
[18:35:13] thread 127829000 started ("Muxer")
[18:35:13] thread 1278ac000 started ("Muxer")
[h264 @ 0x102374400] left block unavailable for requested intra mode at 0 42
[h264 @ 0x102374400] error while decoding MB 0 42, bytestream (18895)
[18:55:22] ffmpeg_read starting chapter 2 at 39080250
[18:55:29] h264: "Chapter 01" (2) at frame 10419 time 39080250
[h264 @ 0x102374400] error while decoding MB 6 59, bytestream (-25)
[h264 @ 0x102374400] error while decoding MB 101 50, bytestream (-22)
[h264 @ 0x102374400] error while decoding MB 52 51, bytestream (-6)
[19:32:31] ffmpeg_read starting chapter 3 at 98614710
[19:32:37] h264: "Chapter 02" (3) at frame 26279 time 98614710
[19:56:16] ffmpeg_read starting chapter 4 at 132612480
[19:56:23] h264: "Chapter 03" (4) at frame 35336 time 132612480
[h264 @ 0x102374400] error while decoding MB 69 17, bytestream (-7)
[h264 @ 0x102374400] left block unavailable for requested intra mode at 0 25
[h264 @ 0x102374400] error while decoding MB 0 25, bytestream (31990)
[20:06:49] ffmpeg_read starting chapter 5 at 149872140
[20:06:55] h264: "Chapter 04" (5) at frame 39934 time 149872140
[20:19:21] ffmpeg_read starting chapter 6 at 173460780
[20:19:27] h264: "Chapter 05" (6) at frame 46218 time 173460780
[h264 @ 0x102374400] left block unavailable for requested intra4x4 mode -1 at 0 24
[h264 @ 0x102374400] error while decoding MB 0 24, bytestream (36811)
[h264 @ 0x102374400] error while decoding MB 0 34, bytestream (-21)
[h264 @ 0x102374400] left block unavailable for requested intra mode at 0 33
[h264 @ 0x102374400] error while decoding MB 0 33, bytestream (5798)
[20:51:38] ffmpeg_read starting chapter 7 at 233693460
[20:51:42] h264: "Chapter 06" (7) at frame 62264 time 233693460
[20:59:38] ffmpeg_read starting chapter 8 at 247450950
[20:59:44] h264: "Chapter 07" (8) at frame 65929 time 247450950
[21:17:28] ffmpeg_read starting chapter 9 at 279466650
[21:17:34] h264: "Chapter 08" (9) at frame 74458 time 279466650
[h264 @ 0x102374400] left block unavailable for requested intra mode at 0 49
[h264 @ 0x102374400] error while decoding MB 0 49, bytestream (9576)
[21:35:19] ffmpeg_read starting chapter 10 at 312034140
[21:35:25] h264: "Chapter 09" (10) at frame 83134 time 312034140
[h264 @ 0x102374400] error while decoding MB 113 50, bytestream (-8)
[h264 @ 0x102374400] left block unavailable for requested intra4x4 mode -1 at 0 23
[h264 @ 0x102374400] error while decoding MB 0 23, bytestream (95934)
[22:02:23] ffmpeg_read starting chapter 11 at 357972570
[22:02:29] h264: "Chapter 10" (11) at frame 95372 time 357972570
[22:18:35] ffmpeg_read starting chapter 12 at 382510800
[22:18:41] h264: "Chapter 11" (12) at frame 101909 time 382510800
[22:51:44] ffmpeg_read starting chapter 13 at 431831340
[22:51:51] h264: "Chapter 12" (13) at frame 115048 time 431831340
[23:20:22] ffmpeg_read starting chapter 14 at 480956670
[23:20:27] h264: "Chapter 13" (14) at frame 128135 time 480956670
[h264 @ 0x102374400] left block unavailable for requested intra4x4 mode -1 at 0 34
[h264 @ 0x102374400] error while decoding MB 0 34, bytestream (26)
[h264 @ 0x102374400] error while decoding MB 8 59, bytestream (-19)
[23:55:53] ffmpeg_read starting chapter 15 at 538584210
[23:55:59] h264: "Chapter 14" (15) at frame 143487 time 538584210
[00:31:04] ffmpeg_read starting chapter 16 at 593940780
[00:31:11] h264: "Chapter 15" (16) at frame 158234 time 593940780
[h264 @ 0x102374400] left block unavailable for requested intra mode at 0 30
[h264 @ 0x102374400] error while decoding MB 0 30, bytestream (14986)
[h264 @ 0x102374400] error while decoding MB 13 34, bytestream (-20)
[00:52:18] reader: done. 1 scr changes
[00:52:18] thread 1148b4000 exited ("reader")
[00:52:27] work: average encoding speed for job is 7.500075 fps
[00:52:27] thread 114c39000 exited ("AudioSynchronization")
[00:52:27] thread 1244a0000 exited ("AAC encoder (Apple)")
[00:52:27] thread 124523000 exited ("AC3 decoder")
[00:52:27] thread 119180000 exited ("Video decoder (ffmpeg streams)")
[00:52:27] thread 114bb6000 exited ("AudioSynchronization")
[00:52:27] thread 118b86000 exited ("Renderer")
[00:52:27] thread 1245a6000 exited ("Video Synchronization")
[00:52:27] thread 1245a6000 joined ("Video Synchronization")
[00:52:27] sync: got 169737 frames, 169761 expected
[00:52:27] thread 114bb6000 joined ("AudioSynchronization")
[00:52:27] thread 114c39000 joined ("AudioSynchronization")
[00:52:27] thread 119180000 joined ("Video decoder (ffmpeg streams)")
[00:52:27] h264-decoder done: 169737 frames, 0 decoder errors, 0 drops
[00:52:27] thread 127829000 exited ("Muxer")
[00:52:27] thread 1278ac000 exited ("Muxer")
[00:52:27] thread 11f30a000 exited ("AC3 decoder")
[00:52:27] thread 118b86000 joined ("Renderer")
[00:52:27] render: lost time: 0 (0 frames)
[00:52:27] render: gained time: 0 (0 frames) (0 not accounted for)
[00:52:27] fifo_close: trashing 0 buffer(s)
[00:52:27] fifo_close: trashing 0 buffer(s)
[00:52:27] thread 11caf7000 exited ("H.264/AVC encoder (libx264)")
[00:52:27] thread 11caf7000 joined ("H.264/AVC encoder (libx264)")
x264 [info]: frame I:1555  Avg QP:15.42  size: 87992  PSNR Mean Y:48.06 U:50.23 V:50.75 Avg:48.72 Global:48.33
x264 [info]: frame P:50503 Avg QP:18.21  size: 23135  PSNR Mean Y:46.31 U:48.66 V:49.45 Avg:46.95 Global:46.29
x264 [info]: frame B:117679 Avg QP:21.25  size:  5757  PSNR Mean Y:45.24 U:47.99 V:48.86 Avg:46.01 Global:45.36
x264 [info]: consecutive B-frames:  1.7%  5.3% 28.6% 64.3%
x264 [info]: mb I  I16..4:  9.2% 66.4% 24.3%
x264 [info]: mb P  I16..4:  4.3%  8.3%  1.6%  P16..4: 40.4% 19.7% 12.5%  0.0%  0.0%    skip:13.2%
x264 [info]: mb B  I16..4:  0.3%  0.8%  0.2%  B16..8: 42.6%  5.8%  1.2%  direct: 3.3%  skip:45.8%  L0:39.0% L1:50.7% BI:10.3%
x264 [info]: 8x8 transform intra:60.7% inter:76.0%
x264 [info]: coded y,uvDC,uvAC intra: 61.8% 80.4% 59.2% inter: 21.3% 22.6% 3.9%
x264 [info]: i16 v,h,dc,p: 58% 14%  7% 22%
x264 [info]: i8 v,h,dc,ddl,ddr,vr,hd,vl,hu: 15% 17% 22%  6%  8%  8%  9%  7%  9%
x264 [info]: i4 v,h,dc,ddl,ddr,vr,hd,vl,hu: 20% 19% 17%  6%  9%  8%  9%  6%  6%
x264 [info]: i8c dc,h,v,p: 52% 19% 19% 10%
x264 [info]: Weighted P-Frames: Y:3.6% UV:2.2%
x264 [info]: ref P L0: 57.3% 13.0% 20.4%  9.0%  0.3%
x264 [info]: ref B L0: 86.6% 10.9%  2.6%
x264 [info]: ref B L1: 94.0%  6.0%
x264 [info]: SSIM Mean Y:0.9858431 (18.490db)
x264 [info]: PSNR Mean Y:45.583 U:48.209 V:49.053 Avg:46.314 Global:45.636 kb/s:2240.55
[00:52:27] thread 11f30a000 joined ("AC3 decoder")
[00:52:27] thread 1244a0000 joined ("AAC encoder (Apple)")
[00:52:27] thread 124523000 joined ("AC3 decoder")
[00:52:27] thread 127829000 joined ("Muxer")
[00:52:27] thread 1278ac000 joined ("Muxer")
[00:52:27] mux: file size, 2729245981 bytes
[00:52:27] mux: track 0, 169737 frames, 1982663788 bytes, 2240.46 kbps, fifo 8
[00:52:27] mux: video bitrate error, +1982663788 bytes
[00:52:27] mux: track 1, 331850 frames, 174722041 bytes, 197.44 kbps, fifo 512
[00:52:27] mux: track 2, 221233 frames, 566356480 bytes, 640.00 kbps, fifo 256
[00:52:27] mux: overhead, 7.61 bytes per frame
[00:52:27] thread 1148b4000 joined ("reader")
[00:52:27] fifo_close: trashing 0 buffer(s)
[00:52:27] fifo_close: trashing 0 buffer(s)
[00:52:27] fifo_close: trashing 0 buffer(s)
[00:52:27] fifo_close: trashing 0 buffer(s)
[00:52:27] fifo_close: trashing 0 buffer(s)
[00:52:27] fifo_close: trashing 0 buffer(s)
[00:52:27] fifo_close: trashing 0 buffer(s)
[00:52:27] fifo_close: trashing 0 buffer(s)
[00:52:27] fifo_close: trashing 0 buffer(s)
[00:52:27] fifo_close: trashing 0 buffer(s)
[00:52:27] fifo_close: trashing 0 buffer(s)
[00:52:27] fifo_close: trashing 0 buffer(s)
[00:52:27] fifo_close: trashing 0 buffer(s)
[00:52:27] Freed 32 buffers of size 2048
[00:52:27] Freed 32 buffers of size 4096
[00:52:27] Freed 32 buffers of size 16384
[00:52:27] Freed 32 buffers of size 131072
[00:52:27] Freed 18 buffers of size 262144
[00:52:27] Freed 32 buffers of size 524288
[00:52:27] Freed 32 buffers of size 1048576
[00:52:27] Freed 32 buffers of size 4194304
[00:52:27] Allocated 194183168 bytes of buffers on this pass and Freed 194183168 bytes, 0 bytes leaked
[00:52:27] thread 114831000 exited ("work")
[00:52:28] thread 114831000 joined ("work")
[00:52:28] libhb: work result = 0
The parts that stood out to me:

Code: Select all

[h264 @ 0x102374400] left block unavailable for requested intra mode at 0 42
[h264 @ 0x102374400] error while decoding MB 0 42, bytestream (18895)
[18:55:22] ffmpeg_read starting chapter 2 at 39080250
[18:55:29] h264: "Chapter 01" (2) at frame 10419 time 39080250
[h264 @ 0x102374400] error while decoding MB 6 59, bytestream (-25)
[h264 @ 0x102374400] error while decoding MB 101 50, bytestream (-22)
[h264 @ 0x102374400] error while decoding MB 52 51, bytestream (-6)
[19:32:31] ffmpeg_read starting chapter 3 at 98614710
[19:32:37] h264: "Chapter 02" (3) at frame 26279 time 98614710
[19:56:16] ffmpeg_read starting chapter 4 at 132612480
[19:56:23] h264: "Chapter 03" (4) at frame 35336 time 132612480
[h264 @ 0x102374400] error while decoding MB 69 17, bytestream (-7)
[h264 @ 0x102374400] left block unavailable for requested intra mode at 0 25
[h264 @ 0x102374400] error while decoding MB 0 25, bytestream (31990)
[20:06:49] ffmpeg_read starting chapter 5 at 149872140
[20:06:55] h264: "Chapter 04" (5) at frame 39934 time 149872140
[20:19:21] ffmpeg_read starting chapter 6 at 173460780
[20:19:27] h264: "Chapter 05" (6) at frame 46218 time 173460780
[h264 @ 0x102374400] left block unavailable for requested intra4x4 mode -1 at 0 24
[h264 @ 0x102374400] error while decoding MB 0 24, bytestream (36811)
[h264 @ 0x102374400] error while decoding MB 0 34, bytestream (-21)
[h264 @ 0x102374400] left block unavailable for requested intra mode at 0 33
[h264 @ 0x102374400] error while decoding MB 0 33, bytestream (5798)
[20:51:38] ffmpeg_read starting chapter 7 at 233693460
[20:51:42] h264: "Chapter 06" (7) at frame 62264 time 233693460
[20:59:38] ffmpeg_read starting chapter 8 at 247450950
[20:59:44] h264: "Chapter 07" (8) at frame 65929 time 247450950
[21:17:28] ffmpeg_read starting chapter 9 at 279466650
[21:17:34] h264: "Chapter 08" (9) at frame 74458 time 279466650
[h264 @ 0x102374400] left block unavailable for requested intra mode at 0 49
[h264 @ 0x102374400] error while decoding MB 0 49, bytestream (9576)
[21:35:19] ffmpeg_read starting chapter 10 at 312034140
[21:35:25] h264: "Chapter 09" (10) at frame 83134 time 312034140
[h264 @ 0x102374400] error while decoding MB 113 50, bytestream (-8)
[h264 @ 0x102374400] left block unavailable for requested intra4x4 mode -1 at 0 23
[h264 @ 0x102374400] error while decoding MB 0 23, bytestream (95934)
[22:02:23] ffmpeg_read starting chapter 11 at 357972570
[22:02:29] h264: "Chapter 10" (11) at frame 95372 time 357972570
[22:18:35] ffmpeg_read starting chapter 12 at 382510800
[22:18:41] h264: "Chapter 11" (12) at frame 101909 time 382510800
[22:51:44] ffmpeg_read starting chapter 13 at 431831340
[22:51:51] h264: "Chapter 12" (13) at frame 115048 time 431831340
[23:20:22] ffmpeg_read starting chapter 14 at 480956670
[23:20:27] h264: "Chapter 13" (14) at frame 128135 time 480956670
[h264 @ 0x102374400] left block unavailable for requested intra4x4 mode -1 at 0 34
[h264 @ 0x102374400] error while decoding MB 0 34, bytestream (26)
[h264 @ 0x102374400] error while decoding MB 8 59, bytestream (-19)
[23:55:53] ffmpeg_read starting chapter 15 at 538584210
[23:55:59] h264: "Chapter 14" (15) at frame 143487 time 538584210
[00:31:04] ffmpeg_read starting chapter 16 at 593940780
[00:31:11] h264: "Chapter 15" (16) at frame 158234 time 593940780
[h264 @ 0x102374400] left block unavailable for requested intra mode at 0 30
[h264 @ 0x102374400] error while decoding MB 0 30, bytestream (14986)
[h264 @ 0x102374400] error while decoding MB 13 34, bytestream (-20)
A couple of visual examples, I haven't been able to reproduce this one:
Image

This one is harder to see but shows up in every subsequent encode (see his sideburn/ear) :
Image

Is this more of a MakeMKV problem or something Handbrake/x264 having an issue with?
Deleted User 11865

Re: Errors in Encodes from MakeMKV/Bluray

Post by Deleted User 11865 »

The error is printed by the H.264 decoder. It's not likely/necessarily an H.264 decoding bug because the decoder is clearly aware that something is wrong.
There haven't been any reports of similar errors either.

Does this only happen with H.264 Blu-Rays?
What other discs are you having trouble with?
Can you describe your ripping setup (drive, interface, official vs. patched firmware)?
Starhawk
Experienced
Posts: 90
Joined: Sun Feb 24, 2008 8:27 pm

Re: Errors in Encodes from MakeMKV/Bluray

Post by Starhawk »

Yes, all the Blurays I have are MPEG-4 AVC. The other disc I've encoded is True Blood, Season 1 with similar glitches in the video as seen above.

Im using an external [Censored] BD-CMB UJ141AL drive via USB 2.0 to a Macbook Pro running the latest version of MakeMKV and using Handbrake nightlies. I've not performed any firmware updates to my drive.

Edit: Rodeo, this must be mainly a Make MKV issue. I went back reviewed my MKVs and some, but not all, of the errors are in those encodes when viewed in VLC. I checked this before, but not all of the errors that appear in the encodes show up in the original (the one with Data spinning around, for example).
Deleted User 11865

Re: Errors in Encodes from MakeMKV/Bluray

Post by Deleted User 11865 »

VLC uses the same H.264 decoder as HandBrake, so this isn't surprising.

One thing you could try is to to a disc backup to a file/folder structure in MakeMKV and open that with HandBrake; see if it makes any difference.
rogue23
Enlightened
Posts: 137
Joined: Thu Dec 16, 2010 7:51 pm

Re: Errors in Encodes from MakeMKV/Bluray

Post by rogue23 »

I've been running into issues with files created with MakeMKV as well, although I haven't done much troubleshooting on it. Using the disc backup to a file/folder structure and then using handbrake on that folder works perfectly. It seems like MakeMKV is doing something potentially wacky in muxing the mkv file.
Post Reply