HandBrake Activity Log for Session (Cleared): 2008-03-17 12:18:54 -0500

[12:18:54] macgui: Handbrake Version: 0.9.2 (2008021900)
[12:18:54] hb_init: checking cpu count
[12:18:54] hb_init: starting libhb thread
[12:18:54] thread b01c9000 started ("libhb")
[12:19:00] macgui: trying to open video_ts folder (parent directory chosen)
[12:19:00] hb_scan: path=/Users/Joe/Desktop/SoundStage_TomPetty.mpg, title_index=0
[12:19:00] thread b088f000 started ("scan")
[12:19:00] scan: trying to open with libdvdread
GUI ERROR dialog: dvd: DVDOpen failed (/Users/Joe/Desktop/SoundStage_TomPetty.mpg)
[12:19:00] file is MPEG Program Stream
[12:19:00] hb_sample_pts: pts 553746 at 9811968
[12:19:00] hb_sample_pts: pts 1364556 at 24758272
[12:19:00] hb_sample_pts: pts 2194885 at 41697280
[12:19:00] hb_sample_pts: pts 3005695 at 57683968
[12:19:00] hb_sample_pts: pts 3769959 at 73682944
[12:19:00] hb_sample_pts: pts 4484673 at 88516608
[12:19:00] hb_sample_pts: pts 5369056 at 105846784
[12:19:00] hb_sample_pts: pts 6139326 at 120870912
[12:19:00] hb_sample_pts: pts 6987673 at 137134080
[12:19:01] hb_sample_pts: pts 7816501 at 153470976
[12:19:01] hb_sample_pts: pts 8648332 at 170250240
[12:19:01] hb_sample_pts: pts 9382566 at 185198592
[12:19:01] hb_sample_pts: pts 10178361 at 202035200
[12:19:01] hb_sample_pts: pts 10951633 at 218290176
[12:19:01] hb_sample_pts: pts 11660341 at 233256960
[12:19:01] hb_sample_pts: pts 12427608 at 249571328
[12:19:01] add_audio_to_title: added AC3 audio stream 0x80bd
[12:19:01] scan: decoding previews for title 1
[12:19:01] scan: preview 1
[12:19:02] scan: AC3, rate=48000Hz, bitrate=384000
[12:19:02] scan: preview 2
[12:19:03] scan: preview 3
[12:19:03] scan: preview 4
[12:19:03] scan: preview 5
[12:19:04] Interlacing detected in preview frame 4
[12:19:04] scan: preview 6
[12:19:04] scan: preview 7
[12:19:05] scan: preview 8
[12:19:05] scan: preview 9
[12:19:05] scan: preview 10
[12:19:05] Interlacing detected in preview frame 9
[12:19:05] scan: 10 previews, 1920x1088, 29.970 fps, autocrop = 0/0/0/0, aspect 16:9
[12:19:05] stream: audio 80bd: lang Unknown (AC3) (5.1 ch), rate 48000, bitrate 384000, flags = 0x17
[12:19:05] scan: title (0) job->width:1920, job->height:1088
[12:19:05] thread b088f000 exited ("scan")
[12:19:05] thread b088f000 joined ("scan")
[12:19:05] libhb: scan thread found 1 valid title(s)
[12:20:22] thread b0687000 started ("work")
[12:20:22] 1 job(s) to process
[12:20:22] starting job
[12:20:22]  + device /Users/Joe/Desktop/SoundStage_TomPetty.mpg
[12:20:22]  + title 1, chapter(s) 1 to 1
[12:20:22]  + 1920x1088 -> 720x400, crop 0/0/0/0
[12:20:22]  + filters
[12:20:22]    + Detelecine (pullup) (default settings)
[12:20:22]    + Deinterlace (ffmpeg or yadif/mcdeint) (0:-1:-1:0:1)
[12:20:22]  + video frame rate: variable (detected 29.970 fps)
[12:20:22]  + video bitrate 700 kbps, pass 0
[12:20:22]  + PixelRatio: 0, width:720, height: 400
[12:20:22]  + encoder x264
[12:20:22]    + x264 options: level=30:bframes=0:cabac=0:ref=1:vbv-maxrate=768:vbv-bufsize=2000:analyse=all:me=umh:subq=6:no-fast-pskip=1
[12:20:22]  + audio 160 kbps, 48000 Hz
[12:20:22]  + encoder faac
[12:20:22]    + 80bd, Unknown (AC3) (5.1 ch)
[12:20:22]      + Requested mixdown: Dolby Pro Logic II (HB_AMIXDOWN_DOLBYPLII)
[12:20:22]      + Actual mixdown: Dolby Pro Logic II (HB_AMIXDOWN_DOLBYPLII)
GUI ERROR dialog: dvd: DVDOpen failed (/Users/Joe/Desktop/SoundStage_TomPetty.mpg)
[12:20:22] reader: first SCR 3 scr_offset 13206
[12:20:22] thread b078b000 started ("reader")
[12:20:22]  + output: /Users/Joe/Desktop/SoundStage_TomPetty.m4v
[12:20:22] thread b088f000 started ("muxer")
[12:20:22] thread b0911000 started ("MPEG-2 decoder (libmpeg2)")
[12:20:22] thread b0993000 started ("Renderer")
[12:20:22] encx264: keyint-min: 30, keyint-max: 300
[12:20:22] encx264: opening libx264 (pass 0)
x264 [info]: using cpu capabilities: MMX MMXEXT SSE SSE2 SSE3 SSSE3 Cache64 
[12:20:22] thread b0aa5000 started ("H.264/AVC encoder (libx264)")
No accelerated IMDCT transform found
[12:20:22] thread b0b27000 started ("AC3 decoder")
[12:20:22] thread b0ba9000 started ("AAC encoder (libfaac)")
[12:20:22] sync: expecting 4293 video frames
[12:20:22] 0.033367s: Film -> Video
[12:20:22] sync: audio 0 time went backwards 34 ms, dropped 1 frames (frame -3126, expected 0)
[12:20:23] macgui: Using preset: Test Content
[12:20:23] About to add iPod atom
[12:21:00] 15.148467s: Video -> Film
[12:21:04] 16.883499s: Film -> Video
[12:21:10] 19.586233s: Video -> Film
[12:21:57] 38.321602s: Film -> Video
[12:22:19] 46.613232s: Video -> Film
[12:22:24] 48.665279s: Film -> Video
[12:22:25] 48.932213s: Video -> Film
[12:22:25] 49.165768s: Film -> Video
[12:22:26] 49.432701s: Video -> Film
[12:22:39] 55.538811s: Film -> Video
[12:22:39] 55.638912s: Video -> Film
[12:22:55] 62.879433s: Film -> Video
[12:23:21] 74.340935s: Video -> Film
[12:23:58] 89.722969s: Film -> Video
[12:24:00] 90.657234s: Video -> Film
[12:24:00] 90.874107s: Film -> Video
[12:24:00] 90.974213s: Video -> Film
[12:24:08] 94.577774s: Film -> Video
[12:24:08] 94.677879s: Video -> Film
[12:24:15] 97.430656s: Film -> Video
[12:24:19] 99.365936s: Video -> Film
[12:24:20] 99.766319s: Film -> Video
[12:24:28] 103.203102s: Video -> Film
[12:24:29] 103.436653s: Film -> Video
[12:24:33] 105.371933s: Video -> Film
[12:24:50] 112.946167s: Film -> Video
[12:24:51] 113.213097s: Video -> Film
[12:25:11] 122.121964s: Film -> Video
[12:25:11] 122.222069s: Video -> Film
[12:25:17] 124.457657s: Film -> Video
[12:25:19] 125.225098s: Video -> Film
[12:25:31] 130.964157s: Film -> Video
[12:25:58] reader: done. 0 scr changes
[12:25:58] thread b078b000 exited ("reader")
[12:26:05] sync: got 4081 frames, 4293 expected
[12:26:06] thread b0911000 exited ("MPEG-2 decoder (libmpeg2)")
[12:26:06] thread b0b27000 exited ("AC3 decoder")
[12:26:06] thread b0ba9000 exited ("AAC encoder (libfaac)")
[12:26:06] thread b0993000 exited ("Renderer")
[12:26:06] thread b0911000 joined ("MPEG-2 decoder (libmpeg2)")
[12:26:06] thread b0993000 joined ("Renderer")
[12:26:06] render: lost time: 1543547 (514 frames)
[12:26:06] render: gained time: 1542047 (2007 frames) (1500 not accounted for)
[12:26:06] render: average dropped frame duration: 3003
[12:26:06] fifo_close: trashing 1 buffer(s)
[12:26:06] fifo_close: trashing 2 buffer(s)
[12:26:06] thread b0aa5000 exited ("H.264/AVC encoder (libx264)")
[12:26:06] thread b0aa5000 joined ("H.264/AVC encoder (libx264)")
x264 [info]: slice I:38    Avg QP:21.89  size: 18832  PSNR Mean Y:42.63 U:44.22 V:45.46 Avg:43.19 Global:42.25
x264 [info]: slice P:3526  Avg QP:23.82  size:  2813  PSNR Mean Y:41.39 U:43.98 V:45.21 Avg:42.16 Global:40.51
x264 [info]: mb I  I16..4: 49.5%  0.0% 50.5%
x264 [info]: mb P  I16..4:  6.7%  0.0%  0.9%  P16..4: 48.8% 10.2%  1.1%  0.1%  0.0%    skip:32.2%
x264 [info]: SSIM Mean Y:0.9746582
x264 [info]: PSNR Mean Y:41.402 U:43.978 V:45.211 Avg:42.166 Global:40.523 kb/s:715.41
[12:26:06] mux: file size, 13529250 bytes
[12:26:06] mux: track 0, 10629399 bytes, 600.60 kbps
[12:26:06] mux: video bitrate error, -1759125 bytes
[12:26:06] mux: track 1, 2828702 bytes, 159.83 kbps
[12:26:06] mux: overhead, 6.98 bytes per frame
[12:26:06] thread b088f000 exited ("muxer")
[12:26:06] thread b0b27000 joined ("AC3 decoder")
[12:26:06] thread b0ba9000 joined ("AAC encoder (libfaac)")
[12:26:06] thread b078b000 joined ("reader")
[12:26:06] thread b088f000 joined ("muxer")
[12:26:06] fifo_close: trashing 0 buffer(s)
[12:26:06] fifo_close: trashing 0 buffer(s)
[12:26:06] fifo_close: trashing 0 buffer(s)
[12:26:06] fifo_close: trashing 1 buffer(s)
[12:26:06] fifo_close: trashing 1 buffer(s)
[12:26:06] fifo_close: trashing 0 buffer(s)
[12:26:06] fifo_close: trashing 0 buffer(s)
[12:26:06] fifo_close: trashing 3 buffer(s)
[12:26:06] fifo_close: trashing 13 buffer(s)
[12:26:06] deinterlacer: filtered 66 | unfiltered 3500 | total 3566
[12:26:06] Freed 1 buffers of size 512
[12:26:06] Freed 1 buffers of size 1024
[12:26:06] Freed 2048 buffers of size 2048
[12:26:06] Freed 0 buffers of size 4096
[12:26:06] Freed 0 buffers of size 8192
[12:26:06] Freed 34 buffers of size 16384
[12:26:06] Freed 0 buffers of size 32768
[12:26:06] Freed 43 buffers of size 3133440
[12:26:06] Allocated 139523584 bytes of buffers on this pass and Freed 139490816 bytes, 32768 bytes leaked
[12:26:06] thread b0687000 exited ("work")
[12:26:06] thread b0687000 joined ("work")
[12:26:06] libhb: work result = 0