more than 25% speed decrease moving to 0.9.6

HandBrake for Mac support
Forum rules
An Activity Log is required for support requests. Please read How-to get an activity log? for details on how and why this should be provided.
Post Reply
Deleted User 7622

more than 25% speed decrease moving to 0.9.6

Post by Deleted User 7622 »

[EDIT: Disregard first post, go down to post 3:]Since upgrading to the latest version of Handbrake (0.9.6) I have noticed that using the exact same presets I used before I am seeing about a 60% drop in speed in the rendering of a .mkv file. On 0.9.5 I was seeing speeds as high as 250+ fps (on turbo first scan and 2nd pass) and with 0.9.6 I am seeing no higher than 110 fps during Turbo First Pass and about 95 fps on 2nd pass. I have activity logs for two similar files:

0.9.6:

Code: Select all

HandBrake Activity Log for /Volumes/Mr. Glitch HD/Handbrake/THE_CRITIC_01-3.mkv: 2012-03-08 00:31:40 -0400
Handbrake Version: 0.9.6 x86_64 (2012022800)

[00:31:40] macgui: Rip: Pending queue count is 51
[00:31:40] macgui: getNextPendingQueueIndex next pending encode index is:0
[00:31:40] macgui: scanning specifically for title: 3
[00:31:40] hb_scan: path=/Volumes/Mathman HD/DVD Backups/THE_CRITIC_01/VIDEO_TS, title_index=3
libbluray/bdnav/index_parse.c:157: indx_parse(): error opening /Volumes/Mathman HD/DVD Backups/THE_CRITIC_01/VIDEO_TS/BDMV/index.bdmv
libbluray/bluray.c:1471: nav_get_title_list(/Volumes/Mathman HD/DVD Backups/THE_CRITIC_01/VIDEO_TS) failed (0x103815c00)
[00:31:40] 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
libdvdread: Couldn't find device name.
libdvdnav: Can't read name block. Probably not a DVD-ROM device.
libdvdnav: Unable to find map file '/Users/morpie/.dvdnav/.map'
libdvdnav: DVD disk reports itself with Region mask 0x00000000. Regions: 1 2 3 4 5 6 7 8
libdvdread: Using libdvdcss version 1.2.10 for DVD access
libdvdread: Couldn't find device name.
[00:31:40] scan: DVD has 11 title(s)
[00:31:40] scan: scanning title 3
[00:31:40] scan: opening IFO for VTS 3
[00:31:40] scan: duration is 00:23:39 (1419186 ms)
[00:31:40] pgc_id: 1, pgn: 1: pgc: 0x101d7baf0
[00:31:40] scan: vts=3, ttn=1, cells=0->5, blocks=0->449944, 449945 blocks
[00:31:40] scan: checking audio 1
[00:31:40] scan: id=0x80bd, lang=English (AC3), 3cc=eng ext=0
[00:31:40] scan: title 3 has 6 chapters
[00:31:40] scan: chap 1 c=0->0, b=0->27154 (27155), 77356 ms
[00:31:40] scan: chap 2 c=1->1, b=27155->151626 (124472), 364608 ms
[00:31:40] scan: chap 3 c=2->2, b=151627->310956 (159330), 529626 ms
[00:31:40] scan: chap 4 c=3->3, b=310957->428835 (117879), 373416 ms
[00:31:40] scan: chap 5 c=4->4, b=428836->449430 (20595), 73166 ms
[00:31:40] scan: chap 6 c=5->5, b=449431->449944 (514), 1010 ms
[00:31:40] scan: aspect = 0
[00:31:40] scan: decoding previews for title 3
libdvdnav: DVD disk reports itself with Region mask 0x00000000. Regions: 1 2 3 4 5 6 7 8
[00:31:40] scan: title angle(s) 1
[00:31:40] scan: audio 0x80bd: AC-3, rate=48000Hz, bitrate=192000 English (AC3) (Dolby Surround)
[00:31:40] scan: 10 previews, 720x480, 23.976 fps, autocrop = 0/0/6/4, aspect 4:3, PAR 8:9
[00:31:40] scan: title (0) job->width:624, job->height:480
[00:31:40] libhb: scan thread found 1 valid title(s)
[00:31:41] macgui: ScanDone state received from fQueueEncodeLibhb
[00:31:41] macgui: Preset: SD - Normal (1100 kbps mkv)
[00:31:41] macgui: processNewQueueEncode number of passes expected is: 2
[00:31:41] macgui: Start / Stop set to chapters
[00:31:41] macgui: prepareJob exiting
[00:31:41] 2 job(s) to process
[00:31:41] starting job
[00:31:41] sync: expecting 34050 video frames
[00:31:41] job configuration:
[00:31:41]  * source
[00:31:41]    + /Volumes/Mathman HD/DVD Backups/THE_CRITIC_01/VIDEO_TS
[00:31:41]    + title 3, chapter(s) 1 to 6
[00:31:41]  * destination
[00:31:41]    + /Volumes/Mr. Glitch HD/Handbrake/THE_CRITIC_01-3.mkv
[00:31:41]    + container: Matroska (.mkv)
[00:31:41]      + chapter markers
[00:31:41]  * video track
[00:31:41]    + decoder: mpeg2
[00:31:41]      + bitrate 9800 kbps
[00:31:41]    + frame rate: same as source (around 23.976 fps)
[00:31:41]    + strict anamorphic
[00:31:41]      + storage dimensions: 720 * 480 -> 710 * 480, crop 0/0/6/4, mod 16
[00:31:41]      + pixel aspect ratio: 8 / 9
[00:31:41]      + display dimensions: 631 * 480
[00:31:41]    + filters
[00:31:41]      + Detelecine (pullup) (default settings)
[00:31:41]      + Decomb (default settings)
[00:31:41]    + encoder: H.264 (x264)
[00:31:41]      + options: b-adapt=2:rc-lookahead=50:ref=1:subme=2:me=dia:analyse=none:trellis=0:no-fast-pskip=0:8x8dct=0:weightb=0
[00:31:41]      + bitrate: 1100 kbps, pass: 1
[00:31:41]  * audio track 1
[00:31:41]    + decoder: English (AC3) (Dolby Surround) (track 1, id 0x80bd)
[00:31:41]      + bitrate: 192 kbps, samplerate: 48000 Hz
[00:31:41]    + AC3 Passthru
libdvdnav: Using dvdnav version 4.1.3
libdvdread: Using libdvdcss version 1.2.10 for DVD access
libdvdread: Couldn't find device name.
libdvdnav: Can't read name block. Probably not a DVD-ROM device.
libdvdnav: Unable to find map file '/Users/morpie/.dvdnav/.map'
libdvdnav: DVD disk reports itself with Region mask 0x00000000. Regions: 1 2 3 4 5 6 7 8
libdvdread: Using libdvdcss version 1.2.10 for DVD access
libdvdread: Couldn't find device name.
libdvdnav: DVD disk reports itself with Region mask 0x00000000. Regions: 1 2 3 4 5 6 7 8
[00:31:41] yadif thread started for segment 0
[00:31:41] yadif thread started for segment 1
[00:31:41] yadif thread started for segment 3
[00:31:41] yadif thread started for segment 2
[00:31:41] yadif thread started for segment 5
[00:31:41] yadif thread started for segment 4
[00:31:41] yadif thread started for segment 6
[00:31:41] yadif thread started for segment 7
[00:31:41] decomb thread started for segment 1
[00:31:41] decomb thread started for segment 0
[00:31:41] decomb thread started for segment 2
[00:31:41] decomb thread started for segment 3
[00:31:41] decomb thread started for segment 4
[00:31:41] decomb thread started for segment 5
[00:31:41] decomb thread started for segment 6
[00:31:41] decomb thread started for segment 7
[00:31:41] reader: first SCR 146 id 0xe0 DTS 732
[00:31:41] mpeg2: "Chapter  1" (1) at frame 0 time 3003
[00:31:41] encx264: min-keyint: 24, keyint: 240
[00:31:41] encx264: encoding with stored aspect 8/9
x264 [warning]: --psnr used with psy on: results will be invalid!
x264 [warning]: --tune psnr should be used if attempting to benchmark psnr!
x264 [info]: using SAR=8/9
x264 [info]: using cpu capabilities: MMX2 SSE2Fast SSSE3 FastShuffle SSE4.2 AVX
x264 [info]: profile Main, level 3.0
[00:31:41] sync: first pts is 3003
[00:31:41] 2.452445s: Video -> Film
[00:31:57] 77.977875s: Film -> Video
[00:31:57] mpeg2: "Chapter  2" (2) at frame 1886 time 7024017
[00:31:57] 78.128044s: Video -> Film
[00:33:16] mpeg2: "Chapter  3" (3) at frame 10637 time 39870831
[00:33:16] 443.009247s: Film -> Video
[00:33:16] 443.159363s: Video -> Film
[00:34:52] 891.357178s: Film -> Video
[00:34:52] 891.407227s: Video -> Film
[00:35:10] mpeg2: "Chapter  4" (4) at frame 23346 time 87570483
[00:35:10] 973.038757s: Film -> Video
[00:35:10] 973.188904s: Video -> Film
[00:36:31] 1346.728760s: Film -> Video
[00:36:31] mpeg2: "Chapter  5" (5) at frame 32309 time 121210089
[00:36:31] 1346.895508s: Video -> Film
[00:36:47] 1419.835083s: Film -> Video
[00:36:47] mpeg2: "Chapter  6" (6) at frame 34065 time 127795668
[00:36:47] 1420.001953s: Video -> Film
[00:36:47] 1421.153076s: Film -> Video
[00:36:47] reader: done. 1 scr changes
[00:36:48] work: average encoding speed for job is 111.234886 fps
[00:36:48] sync: got 34096 frames, 34050 expected
[00:36:48] mpeg2 done: 34096 frames
[00:36:48] render: lost time: 25525 (8 frames)
[00:36:48] render: gained time: 25525 (29 frames) (0 not accounted for)
[00:36:48] render: average dropped frame duration: 3190
x264 [info]: frame I:394   Avg QP:17.63  size: 43843  PSNR Mean Y:46.01 U:47.68 V:48.26 Avg:46.55 Global:45.98
x264 [info]: frame P:9762  Avg QP:20.69  size: 11684  PSNR Mean Y:43.31 U:45.19 V:46.04 Avg:43.92 Global:43.23
x264 [info]: frame B:23931 Avg QP:22.55  size:  2627  PSNR Mean Y:42.02 U:44.12 V:45.25 Avg:42.71 Global:42.31
x264 [info]: consecutive B-frames:  2.8%  4.3% 19.7% 73.3%
x264 [info]: mb I  I16..4: 34.4%  0.0% 65.6%
x264 [info]: mb P  I16..4: 21.4%  0.0%  0.0%  P16..4: 66.4%  0.0%  0.0%  0.0%  0.0%    skip:12.2%
x264 [info]: mb B  I16..4:  3.6%  0.0%  0.0%  B16..8: 24.6%  0.0%  0.0%  direct:21.2%  skip:50.6%  L0:35.4% L1:49.6% BI:14.9%
x264 [info]: final ratefactor: 19.52
x264 [info]: coded y,uvDC,uvAC intra: 59.7% 78.4% 39.9% inter: 15.9% 35.2% 2.3%
x264 [info]: i16 v,h,dc,p: 32% 28% 33%  7%
x264 [info]: i4 v,h,dc,ddl,ddr,vr,hd,vl,hu: 23% 24% 12%  6%  7%  6%  8%  6%  9%
x264 [info]: i8c dc,h,v,p: 45% 28% 22%  6%
x264 [info]: Weighted P-Frames: Y:8.9% UV:3.9%
x264 [info]: SSIM Mean Y:0.9772432 (16.429db)
x264 [info]: PSNR Mean Y:42.431 U:44.458 V:45.507 Avg:43.092 Global:42.578 kb/s:1093.20
[00:36:48] decomb: deinterlaced 1 | blended 1 | unfiltered 34085 | total 34087
[00:36:48] starting job
[00:36:48] sync: expecting 34096 video frames
[00:36:48] job configuration:
[00:36:48]  * source
[00:36:48]    + /Volumes/Mathman HD/DVD Backups/THE_CRITIC_01/VIDEO_TS
[00:36:48]    + title 3, chapter(s) 1 to 6
[00:36:48]  * destination
[00:36:48]    + /Volumes/Mr. Glitch HD/Handbrake/THE_CRITIC_01-3.mkv
[00:36:48]    + container: Matroska (.mkv)
[00:36:48]      + chapter markers
[00:36:48]  * video track
[00:36:48]    + decoder: mpeg2
[00:36:48]      + bitrate 9800 kbps
[00:36:48]    + frame rate: same as source (around 23.976 fps)
[00:36:48]    + strict anamorphic
[00:36:48]      + storage dimensions: 720 * 480 -> 710 * 480, crop 0/0/6/4, mod 16
[00:36:48]      + pixel aspect ratio: 8 / 9
[00:36:48]      + display dimensions: 631 * 480
[00:36:48]    + filters
[00:36:48]      + Detelecine (pullup) (default settings)
[00:36:48]      + Decomb (default settings)
[00:36:48]    + encoder: H.264 (x264)
[00:36:48]      + options: b-adapt=2:rc-lookahead=50
[00:36:48]      + bitrate: 1100 kbps, pass: 2
[00:36:48]  * audio track 1
[00:36:48]    + decoder: English (AC3) (Dolby Surround) (track 1, id 0x80bd)
[00:36:48]      + bitrate: 192 kbps, samplerate: 48000 Hz
[00:36:48]    + AC3 Passthru
libdvdnav: Using dvdnav version 4.1.3
libdvdread: Using libdvdcss version 1.2.10 for DVD access
libdvdread: Couldn't find device name.
libdvdnav: Can't read name block. Probably not a DVD-ROM device.
libdvdnav: Unable to find map file '/Users/morpie/.dvdnav/.map'
libdvdnav: DVD disk reports itself with Region mask 0x00000000. Regions: 1 2 3 4 5 6 7 8
libdvdread: Using libdvdcss version 1.2.10 for DVD access
libdvdread: Couldn't find device name.
libdvdnav: DVD disk reports itself with Region mask 0x00000000. Regions: 1 2 3 4 5 6 7 8
[00:36:48] yadif thread started for segment 0
[00:36:48] yadif thread started for segment 1
[00:36:48] yadif thread started for segment 2
[00:36:48] yadif thread started for segment 3
[00:36:48] yadif thread started for segment 4
[00:36:48] yadif thread started for segment 5
[00:36:48] yadif thread started for segment 6
[00:36:48] yadif thread started for segment 7
[00:36:48] decomb thread started for segment 0
[00:36:48] decomb thread started for segment 1
[00:36:48] decomb thread started for segment 3
[00:36:48] decomb thread started for segment 2
[00:36:48] decomb thread started for segment 4
[00:36:48] decomb thread started for segment 5
[00:36:48] decomb thread started for segment 7
[00:36:48] encx264: min-keyint: 24, keyint: 240
[00:36:48] decomb thread started for segment 6
[00:36:48] encx264: encoding with stored aspect 8/9
x264 [warning]: --psnr used with psy on: results will be invalid!
x264 [warning]: --tune psnr should be used if attempting to benchmark psnr!
x264 [info]: using SAR=8/9
x264 [info]: using cpu capabilities: MMX2 SSE2Fast SSSE3 FastShuffle SSE4.2 AVX
[00:36:48] reader: first SCR 146 id 0xe0 DTS 732
[00:36:48] mpeg2: "Chapter  1" (1) at frame 0 time 3003
x264 [info]: profile High, level 3.0
[00:36:48] sync: first pts is 3003
[00:36:49] 2.452445s: Video -> Film
[00:37:08] 77.977875s: Film -> Video
[00:37:08] mpeg2: "Chapter  2" (2) at frame 1886 time 7024017
[00:37:08] 78.128044s: Video -> Film
[00:38:44] mpeg2: "Chapter  3" (3) at frame 10637 time 39870831
[00:38:44] 443.009247s: Film -> Video
[00:38:44] 443.159363s: Video -> Film
[00:40:38] 891.357178s: Film -> Video
[00:40:38] 891.407227s: Video -> Film
[00:40:59] mpeg2: "Chapter  4" (4) at frame 23346 time 87570483
[00:40:59] 973.038757s: Film -> Video
[00:40:59] 973.188904s: Video -> Film
[00:42:35] 1346.728760s: Film -> Video
[00:42:35] mpeg2: "Chapter  5" (5) at frame 32309 time 121210089
[00:42:35] 1346.895508s: Video -> Film
[00:42:53] 1419.835083s: Film -> Video
[00:42:53] mpeg2: "Chapter  6" (6) at frame 34065 time 127795668
[00:42:53] 1420.001953s: Video -> Film
[00:42:53] 1421.153076s: Film -> Video
[00:42:53] reader: done. 1 scr changes
[00:42:54] work: average encoding speed for job is 93.415634 fps
[00:42:54] sync: got 34096 frames, 34096 expected
[00:42:54] mpeg2 done: 34096 frames
[00:42:54] render: lost time: 25525 (8 frames)
[00:42:54] render: gained time: 25525 (29 frames) (0 not accounted for)
[00:42:54] render: average dropped frame duration: 3190
x264 [info]: frame I:394   Avg QP:18.55  size: 40593  PSNR Mean Y:46.01 U:48.19 V:48.77 Avg:46.67 Global:46.24
x264 [info]: frame P:9762  Avg QP:21.18  size: 11410  PSNR Mean Y:43.76 U:46.00 V:46.86 Avg:44.46 Global:43.93
x264 [info]: frame B:23931 Avg QP:23.39  size:  2842  PSNR Mean Y:42.49 U:44.53 V:45.80 Avg:43.18 Global:42.91
x264 [info]: consecutive B-frames:  2.8%  4.3% 19.7% 73.3%
x264 [info]: mb I  I16..4:  6.0% 78.5% 15.5%
x264 [info]: mb P  I16..4:  0.6%  5.8%  1.5%  P16..4: 48.0% 20.0% 13.8%  0.0%  0.0%    skip:10.3%
x264 [info]: mb B  I16..4:  0.1%  0.4%  0.2%  B16..8: 42.7%  4.2%  0.8%  direct: 4.1%  skip:47.5%  L0:43.2% L1:51.7% BI: 5.2%
x264 [info]: 8x8 transform intra:74.4% inter:79.4%
x264 [info]: coded y,uvDC,uvAC intra: 82.8% 93.1% 69.9% inter: 22.2% 41.6% 4.0%
x264 [info]: i16 v,h,dc,p: 63% 18%  6% 13%
x264 [info]: i8 v,h,dc,ddl,ddr,vr,hd,vl,hu: 18% 19% 23%  5%  6%  6%  7%  6%  9%
x264 [info]: i4 v,h,dc,ddl,ddr,vr,hd,vl,hu: 22% 22% 13%  6%  8%  8%  9%  6%  6%
x264 [info]: i8c dc,h,v,p: 41% 27% 22% 10%
x264 [info]: Weighted P-Frames: Y:8.9% UV:3.9%
x264 [info]: ref P L0: 49.2% 12.6% 26.0% 11.5%  0.8%
x264 [info]: ref B L0: 76.4% 18.7%  4.9%
x264 [info]: ref B L1: 89.8% 10.2%
x264 [info]: SSIM Mean Y:0.9778512 (16.547db)
x264 [info]: PSNR Mean Y:42.889 U:44.987 V:46.134 Avg:43.583 Global:43.199 kb/s:1099.91
[00:42:54] mux: track 0, 34087 frames, 195374977 bytes, 1099.73 kbps, fifo 4096
[00:42:54] mux: track 1, 44414 frames, 34109952 bytes, 192.00 kbps, fifo 4096
[00:42:54] decomb: deinterlaced 1 | blended 1 | unfiltered 34085 | total 34087
[00:42:54] libhb: work result = 0
and from 0.9.5:

Code: Select all

[00:46:08] 503.920044s: Film -> Video
[00:46:08] mpeg2: "Chapter  3" (3) at frame 12100 time 45360315
[00:46:08] 504.086945s: Video -> Film
[00:46:42] 883.966370s: Film -> Video
[00:46:42] mpeg2: "Chapter  4" (4) at frame 21213 time 79564485
[00:46:42] 884.133240s: Video -> Film
[00:47:20] mpeg2: "Chapter  5" (5) at frame 31308 time 117456339
[00:47:20] 1305.070435s: Film -> Video
[00:47:20] 1305.220581s: Video -> Film
[00:47:26] reader: done. 0 scr changes
[00:47:26] mpeg2: "Chapter  6" (6) at frame 32864 time 123294171
[00:47:26] 1369.968628s: Film -> Video
[00:47:26] 1370.118774s: Video -> Film
[00:47:27] work: average encoding speed for job is 264.993439 fps
[00:47:27] sync: got 32895 frames, 32852 expected
[00:47:27] mpeg2 done: 32895 frames
[00:47:27] render: lost time: 9009 (3 frames)
[00:47:27] render: gained time: 9009 (9 frames) (0 not accounted for)
[00:47:27] render: average dropped frame duration: 3003
[00:47:27] decomb: deinterlaced 0 | blended 1 | unfiltered 32890 | total 32891
[00:47:27] starting job
[00:47:27] sync: expecting 32895 video frames
[ac3 @ 0x115800000] No channel layout specified. The encoder will guess the layout, but it might be incorrect.
[00:47:27] job configuration:
[00:47:27]  * source
[00:47:27]    + /Volumes/Mathman HD/DVD Backups/THE_CRITIC_01/VIDEO_TS
[00:47:27]    + title 4, chapter(s) 1 to 6
[00:47:27]  * destination
[00:47:27]    + /Volumes/Mr. Glitch HD/Handbrake/THE_CRITIC_01-4.mkv
[00:47:27]    + container: Matroska (.mkv)
[00:47:27]      + chapter markers
[00:47:27]  * video track
[00:47:27]    + decoder: mpeg2
[00:47:27]      + bitrate 9800 kbps
[00:47:27]    + frame rate: same as source (around 23.976 fps)
[00:47:27]    + strict anamorphic
[00:47:27]      + storage dimensions: 720 * 480 -> 720 * 480, crop 0/0/0/0, mod 16
[00:47:27]      + pixel aspect ratio: 8 / 9
[00:47:27]      + display dimensions: 640 * 480
[00:47:27]    + filters
[00:47:27]      + Detelecine (pullup) (default settings)
[00:47:27]      + Decomb (default settings)
[00:47:27]    + encoder: FFmpeg
[00:47:27]      + bitrate: 1100 kbps, pass: 2
[00:47:27]  * audio track 0
[00:47:27]    + decoder: English (AC3) (Dolby Surround) (track 1, id 80bd)
[00:47:27]      + bitrate: 192 kbps, samplerate: 48000 Hz
[00:47:27]    + AC3 passthrough
libdvdnav: Using dvdnav version 4.1.3
libdvdread: Using libdvdcss version 1.2.10 for DVD access
[00:47:27] yadif thread started for segment 1
[00:47:27] yadif thread started for segment 0
libdvdread: Couldn't find device name.
[00:47:27] yadif thread started for segment 2
[00:47:27] yadif thread started for segment 4
[00:47:27] yadif thread started for segment 3
[00:47:27] yadif thread started for segment 5
[00:47:27] yadif thread started for segment 6
[00:47:27] yadif thread started for segment 7
[00:47:27] decomb thread started for segment 0
[00:47:27] decomb thread started for segment 1
[00:47:27] decomb thread started for segment 2
[00:47:27] decomb thread started for segment 3
[00:47:27] decomb thread started for segment 4
[00:47:27] decomb thread started for segment 5
[00:47:27] decomb thread started for segment 6
[00:47:27] decomb thread started for segment 7
libdvdnav: Can't read name block. Probably not a DVD-ROM device.
[00:47:27] encavcodec: truncating framerate 1126125 / 27015112
libdvdnav: Unable to find map file '/Users/morpie/.dvdnav/.map'
[00:47:27] encavcodec: encoding with stored aspect 8/9
libdvdnav: DVD disk reports itself with Region mask 0x00000000. Regions: 1 2 3 4 5 6 7 8
libdvdread: Using libdvdcss version 1.2.10 for DVD access
libdvdread: Couldn't find device name.
libdvdnav: DVD disk reports itself with Region mask 0x00000000. Regions: 1 2 3 4 5 6 7 8
[00:47:27] reader: first SCR 146 id 224 DTS 732
[00:47:27] mpeg2: "Chapter  1" (1) at frame 0 time 3003
No accelerated IMDCT transform found
[00:47:27] 2.485811s: Video -> Film
[00:47:34] 81.664909s: Film -> Video
[00:47:34] mpeg2: "Chapter  2" (2) at frame 1974 time 7354347
[00:47:34] 81.831741s: Video -> Film
[00:48:13] 503.920044s: Film -> Video
[00:48:13] mpeg2: "Chapter  3" (3) at frame 12100 time 45360315
[00:48:13] 504.086945s: Video -> Film
[00:48:47] 883.966370s: Film -> Video
[00:48:47] mpeg2: "Chapter  4" (4) at frame 21213 time 79564485
[00:48:47] 884.133240s: Video -> Film
[00:49:25] mpeg2: "Chapter  5" (5) at frame 31308 time 117456339
[00:49:25] 1305.070435s: Film -> Video
[00:49:25] 1305.220581s: Video -> Film
[00:49:31] reader: done. 0 scr changes
[00:49:31] mpeg2: "Chapter  6" (6) at frame 32864 time 123294171
[00:49:31] 1369.968628s: Film -> Video
[00:49:31] 1370.118774s: Video -> Film
[00:49:32] work: average encoding speed for job is 264.600128 fps
[00:49:32] sync: got 32895 frames, 32895 expected
[00:49:32] mpeg2 done: 32895 frames
[00:49:32] render: lost time: 9009 (3 frames)
[00:49:32] render: gained time: 9009 (9 frames) (0 not accounted for)
[00:49:32] render: average dropped frame duration: 3003
[00:49:32] mux: track 0, 32891 frames, 188490474 bytes, 1099.69 kbps, fifo 32
[00:49:32] mux: track 1, 42851 frames, 32909568 bytes, 192.00 kbps, fifo 256
[00:49:32] decomb: deinterlaced 0 | blended 1 | unfiltered 32890 | total 32891
[00:49:32] libhb: work result = 0
By going back to 0.9.5 I'm seeing the better speeds again, file sizes remain about the same. Also, CPU and RAM performance seem to be about thesame on either version of Handbrake, if anything 0.9.6 is using slightly more CPU and RAM to encode video more slowly. Any thoughts? If it has to do with optimization of the x264 encoder fine, but losing more than half the speed seems more like a bug.

My machine specs are for an Intel Core i7 hackintosh, 16GB RAM, XFX 6870 (probably doesn't matter).
Last edited by Deleted User 7622 on Thu Mar 08, 2012 6:00 am, edited 1 time in total.
mac_man_ad
Experienced
Posts: 75
Joined: Wed Aug 22, 2007 5:21 am

Re: more than 50% speed decrease moving to 0.9.6

Post by mac_man_ad »

You are using FFMpeg as the encoder on 0.9.5 but x264 in 0.9.6.
This is a slower encoder with VERY MUCH higher visual quality (and smaller file size) output.
Deleted User 7622

Re: more than 50% speed decrease moving to 0.9.6

Post by Deleted User 7622 »

k, that's my mistake, but a separate issue, going back to 0.9.5 I saw a huge speed boost which didn't make sense but I wasn't going to complain about :P I do normally use x264, I was using the same preset on both files and normally I see speeds around 120fps at most on 2nd Pass using x264. For some reason when going back to 0.9.5 it must have not been able to read my preset and defaulted to FFMpeg. But I'm still seeing a speed drop even when I use x264 between versions.

To test it further, I completely removed Handbrake from my system, deleting all Application Support and Preferences and clean installed 0.9.5 again. Then I deleted that version completely, and installed 0.9.6 and reencoded the exact same file, using the same preset on both files. I'm still seeing a fairly decent speed drop, here are my results:

0.9.5 (165+fps turbo, 125fps 2nd pass):

Code: Select all

HandBrake Activity Log for /Users/morpie/Desktop/THE_CRITIC_01.mkv: 2012-03-08 01:26:55 -0400
Handbrake Version: 0.9.5 x86_64 (2011010300)

[01:26:55] macgui: Rip: Pending queue count is 1
[01:26:55] macgui: getNextPendingQueueIndex next pending encode index is:0
[01:26:55] macgui: scanning specifically for title: 1
[01:26:55] hb_scan: path=/Volumes/Mathman HD/DVD Backups/THE_CRITIC_01/VIDEO_TS, title_index=1
libbluray/bdnav/index_parse.c:157: indx_parse(): error opening /Volumes/Mathman HD/DVD Backups/THE_CRITIC_01/VIDEO_TS/BDMV/index.bdmv
libbluray/bluray.c:960: nav_get_title_list(/Volumes/Mathman HD/DVD Backups/THE_CRITIC_01/VIDEO_TS) failed (0x1021bb600)
[01:26:55] 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
libdvdread: Couldn't find device name.
libdvdnav: Can't read name block. Probably not a DVD-ROM device.
libdvdnav: Unable to find map file '/Users/morpie/.dvdnav/.map'
libdvdnav: DVD disk reports itself with Region mask 0x00000000. Regions: 1 2 3 4 5 6 7 8
libdvdread: Using libdvdcss version 1.2.10 for DVD access
libdvdread: Couldn't find device name.
[01:26:55] scan: DVD has 11 title(s)
[01:26:55] scan: scanning title 1
[01:26:55] scan: opening IFO for VTS 1
[01:26:55] scan: duration is 00:23:05 (1385086 ms)
[01:26:55] pgc_id: 1, pgn: 1: pgc: 0x101c47cd0
[01:26:55] scan: vts=1, ttn=1, cells=0->5, blocks=0->455393, 455394 blocks
[01:26:55] scan: checking audio 1
[01:26:55] scan: id=80bd, lang=English (AC3), 3cc=eng ext=0
[01:26:55] scan: checking audio 2
[01:26:55] scan: id=81bd, lang=English (AC3), 3cc=eng ext=0
[01:26:55] scan: title 1 has 6 chapters
[01:26:55] scan: chap 1 c=0->0, b=0->31511 (31512), 79360 ms
[01:26:55] scan: chap 2 c=1->1, b=31512->156776 (125265), 391642 ms
[01:26:55] scan: chap 3 c=2->2, b=156777->324037 (167261), 504614 ms
[01:26:55] scan: chap 4 c=3->3, b=324038->421673 (97636), 305351 ms
[01:26:55] scan: chap 5 c=4->4, b=421674->455340 (33667), 103106 ms
[01:26:55] scan: chap 6 c=5->5, b=455341->455393 (53), 1010 ms
[01:26:55] scan: aspect = 0
[01:26:55] scan: decoding previews for title 1
libdvdnav: DVD disk reports itself with Region mask 0x00000000. Regions: 1 2 3 4 5 6 7 8
[01:26:55] scan: title angle(s) 1
[01:26:55] scan: audio 0x81bd: AC-3, rate=48000Hz, bitrate=192000 English (AC3) (Dolby Surround)
[01:26:55] scan: audio 0x80bd: AC-3, rate=48000Hz, bitrate=192000 English (AC3) (Dolby Surround)
[01:26:55] scan: 10 previews, 720x480, 23.976 fps, autocrop = 0/0/6/4, aspect 4:3, PAR 8:9
[01:26:55] scan: title (0) job->width:624, job->height:480
[01:26:55] libhb: scan thread found 1 valid title(s)
[01:26:55] macgui: ScanDone state received from fQueueEncodeLibhb
[01:26:55] macgui: Preset: (import) SD - Normal (1100 kbps mkv)
[01:26:55] macgui: processNewQueueEncode number of passes expected is: 2
[01:26:55] macgui: Start / Stop set to chapters
[01:26:55] macgui: prepareJob exiting
[01:26:55] 2 job(s) to process
[01:26:55] starting job
[01:26:55] sync: expecting 33232 video frames
[ac3 @ 0x1051e2600] No channel layout specified. The encoder will guess the layout, but it might be incorrect.
[ac3 @ 0x1051e2600] No channel layout specified. The encoder will guess the layout, but it might be incorrect.
[01:26:55] job configuration:
[01:26:55]  * source
[01:26:55]    + /Volumes/Mathman HD/DVD Backups/THE_CRITIC_01/VIDEO_TS
[01:26:55]    + title 1, chapter(s) 1 to 6
[01:26:55]  * destination
[01:26:55]    + /Users/morpie/Desktop/THE_CRITIC_01.mkv
[01:26:55]    + container: Matroska (.mkv)
[01:26:55]      + chapter markers
[01:26:55]  * video track
[01:26:55]    + decoder: mpeg2
[01:26:55]      + bitrate 9800 kbps
[01:26:55]    + frame rate: same as source (around 23.976 fps)
[01:26:55]    + strict anamorphic
[01:26:55]      + storage dimensions: 720 * 480 -> 710 * 480, crop 0/0/6/4, mod 16
[01:26:55]      + pixel aspect ratio: 8 / 9
[01:26:55]      + display dimensions: 631 * 480
[01:26:55]    + filters
[01:26:55]      + Detelecine (pullup) (default settings)
[01:26:55]      + Decomb (default settings)
[01:26:55]    + encoder: x264
[01:26:55]      + options: b-adapt=2:rc-lookahead=50:ref=1:subme=2:me=dia:analyse=none:trellis=0:no-fast-pskip=0:8x8dct=0:weightb=0
[01:26:55]      + bitrate: 1100 kbps, pass: 1
[01:26:55]  * audio track 0
[01:26:55]    + decoder: English (AC3) (Dolby Surround) (track 1, id 80bd)
[01:26:55]      + bitrate: 192 kbps, samplerate: 48000 Hz
[01:26:55]    + AC3 passthrough
[01:26:55]  * audio track 1
[01:26:55]    + decoder: English (AC3) (Dolby Surround) (track 2, id 81bd)
[01:26:55]      + bitrate: 192 kbps, samplerate: 48000 Hz
[01:26:55]    + AC3 passthrough
libdvdnav: Using dvdnav version 4.1.3
libdvdread: Using libdvdcss version 1.2.10 for DVD access
libdvdread: Couldn't find device name.
[01:26:55] yadif thread started for segment 0
[01:26:55] yadif thread started for segment 1
[01:26:55] yadif thread started for segment 3
[01:26:55] yadif thread started for segment 2
[01:26:55] yadif thread started for segment 5
[01:26:55] yadif thread started for segment 4
[01:26:55] yadif thread started for segment 6
[01:26:55] yadif thread started for segment 7
libdvdnav: Can't read name block. Probably not a DVD-ROM device.
[01:26:55] decomb thread started for segment 1
[01:26:55] decomb thread started for segment 0
[01:26:55] decomb thread started for segment 2
[01:26:55] decomb thread started for segment 4
[01:26:55] decomb thread started for segment 3
[01:26:55] decomb thread started for segment 6
libdvdnav: Unable to find map file '/Users/morpie/.dvdnav/.map'
[01:26:55] decomb thread started for segment 5
[01:26:55] decomb thread started for segment 7
libdvdnav: DVD disk reports itself with Region mask 0x00000000. Regions: 1 2 3 4 5 6 7 8
libdvdread: Using libdvdcss version 1.2.10 for DVD access
libdvdread: Couldn't find device name.
[01:26:55] encx264: min-keyint: auto (23), keyint: 240
[01:26:55] encx264: encoding with stored aspect 8/9
x264 [info]: libdvdnav: DVD disk reports itself with Region mask 0x00000000. Regions:using SAR=8/9
 1 2 3 4 5 6 7 8
x264 [info]: using cpu capabilities: MMX2 SSE2Fast SSSE3 FastShuffle SSE4.2
[01:26:55] reader: first SCR 146 id 224 DTS 732
[01:26:55] mpeg2: "Chapter  1" (1) at frame 0 time 3003
x264 [info]: profile Main, level 3.0
No accelerated IMDCT transform found
No accelerated IMDCT transform found
[01:26:56] 2.585911s: Video -> Film
[01:27:07] 79.996559s: Film -> Video
[01:27:07] mpeg2: "Chapter  2" (2) at frame 1934 time 7204197
[01:27:07] 80.163414s: Video -> Film
[01:28:01] mpeg2: "Chapter  3" (3) at frame 11333 time 42483441
[01:28:01] 472.071594s: Film -> Video
[01:28:01] 472.221741s: Video -> Film
[01:29:11] 976.942566s: Film -> Video
[01:29:11] mpeg2: "Chapter  4" (4) at frame 23442 time 87930843
[01:29:11] 977.092773s: Video -> Film
[01:29:54] 1282.331055s: Film -> Video
[01:29:54] mpeg2: "Chapter  5" (5) at frame 30765 time 115414299
[01:29:54] 1282.497925s: Video -> Film
[01:29:59] 1322.704712s: Film -> Video
[01:29:59] 1322.754761s: Video -> Film
[01:30:08] reader: done. 0 scr changes
[01:30:08] mpeg2: "Chapter  6" (6) at frame 33246 time 124723599
[01:30:08] 1385.851074s: Film -> Video
[01:30:08] 1386.001221s: Video -> Film
[01:30:08] work: average encoding speed for job is 172.667892 fps
[01:30:09] sync: got 33277 frames, 33232 expected
[01:30:09] mpeg2 done: 33277 frames
[01:30:09] render: lost time: 15015 (5 frames)
[01:30:09] render: gained time: 15015 (20 frames) (0 not accounted for)
[01:30:09] render: average dropped frame duration: 3003
x264 [info]: frame I:406   Avg QP:16.64  size: 48126  PSNR Mean Y:46.83 U:48.17 V:48.74 Avg:47.30 Global:46.82
x264 [info]: frame P:9635  Avg QP:19.68  size: 11798  PSNR Mean Y:44.15 U:45.70 V:46.54 Avg:44.68 Global:43.96
x264 [info]: frame B:23230 Avg QP:21.75  size:  2438  PSNR Mean Y:42.62 U:44.30 V:45.48 Avg:43.22 Global:42.98
x264 [info]: consecutive B-frames:  1.8%  4.1% 23.5% 70.6%
x264 [info]: mb I  I16..4: 30.7%  0.0% 69.3%
x264 [info]: mb P  I16..4: 17.8%  0.0%  0.0%  P16..4: 69.6%  0.0%  0.0%  0.0%  0.0%    skip:12.6%
x264 [info]: mb B  I16..4:  2.7%  0.0%  0.0%  B16..8: 24.2%  0.0%  0.0%  direct:20.2%  skip:52.9%  L0:35.3% L1:50.7% BI:14.0%
x264 [info]: final ratefactor: 18.61
x264 [info]: coded y,uvDC,uvAC intra: 60.9% 82.4% 42.7% inter: 15.1% 35.1% 2.9%
x264 [info]: i16 v,h,dc,p: 32% 27% 33%  8%
x264 [info]: i4 v,h,dc,ddl,ddr,vr,hd,vl,hu: 24% 24% 17%  3%  8%  5%  6%  5%  8%
x264 [info]: i8c dc,h,v,p: 42% 29% 23%  6%
x264 [info]: Weighted P-Frames: Y:7.0% UV:2.6%
x264 [info]: SSIM Mean Y:0.9813309 (17.289db)
x264 [info]: PSNR Mean Y:43.115 U:44.759 V:45.828 Avg:43.699 Global:43.275 kb/s:1095.03
[01:30:09] decomb: deinterlaced 0 | blended 0 | unfiltered 33271 | total 33271
[01:30:09] starting job
[01:30:09] sync: expecting 33277 video frames
[ac3 @ 0x1051aac00] No channel layout specified. The encoder will guess the layout, but it might be incorrect.
[ac3 @ 0x1051aac00] No channel layout specified. The encoder will guess the layout, but it might be incorrect.
[01:30:09] job configuration:
[01:30:09]  * source
[01:30:09]    + /Volumes/Mathman HD/DVD Backups/THE_CRITIC_01/VIDEO_TS
[01:30:09]    + title 1, chapter(s) 1 to 6
[01:30:09]  * destination
[01:30:09]    + /Users/morpie/Desktop/THE_CRITIC_01.mkv
[01:30:09]    + container: Matroska (.mkv)
[01:30:09]      + chapter markers
[01:30:09]  * video track
[01:30:09]    + decoder: mpeg2
[01:30:09]      + bitrate 9800 kbps
[01:30:09]    + frame rate: same as source (around 23.976 fps)
[01:30:09]    + strict anamorphic
[01:30:09]      + storage dimensions: 720 * 480 -> 710 * 480, crop 0/0/6/4, mod 16
[01:30:09]      + pixel aspect ratio: 8 / 9
[01:30:09]      + display dimensions: 631 * 480
[01:30:09]    + filters
[01:30:09]      + Detelecine (pullup) (default settings)
[01:30:09]      + Decomb (default settings)
[01:30:09]    + encoder: x264
[01:30:09]      + options: b-adapt=2:rc-lookahead=50
[01:30:09]      + bitrate: 1100 kbps, pass: 2
[01:30:09]  * audio track 0
[01:30:09]    + decoder: English (AC3) (Dolby Surround) (track 1, id 80bd)
[01:30:09]      + bitrate: 192 kbps, samplerate: 48000 Hz
[01:30:09]    + AC3 passthrough
[01:30:09]  * audio track 1
[01:30:09]    + decoder: English (AC3) (Dolby Surround) (track 2, id 81bd)
[01:30:09]      + bitrate: 192 kbps, samplerate: 48000 Hz
[01:30:09]    + AC3 passthrough
libdvdnav: Using dvdnav version 4.1.3
libdvdread: Using libdvdcss version 1.2.10 for DVD access
[01:30:09] yadif thread started for segment 0
[01:30:09] yadif thread started for segment 1
[01:30:09] yadif thread started for segment 2
[01:30:09] yadif thread started for segment 3
[01:30:09] yadif thread started for segment 4
[01:30:09] yadif thread started for segment 5
[01:30:09] yadif thread started for segment 6
[01:30:09] yadif thread started for segment 7
[01:30:09] decomb thread started for segment 0
[01:30:09] decomb thread started for segment 2
[01:30:09] decomb thread started for segment 1
[01:30:09] decomb thread started for segment 3
[01:30:09] decomb thread started for segment 4
[01:30:09] decomb thread started for segment 5
[01:30:09] decomb thread started for segment 6
[01:30:09] decomb thread started for segment 7
[01:30:09] encx264: min-keyint: auto (23), keyint: 240
[01:30:09] encx264: encoding with stored aspect 8/9
x264 [info]: using SAR=8/9
x264 [info]: using cpu capabilities: MMX2 SSE2Fast SSSE3 FastShuffle SSE4.2
libdvdread: Couldn't find device name.
libdvdnav: Can't read name block. Probably not a DVD-ROM device.
libdvdnav: Unable to find map file '/Users/morpie/.dvdnav/.map'
libdvdnav: DVD disk reports itself with Region mask 0x00000000. Regions: 1 2 3 4 5 6 7 8
libdvdread: Using libdvdcss version 1.2.10 for DVD access
libdvdread: Couldn't find device name.
libdvdnav: DVD disk reports itself with Region mask 0x00000000. Regions: 1 2 3 4 5 6 7 8
[01:30:09] reader: first SCR 146 id 224 DTS 732
[01:30:09] mpeg2: "Chapter  1" (1) at frame 0 time 3003
x264 [info]: profile High, level 3.0
No accelerated IMDCT transform found
No accelerated IMDCT transform found
[01:30:09] 2.585911s: Video -> Film
[01:30:25] 79.996559s: Film -> Video
[01:30:25] mpeg2: "Chapter  2" (2) at frame 1934 time 7204197
[01:30:25] 80.163414s: Video -> Film
[01:31:39] mpeg2: "Chapter  3" (3) at frame 11333 time 42483441
[01:31:39] 472.071594s: Film -> Video
[01:31:39] 472.221741s: Video -> Film
[01:33:15] 976.942566s: Film -> Video
[01:33:15] mpeg2: "Chapter  4" (4) at frame 23442 time 87930843
[01:33:15] 977.092773s: Video -> Film
[01:34:14] 1282.331055s: Film -> Video
[01:34:14] mpeg2: "Chapter  5" (5) at frame 30765 time 115414299
[01:34:14] 1282.497925s: Video -> Film
[01:34:22] 1322.704712s: Film -> Video
[01:34:22] 1322.754761s: Video -> Film
[01:34:35] reader: done. 0 scr changes
[01:34:35] mpeg2: "Chapter  6" (6) at frame 33246 time 124723599
[01:34:35] 1385.851074s: Film -> Video
[01:34:35] 1386.001221s: Video -> Film
[01:34:36] work: average encoding speed for job is 125.035698 fps
[01:34:36] sync: got 33277 frames, 33277 expected
[01:34:36] mpeg2 done: 33277 frames
[01:34:36] render: lost time: 15015 (5 frames)
[01:34:36] render: gained time: 15015 (20 frames) (0 not accounted for)
[01:34:36] render: average dropped frame duration: 3003
x264 [info]: frame I:406   Avg QP:17.20  size: 46069  PSNR Mean Y:46.94 U:48.90 V:49.46 Avg:47.56 Global:47.17
x264 [info]: frame P:9635  Avg QP:20.13  size: 11566  PSNR Mean Y:44.55 U:46.54 V:47.37 Avg:45.19 Global:44.57
x264 [info]: frame B:23230 Avg QP:22.70  size:  2607  PSNR Mean Y:43.10 U:44.79 V:46.05 Avg:43.72 Global:43.55
x264 [info]: consecutive B-frames:  1.8%  4.1% 23.5% 70.6%
x264 [info]: mb I  I16..4:  5.5% 77.1% 17.4%
x264 [info]: mb P  I16..4:  0.4%  4.0%  1.3%  P16..4: 47.4% 21.8% 14.9%  0.0%  0.0%    skip:10.2%
x264 [info]: mb B  I16..4:  0.0%  0.3%  0.1%  B16..8: 42.6%  4.2%  0.9%  direct: 3.3%  skip:48.5%  L0:42.6% L1:51.9% BI: 5.5%
x264 [info]: 8x8 transform intra:72.1% inter:78.4%
x264 [info]: coded y,uvDC,uvAC intra: 85.3% 94.5% 76.2% inter: 20.8% 38.9% 5.0%
x264 [info]: i16 v,h,dc,p: 50% 24%  8% 18%
x264 [info]: i8 v,h,dc,ddl,ddr,vr,hd,vl,hu: 19% 19% 25%  5%  5%  6%  6%  6%  9%
x264 [info]: i4 v,h,dc,ddl,ddr,vr,hd,vl,hu: 21% 22% 15%  5%  8%  8%  9%  6%  7%
x264 [info]: i8c dc,h,v,p: 38% 29% 23% 10%
x264 [info]: Weighted P-Frames: Y:7.0% UV:2.6%
x264 [info]: ref P L0: 50.7% 12.6% 25.6% 10.6%  0.5%
x264 [info]: ref B L0: 75.2% 20.3%  4.6%
x264 [info]: ref B L1: 88.7% 11.3%
x264 [info]: SSIM Mean Y:0.9815294 (17.335db)
x264 [info]: PSNR Mean Y:43.572 U:45.352 V:46.474 Avg:44.199 Global:43.855 kb/s:1099.96
[01:34:36] mux: track 0, 33271 frames, 190688871 bytes, 1099.78 kbps, fifo 8
[01:34:36] mux: track 1, 43347 frames, 33290496 bytes, 192.00 kbps, fifo 128
[01:34:36] mux: track 2, 43347 frames, 33290496 bytes, 192.00 kbps, fifo 128
[01:34:36] decomb: deinterlaced 0 | blended 0 | unfiltered 33271 | total 33271
[01:34:36] libhb: work result = 0
0.9.6 (125 fps turbo, 95 fps 2nd pass):

Code: Select all

HandBrake Activity Log for /Users/morpie/Desktop/THE_CRITIC_01_1.mkv: 2012-03-08 01:38:36 -0400
Handbrake Version: 0.9.6 x86_64 (2012022800)

[01:38:36] macgui: Rip: Pending queue count is 0
[01:38:36] macgui: createQueueFileItem: Getting Audio from prepareAudioForQueueFileJob ...
[01:38:36] macgui: createQueueFileItem: Returned getting audio from prepareAudioForQueueFileJob
[01:38:36] macgui: getNextPendingQueueIndex next pending encode index is:0
[01:38:36] macgui: scanning specifically for title: 1
[01:38:36] hb_scan: path=/Volumes/Mathman HD/DVD Backups/THE_CRITIC_01/VIDEO_TS, title_index=1
libbluray/bdnav/index_parse.c:157: indx_parse(): error opening /Volumes/Mathman HD/DVD Backups/THE_CRITIC_01/VIDEO_TS/BDMV/index.bdmv
libbluray/bluray.c:1471: nav_get_title_list(/Volumes/Mathman HD/DVD Backups/THE_CRITIC_01/VIDEO_TS) failed (0x115814800)
[01:38:36] 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
libdvdread: Couldn't find device name.
libdvdnav: Can't read name block. Probably not a DVD-ROM device.
libdvdnav: Unable to find map file '/Users/morpie/.dvdnav/.map'
libdvdnav: DVD disk reports itself with Region mask 0x00000000. Regions: 1 2 3 4 5 6 7 8
libdvdread: Using libdvdcss version 1.2.10 for DVD access
libdvdread: Couldn't find device name.
[01:38:36] scan: DVD has 11 title(s)
[01:38:36] scan: scanning title 1
[01:38:36] scan: opening IFO for VTS 1
[01:38:36] scan: duration is 00:23:05 (1385086 ms)
[01:38:36] pgc_id: 1, pgn: 1: pgc: 0x101cbf7e0
[01:38:36] scan: vts=1, ttn=1, cells=0->5, blocks=0->455393, 455394 blocks
[01:38:36] scan: checking audio 1
[01:38:36] scan: id=0x80bd, lang=English (AC3), 3cc=eng ext=0
[01:38:36] scan: checking audio 2
[01:38:36] scan: id=0x81bd, lang=English (AC3), 3cc=eng ext=0
[01:38:36] scan: title 1 has 6 chapters
[01:38:36] scan: chap 1 c=0->0, b=0->31511 (31512), 79360 ms
[01:38:36] scan: chap 2 c=1->1, b=31512->156776 (125265), 391642 ms
[01:38:36] scan: chap 3 c=2->2, b=156777->324037 (167261), 504614 ms
[01:38:36] scan: chap 4 c=3->3, b=324038->421673 (97636), 305351 ms
[01:38:36] scan: chap 5 c=4->4, b=421674->455340 (33667), 103106 ms
[01:38:36] scan: chap 6 c=5->5, b=455341->455393 (53), 1010 ms
[01:38:36] scan: aspect = 0
[01:38:36] scan: decoding previews for title 1
libdvdnav: DVD disk reports itself with Region mask 0x00000000. Regions: 1 2 3 4 5 6 7 8
[01:38:36] scan: title angle(s) 1
[01:38:36] scan: audio 0x81bd: AC-3, rate=48000Hz, bitrate=192000 English (AC3) (Dolby Surround)
[01:38:36] scan: audio 0x80bd: AC-3, rate=48000Hz, bitrate=192000 English (AC3) (Dolby Surround)
[01:38:36] scan: 10 previews, 720x480, 23.976 fps, autocrop = 0/0/6/4, aspect 4:3, PAR 8:9
[01:38:36] scan: title (0) job->width:624, job->height:480
[01:38:36] libhb: scan thread found 1 valid title(s)
[01:38:36] macgui: ScanDone state received from fQueueEncodeLibhb
[01:38:36] macgui: Preset: Custom
[01:38:36] macgui: processNewQueueEncode number of passes expected is: 2
[01:38:36] macgui: Start / Stop set to chapters
[01:38:36] macgui: prepareJob exiting
[01:38:36] 2 job(s) to process
[01:38:36] starting job
[01:38:36] sync: expecting 33232 video frames
[01:38:36] job configuration:
[01:38:36]  * source
[01:38:36]    + /Volumes/Mathman HD/DVD Backups/THE_CRITIC_01/VIDEO_TS
[01:38:36]    + title 1, chapter(s) 1 to 6
[01:38:36]  * destination
[01:38:36]    + /Users/morpie/Desktop/THE_CRITIC_01_1.mkv
[01:38:36]    + container: Matroska (.mkv)
[01:38:36]      + chapter markers
[01:38:36]  * video track
[01:38:36]    + decoder: mpeg2
[01:38:36]      + bitrate 9800 kbps
[01:38:36]    + frame rate: same as source (around 23.976 fps)
[01:38:36]    + strict anamorphic
[01:38:36]      + storage dimensions: 720 * 480 -> 710 * 480, crop 0/0/6/4, mod 16
[01:38:36]      + pixel aspect ratio: 8 / 9
[01:38:36]      + display dimensions: 631 * 480
[01:38:36]    + filters
[01:38:36]      + Detelecine (pullup) (default settings)
[01:38:36]      + Decomb (default settings)
[01:38:36]    + encoder: H.264 (x264)
[01:38:36]      + options: b-adapt=2:rc-lookahead=50:ref=1:subme=2:me=dia:analyse=none:trellis=0:no-fast-pskip=0:8x8dct=0:weightb=0
[01:38:36]      + bitrate: 1100 kbps, pass: 1
[01:38:36]  * audio track 1
[01:38:36]    + decoder: English (AC3) (Dolby Surround) (track 1, id 0x80bd)
[01:38:36]      + bitrate: 192 kbps, samplerate: 48000 Hz
[01:38:36]    + AC3 Passthru
[01:38:36]  * audio track 2
[01:38:36]    + decoder: English (AC3) (Dolby Surround) (track 2, id 0x81bd)
[01:38:36]      + bitrate: 192 kbps, samplerate: 48000 Hz
[01:38:36]    + AC3 Passthru
libdvdnav: Using dvdnav version 4.1.3
libdvdread: Using libdvdcss version 1.2.10 for DVD access
libdvdread: Couldn't find device name.
libdvdnav: Can't read name block. Probably not a DVD-ROM device.
libdvdnav: Unable to find map file '/Users/morpie/.dvdnav/.map'
libdvdnav: DVD disk reports itself with Region mask 0x00000000. Regions: 1 2 3 4 5 6 7 8
libdvdread: Using libdvdcss version 1.2.10 for DVD access
libdvdread: Couldn't find device name.
libdvdnav: DVD disk reports itself with Region mask 0x00000000. Regions: 1 2 3 4 5 6 7 8
[01:38:36] yadif thread started for segment 0
[01:38:36] yadif thread started for segment 1
[01:38:36] yadif thread started for segment 3
[01:38:36] yadif thread started for segment 2
[01:38:36] yadif thread started for segment 4
[01:38:36] yadif thread started for segment 5
[01:38:36] yadif thread started for segment 6
[01:38:36] yadif thread started for segment 7
[01:38:36] decomb thread started for segment 0
[01:38:36] decomb thread started for segment 1
[01:38:36] decomb thread started for segment 2
[01:38:36] decomb thread started for segment 3
[01:38:36] decomb thread started for segment 4
[01:38:36] decomb thread started for segment 5
[01:38:36] decomb thread started for segment 6
[01:38:36] decomb thread started for segment 7
[01:38:36] reader: first SCR 146 id 0xe0 DTS 732
[01:38:36] mpeg2: "Chapter  1" (1) at frame 0 time 3003
[01:38:36] encx264: min-keyint: 24, keyint: 240
[01:38:36] encx264: encoding with stored aspect 8/9
x264 [warning]: --psnr used with psy on: results will be invalid!
x264 [warning]: --tune psnr should be used if attempting to benchmark psnr!
x264 [info]: using SAR=8/9
x264 [info]: using cpu capabilities: MMX2 SSE2Fast SSSE3 FastShuffle SSE4.2 AVX
x264 [info]: profile Main, level 3.0
[01:38:36] sync: first pts is 3003
[01:38:37] 2.585911s: Video -> Film
[01:38:53] 79.996559s: Film -> Video
[01:38:53] mpeg2: "Chapter  2" (2) at frame 1934 time 7204197
[01:38:53] 80.163414s: Video -> Film
[01:40:18] mpeg2: "Chapter  3" (3) at frame 11333 time 42483441
[01:40:18] 472.071594s: Film -> Video
[01:40:18] 472.221741s: Video -> Film
[01:42:06] 976.942566s: Film -> Video
[01:42:06] mpeg2: "Chapter  4" (4) at frame 23442 time 87930843
[01:42:06] 977.092773s: Video -> Film
[01:43:11] 1282.331055s: Film -> Video
[01:43:11] mpeg2: "Chapter  5" (5) at frame 30765 time 115414299
[01:43:11] 1282.497925s: Video -> Film
[01:43:20] 1322.704712s: Film -> Video
[01:43:20] 1322.754761s: Video -> Film
[01:43:34] reader: done. 1 scr changes
[01:43:34] mpeg2: "Chapter  6" (6) at frame 33246 time 124723599
[01:43:34] 1385.851074s: Film -> Video
[01:43:34] 1386.001221s: Video -> Film
[01:43:34] work: average encoding speed for job is 111.686760 fps
[01:43:34] sync: got 33277 frames, 33232 expected
[01:43:34] mpeg2 done: 33277 frames
[01:43:35] render: lost time: 15015 (5 frames)
[01:43:35] render: gained time: 15015 (20 frames) (0 not accounted for)
[01:43:35] render: average dropped frame duration: 3003
x264 [info]: frame I:406   Avg QP:16.60  size: 48106  PSNR Mean Y:46.83 U:48.16 V:48.73 Avg:47.29 Global:46.80
x264 [info]: frame P:9604  Avg QP:19.71  size: 11786  PSNR Mean Y:44.17 U:45.71 V:46.54 Avg:44.70 Global:43.98
x264 [info]: frame B:23261 Avg QP:21.77  size:  2458  PSNR Mean Y:42.60 U:44.30 V:45.47 Avg:43.21 Global:42.96
x264 [info]: consecutive B-frames:  2.9%  3.9% 23.0% 70.2%
x264 [info]: mb I  I16..4: 29.3%  0.0% 70.7%
x264 [info]: mb P  I16..4: 17.7%  0.0%  0.0%  P16..4: 69.5%  0.0%  0.0%  0.0%  0.0%    skip:12.8%
x264 [info]: mb B  I16..4:  2.8%  0.0%  0.0%  B16..8: 24.0%  0.0%  0.0%  direct:20.1%  skip:53.1%  L0:35.4% L1:50.5% BI:14.1%
x264 [info]: final ratefactor: 18.74
x264 [info]: coded y,uvDC,uvAC intra: 61.2% 81.9% 43.1% inter: 15.1% 34.9% 2.9%
x264 [info]: i16 v,h,dc,p: 32% 27% 33%  8%
x264 [info]: i4 v,h,dc,ddl,ddr,vr,hd,vl,hu: 25% 24% 12%  6%  6%  6%  7%  6%  8%
x264 [info]: i8c dc,h,v,p: 42% 29% 23%  6%
x264 [info]: Weighted P-Frames: Y:8.1% UV:2.5%
x264 [info]: SSIM Mean Y:0.9813086 (17.284db)
x264 [info]: PSNR Mean Y:43.109 U:44.754 V:45.825 Avg:43.694 Global:43.263 kb/s:1095.28
[01:43:35] decomb: deinterlaced 0 | blended 0 | unfiltered 33271 | total 33271
[01:43:35] starting job
[01:43:35] sync: expecting 33277 video frames
[01:43:35] job configuration:
[01:43:35]  * source
[01:43:35]    + /Volumes/Mathman HD/DVD Backups/THE_CRITIC_01/VIDEO_TS
[01:43:35]    + title 1, chapter(s) 1 to 6
[01:43:35]  * destination
[01:43:35]    + /Users/morpie/Desktop/THE_CRITIC_01_1.mkv
[01:43:35]    + container: Matroska (.mkv)
[01:43:35]      + chapter markers
[01:43:35]  * video track
[01:43:35]    + decoder: mpeg2
[01:43:35]      + bitrate 9800 kbps
[01:43:35]    + frame rate: same as source (around 23.976 fps)
[01:43:35]    + strict anamorphic
[01:43:35]      + storage dimensions: 720 * 480 -> 710 * 480, crop 0/0/6/4, mod 16
[01:43:35]      + pixel aspect ratio: 8 / 9
[01:43:35]      + display dimensions: 631 * 480
[01:43:35]    + filters
[01:43:35]      + Detelecine (pullup) (default settings)
[01:43:35]      + Decomb (default settings)
[01:43:35]    + encoder: H.264 (x264)
[01:43:35]      + options: b-adapt=2:rc-lookahead=50
[01:43:35]      + bitrate: 1100 kbps, pass: 2
[01:43:35]  * audio track 1
[01:43:35]    + decoder: English (AC3) (Dolby Surround) (track 1, id 0x80bd)
[01:43:35]      + bitrate: 192 kbps, samplerate: 48000 Hz
[01:43:35]    + AC3 Passthru
[01:43:35]  * audio track 2
[01:43:35]    + decoder: English (AC3) (Dolby Surround) (track 2, id 0x81bd)
[01:43:35]      + bitrate: 192 kbps, samplerate: 48000 Hz
[01:43:35]    + AC3 Passthru
libdvdnav: Using dvdnav version 4.1.3
libdvdread: Using libdvdcss version 1.2.10 for DVD access
libdvdread: Couldn't find device name.
libdvdnav: Can't read name block. Probably not a DVD-ROM device.
libdvdnav: Unable to find map file '/Users/morpie/.dvdnav/.map'
libdvdnav: DVD disk reports itself with Region mask 0x00000000. Regions: 1 2 3 4 5 6 7 8
libdvdread: Using libdvdcss version 1.2.10 for DVD access
libdvdread: Couldn't find device name.
libdvdnav: DVD disk reports itself with Region mask 0x00000000. Regions: 1 2 3 4 5 6 7 8
[01:43:35] yadif thread started for segment 0
[01:43:35] yadif thread started for segment 2
[01:43:35] yadif thread started for segment 1
[01:43:35] yadif thread started for segment 3
[01:43:35] yadif thread started for segment 4
[01:43:35] yadif thread started for segment 5
[01:43:35] yadif thread started for segment 6
[01:43:35] yadif thread started for segment 7
[01:43:35] decomb thread started for segment 0
[01:43:35] decomb thread started for segment 1
[01:43:35] decomb thread started for segment 2
[01:43:35] decomb thread started for segment 3
[01:43:35] decomb thread started for segment 4
[01:43:35] decomb thread started for segment 5
[01:43:35] decomb thread started for segment 6
[01:43:35] decomb thread started for segment 7
[01:43:35] encx264: min-keyint: 24, keyint: 240
[01:43:35] encx264: encoding with stored aspect 8/9
x264 [warning]: --psnr used with psy on: results will be invalid!
x264 [warning]: --tune psnr should be used if attempting to benchmark psnr!
x264 [info]: using SAR=8/9
x264 [info]: using cpu capabilities: MMX2 SSE2Fast SSSE3 FastShuffle SSE4.2 AVX
[01:43:35] reader: first SCR 146 id 0xe0 DTS 732
[01:43:35] mpeg2: "Chapter  1" (1) at frame 0 time 3003
x264 [info]: profile High, level 3.0
[01:43:35] sync: first pts is 3003
[01:43:36] 2.585911s: Video -> Film
[01:43:56] 79.996559s: Film -> Video
[01:43:56] mpeg2: "Chapter  2" (2) at frame 1934 time 7204197
[01:43:56] 80.163414s: Video -> Film
[01:45:35] mpeg2: "Chapter  3" (3) at frame 11333 time 42483441
[01:45:35] 472.071594s: Film -> Video
[01:45:35] 472.221741s: Video -> Film
[01:47:43] 976.942566s: Film -> Video
[01:47:43] mpeg2: "Chapter  4" (4) at frame 23442 time 87930843
[01:47:43] 977.092773s: Video -> Film
[01:49:01] 1282.331055s: Film -> Video
[01:49:01] mpeg2: "Chapter  5" (5) at frame 30765 time 115414299
[01:49:01] 1282.497925s: Video -> Film
[01:49:11] 1322.704712s: Film -> Video
[01:49:11] 1322.754761s: Video -> Film
[01:49:27] reader: done. 1 scr changes
[01:49:27] mpeg2: "Chapter  6" (6) at frame 33246 time 124723599
[01:49:27] 1385.851074s: Film -> Video
[01:49:27] 1386.001221s: Video -> Film
[01:49:28] work: average encoding speed for job is 94.405556 fps
[01:49:28] sync: got 33277 frames, 33277 expected
[01:49:28] mpeg2 done: 33277 frames
[01:49:28] render: lost time: 15015 (5 frames)
[01:49:28] render: gained time: 15015 (20 frames) (0 not accounted for)
[01:49:28] render: average dropped frame duration: 3003
x264 [info]: frame I:406   Avg QP:17.46  size: 44763  PSNR Mean Y:46.73 U:48.71 V:49.28 Avg:47.35 Global:46.94
x264 [info]: frame P:9604  Avg QP:20.12  size: 11597  PSNR Mean Y:44.57 U:46.53 V:47.36 Avg:45.19 Global:44.58
x264 [info]: frame B:23261 Avg QP:22.69  size:  2630  PSNR Mean Y:43.10 U:44.78 V:46.05 Avg:43.72 Global:43.54
x264 [info]: consecutive B-frames:  2.9%  3.9% 23.0% 70.2%
x264 [info]: mb I  I16..4:  5.5% 76.5% 18.0%
x264 [info]: mb P  I16..4:  0.4%  4.1%  1.3%  P16..4: 47.2% 21.7% 15.0%  0.0%  0.0%    skip:10.4%
x264 [info]: mb B  I16..4:  0.0%  0.3%  0.1%  B16..8: 42.5%  4.3%  0.9%  direct: 3.4%  skip:48.5%  L0:42.6% L1:51.9% BI: 5.5%
x264 [info]: 8x8 transform intra:71.9% inter:78.2%
x264 [info]: coded y,uvDC,uvAC intra: 85.0% 94.3% 75.6% inter: 20.9% 38.8% 5.0%
x264 [info]: i16 v,h,dc,p: 50% 24%  8% 18%
x264 [info]: i8 v,h,dc,ddl,ddr,vr,hd,vl,hu: 21% 20% 22%  5%  5%  6%  6%  7%  9%
x264 [info]: i4 v,h,dc,ddl,ddr,vr,hd,vl,hu: 22% 22% 13%  6%  8%  8%  9%  6%  6%
x264 [info]: i8c dc,h,v,p: 38% 29% 23% 10%
x264 [info]: Weighted P-Frames: Y:8.1% UV:2.5%
x264 [info]: ref P L0: 51.1% 12.0% 25.6% 10.6%  0.6%
x264 [info]: ref B L0: 75.3% 20.2%  4.6%
x264 [info]: ref B L1: 88.7% 11.3%
x264 [info]: SSIM Mean Y:0.9815381 (17.337db)
x264 [info]: PSNR Mean Y:43.572 U:45.343 V:46.469 Avg:44.193 Global:43.853 kb/s:1100.07
[01:49:28] mux: track 0, 33271 frames, 190708221 bytes, 1099.90 kbps, fifo 2048
[01:49:28] mux: track 1, 43347 frames, 33290496 bytes, 192.00 kbps, fifo 4096
[01:49:28] mux: track 2, 43347 frames, 33290496 bytes, 192.00 kbps, fifo 4096
[01:49:28] decomb: deinterlaced 0 | blended 0 | unfiltered 33271 | total 33271
[01:49:28] libhb: work result = 0
Still losing some time on the encodes, about 25-30%...
User avatar
JohnAStebbins
HandBrake Team
Posts: 5726
Joined: Sat Feb 09, 2008 7:21 pm

Re: more than 25% speed decrease moving to 0.9.6

Post by JohnAStebbins »

The new settings for the decomb filter are slower than 0.9.5. If you want the old 0.9.5 settings, you can choose the "Fast" option in the decomb dropdown. But the new settings are significantly better.
Deleted User 7622

Re: more than 25% speed decrease moving to 0.9.6

Post by Deleted User 7622 »

That answered my question, thanks!
Post Reply