Audio Out of Sync

[capgun42]

After encoding the audio is way out of sync. As the video progresses the time out of sync increases. Encoded using 6268svn-MacOSX.6_GUIx86_64, downloaded 8/6/2014 from HandBrake website.Running OSX 10.9.4. Firefox was ran during the encode. Tried nightly build 6267 with same problem. Tried different audio/video settings with same issue. See activity log below.

xxxxxxx

HandBrake Activity Log for XXXXXX John Carter 2012 XXXX: 2014-08-06 21:09:22 -0700
Handbrake Version: 6268svn x86_64 (2014080601)

[21:09:22] macgui: Rip: Pending queue count is 0
[21:09:22] macgui: getNextPendingQueueIndex next pending encode index is:0
[21:09:22] macgui: scanning specifically for title: 1
[21:09:22] CPU: Intel(R) Core(TM) i7-2820QM CPU @ 2.30GHz
[21:09:22] - Intel microarchitecture Sandy Bridge
[21:09:22] - logical processor count: 8
[21:09:22] OpenCL device #1: AMD ATI Radeon HD 6750M
[21:09:22] - OpenCL version: 1.2
[21:09:22] - driver version: 1.2 (Jun 10 2014 22:41:20)
[21:09:22] - device type: GPU
[21:09:22] - supported: YES
[21:09:22] hb_scan: path=/Users/xxxxxxx/John.Carter.2012.mp4, title_index=1
libbluray/bdnav/index_parse.c:162: indx_parse(): error opening /Users/xxxxxx/John Carter (2012) [1080p]/John.Carter.2012.mp4/BDMV/index.bdmv
libbluray/bdnav/index_parse.c:162: indx_parse(): error opening /Users/xxxxxx/John Carter (2012) [1080p]/John.Carter.2012.mp4/BDMV/BACKUP/index.bdmv
libbluray/bluray.c:2182: nav_get_title_list(/Users/xxxxxxxx/John Carter (2012) [1080p]/John.Carter.2012.mp4) failed
[21:09:22] bd: not a bd - trying as a stream/file instead
libdvdnav: Using dvdnav version 5.0.0
libdvdread:DVDOpenFileUDF:UDFFindFile /VIDEO_TS/VIDEO_TS.IFO failed
libdvdread:DVDOpenFileUDF:UDFFindFile /VIDEO_TS/VIDEO_TS.BUP failed
libdvdread: Can't open file VIDEO_TS.IFO.
libdvdnav: vm: failed to read VIDEO_TS.IFO
[21:09:22] dvd: not a dvd - trying as a stream/file instead
Input #0, mov,mp4,m4a,3gp,3g2,mj2, from '/Users/xxxx/John Carter (2012) [1080p]/John.Carter.2012.mp4':
Metadata:
major_brand : isom
minor_version : 1
compatible_brands: isomavc1
creation_time : 2012-05-19 08:08:06
Duration: 02:12:01.74, start: 0.000000, bitrate: 1841 kb/s
Stream #0.0(und): Video: h264 (High), yuv420p, 1920x800 [PAR 1:1 DAR 12:5], 1743 kb/s, 23.98 fps, 96k tbn, 47.95 tbc (default)
Metadata:
creation_time : 2012-05-19 08:08:06
Stream #0.1(und): Audio: aac, 44100 Hz, stereo, fltp, 93 kb/s (default)
Metadata:
creation_time : 2012-05-19 08:18:10
[21:09:23] scan: decoding previews for title 1
[21:09:23] scan: audio 0x1: aac, rate=44100Hz, bitrate=93999 Unknown (AAC) (2.0 ch)
[21:09:23] scan: 10 previews, 1920x800, 23.976 fps, autocrop = 0/0/0/0, aspect 2.40:1, PAR 1:1
[21:09:23] libhb: scan thread found 1 valid title(s)
[21:09:23] macgui: ScanDone state received from fQueueEncodeLibhb
[21:09:23] macgui: Preset: High Profile
[21:09:23] macgui: processNewQueueEncode number of passes expected is: 1
[21:09:23] macgui: Start / Stop set to chapters
[21:09:23] macgui: prepareJob exiting
[21:09:23] 1 job(s) to process
[21:09:23] starting job
[21:09:23] yadif thread started for segment 0
[21:09:23] yadif thread started for segment 1
[21:09:23] yadif thread started for segment 2
[21:09:23] yadif thread started for segment 4
[21:09:23] yadif thread started for segment 3
[21:09:23] yadif thread started for segment 5
[21:09:23] yadif thread started for segment 6
[21:09:23] yadif thread started for segment 7
[21:09:23] decomb filter thread started for segment 0
[21:09:23] decomb filter thread started for segment 1
[21:09:23] decomb filter thread started for segment 2
[21:09:23] decomb filter thread started for segment 3
[21:09:23] decomb filter thread started for segment 4
[21:09:23] decomb filter thread started for segment 5
[21:09:23] decomb filter thread started for segment 6
[21:09:23] decomb filter thread started for segment 7
[21:09:23] decomb check thread started for segment 0
[21:09:23] decomb check thread started for segment 1
[21:09:23] decomb check thread started for segment 2
[21:09:23] decomb check thread started for segment 3
[21:09:23] decomb check thread started for segment 4
[21:09:23] decomb check thread started for segment 5
[21:09:23] decomb check thread started for segment 6
[21:09:23] decomb check thread started for segment 7
[21:09:23] mask filter thread started for segment 0
[21:09:23] mask filter thread started for segment 1
[21:09:23] mask filter thread started for segment 2
[21:09:23] mask filter thread started for segment 3
[21:09:23] mask filter thread started for segment 4
[21:09:23] mask filter thread started for segment 5
[21:09:23] mask filter thread started for segment 6
[21:09:23] mask filter thread started for segment 7
[21:09:23] mask erode thread started for segment 0
[21:09:23] mask erode thread started for segment 1
[21:09:23] mask erode thread started for segment 2
[21:09:23] mask erode thread started for segment 3
[21:09:23] mask erode thread started for segment 4
[21:09:23] mask erode thread started for segment 5
[21:09:23] mask erode thread started for segment 6
[21:09:23] mask erode thread started for segment 7
[21:09:23] mask dilate thread started for segment 0
[21:09:23] mask dilate thread started for segment 1
[21:09:23] mask dilate thread started for segment 2
[21:09:23] mask dilate thread started for segment 3
[21:09:23] mask dilate thread started for segment 4
[21:09:23] mask dilate thread started for segment 5
[21:09:23] mask dilate thread started for segment 6
[21:09:23] mask dilate thread started for segment 7
Fontconfig error: "/usr/X11/lib/X11/fontconfig/conf.d/10-scale-bitmap-fonts.conf", line 70: non-double matrix element
Fontconfig error: "/usr/X11/lib/X11/fontconfig/conf.d/10-scale-bitmap-fonts.conf", line 70: non-double matrix element
Fontconfig warning: "/usr/X11/lib/X11/fontconfig/conf.d/10-scale-bitmap-fonts.conf", line 78: saw unknown, expected number
[21:09:23] sync: expecting 189932 video frames
[21:09:23] job configuration:
[21:09:23] * source
[21:09:23] + /Users/xxxxxx/John Carter (2012) [1080p]/John.Carter.2012.mp4
[21:09:23] + title 1, chapter(s) 1 to 1
[21:09:23] + container: mov,mp4,m4a,3gp,3g2,mj2
[21:09:23] + data rate: 1841 kbps
[21:09:23] * destination
[21:09:23] + /Users/xxxxxxx/John.Carter.2012.m4v
[21:09:23] + container: MPEG-4 (libavformat)
[21:09:23] * video track
[21:09:23] + decoder: h264
[21:09:23] + bitrate 1743 kbps
[21:09:23] + filters
[21:09:23] + Decomb (default settings)
[21:09:23] + Framerate Shaper (0:27000000:1126125)
[21:09:23] + frame rate: same as source (around 23.976 fps)
[21:09:23] + Subtitle renderer (0:0:0:0)
[21:09:23] + Crop and Scale (1920:800:0:0:0:0)
[21:09:23] + source: 1920 * 800, crop (0/0/0/0): 1920 * 800, scale: 1920 * 800
[21:09:23] + loose anamorphic
[21:09:23] + storage dimensions: 1920 * 800, mod 2
[21:09:23] + pixel aspect ratio: 1 / 1
[21:09:23] + display dimensions: 1920 * 800
[21:09:23] + encoder: H.264 (libx264)
[21:09:23] + preset: medium
[21:09:23] + profile: high
[21:09:23] + level: 4.0
[21:09:23] + quality: 20.00 (RF)
[21:09:23] * subtitle track 1, English (track 0, id 0xff) Text [SRT] -> Render/Burn-in, offset: 0, charset: ISO-8859-1
[21:09:23] * audio track 1
[21:09:23] + decoder: Unknown (AAC) (2.0 ch) (track 1, id 0x1)
[21:09:23] + bitrate: 93 kbps, samplerate: 44100 Hz
[21:09:23] + mixdown: Stereo
[21:09:23] + encoder: AAC (Apple AudioToolbox)
[21:09:23] + bitrate: 160 kbps, samplerate: 44100 Hz
[21:09:23] * audio track 2
[21:09:23] + decoder: Unknown (AAC) (2.0 ch) (track 1, id 0x1)
[21:09:23] + bitrate: 93 kbps, samplerate: 44100 Hz
[21:09:23] + mixdown: Stereo
[21:09:23] + encoder: AC3 (libavcodec)
[21:09:23] + bitrate: 224 kbps, samplerate: 44100 Hz
[21:09:23] reader: first SCR 7507 id 0x0 DTS 0
[21:09:23] encx264: min-keyint: 24, keyint: 240
[21:09:23] encx264: encoding at constant RF 20.000000
[21:09:23] encx264: unparsed options: level=4.0:vbv-bufsize=31250:vbv-maxrate=25000
x264 [info]: using SAR=1/1
x264 [info]: using cpu capabilities: MMX2 SSE2Fast SSSE3 SSE4.2 AVX
x264 [info]: profile High, level 4.0
[21:09:23] sync: first pts is 7507
[21:09:24] macgui: Queue reloaded
[23:27:31] reader: done. 1 scr changes
[23:27:33] work: average encoding speed for job is 22.910927 fps
[23:27:34] sync: got 189930 frames, 189932 expected
[23:27:34] decomb: deinterlaced 139 | blended 549 | unfiltered 189241 | total 189929
[23:27:34] render: lost time: 0 (0 frames)
[23:27:34] render: gained time: 0 (0 frames) (0 not accounted for)
[23:27:34] h264-decoder done: 189930 frames, 0 decoder errors, 0 drops
x264 [info]: frame I:2981 Avg QP:15.35 size:102366
x264 [info]: frame P:82905 Avg QP:18.74 size: 29945
x264 [info]: frame B:104043 Avg QP:20.95 size: 6784
x264 [info]: consecutive B-frames: 17.4% 24.9% 11.5% 46.2%
x264 [info]: mb I I16..4: 16.9% 72.3% 10.8%
x264 [info]: mb P I16..4: 4.0% 14.8% 0.9% P16..4: 42.4% 12.3% 5.6% 0.0% 0.0% skip:20.0%
x264 [info]: mb B I16..4: 0.1% 0.6% 0.0% B16..8: 41.7% 2.9% 0.5% direct: 1.4% skip:52.8% L0:43.4% L1:52.4% BI: 4.2%
x264 [info]: 8x8 transform intra:74.7% inter:79.1%
x264 [info]: coded y,uvDC,uvAC intra: 53.3% 63.4% 15.2% inter: 13.0% 16.4% 0.4%
x264 [info]: i16 v,h,dc,p: 26% 23% 11% 41%
x264 [info]: i8 v,h,dc,ddl,ddr,vr,hd,vl,hu: 20% 17% 20% 6% 8% 8% 8% 7% 7%
x264 [info]: i4 v,h,dc,ddl,ddr,vr,hd,vl,hu: 23% 19% 12% 6% 10% 9% 9% 6% 6%
x264 [info]: i8c dc,h,v,p: 51% 22% 20% 6%
x264 [info]: Weighted P-Frames: Y:3.0% UV:2.0%
x264 [info]: ref P L0: 61.2% 12.0% 19.4% 7.2% 0.2%
x264 [info]: ref B L0: 85.4% 12.8% 1.8%
x264 [info]: ref B L1: 96.2% 3.8%
x264 [info]: kb/s:3528.02
[23:27:34] aac-decoder done: 0 frames, 0 decoder errors, 0 drops
[23:27:34] aac-decoder done: 0 frames, 0 decoder errors, 0 drops
[23:27:34] mux: track 0, 189929 frames, 3493389324 bytes, 3527.92 kbps, fifo 2048
[23:27:34] mux: track 1, 341162 frames, 154355717 bytes, 155.88 kbps, fifo 4096
[23:27:34] mux: track 2, 227440 frames, 221808152 bytes, 224.00 kbps, fifo 2048
[23:27:34] libhb: work result = 0

[TedJ]

Funny looking file you have there... why did you resample the audio to 44.1 KHz in your source?