Slow encoding...why?

[showngo2000]

After updating to 1.1.0, encoding has been tragically slow. For example, on a 1.5hr movie, encoding is taking about 2+ hrs. I've tried on several different movies and all of them are terribly slow...usually slower than real-time watching would even be. Before I updated, I was using 1.0.0 and everything was super fast and working great. I'm trying to output files for an Apple TV.

Using Handbrake 1.1.0 on Mac 10.13.4

https://pastebin.com/embed_js/PZ8Xj9kj
Thanks for the help!

[s55]

Can you please encode 1 chapter and post the log of the completed encode.

[showngo2000]

https://pastebin.com/embed_js/BYbDDUj4


This one went for a long time...is this what you need?

[rollin_eng]

Do you have a log from a “fast” encode?

[Woodstock]

Were you using Foreign audio scan for subtitles in the previous version? It's part of the subtitle selection rules, and turned on by default in a lot of stock presets.

Using FAS causes an extra pass through the video before encoding starts, which will affect how long the encode takes. If you're not using the subtitles, you may want to disable that, at least as a test.

[showngo2000]

I disabled the FAS and nothing seemed to change. This one was on "very fast"

Code: Select all

 
 HandBrake Activity Log for Session: 2018-04-14 20:07:21 -0500
Handbrake Version: 1.1.0 (2018040700)
THE_BIG_SLEEP.m4v
Preset: Very Fast 1080p30 (Modified)
[20:07:21] macgui: QueueCore scanning specifically for title: 1
[20:07:21] CPU: Intel(R) Core(TM) i7-6700HQ CPU @ 2.60GHz
[20:07:21]  - Intel microarchitecture Skylake
[20:07:21]  - logical processor count: 8
[20:07:21] hb_scan: path=/Volumes/THE_BIG_SLEEP, title_index=1
disc.c:424: error opening file BDMV/index.bdmv
disc.c:424: error opening file BDMV/BACKUP/index.bdmv
[20:07:21] bd: not a bd - trying as a stream/file instead
libdvdread: Attempting to use device /dev/rdisk3 mounted on /Volumes/THE_BIG_SLEEP for CSS authentication
[20:07:23] scan: DVD has 5 title(s)
[20:07:23] scan: scanning title 1
[20:07:23] scan: opening IFO for VTS 1
[20:07:24] pgc_id: 1, pgn: 1: pgc: 0x7fd7f7c74ca0
[20:07:24] scan: vts=1, ttn=1, cells=0->31, blocks=0->1841185, 1841186 blocks
[20:07:24] scan: duration is 01:53:51 (6831100 ms)
[20:07:24] scan: checking audio 1
[20:07:24] scan: id=0x80bd, lang=English (AC3), 3cc=eng ext=0
[20:07:24] scan: checking audio 2
[20:07:24] scan: audio channel is not active
[20:07:24] scan: checking audio 3
[20:07:24] scan: audio channel is not active
[20:07:24] scan: checking subtitle 1
[20:07:24] scan: id=0x20bd, lang=English (4:3) [VOBSUB], 3cc=eng ext=0
[20:07:24] scan: checking subtitle 2
[20:07:24] scan: id=0x21bd, lang=Francais (4:3) [VOBSUB], 3cc=fra ext=0
[20:07:24] scan: title 1 has 32 chapters
[20:07:24] scan: chap 1 c=0->0, b=0->17064 (17065), 60367 ms
[20:07:24] scan: chap 2 c=1->1, b=17065->47356 (30292), 103500 ms
[20:07:24] scan: chap 3 c=2->2, b=47357->165761 (118405), 378834 ms
[20:07:24] scan: chap 4 c=3->3, b=165762->237243 (71482), 244667 ms
[20:07:24] scan: chap 5 c=4->4, b=237244->273858 (36615), 120834 ms
[20:07:24] scan: chap 6 c=5->5, b=273859->332236 (58378), 221533 ms
[20:07:24] scan: chap 7 c=6->6, b=332237->417951 (85715), 340967 ms
[20:07:24] scan: chap 8 c=7->7, b=417952->460620 (42669), 168000 ms
[20:07:24] scan: chap 9 c=8->8, b=460621->482545 (21925), 88500 ms
[20:07:24] scan: chap 10 c=9->9, b=482546->534336 (51791), 203500 ms
[20:07:24] scan: chap 11 c=10->10, b=534337->650990 (116654), 335000 ms
[20:07:24] scan: chap 12 c=11->11, b=650991->728759 (77769), 251533 ms
[20:07:24] scan: chap 13 c=12->12, b=728760->799308 (70549), 258133 ms
[20:07:24] scan: chap 14 c=13->13, b=799309->908075 (108767), 408667 ms
[20:07:24] scan: chap 15 c=14->14, b=908076->972438 (64363), 230367 ms
[20:07:24] scan: chap 16 c=15->15, b=972439->1030563 (58125), 236300 ms
[20:07:24] scan: chap 17 c=16->16, b=1030564->1117704 (87141), 304000 ms
[20:07:24] scan: chap 18 c=17->17, b=1117705->1189916 (72212), 281667 ms
[20:07:24] scan: chap 19 c=18->18, b=1189917->1220527 (30611), 116834 ms
[20:07:24] scan: chap 20 c=19->19, b=1220528->1256068 (35541), 141500 ms
[20:07:24] scan: chap 21 c=20->20, b=1256069->1287993 (31925), 126667 ms
[20:07:24] scan: chap 22 c=21->21, b=1287994->1308341 (20348), 83166 ms
[20:07:24] scan: chap 23 c=22->22, b=1308342->1402405 (94064), 362500 ms
[20:07:24] scan: chap 24 c=23->23, b=1402406->1445296 (42891), 149667 ms
[20:07:24] scan: chap 25 c=24->24, b=1445297->1525327 (80031), 314834 ms
[20:07:24] scan: chap 26 c=25->25, b=1525328->1545038 (19711), 82166 ms
[20:07:24] scan: chap 27 c=26->26, b=1545039->1588144 (43106), 178333 ms
[20:07:24] scan: chap 28 c=27->27, b=1588145->1645503 (57359), 228333 ms
[20:07:24] scan: chap 29 c=28->28, b=1645504->1699250 (53747), 214333 ms
[20:07:24] scan: chap 30 c=29->29, b=1699251->1748997 (49747), 206667 ms
[20:07:24] scan: chap 31 c=30->30, b=1748998->1812025 (63028), 262367 ms
[20:07:24] scan: chap 32 c=31->31, b=1812026->1841185 (29160), 127367 ms
[20:07:24] scan: aspect = 4:3
[20:07:24] scan: decoding previews for title 1

libdvdread: Attempting to retrieve all CSS keys
libdvdread: This can take a _long_ time, please be patient

libdvdread: Get key for /VIDEO_TS/VTS_01_0.VOB at 0x00000153
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_01_1.VOB at 0x0000067d
libdvdread: Elapsed time 0
libdvdread: Found 1 VTS's
libdvdread: Elapsed time 0
[20:07:24] scan: title angle(s) 1
[ac3 @ 0x7fd7f29e8c00] frame sync error
[20:07:24] scan: audio 0x80bd: ac3, rate=48000Hz, bitrate=192000 English (AC3) (2.0 ch)
[20:07:30] scan: 10 previews, 720x480, 23.976 fps, autocrop = 0/0/0/0, aspect 4:3, PAR 8:9
[20:07:31] libhb: scan thread found 1 valid title(s)
[20:07:31] macgui: QueueCore scan done
[20:07:31] macgui: QueueCore started encoding THE_BIG_SLEEP.m4v
[20:07:31] macgui: QueueCore with preset Very Fast 1080p30 (Modified)
[20:07:31] 1 job(s) to process
[20:07:31] starting job
[20:07:31] decomb filter thread started for segment 1
[20:07:31] decomb filter thread started for segment 0
[20:07:31] decomb filter thread started for segment 2
[20:07:31] decomb filter thread started for segment 3
[20:07:31] decomb filter thread started for segment 4
[20:07:31] decomb filter thread started for segment 5
[20:07:31] decomb filter thread started for segment 6
[20:07:31] decomb filter thread started for segment 7
[20:07:31] decomb check thread started for segment 0
[20:07:31] decomb check thread started for segment 1
[20:07:31] decomb check thread started for segment 2
[20:07:31] decomb check thread started for segment 4
[20:07:31] decomb check thread started for segment 3
[20:07:31] decomb check thread started for segment 5
[20:07:31] decomb check thread started for segment 6
[20:07:31] decomb check thread started for segment 7
[20:07:31] yadif thread started for segment 0
[20:07:31] yadif thread started for segment 1
[20:07:31] yadif thread started for segment 2
[20:07:31] yadif thread started for segment 3
[20:07:31] yadif thread started for segment 4
[20:07:31] yadif thread started for segment 5
[20:07:31] yadif thread started for segment 6
[20:07:31] yadif thread started for segment 7
[20:07:31] job configuration:
[20:07:31]  * source
[20:07:31]    + /Volumes/THE_BIG_SLEEP
[20:07:31]    + title 1, chapter(s) 1 to 32
[20:07:31]  * destination
[20:07:31]    + /Users/Mike/Desktop/THE_BIG_SLEEP.m4v
[20:07:31]    + container: MPEG-4 (libavformat)
[20:07:31]      + align initial A/V stream timestamps
[20:07:31]      + chapter markers
[20:07:31]  * video track
[20:07:31]    + decoder: mpeg2video
[20:07:31]      + bitrate 7500 kbps
[20:07:31]    + filters
[20:07:31]      + Comb Detect (mode=0:spatial-metric=2:motion-thresh=2:spatial-thresh=3:filter-mode=1:block-thresh=80:block-width=16:block-height=16)
[20:07:31]      + Decomb (mode=39)
[20:07:31]      + Framerate Shaper (mode=2:rate=27000000/900000)
[20:07:31]        + frame rate: 23.976 fps -> peak rate limited to 30.000 fps
[20:07:31]      + Crop and Scale (width=720:height=480:crop-top=0:crop-bottom=0:crop-left=0:crop-right=0)
[20:07:31]        + source: 720 * 480, crop (0/0/0/0): 720 * 480, scale: 720 * 480
[20:07:31]    + Output geometry
[20:07:31]      + storage dimensions: 720 x 480
[20:07:31]      + pixel aspect ratio: 8 : 9
[20:07:31]      + display dimensions: 640 x 480
[20:07:31]  * Foreign Audio Search: Render/Burn-in, Forced Only
[20:07:31]    + subtitle, English (4:3) [VOBSUB] (track 0, id 0x20bd, Picture)
libdvdread: Attempting to use device /dev/rdisk3 mounted on /Volumes/THE_BIG_SLEEP for CSS authentication

libdvdread: Attempting to retrieve all CSS keys
libdvdread: This can take a _long_ time, please be patient

libdvdread: Get key for /VIDEO_TS/VTS_01_0.VOB at 0x00000153
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_01_1.VOB at 0x0000067d
libdvdread: Elapsed time 0
libdvdread: Found 1 VTS's
libdvdread: Elapsed time 0
[20:07:31] sync: expecting 163782 video frames
[22:15:12] reader: done. 1 scr changes
[22:15:12] work: average encoding speed for job is 0.000000 fps
[22:15:12] comb detect: heavy 0 | light 0 | uncombed 0 | total 0
[22:15:12] decomb: deinterlaced 0 | blended 0 | unfiltered 0 | total 0
[22:15:12] vfr: 0 frames output, 0 dropped and 0 duped for CFR/PFR
[22:15:12] vfr: lost time: 0 (0 frames)
[22:15:12] vfr: gained time: 0 (0 frames) (0 not accounted for)
[22:15:12] sync: got 0 frames, 163782 expected
[22:15:12] Subtitle track 0 (id 0x20bd) 'English (4:3) [VOBSUB]': 1674 hits (0 forced)
[22:15:12] No candidate detected during subtitle scan
[22:15:12] starting job
[22:15:12] decomb filter thread started for segment 1
[22:15:12] decomb filter thread started for segment 0
[22:15:12] decomb filter thread started for segment 2
[22:15:12] decomb filter thread started for segment 3
[22:15:12] decomb filter thread started for segment 4
[22:15:12] decomb filter thread started for segment 5
[22:15:12] decomb filter thread started for segment 6
[22:15:12] decomb filter thread started for segment 7
[22:15:12] decomb check thread started for segment 0
[22:15:12] decomb check thread started for segment 1
[22:15:12] decomb check thread started for segment 2
[22:15:12] decomb check thread started for segment 3
[22:15:12] decomb check thread started for segment 4
[22:15:12] decomb check thread started for segment 5
[22:15:12] decomb check thread started for segment 6
[22:15:12] decomb check thread started for segment 7
[22:15:12] yadif thread started for segment 0
[22:15:12] yadif thread started for segment 1
[22:15:12] yadif thread started for segment 2
[22:15:12] yadif thread started for segment 3
[22:15:12] yadif thread started for segment 4
[22:15:12] yadif thread started for segment 5
[22:15:12] yadif thread started for segment 6
[22:15:12] yadif thread started for segment 7
[22:15:12] job configuration:
[22:15:12]  * source
[22:15:12]    + /Volumes/THE_BIG_SLEEP
[22:15:12]    + title 1, chapter(s) 1 to 32
[22:15:12]  * destination
[22:15:12]    + /Users/Mike/Desktop/THE_BIG_SLEEP.m4v
[22:15:12]    + container: MPEG-4 (libavformat)
[22:15:12]      + align initial A/V stream timestamps
[22:15:12]      + chapter markers
[22:15:12]  * video track
[22:15:12]    + decoder: mpeg2video
[22:15:12]      + bitrate 7500 kbps
[22:15:12]    + filters
[22:15:12]      + Comb Detect (mode=0:spatial-metric=2:motion-thresh=2:spatial-thresh=3:filter-mode=1:block-thresh=80:block-width=16:block-height=16)
[22:15:12]      + Decomb (mode=39)
[22:15:12]      + Framerate Shaper (mode=2:rate=27000000/900000)
[22:15:12]        + frame rate: 23.976 fps -> peak rate limited to 30.000 fps
[22:15:12]      + Crop and Scale (width=720:height=480:crop-top=0:crop-bottom=0:crop-left=0:crop-right=0)
[22:15:12]        + source: 720 * 480, crop (0/0/0/0): 720 * 480, scale: 720 * 480
[22:15:12]    + Output geometry
[22:15:12]      + storage dimensions: 720 x 480
[22:15:12]      + pixel aspect ratio: 8 : 9
[22:15:12]      + display dimensions: 640 x 480
[22:15:12]    + encoder: H.264 (libx264)
[22:15:12]      + preset:  veryfast
[22:15:12]      + tune:    fastdecode
[22:15:12]      + profile: main
[22:15:12]      + level:   4.0
[22:15:12]      + quality: 24.00 (RF)
[22:15:12]  * audio track 1
[22:15:12]    + decoder: English (AC3) (2.0 ch) (track 1, id 0x80bd)
[22:15:12]      + bitrate: 192 kbps, samplerate: 48000 Hz
[22:15:12]    + mixdown: Stereo
[22:15:12]    + encoder: AAC (Apple AudioToolbox)
[22:15:12]      + bitrate: 160 kbps, samplerate: 48000 Hz
libdvdread: Attempting to use device /dev/rdisk3 mounted on /Volumes/THE_BIG_SLEEP for CSS authentication

libdvdread: Attempting to retrieve all CSS keys
libdvdread: This can take a _long_ time, please be patient

libdvdread: Get key for /VIDEO_TS/VTS_01_0.VOB at 0x00000153
libdvdread: Elapsed time 0
libdvdread: Get key for /VIDEO_TS/VTS_01_1.VOB at 0x0000067d
libdvdread: Elapsed time 0
libdvdread: Found 1 VTS's
libdvdread: Elapsed time 0
[22:15:12] sync: expecting 163782 video frames
[22:15:12] encx264: min-keyint: 24, keyint: 240
[22:15:12] encx264: encoding at constant RF 24.000000
[22:15:12] encx264: unparsed options: level=4.0:ref=1:weightb=0:no-deblock=1:cabac=0:8x8dct=0:weightp=0:subme=2:mixed-refs=0:trellis=0:vbv-bufsize=25000:vbv-maxrate=20000:rc-lookahead=10
x264 [info]: using SAR=8/9
x264 [info]: using cpu capabilities: MMX2 SSE2Fast SSSE3 SSE4.2 AVX FMA3 BMI2 AVX2
x264 [info]: profile Main, level 4.0
[22:15:13] sync: first pts video is 0
[22:15:13] sync: first pts audio 0x80bd is 0
[22:15:13] sync: "Chapter 1" (1) at frame 3 time 7507
[22:16:27] sync: "Chapter 2" (2) at frame 1452 time 5446691
[22:18:36] sync: "Chapter 3" (3) at frame 3936 time 14771006

 

[rollin_eng]

You still have FAS turned on.

If you really want to speed up your encode try ripping with makemkv first then encode with HB.