Page 1 of 1

[SVN2165] HB or x264 problem with badly encoded frames?

Posted: Sun Feb 22, 2009 5:55 am
by belloq
My gut tells me this is an issue with x264, but just in case it's not, or there's a setting I've dorked with which has borked my encode, I present the following.

It's painfully clear from the Activity Log that exporting to MPEG in MPEG Streamclip is still not clearing up the AC3 stream. I really need to give avidemux a go. I hope MPSC is not the source of the issue I am seeing in this encode.

Code: Select all

HandBrake Activity Log for /Volumes/FINALCUT/LOST.Exodus_Part_1.720.x264.AC3.m4v: 2009-02-21 12:37:51 -0800
Handbrake Version: svn2165 (2009021601)

[12:37:51] macgui: incrementQueueItemDone currentQueueEncodeIndex is incremented to: 7
[12:37:51] macgui: incrementQueueItemDone currentQueueEncodeIndex is incremented to: 7
[12:37:51] macgui: scanning specifically for title: 1
[12:37:51] macgui: performNewQueueScan currentQueueEncodeIndex is: 7
[12:37:51] hb_scan: path=/Volumes/FINALCUT/LOST.Exodus Part 1.mpeg, title_index=1
[12:37:51] scan: trying to open with libdvdread
[12:37:51] dvd: not a dvd - trying as a stream/file instead
[12:37:51] file is MPEG Program Stream
[12:37:53] add_audio_to_title: added AC3 audio stream 0x80bd
[12:37:56] scan: decoding previews for title 1
[12:37:57] scan: audio 0x80bd: AC-3, rate=48000Hz, bitrate=384000 Unknown (AC3) (5.1 ch)
[12:37:58] scan: 10 previews, 1920x1088, 29.970 fps, autocrop = 0/8/0/0, aspect 1.76:1, PAR 1:1
[12:37:58] scan: title (0) job->width:1936, job->height:1088
[12:37:58] libhb: scan thread found 1 valid title(s)
[12:37:58] macgui: ScanDone state received from fQueueEncodeLibhb
[12:37:58] macgui: processNewQueueEncode title list is: 1
[12:37:58] macgui: Preset: Custom
[12:37:58] macgui: processNewQueueEncode number of passes expected is: 1
[12:37:58] macgui: prepareJob audiotrack 2 is: 0
[12:37:58] macgui: prepareJob exiting
[12:37:58] 1 job(s) to process
[12:37:58] starting job
[12:37:58] job configuration:
[12:37:58]  * source
[12:37:58]    + /Volumes/FINALCUT/LOST.Exodus Part 1.mpeg
[12:37:58]    + title 1, chapter(s) 1 to 1
[12:37:58]  * destination
[12:37:58]    + /Volumes/FINALCUT/LOST.Exodus_Part_1.720.x264.AC3.m4v
[12:37:58]    + container: MPEG-4 (.mp4 and .m4v)
[12:37:58]  * video track
[12:37:58]    + decoder: mpeg2
[12:37:58]      + bitrate 17297 kbps
[12:37:58]    + frame rate: 29.970 fps -> variable fps
[12:37:58]    + dimensions: 1920 * 1088 -> 1280 * 720, crop 0/10/0/0
[12:37:58]    + filters
[12:37:58]      + Detelecine (pullup) (default settings)
[12:37:58]      + Deinterlace (ffmpeg or yadif/mcdeint) (0)
[12:37:58]    + encoder: x264
[12:37:58]      + options: ref=4:bframes=3:me=umh:b-adapt=2:direct=auto:mixed-refs=1:subq=9:merange=16:analyse=all:8x8dct=1:no-fast-pskip=1
[12:37:58]      + quality: 20 (RF)
[12:37:58]  * audio track 0
[12:37:58]    + decoder: Unknown (AC3) (5.1 ch) (track 1, id 80bd)
[12:37:58]      + bitrate: 384 kbps, samplerate: 48000 Hz
[12:37:58]    + mixdown: Dolby Pro Logic II
[12:37:58]    + dynamic range compression: 1.000000
[12:37:58]    + encoder: faac
[12:37:58]      + bitrate: 160 kbps, samplerate: 48000 Hz
[12:37:58]  * audio track 1
[12:37:58]    + decoder: Unknown (AC3) (5.1 ch) (track 1, id 80bd)
[12:37:58]      + bitrate: 384 kbps, samplerate: 48000 Hz
[12:37:58]    + AC3 passthrough
[12:37:58] dvd: not a dvd - trying as a stream/file instead
[12:37:58] reader: first SCR 0
[12:37:58] mpeg2: "" (1) at frame 0 time 9008
[12:37:58] Yadif Deinterlace thread started for segment 0
[12:37:58] Yadif Deinterlace thread started for segment 1
[12:37:58] encx264: keyint-min: 30, keyint-max: 300
[12:37:58] encx264: Encoding at constant RF 19.500000
x264 [info]: using cpu capabilities: MMX2 SSE2Fast SSSE3 PHADD SSE4.1 Cache64
x264 [info]: profile High, level 3.1
No accelerated IMDCT transform found
No accelerated IMDCT transform found
[12:37:58] sync: expecting 71438 video frames
[12:37:58] sync: first pts is 9008
[12:37:58] sync: adding 90 ms of silence to audio 0  start 8106, next 0
[12:37:58] sync: adding 90 ms of silence to audio 1  start 8106, next 0
[12:38:03] output track 0: ac3 in sync after skipping 10752 bytes
[12:38:03] output track 1: ac3 in sync after skipping 10752 bytes
[12:38:03] sync: adding 79 ms of silence to audio 0  start 346431, next 339306
[12:38:03] sync: adding 79 ms of silence to audio 1  start 346431, next 339306
[12:38:20] sync: video time didn't advance - dropped 4 frames (delta 111 ms, current 432432, next 434411, dur 1979)
[12:41:43] output track 0: ac3 in sync after skipping 6144 bytes
[12:41:43] output track 1: ac3 in sync after skipping 6144 bytes
[12:41:43] sync: adding 139 ms of silence to audio 0  start 3041783, next 3029226
[12:41:43] sync: adding 139 ms of silence to audio 1  start 3041783, next 3029226
[12:49:12] output track 1: ac3 in sync after skipping 10752 bytes
[12:49:12] sync: adding 267 ms of silence to audio 1  start 8479222, next 8455146
[12:49:12] output track 0: ac3 in sync after skipping 10752 bytes
[12:49:12] sync: adding 267 ms of silence to audio 0  start 8479222, next 8455146
[12:50:10] output track 1: ac3 in sync after skipping 12288 bytes
[12:50:10] output track 0: ac3 in sync after skipping 12288 bytes
[12:50:10] sync: adding 267 ms of silence to audio 0  start 9262581, next 9238506
[12:50:10] sync: adding 267 ms of silence to audio 1  start 9262581, next 9238506
[12:51:08] output track 0: ac3 in sync after skipping 1536 bytes
[12:51:08] output track 1: ac3 in sync after skipping 1536 bytes
[12:56:51] output track 1: ac3 in sync after skipping 9216 bytes
[12:56:51] output track 0: ac3 in sync after skipping 9216 bytes
[12:56:51] sync: adding 267 ms of silence to audio 0  start 13962739, next 13938666
[12:56:51] sync: adding 267 ms of silence to audio 1  start 13962739, next 13938666
[12:59:25] output track 0: ac3 in sync after skipping 10752 bytes
[12:59:25] output track 1: ac3 in sync after skipping 10752 bytes
[12:59:25] sync: adding 235 ms of silence to audio 0  start 15759858, next 15738666
[12:59:25] sync: adding 235 ms of silence to audio 1  start 15759858, next 15738666
[13:03:55] output track 0: ac3 in sync after skipping 6144 bytes
[13:03:55] output track 1: ac3 in sync after skipping 6144 bytes
[13:03:55] sync: adding 171 ms of silence to audio 0  start 18939376, next 18923946
[13:03:55] sync: adding 171 ms of silence to audio 1  start 18939376, next 18923946
[13:08:33] output track 0: ac3 in sync after skipping 1536 bytes
[13:08:33] output track 1: ac3 in sync after skipping 1536 bytes
[13:17:36] output track 1: ac3 in sync after skipping 3072 bytes
[13:17:36] output track 0: ac3 in sync after skipping 3072 bytes
[13:17:36] sync: adding 102 ms of silence to audio 0  start 29125447, next 29116266
[13:17:36] sync: adding 102 ms of silence to audio 1  start 29125447, next 29116266
[13:20:00] output track 0: ac3 in sync after skipping 1536 bytes
[13:20:00] output track 1: ac3 in sync after skipping 1536 bytes
[13:33:00] output track 1: ac3 in sync after skipping 10752 bytes
[13:33:00] output track 0: ac3 in sync after skipping 10752 bytes
[13:33:00] sync: adding 325 ms of silence to audio 0  start 39493442, next 39464106
[13:33:00] sync: adding 325 ms of silence to audio 1  start 39493442, next 39464106
[13:34:21] output track 1: ac3 in sync after skipping 6144 bytes
[13:34:21] output track 0: ac3 in sync after skipping 6144 bytes
[13:34:21] sync: adding 133 ms of silence to audio 0  start 40392001, next 40379946
[13:34:21] sync: adding 133 ms of silence to audio 1  start 40392001, next 40379946
[13:42:58] output track 1: ac3 in sync after skipping 4608 bytes
[13:42:58] output track 0: ac3 in sync after skipping 4608 bytes
[13:42:58] sync: adding 133 ms of silence to audio 1  start 46105921, next 46093866
[13:42:58] sync: adding 133 ms of silence to audio 0  start 46105921, next 46093866
[13:47:24] output track 1: ac3 in sync after skipping 3072 bytes
[13:47:24] output track 0: ac3 in sync after skipping 3072 bytes
[13:50:38] output track 1: ac3 in sync after skipping 4608 bytes
[13:50:38] output track 0: ac3 in sync after skipping 4608 bytes
[13:50:38] sync: adding 165 ms of silence to audio 0  start 51243841, next 51228906
[13:50:38] sync: adding 165 ms of silence to audio 1  start 51243841, next 51228906
[13:53:43] output track 1: ac3 in sync after skipping 12288 bytes
[13:53:43] output track 0: ac3 in sync after skipping 12288 bytes
[13:53:43] sync: adding 261 ms of silence to audio 0  start 53455681, next 53432106
[13:53:43] sync: adding 261 ms of silence to audio 1  start 53455681, next 53432106
[13:57:54] output track 0: ac3 in sync after skipping 1536 bytes
[13:57:54] output track 1: ac3 in sync after skipping 1536 bytes
[13:59:36] output track 1: ac3 in sync after skipping 9216 bytes
[13:59:36] output track 0: ac3 in sync after skipping 9216 bytes
[13:59:36] sync: adding 234 ms of silence to audio 0  start 57701193, next 57680106
[13:59:36] sync: adding 234 ms of silence to audio 1  start 57701193, next 57680106
[14:11:42] output track 1: ac3 in sync after skipping 6144 bytes
[14:11:42] output track 0: ac3 in sync after skipping 6144 bytes
[14:11:42] sync: adding 138 ms of silence to audio 0  start 66318152, next 66305706
[14:11:42] sync: adding 138 ms of silence to audio 1  start 66318152, next 66305706
[14:13:05] output track 0: ac3 in sync after skipping 7680 bytes
[14:13:05] output track 1: ac3 in sync after skipping 7680 bytes
[14:13:05] sync: adding 170 ms of silence to audio 0  start 67239751, next 67224426
[14:13:05] sync: adding 170 ms of silence to audio 1  start 67239751, next 67224426
[14:13:24] output track 1: ac3 in sync after skipping 1536 bytes
[14:13:24] output track 0: ac3 in sync after skipping 1536 bytes
[14:30:50] output track 1: ac3 in sync after skipping 1536 bytes
[14:30:50] sync: adding 106 ms of silence to audio 1  start 79335750, next 79326186
[14:30:50] output track 0: ac3 in sync after skipping 1536 bytes
[14:30:50] sync: adding 106 ms of silence to audio 0  start 79335750, next 79326186
[14:39:45] output track 1: ac3 in sync after skipping 10752 bytes
[14:39:45] output track 0: ac3 in sync after skipping 10752 bytes
[14:39:45] sync: adding 234 ms of silence to audio 1  start 85856070, next 85834986
[14:39:45] sync: adding 234 ms of silence to audio 0  start 85856070, next 85834986
[14:46:00] output track 0: ac3 in sync after skipping 9216 bytes
[14:46:00] output track 1: ac3 in sync after skipping 9216 bytes
[14:46:00] sync: adding 202 ms of silence to audio 0  start 90371910, next 90353706
[14:46:00] sync: adding 202 ms of silence to audio 1  start 90371910, next 90353706
[14:47:18] output track 0: ac3 in sync after skipping 12288 bytes
[14:47:18] output track 1: ac3 in sync after skipping 12288 bytes
[14:47:18] sync: adding 266 ms of silence to audio 0  start 91293510, next 91269546
[14:47:18] sync: adding 266 ms of silence to audio 1  start 91293510, next 91269546
[14:49:04] output track 1: ac3 in sync after skipping 10752 bytes
[14:49:04] output track 0: ac3 in sync after skipping 10752 bytes
[14:49:04] sync: adding 234 ms of silence to audio 1  start 92537670, next 92516586
[14:49:04] sync: adding 234 ms of silence to audio 0  start 92537670, next 92516586
[14:54:42] output track 1: ac3 in sync after skipping 9216 bytes
[14:54:42] sync: adding 202 ms of silence to audio 1  start 96592710, next 96574506
[14:54:42] output track 0: ac3 in sync after skipping 9216 bytes
[14:54:42] sync: adding 202 ms of silence to audio 0  start 96592710, next 96574506
[14:55:37] output track 1: ac3 in sync after skipping 12288 bytes
[14:55:37] output track 0: ac3 in sync after skipping 12288 bytes
[14:55:37] sync: adding 266 ms of silence to audio 0  start 97260870, next 97236906
[14:55:37] sync: adding 266 ms of silence to audio 1  start 97260870, next 97236906
[14:58:38] output track 0: ac3 in sync after skipping 10752 bytes
[14:58:38] sync: adding 266 ms of silence to audio 0  start 99403590, next 99379626
[14:58:38] output track 1: ac3 in sync after skipping 10752 bytes
[14:58:38] sync: adding 266 ms of silence to audio 1  start 99403590, next 99379626
[15:03:58] output track 0: ac3 in sync after skipping 10752 bytes
[15:03:58] output track 1: ac3 in sync after skipping 10752 bytes
[15:03:58] sync: adding 234 ms of silence to audio 0  start 103320390, next 103299306
[15:03:58] sync: adding 234 ms of silence to audio 1  start 103320390, next 103299306
[15:04:29] output track 0: ac3 in sync after skipping 10752 bytes
[15:04:29] output track 1: ac3 in sync after skipping 10752 bytes
[15:04:29] sync: adding 234 ms of silence to audio 1  start 103689030, next 103667946
[15:04:29] sync: adding 234 ms of silence to audio 0  start 103689030, next 103667946
[15:10:27] output track 0: ac3 in sync after skipping 7680 bytes
[15:10:27] output track 1: ac3 in sync after skipping 7680 bytes
[15:10:27] sync: adding 170 ms of silence to audio 0  start 107859270, next 107843946
[15:10:27] sync: adding 170 ms of silence to audio 1  start 107859270, next 107843946
[15:10:36] output track 1: ac3 in sync after skipping 3072 bytes
[15:10:36] output track 0: ac3 in sync after skipping 3072 bytes
[15:10:36] sync: adding 74 ms of silence to audio 0  start 107928390, next 107921706
[15:10:36] sync: adding 74 ms of silence to audio 1  start 107928390, next 107921706
[15:11:23] output track 1: ac3 in sync after skipping 12288 bytes
[15:11:23] sync: adding 266 ms of silence to audio 1  start 108481350, next 108457386
[15:11:23] output track 0: ac3 in sync after skipping 12288 bytes
[15:11:23] sync: adding 266 ms of silence to audio 0  start 108481350, next 108457386
[15:11:48] output track 0: ac3 in sync after skipping 12288 bytes
[15:11:48] output track 1: ac3 in sync after skipping 12288 bytes
[15:11:48] sync: adding 266 ms of silence to audio 0  start 108757830, next 108733866
[15:11:48] sync: adding 266 ms of silence to audio 1  start 108757830, next 108733866
[15:14:46] output track 1: ac3 in sync after skipping 6144 bytes
[15:14:46] sync: adding 166 ms of silence to audio 1  start 110978014, next 110962986
[15:14:46] output track 0: ac3 in sync after skipping 6144 bytes
[15:14:46] sync: adding 166 ms of silence to audio 0  start 110978014, next 110962986
[15:27:03] output track 0: ac3 in sync after skipping 6144 bytes
[15:27:03] output track 1: ac3 in sync after skipping 6144 bytes
[15:27:03] sync: adding 134 ms of silence to audio 0  start 120101853, next 120089706
[15:27:03] sync: adding 134 ms of silence to audio 1  start 120101853, next 120089706
[15:29:23] output track 0: ac3 in sync after skipping 10752 bytes
[15:29:23] sync: adding 262 ms of silence to audio 0  start 121622492, next 121598826
[15:29:23] output track 1: ac3 in sync after skipping 10752 bytes
[15:29:23] sync: adding 262 ms of silence to audio 1  start 121622492, next 121598826
[15:32:16] output track 0: ac3 in sync after skipping 9216 bytes
[15:32:16] sync: adding 230 ms of silence to audio 0  start 123580891, next 123560106
[15:32:16] output track 1: ac3 in sync after skipping 9216 bytes
[15:32:16] sync: adding 230 ms of silence to audio 1  start 123580891, next 123560106
[15:38:54] output track 1: ac3 in sync after skipping 1536 bytes
[15:38:54] sync: adding 70 ms of silence to audio 1  start 128050650, next 128044266
[15:38:54] output track 0: ac3 in sync after skipping 1536 bytes
[15:38:54] sync: adding 70 ms of silence to audio 0  start 128050650, next 128044266
[15:42:59] output track 0: ac3 in sync after skipping 7680 bytes
[15:42:59] output track 1: ac3 in sync after skipping 7680 bytes
[15:42:59] sync: adding 166 ms of silence to audio 0  start 130884570, next 130869546
[15:42:59] sync: adding 166 ms of silence to audio 1  start 130884570, next 130869546
[15:44:08] output track 1: ac3 in sync after skipping 7680 bytes
[15:44:08] output track 0: ac3 in sync after skipping 7680 bytes
[15:44:08] sync: adding 198 ms of silence to audio 1  start 131667930, next 131650026
[15:44:08] sync: adding 198 ms of silence to audio 0  start 131667930, next 131650026
[15:49:37] output track 0: ac3 in sync after skipping 7680 bytes
[15:49:37] output track 1: ac3 in sync after skipping 7680 bytes
[15:49:37] sync: adding 166 ms of silence to audio 1  start 135354330, next 135339306
[15:49:37] sync: adding 166 ms of silence to audio 0  start 135354330, next 135339306
[16:03:41] output track 0: ac3 in sync after skipping 10752 bytes
[16:03:41] sync: adding 230 ms of silence to audio 0  start 145445850, next 145425066
[16:03:41] output track 1: ac3 in sync after skipping 10752 bytes
[16:03:41] sync: adding 230 ms of silence to audio 1  start 145445850, next 145425066
[16:04:09] output track 1: ac3 in sync after skipping 7680 bytes
[16:04:09] output track 0: ac3 in sync after skipping 7680 bytes
[16:04:09] sync: adding 198 ms of silence to audio 0  start 145883610, next 145865706
[16:04:09] sync: adding 198 ms of silence to audio 1  start 145883610, next 145865706
[16:04:49] output track 0: ac3 in sync after skipping 9216 bytes
[16:04:49] sync: adding 198 ms of silence to audio 0  start 146344410, next 146326506
[16:04:49] output track 1: ac3 in sync after skipping 9216 bytes
[16:04:49] sync: adding 198 ms of silence to audio 1  start 146344410, next 146326506
[16:15:19] output track 0: ac3 in sync after skipping 9216 bytes
[16:15:19] sync: adding 230 ms of silence to audio 0  start 153509850, next 153489066
[16:15:19] output track 1: ac3 in sync after skipping 9216 bytes
[16:15:19] sync: adding 230 ms of silence to audio 1  start 153509850, next 153489066
[16:17:47] output track 0: ac3 in sync after skipping 1536 bytes
[16:17:47] output track 1: ac3 in sync after skipping 1536 bytes
[16:25:53] output track 1: ac3 in sync after skipping 12288 bytes
[16:25:53] sync: adding 273 ms of silence to audio 1  start 160324878, next 160300266
[16:25:53] output track 0: ac3 in sync after skipping 12288 bytes
[16:25:53] sync: audio 1 time went backwards 0 ms, dropped 1 frames (next 160326186, current 160326186)
[16:25:53] sync: adding 273 ms of silence to audio 0  start 160324878, next 160300266
[16:25:53] sync: audio 0 time went backwards 0 ms, dropped 1 frames (next 160326186, current 160326186)
[16:31:41] output track 1: ac3 in sync after skipping 7680 bytes
[16:31:41] output track 0: ac3 in sync after skipping 7680 bytes
[16:31:41] sync: adding 159 ms of silence to audio 0  start 164495117, next 164480718
[16:31:41] sync: adding 159 ms of silence to audio 1  start 164495117, next 164480718
[16:33:09] output track 0: ac3 in sync after skipping 10752 bytes
[16:33:09] output track 1: ac3 in sync after skipping 10752 bytes
[16:33:09] sync: adding 223 ms of silence to audio 0  start 165531916, next 165511757
[16:33:09] sync: adding 223 ms of silence to audio 1  start 165531916, next 165511757
[16:35:21] output track 0: ac3 in sync after skipping 9216 bytes
[16:35:21] output track 1: ac3 in sync after skipping 9216 bytes
[16:35:21] sync: adding 191 ms of silence to audio 0  start 167144715, next 167127436
[16:35:21] sync: adding 191 ms of silence to audio 1  start 167144715, next 167127436
[16:37:28] output track 0: ac3 in sync after skipping 6144 bytes
[16:37:28] output track 1: ac3 in sync after skipping 6144 bytes
[16:37:28] sync: adding 127 ms of silence to audio 0  start 168665354, next 168653835
[16:37:28] sync: adding 127 ms of silence to audio 1  start 168665354, next 168653835
[16:41:05] output track 0: ac3 in sync after skipping 9216 bytes
[16:41:05] output track 1: ac3 in sync after skipping 9216 bytes
[16:41:05] sync: adding 191 ms of silence to audio 0  start 171107593, next 171090314
[16:41:05] sync: adding 191 ms of silence to audio 1  start 171107593, next 171090314
[16:42:00] output track 0: ac3 in sync after skipping 6144 bytes
[16:42:00] output track 1: ac3 in sync after skipping 6144 bytes
[16:42:00] sync: adding 127 ms of silence to audio 0  start 171660552, next 171649033
[16:42:00] sync: adding 127 ms of silence to audio 1  start 171660552, next 171649033
[16:43:08] output track 1: ac3 in sync after skipping 10752 bytes
[16:43:08] output track 0: ac3 in sync after skipping 10752 bytes
[16:43:08] sync: adding 223 ms of silence to audio 0  start 172328711, next 172308552
[16:43:08] sync: adding 223 ms of silence to audio 1  start 172328711, next 172308552
[16:47:21] output track 0: ac3 in sync after skipping 6144 bytes
[16:47:21] output track 1: ac3 in sync after skipping 6144 bytes
[16:47:21] sync: adding 159 ms of silence to audio 0  start 175047430, next 175033031
[16:47:21] sync: adding 159 ms of silence to audio 1  start 175047430, next 175033031
[16:49:08] output track 1: ac3 in sync after skipping 7680 bytes
[16:49:08] sync: adding 191 ms of silence to audio 1  start 176222469, next 176205190
[16:49:08] output track 0: ac3 in sync after skipping 7680 bytes
[16:49:08] sync: adding 191 ms of silence to audio 0  start 176222469, next 176205190
[16:54:12] output track 1: ac3 in sync after skipping 9216 bytes
[16:54:12] sync: adding 192 ms of silence to audio 1  start 179632389, next 179615109
[16:54:12] output track 0: ac3 in sync after skipping 9216 bytes
[16:54:12] sync: adding 192 ms of silence to audio 0  start 179632389, next 179615109
[16:57:18] output track 1: ac3 in sync after skipping 1536 bytes
[16:57:18] output track 0: ac3 in sync after skipping 1536 bytes
[17:02:12] output track 1: ac3 in sync after skipping 6144 bytes
[17:02:12] output track 0: ac3 in sync after skipping 6144 bytes
[17:02:12] sync: adding 160 ms of silence to audio 0  start 185023749, next 185009349
[17:02:12] sync: adding 160 ms of silence to audio 1  start 185023749, next 185009349
[17:02:47] output track 1: ac3 in sync after skipping 6144 bytes
[17:02:47] output track 0: ac3 in sync after skipping 6144 bytes
[17:02:47] sync: adding 128 ms of silence to audio 0  start 185438469, next 185426949
[17:02:47] sync: adding 128 ms of silence to audio 1  start 185438469, next 185426949
[17:06:58] output track 0: ac3 in sync after skipping 6144 bytes
[17:06:58] output track 1: ac3 in sync after skipping 6144 bytes
[17:06:58] sync: adding 128 ms of silence to audio 0  start 188018949, next 188007429
[17:06:58] sync: adding 128 ms of silence to audio 1  start 188018949, next 188007429
[17:09:00] output track 1: ac3 in sync after skipping 10752 bytes
[17:09:00] output track 0: ac3 in sync after skipping 10752 bytes
[17:09:00] sync: adding 224 ms of silence to audio 0  start 189355269, next 189335109
[17:09:00] sync: adding 224 ms of silence to audio 1  start 189355269, next 189335109
[17:16:59] output track 0: ac3 in sync after skipping 4608 bytes
[17:16:59] sync: adding 95 ms of silence to audio 0  start 194581733, next 194573098
[17:16:59] output track 1: ac3 in sync after skipping 4608 bytes
[17:16:59] sync: adding 95 ms of silence to audio 1  start 194581733, next 194573098
[17:17:58] output track 1: ac3 in sync after skipping 10752 bytes
[17:17:58] sync: adding 223 ms of silence to audio 1  start 195203811, next 195183653
[17:17:58] output track 0: ac3 in sync after skipping 10752 bytes
[17:17:58] sync: adding 223 ms of silence to audio 0  start 195203811, next 195183653
[17:25:15] sync: adding 95 ms of silence to audio 0  start 200364768, next 200356130
[17:25:15] sync: adding 95 ms of silence to audio 1  start 200364768, next 200356130
[17:26:43] output track 0: ac3 in sync after skipping 3072 bytes
[17:26:43] output track 1: ac3 in sync after skipping 3072 bytes
[17:28:08] output track 0: ac3 in sync after skipping 10752 bytes
[17:28:08] output track 1: ac3 in sync after skipping 10752 bytes
[17:28:08] sync: adding 287 ms of silence to audio 0  start 202392286, next 202366368
[17:28:08] sync: adding 287 ms of silence to audio 1  start 202392286, next 202366368
[17:28:48] output track 0: ac3 in sync after skipping 3072 bytes
[17:28:48] output track 1: ac3 in sync after skipping 3072 bytes
[17:28:48] sync: adding 95 ms of silence to audio 0  start 202876125, next 202867486
[17:28:48] sync: adding 95 ms of silence to audio 1  start 202876125, next 202867486
[17:29:26] output track 1: ac3 in sync after skipping 10752 bytes
[17:29:26] output track 0: ac3 in sync after skipping 10752 bytes
[17:29:26] sync: adding 223 ms of silence to audio 0  start 203290844, next 203270685
[17:29:26] sync: adding 223 ms of silence to audio 1  start 203290844, next 203270685
[17:31:39] output track 1: ac3 in sync after skipping 4608 bytes
[17:31:39] output track 0: ac3 in sync after skipping 4608 bytes
[17:31:39] sync: adding 127 ms of silence to audio 0  start 204880603, next 204869084
[17:31:39] sync: adding 127 ms of silence to audio 1  start 204880603, next 204869084
[17:32:42] output track 1: ac3 in sync after skipping 1536 bytes
[17:32:42] output track 0: ac3 in sync after skipping 1536 bytes
[17:36:07] output track 0: ac3 in sync after skipping 10752 bytes
[17:36:07] output track 1: ac3 in sync after skipping 10752 bytes
[17:36:07] sync: adding 255 ms of silence to audio 0  start 207991001, next 207967963
[17:36:07] sync: adding 255 ms of silence to audio 1  start 207991001, next 207967963
[17:36:58] output track 1: ac3 in sync after skipping 7680 bytes
[17:36:58] output track 0: ac3 in sync after skipping 7680 bytes
[17:36:58] sync: adding 159 ms of silence to audio 0  start 208543960, next 208529561
[17:36:58] sync: adding 159 ms of silence to audio 1  start 208543960, next 208529561
[17:37:02] output track 1: ac3 in sync after skipping 7680 bytes
[17:37:02] output track 0: ac3 in sync after skipping 7680 bytes
[17:37:02] sync: adding 159 ms of silence to audio 0  start 208590039, next 208575640
[17:37:02] sync: adding 159 ms of silence to audio 1  start 208590039, next 208575640
[17:37:19] output track 0: ac3 in sync after skipping 6144 bytes
[17:37:19] output track 1: ac3 in sync after skipping 6144 bytes
[17:37:19] sync: adding 127 ms of silence to audio 0  start 208774358, next 208762839
[17:37:19] sync: adding 127 ms of silence to audio 1  start 208774358, next 208762839
[17:41:19] output track 1: ac3 in sync after skipping 3072 bytes
[17:41:19] output track 0: ac3 in sync after skipping 3072 bytes
[17:42:34] output track 1: ac3 in sync after skipping 1536 bytes
[17:42:34] output track 0: ac3 in sync after skipping 1536 bytes
[17:42:34] sync: adding 96 ms of silence to audio 0  start 212115158, next 212106518
[17:42:34] sync: adding 96 ms of silence to audio 1  start 212115158, next 212106518
[17:47:28] reader: done. 190 scr changes
[17:47:45] sync: got 71714 frames, 71438 expected
[17:47:45] work: average encoding speed for job is 3.858270 fps
[17:47:57] mpeg2 done: 71719 frames
[17:47:57] render: lost time: 42294240 (14084 frames)
[17:47:57] render: gained time: 42291987 (56307 frames) (2253 not accounted for)
[17:47:57] render: average dropped frame duration: 3002
x264 [info]: slice I:747   Avg QP:14.47  size: 72182  PSNR Mean Y:50.17 U:53.71 V:53.79 Avg:51.02 Global:50.29
x264 [info]: slice P:19693 Avg QP:16.44  size: 37314  PSNR Mean Y:48.21 U:51.92 V:52.14 Avg:48.96 Global:47.51
x264 [info]: slice B:37186 Avg QP:18.41  size: 15297  PSNR Mean Y:46.24 U:50.99 V:51.15 Avg:47.29 Global:46.33
x264 [info]: consecutive B-frames:  1.8% 22.8% 30.7% 44.7%
x264 [info]: mb I  I16..4:  7.3% 75.2% 17.4%
x264 [info]: mb P  I16..4:  2.8% 20.3%  3.3%  P16..4: 36.3% 22.4%  9.7%  0.3%  0.3%    skip: 4.6%
x264 [info]: mb B  I16..4:  0.4%  1.9%  0.3%  B16..8: 51.8%  2.9%  4.1%  direct:11.7%  skip:26.8%  L0:40.8% L1:50.4% BI: 8.8%
x264 [info]: 8x8 transform  intra:76.1%  inter:58.1%
x264 [info]: direct mvs  spatial:100.0%  temporal:0.0%
x264 [info]: ref P L0  72.7% 13.8%  8.6%  4.9%
x264 [info]: ref B L0  84.9%  9.6%  5.5%
x264 [info]: SSIM Mean Y:0.9862068
x264 [info]: PSNR Mean Y:46.967 U:51.344 V:51.525 Avg:47.907 Global:46.732 kb/s:5648.41
[17:47:57] deca52: 74357 frames decoded, 21 crc errors, 583680 bytes dropped
[17:47:58] deca52: 74357 frames decoded, 21 crc errors, 583680 bytes dropped
[17:47:58] libhb: work result = 0
The encoded output is, overall, just fine. But there are a couple occurrences of encode frames with terrible pixellation and/or frames being out of order from the source. Examples below of the original frame and encoded frame.

Frame 1: Things look fine
Image
Image

Frame 2: Some ghosty artifacts appear
Image
Image

Frame 3: Really bad artifacting around the areas in motion in the frame. Notice the lady in the background appears to have not moved forward compared to the source frame.
Image
Image

Re: [SVN2165] HB or x264 problem with badly encoded frames?

Posted: Sun Feb 22, 2009 3:58 pm
by jbrjake
Ruling out StreamClip is definitely where to start...

Re: [SVN2165] HB or x264 problem with badly encoded frames?

Posted: Sun Feb 22, 2009 9:06 pm
by belloq
jbrjake wrote:Ruling out StreamClip is definitely where to start...
Would avidemux be your suggesting on Mac?

I am going to first try doing a capture from the DVR again at that point in the program and do not editing to it at all and feed the m2t file directly to Handbrake to see what happens.

Re: [SVN2165] HB or x264 problem with badly encoded frames?

Posted: Mon Feb 23, 2009 12:17 am
by belloq
The artifacts are not there in a re-encode of the same file but with different settings (both CQ and ABR). When I figure out what the culprit is, and I'm thinking it's one of the advanced settings and that should have been the only difference, I'll get back on this thread.

FYI: IMO, avidemux is a POC. The interface looks like something a kindergartner drew with odd icons a layout that is less than intuitive, the controls are totally non-standard for marking clips compared to any A/V editor I've used, and it can't even synchronize audio and video. That last one is a total deal breaker.

Re: [SVN2165] HB or x264 problem with badly encoded frames?

Posted: Mon Feb 23, 2009 12:23 am
by TedJ
Sorry to hear that avidemux wasn't suitable for you, but in my experience it's successfully edited clips that streamclip has totally borked. I'll admit that the interface is a little baroque (not surprising for a long-standing linux app), but once you get used to [=I and ]=O it's not that hard.

Unfortunately, it is one of those apps where you have to read the docs/wiki.

Re: [SVN2165] HB or x264 problem with badly encoded frames?

Posted: Wed Apr 08, 2009 10:55 pm
by Deleted User 11865
I've experienced similar artifacts with one of my test encodes. I've noticed references to deca52 in the log of such encodes, just like in your log:

Code: Select all

[17:47:57] deca52: 74357 frames decoded, 21 crc errors, 583680 bytes dropped
[17:47:58] deca52: 74357 frames decoded, 21 crc errors, 583680 bytes dropped
I've narrowed it down to revision 2018. My test file, when encoded with revision 2017, doesn't have artifacts or references to deca52 in the log. The same file, encoded using the same settings with revision 2018, has artifacts similar to what your picture shows, and a reference to deca52 in the encode log.

Note that I've also tested several other revisions, and that revisions after 2018 shows the artifacts and log messages; similarly, revisions before 2017 don't have artifacts or log messages.

Re: [SVN2165] HB or x264 problem with badly encoded frames?

Posted: Wed Apr 08, 2009 11:20 pm
by belloq
Cool. Thanks, Rodeo, for taking some time to research this.