[16:30:12] thread b02fa000 started ("work")
[16:30:12] 1 job(s) to process
[16:30:12] starting job
[16:30:12]  + device /Volumes/External/XFILES_DISC1/VIDEO_TS
[16:30:12]  + title 1, chapter(s) 1 to 1
[16:30:12]  + 720x576 -> 640x480, crop 0/0/0/0
[16:30:12]  + video frame rate: 25.000 fps
[16:30:12]  + video bitrate 1500 kbps, pass 0
[16:30:12]  + PixelRatio: 0, width:640, height: 480
[16:30:12]  + encoder x264
[16:30:12]    + x264 options: level=30:bframes=0:cabac=0:ref=1:vbv-maxrate=1500:vbv-bufsize=2000:analyse=all:me=umh:subq=6:no-fast-pskip=1
[16:30:12]  + audio 160 kbps, 48000 Hz
[16:30:12]  + encoder faac
[16:30:12]    + 80bd, English (AC3) (2.0 ch)
[16:30:12]      + Requested mixdown: Stereo (HB_AMIXDOWN_STEREO)
[16:30:12]      + Actual mixdown: Stereo (HB_AMIXDOWN_STEREO)
[16:30:12] thread b048b000 started ("reader")
[16:30:12]  + output: /Volumes/Video/Films/Test4.m4v
[16:30:12] thread b058f000 started ("muxer")
[16:30:12] thread b06d3000 started ("MPEG-2 decoder (libmpeg2)")
[16:30:12] thread b0755000 started ("Renderer")
[16:30:12] encx264: opening libx264 (pass 0)
x264 [info]: using cpu capabilities: MMX MMXEXT SSE SSE2 Cache64 
[16:30:12] thread b084c000 started ("H.264/AVC encoder (libx264)")
No accelerated IMDCT transform found
[16:30:12] thread b08ce000 started ("AC3 decoder")
[16:30:12] dvd: Beginning of Cell (0) at block 2959
[16:30:12] thread b0950000 started ("AAC encoder (libfaac)")
[16:30:12] sync: expecting 3313 video frames
[16:30:12] sync: first pts is 13782
[16:30:12] Sync: Audio PTS (4422) < Video PTS (13782) by greater than 100ms, trashing audio to reconverge
[16:30:12] Sync: Audio back in Sync at PTS 7302
[16:30:13] About to add iPod atom
[16:30:13] macgui: Using preset: iPod High-Rez
[16:33:10] dvd: End of Cell (0) at block 51362
[16:33:10] dvd: Beginning of Cell (1) at block 51567
[16:33:10] dvd: Chapter Break Cell Found
[16:33:10] reader: end of chapter 1 (media 1) reached at media chapter 2
[16:33:10] reader: done
[16:33:10] thread b048b000 exited ("reader")
[16:33:18] sync: got 3289 frames, 3313 expected
[16:33:19] thread b06d3000 exited ("MPEG-2 decoder (libmpeg2)")
[16:33:19] thread b08ce000 exited ("AC3 decoder")
[16:33:19] thread b0755000 exited ("Renderer")
[16:33:19] thread b06d3000 joined ("MPEG-2 decoder (libmpeg2)")
[16:33:19] thread b0755000 joined ("Renderer")
[16:33:19] render: lost time: 0 (0 frames)
[16:33:19] render: gained time: 0 (0 frames) (0 not accounted for)
[16:33:19] fifo_close: trashing 0 buffer(s)
[16:33:19] fifo_close: trashing 0 buffer(s)
[16:33:19] thread b0950000 exited ("AAC encoder (libfaac)")
[16:33:19] mux: file size, 27035875 bytes
[16:33:19] mux: track 0, 24367064 bytes, 1482.63 kbps
[16:33:19] mux: video bitrate error, -285436 bytes
[16:33:19] mux: track 1, 2628443 bytes, 159.93 kbps
[16:33:19] mux: overhead, 4.27 bytes per frame
[16:33:19] thread b058f000 exited ("muxer")
[16:33:19] thread b084c000 exited ("H.264/AVC encoder (libx264)")
[16:33:19] thread b084c000 joined ("H.264/AVC encoder (libx264)")
x264 [info]: slice I:55    Avg QP:20.10  size: 27444  PSNR Mean Y:46.84 U:48.67 V:49.22 Avg:47.14 Global:43.04
x264 [info]: slice P:3234  Avg QP:21.77  size:  7069  PSNR Mean Y:43.95 U:46.53 V:47.34 Avg:44.59 Global:41.81
x264 [info]: mb I  I16..4: 52.8%  0.0% 47.2%
x264 [info]: mb P  I16..4:  7.0%  0.0%  6.6%  P16..4: 50.2% 16.1%  1.6%  0.2%  0.0%    skip:18.4%
x264 [info]: SSIM Mean Y:0.9731717
x264 [info]: PSNR Mean Y:43.998 U:46.563 V:47.373 Avg:44.632 Global:41.830 kb/s:1481.96
[16:33:19] thread b08ce000 joined ("AC3 decoder")
[16:33:19] thread b0950000 joined ("AAC encoder (libfaac)")
[16:33:19] thread b048b000 joined ("reader")
[16:33:19] thread b058f000 joined ("muxer")
[16:33:19] fifo_close: trashing 0 buffer(s)
[16:33:19] fifo_close: trashing 0 buffer(s)
[16:33:19] fifo_close: trashing 0 buffer(s)
[16:33:19] fifo_close: trashing 1 buffer(s)
[16:33:19] fifo_close: trashing 1 buffer(s)
[16:33:19] fifo_close: trashing 0 buffer(s)
[16:33:19] fifo_close: trashing 0 buffer(s)
[16:33:19] fifo_close: trashing 0 buffer(s)
[16:33:19] fifo_close: trashing 10 buffer(s)
[16:33:19] Freed 7 buffers of size 512
[16:33:19] Freed 6 buffers of size 1024
[16:33:19] Freed 2048 buffers of size 2048
[16:33:19] Freed 0 buffers of size 4096
[16:33:19] Freed 0 buffers of size 8192
[16:33:19] Freed 36 buffers of size 16384
[16:33:19] Freed 0 buffers of size 32768
[16:33:19] Freed 55 buffers of size 622080
[16:33:19] Allocated 39008256 bytes of buffers on this pass and Freed 39008256 bytes, 0 bytes leaked
[16:33:19] thread b02fa000 exited ("work")
[16:33:19] thread b02fa000 joined ("work")
[16:33:19] libhb: work result = 0