Code: Select all
HandBrake Activity Log for /Users/jr/Downloads/mymovie.m4v: 2009-11-19 02:47:06 -0600
Handbrake Version: svn2943 x86_64 (2009111901)
[02:47:06] macgui: Rip: Pending queue count is 2
[02:47:06] macgui: scanning specifically for title: 1
[02:47:06] macgui: performNewQueueScan currentQueueEncodeIndex is: 0
[02:47:06] hb_scan: path=/Users/jr/Downloads/mymovie.mkv, title_index=1
[02:47:06] thread 11b07c000 started ("scan")
[02:47:06] scan: trying to open with libdvdread
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
[02:47:06] dvd: not a dvd - trying as a stream/file instead
Input #0, matroska, from '/Users/jr/Downloads/mymovie.mkv':
Duration: 01:27:56.28, start: 0.000000, bitrate: N/A
Stream #0.0(eng): Video: h264, yuv420p, 1280x720, PAR 1:1 DAR 16:9, 23.98 tbr, 1k tbn, 47.95 tbc
Stream #0.1(eng): Audio: ac3, 48000 Hz, 5.1, s16
Stream #0.2(eng): Subtitle: 0x0000
[02:47:06] Found ffmpeg 21 chapters, container=matroska
[02:47:06] Added chapter 1, name='00:00:00.000', dur=29343060, (00:05:26)
[02:47:06] Added chapter 2, name='00:05:26.034', dur=25131329, (00:04:39)
[02:47:06] Added chapter 3, name='00:10:05.271', dur=13400911, (00:02:28)
[02:47:06] Added chapter 4, name='00:12:34.170', dur=20364030, (00:03:46)
[02:47:06] Added chapter 5, name='00:16:20.437', dur=18922680, (00:03:30)
[02:47:06] Added chapter 6, name='00:19:50.689', dur=19054080, (00:03:31)
[02:47:06] Added chapter 7, name='00:23:22.401', dur=17976690, (00:03:19)
[02:47:06] Added chapter 8, name='00:26:42.142', dur=13727430, (00:02:32)
[02:47:06] Added chapter 9, name='00:29:14.669', dur=25465410, (00:04:42)
[02:47:06] Added chapter 10, name='00:33:57.618', dur=27274769, (00:05:03)
[02:47:06] Added chapter 11, name='00:39:00.671', dur=15221430, (00:02:49)
[02:47:06] Added chapter 12, name='00:41:49.798', dur=42620131, (00:07:53)
[02:47:06] Added chapter 13, name='00:49:43.355', dur=24913620, (00:04:36)
[02:47:06] Added chapter 14, name='00:54:20.173', dur=44020260, (00:08:09)
[02:47:06] Added chapter 15, name='01:02:29.287', dur=14774760, (00:02:44)
[02:47:06] Added chapter 16, name='01:05:13.451', dur=31584060, (00:05:50)
[02:47:06] Added chapter 17, name='01:11:04.385', dur=32150880, (00:05:57)
[02:47:06] Added chapter 18, name='01:17:01.617', dur=20934630, (00:03:52)
[02:47:06] Added chapter 19, name='01:20:54.224', dur=19395630, (00:03:35)
[02:47:06] Added chapter 20, name='01:24:29.731', dur=18566010, (00:03:26)
[02:47:06] Added chapter 21, name='01:27:56.020', dur=24119, (00:00:00)
[02:47:06] scan: decoding previews for title 1
[02:47:06] scan: preview 1
[02:47:06] scan: audio 0x1: AC-3, rate=48000Hz, bitrate=640000 English (AC3) (5.1 ch)
[02:47:06] scan: preview 2
[02:47:07] scan: preview 3
[02:47:07] scan: preview 4
[02:47:07] scan: preview 5
[02:47:07] scan: preview 6
[02:47:07] Title's mostly NTSC Film, setting fps to 23.976
[02:47:07] scan: preview 7
[02:47:07] scan: preview 8
[02:47:07] scan: preview 9
[02:47:07] scan: preview 10
[02:47:07] scan: 10 previews, 1280x720, 23.976 fps, autocrop = 0/0/0/0, aspect 16:9, PAR 1:1
[02:47:07] scan: title (0) job->width:1280, job->height:720
[02:47:07] thread 11b07c000 exited ("scan")
[02:47:07] thread 11b07c000 joined ("scan")
[02:47:07] libhb: scan thread found 1 valid title(s)
[02:47:07] macgui: ScanDone state received from fQueueEncodeLibhb
[02:47:07] macgui: Preset: Custom
[02:47:07] macgui: processNewQueueEncode number of passes expected is: 1
[02:47:07] macgui: prepareJob audiotrack 2 is: 0
[02:47:07] macgui: prepareJob exiting
[02:47:07] thread 119f32000 started ("work")
[02:47:07] 1 job(s) to process
[02:47:07] starting job
[02:47:07] job configuration:
[02:47:07] * source
[02:47:07] + /Users/jr/Downloads/mymovie.mkv
[02:47:07] + title 1, chapter(s) 1 to 21
[02:47:07] + container: matroska
[02:47:07] * destination
[02:47:07] + /Users/jr/Downloads/mymovie.m4v
[02:47:07] + container: MPEG-4 (.mp4 and .m4v)
[02:47:07] + 64-bit formatting
[02:47:07] * video track
[02:47:07] + decoder: h264
[02:47:07] + frame rate: same as source (around 23.976 fps)
[02:47:07] + loose anamorphic
[02:47:07] + modulus: 0
[02:47:07] + storage dimensions: 1280 * 720 -> 1280 * 720, crop 0/0/0/0
[02:47:07] + pixel aspect ratio: 1 / 1
[02:47:07] + display dimensions: 1280 * 720
[02:47:07] + encoder: x264
[02:47:07] + options: cabac=0:ref=2:me=umh:b-adapt=2:weightb=0:trellis=0
[02:47:07] + quality: 21.00 (RF)
[02:47:07] * audio track 0
[02:47:07] + decoder: English (AC3) (5.1 ch) (track 1, id 1)
[02:47:07] + bitrate: 640 kbps, samplerate: 48000 Hz
[02:47:07] + mixdown: Dolby Pro Logic II
[02:47:07] + encoder: ca_aac
[02:47:07] + bitrate: 256 kbps, samplerate: 48000 Hz
[02:47:07] * audio track 1
[02:47:07] + decoder: English (AC3) (5.1 ch) (track 1, id 1)
[02:47:07] + bitrate: 640 kbps, samplerate: 48000 Hz
[02:47:07] + AC3 passthrough
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
[02:47:07] dvd: not a dvd - trying as a stream/file instead
[02:47:07] thread 119fb5000 started ("reader")
[02:47:07] thread 11a038000 started ("Video decoder (ffmpeg streams)")
[02:47:07] thread 11a0bb000 started ("Renderer")
[02:47:07] encx264: keyint-min: 24, keyint-max: 240
[02:47:07] encx264: encoding with stored aspect 1/1
[02:47:07] encx264: Encoding at constant RF 21.000000
[02:47:07] encx264: opening libx264 (pass 0)
x264 [info]: using SAR=1/1
x264 [info]: using cpu capabilities: MMX2 SSE2Fast SSSE3 Cache64
[02:47:07] Seeking to chapter 1: starts 0, ends 29343060, AV pos 0
[02:47:07] reader: first SCR 0 id 0 DTS 0
x264 [info]: profile High, level 3.1
[02:47:07] thread 11cf38000 started ("H.264/AVC encoder (libx264)")
No accelerated IMDCT transform found
[02:47:07] thread 11cfbb000 started ("AC3 decoder")
[02:47:07] thread 11f167000 started ("AAC encoder (Apple)")
No accelerated IMDCT transform found
[02:47:07] thread 11f1ea000 started ("AC3 decoder")
[02:47:07] thread 11f26d000 started ("muxer")
[02:47:07] sync: expecting 126528 video frames
[02:47:07] muxmp4: using 64-bit MP4 formatting.
[02:47:07] muxmp4: track 0, chunk duration 15015
[02:47:07] muxmp4: track 1, chunk duration 8008
[02:47:07] muxmp4: track 2, chunk duration 8008
[02:47:07] muxmp4: disabled extra audio track 2
[03:02:11] ffmpeg_read starting chapter 2 at 29343060
[03:02:39] h264: "00:05:26.034" (2) at frame 7825 time 29343060
[03:14:59] ffmpeg_read starting chapter 3 at 54474390
[03:15:21] h264: "00:10:05.271" (3) at frame 14520 time 54474390
[03:20:58] ffmpeg_read starting chapter 4 at 67875300
[03:21:26] h264: "00:12:34.170" (4) at frame 18090 time 67875300
[03:32:07] ffmpeg_read starting chapter 5 at 88239420
[03:32:37] h264: "00:16:20.437" (5) at frame 23515 time 88239420
[03:42:28] ffmpeg_read starting chapter 6 at 107162100
[03:42:59] h264: "00:19:50.689" (6) at frame 28556 time 107162100
[03:53:06] ffmpeg_read starting chapter 7 at 126216090
[03:53:37] h264: "00:23:22.401" (7) at frame 33632 time 126216090
[04:03:39] ffmpeg_read starting chapter 8 at 144192780
[04:04:15] h264: "00:26:42.142" (8) at frame 38421 time 144192780
[04:11:06] ffmpeg_read starting chapter 9 at 157920300
[04:11:45] h264: "00:29:14.669" (9) at frame 42078 time 157920300
[04:24:08] ffmpeg_read starting chapter 10 at 183385710
[04:24:36] h264: "00:33:57.618" (10) at frame 48862 time 183385710
[04:38:26] ffmpeg_read starting chapter 11 at 210660480
[04:39:00] h264: "00:39:00.671" (11) at frame 56128 time 210660480
[04:46:26] ffmpeg_read starting chapter 12 at 225881910
[04:47:04] h264: "00:41:49.798" (12) at frame 60183 time 225881910
[05:07:58] ffmpeg_read starting chapter 13 at 268501950
[05:08:29] h264: "00:49:43.355" (13) at frame 71537 time 268501950
[05:22:09] ffmpeg_read starting chapter 14 at 293415660
[05:22:40] h264: "00:54:20.173" (14) at frame 78174 time 293415660
[05:45:32] ffmpeg_read starting chapter 15 at 337435830
[05:46:09] h264: "01:02:29.287" (15) at frame 89901 time 337435830
[05:54:50] ffmpeg_read starting chapter 16 at 352210590
[05:55:21] h264: "01:05:13.451" (16) at frame 93837 time 352210590
[06:11:48] ffmpeg_read starting chapter 17 at 383794650
[06:12:21] h264: "01:11:04.385" (17) at frame 102251 time 383794650
[06:28:51] ffmpeg_read starting chapter 18 at 415949310
[06:29:18] h264: "01:17:01.617" (18) at frame 110817 time 415949310
[06:39:57] ffmpeg_read starting chapter 19 at 436880160
[06:40:25] h264: "01:20:54.224" (19) at frame 116393 time 436880160
[06:51:12] ffmpeg_read starting chapter 20 at 456287040
[06:51:41] h264: "01:24:29.731" (20) at frame 121563 time 456287040
[06:55:48] ffmpeg_read starting chapter 21 at 474841890
[06:55:48] reader: done. 1 scr changes
[06:55:48] thread 119fb5000 exited ("reader")
[06:56:03] sync: got 126503 frames, 126528 expected
[06:56:03] work: average encoding speed for job is 8.469285 fps
[06:56:06] mux: file size, 1924252776 bytes
[06:56:06] mux: track 0, 126503 frames, 1332177092 bytes, 2019.88 kbps, fifo 64
[06:56:06] mux: video bitrate error, +1332177092 bytes
[06:56:06] mux: track 1, 247326 frames, 166263492 bytes, 252.09 kbps, fifo 1024
[06:56:06] mux: track 2, 164884 frames, 422103040 bytes, 640.00 kbps, fifo 512
[06:56:06] mux: overhead, 6.89 bytes per frame
[06:56:06] thread 11f26d000 exited ("muxer")
[06:56:06] thread 11f26d000 joined ("muxer")
[06:56:06] thread 11a038000 exited ("Video decoder (ffmpeg streams)")
[06:56:06] thread 11f167000 exited ("AAC encoder (Apple)")
[06:56:06] thread 11a038000 joined ("Video decoder (ffmpeg streams)")
[06:56:06] h264-decoder done: 126504 frames, 0 decoder errors, 0 drops
[06:56:06] thread 11a0bb000 exited ("Renderer")
[06:56:06] thread 11cfbb000 exited ("AC3 decoder")
[06:56:06] thread 11f1ea000 exited ("AC3 decoder")
[06:56:06] thread 11cf38000 exited ("H.264/AVC encoder (libx264)")
[06:56:06] thread 11a0bb000 joined ("Renderer")
[06:56:06] render: lost time: 0 (0 frames)
[06:56:06] render: gained time: 0 (0 frames) (0 not accounted for)
[06:56:06] fifo_close: trashing 0 buffer(s)
[06:56:06] fifo_close: trashing 0 buffer(s)
[06:56:06] thread 11cf38000 joined ("H.264/AVC encoder (libx264)")
x264 [info]: frame I:1095 Avg QP:16.93 size: 86577 PSNR Mean Y:48.80 U:51.10 V:52.02 Avg:49.46 Global:48.97
x264 [info]: frame P:48435 Avg QP:20.44 size: 17946 PSNR Mean Y:46.03 U:49.34 V:50.18 Avg:46.67 Global:45.72
x264 [info]: frame B:76973 Avg QP:22.41 size: 4784 PSNR Mean Y:44.95 U:48.93 V:49.64 Avg:45.92 Global:45.45
x264 [info]: consecutive B-frames: 3.6% 38.5% 15.7% 42.2%
x264 [info]: mb I I16..4: 13.6% 65.9% 20.5%
x264 [info]: mb P I16..4: 3.9% 4.8% 1.1% P16..4: 47.8% 15.3% 5.8% 0.0% 0.0% skip:21.1%
x264 [info]: mb B I16..4: 0.3% 0.7% 0.1% B16..8: 40.5% 0.8% 0.7% direct: 3.6% skip:53.3% L0:39.6% L1:55.4% BI: 5.0%
x264 [info]: 8x8 transform intra:52.8% inter:55.9%
x264 [info]: coded y,uvDC,uvAC intra: 54.6% 78.3% 40.4% inter: 7.6% 19.9% 1.0%
x264 [info]: i16 v,h,dc,p: 53% 18% 8% 21%
x264 [info]: i8 v,h,dc,ddl,ddr,vr,hd,vl,hu: 15% 17% 22% 6% 8% 8% 9% 7% 8%
x264 [info]: i4 v,h,dc,ddl,ddr,vr,hd,vl,hu: 20% 21% 14% 6% 9% 9% 9% 6% 6%
x264 [info]: Weighted P-Frames: Y:1.5%
x264 [info]: ref P L0: 66.8% 15.9% 17.3%
x264 [info]: SSIM Mean Y:0.9838655
x264 [info]: PSNR Mean Y:45.401 U:49.103 V:49.866 Avg:46.234 Global:45.576 kb/s:2019.96
[06:56:06] thread 11cfbb000 joined ("AC3 decoder")
[06:56:06] thread 11f167000 joined ("AAC encoder (Apple)")
[06:56:06] thread 11f1ea000 joined ("AC3 decoder")
[06:56:06] thread 119fb5000 joined ("reader")
[06:56:06] fifo_close: trashing 0 buffer(s)
[06:56:06] fifo_close: trashing 1 buffer(s)
[06:56:06] fifo_close: trashing 0 buffer(s)
[06:56:06] fifo_close: trashing 0 buffer(s)
[06:56:06] fifo_close: trashing 0 buffer(s)
[06:56:06] fifo_close: trashing 0 buffer(s)
[06:56:06] fifo_close: trashing 0 buffer(s)
[06:56:06] fifo_close: trashing 0 buffer(s)
[06:56:06] fifo_close: trashing 0 buffer(s)
[06:56:06] fifo_close: trashing 0 buffer(s)
[06:56:06] fifo_close: trashing 0 buffer(s)
[06:56:06] fifo_close: trashing 0 buffer(s)
[06:56:06] fifo_close: trashing 0 buffer(s)
[06:56:06] Freed 32 buffers of size 2048
[06:56:06] Freed 32 buffers of size 4096
[06:56:06] Freed 32 buffers of size 16384
[06:56:06] Freed 32 buffers of size 65536
[06:56:06] Freed 32 buffers of size 131072
[06:56:06] Freed 32 buffers of size 262144
[06:56:06] Freed 32 buffers of size 524288
[06:56:06] Freed 32 buffers of size 2097152
[06:56:06] Allocated 99287040 bytes of buffers on this pass and Freed 99287040 bytes, 0 bytes leaked
[06:56:06] thread 119f32000 exited ("work")
[06:56:06] thread 119f32000 joined ("work")
[06:56:06] libhb: work result = 0