[11:37:08] thread f05b7000 joined ("scan") [11:37:08] libhb: scan thread found 1 valid title(s) [11:37:30] thread f038d000 started ("work") [11:37:30] 2 job(s) to process [11:37:30] starting job [11:37:30] job configuration: [11:37:30] * source [11:37:30] + /Volumes/kramer/Disc Rips/MR_MRS_SMITH_WS [11:37:30] + title 1, chapter(s) 1 to 29 [11:37:30] * destination [11:37:30] + /Volumes/frank/MR_MRS_SMITH_WS.m4v [11:37:30] + container: MPEG-4 (.mp4 and .m4v) [11:37:30] * video track [11:37:30] + decoder: mpeg2 [11:37:30] + bitrate 9800 kbps [11:37:30] + frame rate: same as source (around 23.976 fps) [11:37:30] + dimensions: 720 * 480 -> 704 * 304, crop 56/60/0/0 [11:37:30] + encoder: x264 [11:37:30] + options: bframes=3:ref=3:subq=6:me=umh:no-fast-pskip=1:cabac=0:direct=auto:analyse=all:mixed-refs=1:merange=32:brdo=1:bime=1 [11:37:30] + bitrate: 2500 kbps, pass: 1 [11:37:30] thread f04b3000 started ("reader") [11:37:30] thread f0535000 started ("MPEG-2 decoder (libmpeg2)") [11:37:30] thread f05b7000 started ("Renderer") [11:37:30] encx264: keyint-min: 24, keyint-max: 240 [11:37:30] encx264: opening libx264 (pass 1) x264 [info]: using cpu capabilities: Altivec [11:37:30] reader: first SCR 146 scr_offset 12766 [11:37:30] thread f0639000 started ("H.264/AVC encoder (libx264)") [11:37:30] thread f06bb000 started ("muxer") [11:37:30] sync: expecting 172269 video frames [11:37:30] mpeg2: "Chapter 1" (1) at frame 0 time 6756 [11:37:30] 0.108433s: Film -> Video [11:37:30] sync: first pts is 6756 [11:37:30] sync: video time didn't advance - dropped 13 frames (delta 409 ms, current 84834, next 87007, dur 2173) [11:37:31] 1.784222s: Video -> Film [11:37:31] macgui: Using preset: atv4 [11:38:39] 23.789545s: Film -> Video [11:38:43] sync: video time didn't advance - dropped 2 frames (delta 50 ms, current 2214632, next 2216134, dur 1502) [11:38:44] 26.475555s: Video -> Film [11:40:30] 70.819847s: Film -> Video [11:40:30] 71.020035s: Video -> Film [11:42:31] mpeg2: "Chapter 2" (2) at frame 3041 time 11282191 [11:48:11] mpeg2: "Chapter 3" (3) at frame 5277 time 19675576 [11:58:43] mpeg2: "Chapter 4" (4) at frame 9390 time 35113999 [12:08:41] mpeg2: "Chapter 5" (5) at frame 13185 time 49360231 [12:24:12] mpeg2: "Chapter 6" (6) at frame 20525 time 76912756 [12:31:30] mpeg2: "Chapter 7" (7) at frame 24898 time 93327154 [12:50:36] mpeg2: "Chapter 8" (8) at frame 32921 time 123444241 [12:58:49] mpeg2: "Chapter 9" (9) at frame 36565 time 137122906 [13:31:22] mpeg2: "Chapter 10" (10) at frame 50166 time 188176909 [13:46:37] mpeg2: "Chapter 11" (11) at frame 56813 time 213128836 [14:05:05] mpeg2: "Chapter 12" (12) at frame 64365 time 241477156 [14:23:21] mpeg2: "Chapter 13" (13) at frame 72305 time 271281931 [14:32:45] mpeg2: "Chapter 14" (14) at frame 76190 time 285864499 [14:32:45] 3176.305420s: Film -> Video [14:32:45] 3176.388916s: Video -> Film [14:45:06] mpeg2: "Chapter 15" (15) at frame 80685 time 302735353 [15:01:01] mpeg2: "Chapter 16" (16) at frame 87628 time 328798390 [15:19:34] mpeg2: "Chapter 17" (17) at frame 94992 time 356441005 [15:26:09] mpeg2: "Chapter 18" (18) at frame 97772 time 366892138 [16:04:24] mpeg2: "Chapter 19" (19) at frame 111552 time 418618813 [16:30:17] mpeg2: "Chapter 20" (20) at frame 120825 time 453426586 [16:55:25] mpeg2: "Chapter 21" (21) at frame 128208 time 481141273 [17:01:57] mpeg2: "Chapter 22" (22) at frame 131621 time 493952071 [17:17:36] mpeg2: "Chapter 23" (23) at frame 137872 time 517417513 [17:36:13] mpeg2: "Chapter 24" (24) at frame 146240 time 548828893 [17:52:27] mpeg2: "Chapter 25" (25) at frame 152592 time 572672713 [18:07:47] mpeg2: "Chapter 26" (26) at frame 158333 time 594222241 [18:13:41] mpeg2: "Chapter 27" (27) at frame 160253 time 601429441 [18:16:16] mpeg2: "Chapter 28" (28) at frame 161805 time 607255261 [18:16:16] 6747.313965s: Film -> Video [18:16:25] 6750.750488s: Video -> Film [18:33:33] dvd: end of cell 40 at block 2268869 [18:33:33] reader: done. 3 scr changes [18:33:33] thread f04b3000 exited ("reader") [18:33:37] mpeg2: "Chapter 29" (29) at frame 172638 time 647858822 [18:33:38] sync: got 172623 frames, 172269 expected [18:33:40] thread f06bb000 exited ("muxer") [18:33:40] thread f06bb000 joined ("muxer") [18:33:40] thread f0639000 exited ("H.264/AVC encoder (libx264)") [18:33:40] thread f0535000 exited ("MPEG-2 decoder (libmpeg2)") [18:33:40] thread f05b7000 exited ("Renderer") [18:33:40] thread f0535000 joined ("MPEG-2 decoder (libmpeg2)") [18:33:40] mpeg2 done: 172639 frames [18:33:40] thread f05b7000 joined ("Renderer") [18:33:40] render: lost time: 0 (0 frames) [18:33:40] render: gained time: 0 (0 frames) (0 not accounted for) [18:33:40] fifo_close: trashing 0 buffer(s) [18:33:40] fifo_close: trashing 0 buffer(s) [18:33:40] thread f0639000 joined ("H.264/AVC encoder (libx264)") x264 [info]: slice I:1959 Avg QP:12.74 size: 40301 PSNR Mean Y:49.45 U:50.63 V:50.72 Avg:49.75 Global:49.16 x264 [info]: slice P:83328 Avg QP:14.18 size: 19308 PSNR Mean Y:47.20 U:48.80 V:48.73 Avg:47.59 Global:46.92 x264 [info]: slice B:87972 Avg QP:15.90 size: 6319 PSNR Mean Y:46.14 U:47.79 V:47.82 Avg:46.56 Global:45.92 x264 [info]: consecutive B-frames: 18.9% 32.3% 16.4% 32.3% x264 [info]: mb I I16..4: 29.8% 0.0% 70.2% x264 [info]: mb P I16..4: 9.0% 0.0% 18.9% P16..4: 31.3% 23.2% 12.1% 1.2% 0.6% skip: 3.7% x264 [info]: mb B I16..4: 1.6% 0.0% 2.4% B16..8: 40.7% 5.9% 5.4% direct:10.3% skip:33.7% L0:31.3% L1:42.2% BI:26.4% x264 [info]: final ratefactor: 13.34 x264 [info]: direct mvs spatial:99.9% temporal:0.1% x264 [info]: ref P L0 77.4% 13.3% 9.3% x264 [info]: ref B L0 88.3% 11.7% x264 [info]: SSIM Mean Y:0.9897340 x264 [info]: PSNR Mean Y:46.688 U:48.312 V:48.288 Avg:47.089 Global:46.403 kb/s:2483.93 [18:33:40] thread f04b3000 joined ("reader") [18:33:40] fifo_close: trashing 0 buffer(s) [18:33:40] fifo_close: trashing 1 buffer(s) [18:33:40] fifo_close: trashing 0 buffer(s) [18:33:40] fifo_close: trashing 0 buffer(s) [18:33:40] fifo_close: trashing 0 buffer(s) [18:33:40] Freed 6 buffers of size 1024 [18:33:40] Freed 32 buffers of size 2048 [18:33:40] Freed 32 buffers of size 524288 [18:33:40] Allocated 16848896 bytes of buffers on this pass and Freed 16848896 bytes, 0 bytes leaked [18:33:40] starting job [18:33:40] job configuration: [18:33:40] * source [18:33:40] + /Volumes/kramer/Disc Rips/MR_MRS_SMITH_WS [18:33:40] + title 1, chapter(s) 1 to 29 [18:33:40] * destination [18:33:40] + /Volumes/frank/MR_MRS_SMITH_WS.m4v [18:33:40] + container: MPEG-4 (.mp4 and .m4v) [18:33:40] * video track [18:33:40] + decoder: mpeg2 [18:33:40] + bitrate 9800 kbps [18:33:40] + frame rate: same as source (around 23.976 fps) [18:33:40] + dimensions: 720 * 480 -> 704 * 304, crop 56/60/0/0 [18:33:40] + encoder: x264 [18:33:40] + options: bframes=3:ref=3:subq=6:me=umh:no-fast-pskip=1:cabac=0:direct=auto:analyse=all:mixed-refs=1:merange=32:brdo=1:bime=1 [18:33:40] + bitrate: 2500 kbps, pass: 2 [18:33:40] * subtitle track 1, English (id 20bd) [18:33:40] * audio track 0 [18:33:40] + decoder: English (AC3) (5.1 ch) (track 0, id 80bd) [18:33:40] + bitrate: 448 kbps, samplerate: 48000 Hz [18:33:40] + AC3 passthrough [18:33:40] thread f030b000 started ("reader") [18:33:40] thread f04b3000 started ("MPEG-2 decoder (libmpeg2)") [18:33:40] thread f0535000 started ("Renderer") [18:33:40] encx264: keyint-min: 24, keyint-max: 240 [18:33:40] encx264: opening libx264 (pass 2) x264 [info]: using cpu capabilities: Altivec [18:33:40] reader: first SCR 146 scr_offset 12766 [18:33:40] mpeg2: "Chapter 1" (1) at frame 0 time 6756 [18:33:40] 0.108433s: Film -> Video [18:34:05] thread f05b7000 started ("H.264/AVC encoder (libx264)") [18:34:05] thread f0639000 started ("Subtitle decoder") No accelerated IMDCT transform found [18:34:05] thread f06bb000 started ("AC3 decoder") [18:34:05] thread f073d000 started ("muxer") [18:34:05] sync: expecting 172269 video frames [18:34:05] sync: first pts is 6756 [18:34:05] sync: adding 105 ms of silence to audio 0 start 9456, next 0 [18:34:05] sync: video time didn't advance - dropped 2 frames (delta 36 ms, current 84834, next 87534, dur 2700) [18:34:05] macgui: Using preset: atv4 [18:34:06] 2.157111s: Video -> Film [18:35:08] 24.162434s: Film -> Video [18:35:11] sync: video time didn't advance - dropped 2 frames (delta 50 ms, current 2248192, next 2249694, dur 1502) [18:35:12] 26.848444s: Video -> Film [18:36:45] 71.192734s: Film -> Video [18:36:45] 71.392921s: Video -> Film [18:38:28] mpeg2: "Chapter 2" (2) at frame 3041 time 11315751 [18:43:44] mpeg2: "Chapter 3" (3) at frame 5277 time 19709136 [swscaler @ 0x848d20]ALTIVEC: Color Space ARGB [swscaler @ 0x848d20]ALTIVEC: Color Space ARGB [swscaler @ 0x848d20]ALTIVEC: Color Space ARGB [swscaler @ 0x848d20]ALTIVEC: Color Space ARGB [swscaler @ 0x848d20]ALTIVEC: Color Space ARGB [swscaler @ 0x848d20]ALTIVEC: Color Space ARGB [swscaler @ 0x848d20]ALTIVEC: Color Space ARGB [swscaler @ 0x848d20]ALTIVEC: Color Space ARGB [swscaler @ 0x848d20]ALTIVEC: Color Space ARGB [swscaler @ 0x848d20]ALTIVEC: Color Space ARGB [swscaler @ 0x848d20]ALTIVEC: Color Space ARGB [swscaler @ 0x848d20]ALTIVEC: Color Space ARGB [swscaler @ 0x848d20]ALTIVEC: Color Space ARGB [swscaler @ 0x848d20]ALTIVEC: Color Space ARGB [swscaler @ 0x848d20]ALTIVEC: Color Space ARGB [swscaler @ 0x848d20]ALTIVEC: Color Space ARGB [18:55:40] mpeg2: "Chapter 4" (4) at frame 9390 time 35147559 [19:07:14] mpeg2: "Chapter 5" (5) at frame 13185 time 49393791 [19:25:31] mpeg2: "Chapter 6" (6) at frame 20525 time 76946316 [19:32:23] mpeg2: "Chapter 7" (7) at frame 24898 time 93360714 [19:50:37] mpeg2: "Chapter 8" (8) at frame 32921 time 123477801 [19:58:30] mpeg2: "Chapter 9" (9) at frame 36565 time 137156466 [20:35:51] mpeg2: "Chapter 10" (10) at frame 50166 time 188210469 [20:49:22] mpeg2: "Chapter 11" (11) at frame 56813 time 213162396 [21:05:32] mpeg2: "Chapter 12" (12) at frame 64365 time 241510716 [21:22:25] mpeg2: "Chapter 13" (13) at frame 72305 time 271315491 [21:30:27] mpeg2: "Chapter 14" (14) at frame 76190 time 285898059 [21:30:28] 3176.678467s: Film -> Video [21:30:28] 3176.761963s: Video -> Film [21:45:37] mpeg2: "Chapter 15" (15) at frame 80685 time 302768913 [22:06:01] mpeg2: "Chapter 16" (16) at frame 87628 time 328831950 [22:24:31] mpeg2: "Chapter 17" (17) at frame 94992 time 356474565 [22:30:56] sync: adding 152 ms of silence to audio 0 start 366925698, next 366912000 [22:30:58] mpeg2: "Chapter 18" (18) at frame 97772 time 366925698 [23:09:51] mpeg2: "Chapter 19" (19) at frame 111552 time 418652373 [23:35:39] mpeg2: "Chapter 20" (20) at frame 120825 time 453460146 [00:03:36] mpeg2: "Chapter 21" (21) at frame 128208 time 481174833 [00:09:48] mpeg2: "Chapter 22" (22) at frame 131621 time 493985631 [00:24:05] mpeg2: "Chapter 23" (23) at frame 137872 time 517451073 [00:43:11] mpeg2: "Chapter 24" (24) at frame 146240 time 548862453 [00:58:59] mpeg2: "Chapter 25" (25) at frame 152592 time 572706273 [01:14:12] mpeg2: "Chapter 26" (26) at frame 158333 time 594255801 [01:20:09] mpeg2: "Chapter 27" (27) at frame 160253 time 601463001 [01:22:37] mpeg2: "Chapter 28" (28) at frame 161805 time 607288821 [01:22:37] 6747.687012s: Film -> Video [01:22:45] 6751.124023s: Video -> Film [01:37:59] dvd: end of cell 40 at block 2268869 [01:37:59] reader: done. 3 scr changes [01:37:59] thread f030b000 exited ("reader") [01:38:03] mpeg2: "Chapter 29" (29) at frame 172638 time 647892382 [01:38:04] sync: got 172634 frames, 172269 expected x264 [error]: 2nd pass has more frames than 1st pass (173262) x264 [error]: continuing anyway, at constant QP=15 x264 [error]: disabling adaptive B-frames x264 [error]: 2nd pass has more frames than 1st pass (173262) x264 [error]: continuing anyway, at constant QP=15 x264 [error]: disabling adaptive B-frames x264 [error]: 2nd pass has more frames than 1st pass (173262) x264 [error]: continuing anyway, at constant QP=15 x264 [error]: disabling adaptive B-frames