QSV encoding is very agressive

Ricou73-fr · Post by **Ricou73-fr** » Sat Dec 14, 2013 8:00 am

Hello , i have a little problem (i suppose since latest VLC upgrade to 2.1.2 but i dont know if some DLL is shared between VLc and handbrake).
I install the latest nuighty build 5927
Problem, before VLC upgrade encoding with QSV is very fine and run about 140 fps, but know if i try to encode a file encoding speed raise to 400fps and thermal dissipation on processor is to high i can't run it to the end. Strange thing is the end seem never happend progress bar is at 100% but process still running and temperature still raise on processor.
I try to roll back to nighty build 5879 but problem is still present (i suppose if a dll is newer on the system than in the installer dll still to the higest version?).
Any idea to help diagnose the trouble?

Post by **s55** » Sat Dec 14, 2013 10:39 am

QSV is very low power compared to normal encoding, so can't cause the same tempeature spikes you'd get if your CPU was running at 100% with x264. So my guess is your not using quicksync but we can't tell since you didn't post logs.

Also, if your CPU is overheating, that's a hardware problem, not a software one. Check your fans are clean, no dust build up and are all running correctly.

Ricou73-fr · Post by **Ricou73-fr** » Sat Dec 14, 2013 11:04 am

I agree with you, it's an hardware trouble. but the change start with software update.
Previously (last week) encoding rate is around 140fps, now it raise to 400fps.
I have underclocked my CPU and GPU (by bios), if a post can help, here is a complete encoding post.
I have monitored during encoding process, all CPU goes to 100% all encoding time, even by using QSV.
I have see that estimated time of encoding become negative and progress bar is 100% few minute before the end of real encoding.
Please note that i have also transcoding sound from dts to stereo on this video, perhap it is the origine of cpu activity ?

Code: Select all

HandBrake svn5879 (Nightly Build) - 64bit Version
OS: Microsoft Windows NT 6.1.7601 Service Pack 1
CPU: Intel(R) Core(TM) i5-3570K CPU @ 3.40GHz
Ram: 16260 MB, 
GPU Information:
  Intel(R) HD Graphics 4000 - 9.18.10.3257
  AMD Radeon HD 7800 Series - 13.152.0.0
Screen: 1280x1024
Temp Dir: f:\Temp\
Install Dir: F:\Program Files\Handbrake
Data Dir: C:\Users\Ricou\AppData\Roaming\HandBrake\HandBrake\0.0.0.5879

-------------------------------------------

CLI Query:  -i "F:\DVR\Matin Noel 2006.mkv" -t 1 --angle 1 -c 1-20 -o "F:\DVR\Matin Noel 2006-1.mp4"  -f mp4  -w 1200 --crop 0:0:0:2 --loose-anamorphic  --modulus 2 -e qsv_h264 -q 20 --cfr -a 1 -E av_aac -6 stereo -R Auto -B 160 -D 0 --gain 0 --audio-fallback ac3 --markers="f:\Temp\Matin Noel 2006-1-1-chapters.csv" --h264-level="4.0"  --h264-profile=main  -x target-usage=2:async-depth=4 --verbose=1 --disable-qsv-decoding
User Query: False

[11:20:56] CPU: Intel(R) Core(TM) i5-3570K CPU @ 3.40GHz
[11:20:56]  - Intel microarchitecture Ivy Bridge
[11:20:56]  - logical processor count: 4
[11:20:56] OpenCL device #1: Advanced Micro Devices, Inc. Pitcairn
[11:20:56]  - OpenCL version: 1.2 AMD-APP (1268.1)
[11:20:56]  - driver version: 1268.1 (VM)
[11:20:56]  - device type: GPU
[11:20:56]  - supported: yes
[11:20:56] Intel Quick Sync Video support: yes
[11:20:56]  - Intel Media SDK hardware: API 1.7 (minimum: 1.3)
[11:20:56]  - Preferred implementation: hardware (any)
[11:20:56] hb_scan: path=F:\DVR\Matin Noel 2006.mkv, title_index=1
libbluray/bdnav/index_parse.c:162: indx_parse(): error opening F:\DVR\Matin Noel 2006.mkv/BDMV/index.bdmv
libbluray/bdnav/index_parse.c:162: indx_parse(): error opening F:\DVR\Matin Noel 2006.mkv/BDMV/BACKUP/index.bdmv
libbluray/bluray.c:1725: nav_get_title_list(F:\DVR\Matin Noel 2006.mkv) failed (000000002cdce620)
[11:20:56] bd: not a bd - trying as a stream/file instead
libdvdnav: Using dvdnav version 4.1.3
libdvdread: Encrypted DVD support unavailable.
libdvdnav:DVDOpenFileUDF:UDFFindFile /VIDEO_TS/VIDEO_TS.IFO failed
libdvdnav:DVDOpenFileUDF:UDFFindFile /VIDEO_TS/VIDEO_TS.BUP failed
libdvdread: Can't open file VIDEO_TS.IFO.
libdvdnav: vm: failed to read VIDEO_TS.IFO
[11:20:56] dvd: not a dvd - trying as a stream/file instead
Input #0, matroska,webm, from 'F:\DVR\Matin Noel 2006.mkv':
  Duration: 01:18:27.74, start: 0.000000, bitrate: N/A
    Chapter #0.0: start 0.000000, end 226.560000
    Metadata:
      title           : 00:00:00.000
    Chapter #0.1: start 226.560000, end 434.893000
    Metadata:
      title           : 00:03:46.560
    Chapter #0.2: start 434.893000, end 735.360000
    Metadata:
      title           : 00:07:14.893
    Chapter #0.3: start 735.360000, end 1010.551000
    Metadata:
      title           : 00:12:15.360
    Chapter #0.4: start 1010.551000, end 1313.646000
    Metadata:
      title           : 00:16:50.551
    Chapter #0.5: start 1313.646000, end 1573.489000
    Metadata:
      title           : 00:21:53.646
    Chapter #0.6: start 1573.489000, end 1947.737000
    Metadata:
      title           : 00:26:13.489
    Chapter #0.7: start 1947.737000, end 2126.416000
    Metadata:
      title           : 00:32:27.737
    Chapter #0.8: start 2126.416000, end 2294.125000
    Metadata:
      title           : 00:35:26.416
    Chapter #0.9: start 2294.125000, end 2534.157000
    Metadata:
      title           : 00:38:14.125
    Chapter #0.10: start 2534.157000, end 2881.462000
    Metadata:
      title           : 00:42:14.157
    Chapter #0.11: start 2881.462000, end 2943.566000
    Metadata:
      title           : 00:48:01.462
    Chapter #0.12: start 2943.566000, end 3336.667000
    Metadata:
      title           : 00:49:03.566
    Chapter #0.13: start 3336.667000, end 3488.318000
    Metadata:
      title           : 00:55:36.667
    Chapter #0.14: start 3488.318000, end 3749.287000
    Metadata:
      title           : 00:58:08.318
    Chapter #0.15: start 3749.287000, end 3985.732000
    Metadata:
      title           : 01:02:29.287
    Chapter #0.16: start 3985.732000, end 4205.410000
    Metadata:
      title           : 01:06:25.732
    Chapter #0.17: start 4205.410000, end 4354.100000
    Metadata:
      title           : 01:10:05.410
    Chapter #0.18: start 4354.100000, end 4526.731000
    Metadata:
      title           : 01:12:34.100
    Chapter #0.19: start 4526.731000, end 4707.744000
    Metadata:
      title           : 01:15:26.731
    Stream #0.0(eng): Video: h264 (High), yuv420p, 1200x720, PAR 1:1 DAR 5:3, 23.98 fps, 23.98 tbr, 1k tbn, 47.95 tbc (default)
    Stream #0.1(fre): Audio: dca (DTS), 48000 Hz, 5.1, fltp, 1536 kb/s (default)
    Metadata:
      title           : French DTS 1509 kbps
    Stream #0.2(fre): Subtitle: [0][0][0][0] / 0x0000 (default) (forced)
    Metadata:
      title           : French_forced
    Stream #0.3(fre): Subtitle: [0][0][0][0] / 0x0000
    Metadata:
      title           : French_Songs
    Stream #0.4(fre): Subtitle: [0][0][0][0] / 0x0000
    Metadata:
      title           : French
[11:20:56] scan: decoding previews for title 1
[11:20:56] scan: audio 0x1: dca, rate=48000Hz, bitrate=1536000 Francais (DTS) (5.1 ch)
[11:20:56] scan: 1 previews, 1200x720, 11.988 fps, autocrop = 0/0/0/0, aspect 1.67:1, PAR 1:1
[11:20:56] Title is likely interlaced or telecined (0 out of 1 previews). You should do something about that.
[11:20:57] libhb: scan thread found 1 valid title(s)
[11:20:57] 1 job(s) to process
[11:20:57] starting job
[11:20:57] sync: expecting 56436 video frames
[11:20:57] job configuration:
[11:20:57]  * source
[11:20:57]    + F:\DVR\Matin Noel 2006.mkv
[11:20:57]    + title 1, chapter(s) 1 to 20
[11:20:57]    + container: matroska,webm
[11:20:57]  * destination
[11:20:57]    + F:\DVR\Matin Noel 2006-1.mp4
[11:20:57]    + container: MPEG-4 (avformat)
[11:20:57]      + chapter markers
[11:20:57]  * video track
[11:20:57]    + decoder: h264
[11:20:57]    + filters
[11:20:57]      + Framerate Shaper (1:27000000:2252250)
[11:20:57]        + frame rate: 11.988 fps -> constant 11.988 fps
[11:20:57]      + Crop and Scale (1200:720:0:0:0:2)
[11:20:57]        + source: 1200 * 720, crop (0/0/0/2): 1198 * 720, scale: 1200 * 720
[11:20:57]    + loose anamorphic
[11:20:57]      + storage dimensions: 1200 * 720, mod 2
[11:20:57]      + pixel aspect ratio: 599 / 600
[11:20:57]      + display dimensions: 1198 * 720
[11:20:57]    + encoder: H.264 (Intel QSV)
[11:20:57]      + options: async-depth=4
[11:20:57]      + h264 profile: main
[11:20:57]      + h264 level: 4.0
[11:20:57]      + quality: 20.00 (QP)
[11:20:57]  * audio track 1
[11:20:57]    + decoder: Francais (DTS) (5.1 ch) (track 2, id 0x1)
[11:20:57]      + bitrate: 1536 kbps, samplerate: 48000 Hz
[11:20:57]    + mixdown: Stereo
[11:20:57]    + encoder: AAC (avcodec)
[11:20:57]      + bitrate: 160 kbps, samplerate: 48000 Hz
[11:20:57] reader: first SCR 0 id 0x0 DTS 0
[11:20:57] encqsvInit: hb_qsv_param_parse: bad key async-depth
[11:20:57] encqsvInit: using encode-only path
[11:20:57] encqsvInit: TargetUsage 2 AsyncDepth 4
[11:20:57] encqsvInit: GopRefDist 3 GopPicSize 32 NumRefFrame 2
[11:20:57] encqsvInit: BFrames on BPyramid off
[11:20:57] encqsvInit: RateControlMethod CQP with QPI 20 QPP 22 QPB 24
[11:20:57] encqsvInit: CAVLC off
[11:20:57] encqsvInit: H.264 profile Main @ level 4.0
[11:20:57] qsv_enc_init: using 'hardware (1)' implementation, API: 1.7
[11:21:11] h264: "Chapter 2" (2) at frame 5440 time 20390400
[11:21:11] encqsvWork: got chapter 2 before we could write chapter 2, dropping marker
[11:21:25] h264: "Chapter 3" (3) at frame 10435 time 39140370
[11:21:45] h264: "Chapter 4" (4) at frame 17640 time 66186180
[11:21:45] encqsvWork: got chapter 4 before we could write chapter 4, dropping marker
[11:22:02] h264: "Chapter 5" (5) at frame 24237 time 90949590
[11:22:22] h264: "Chapter 6" (6) at frame 31506 time 118235610
[11:22:39] h264: "Chapter 7" (7) at frame 37735 time 141617700
[11:23:03] h264: "Chapter 8" (8) at frame 46707 time 175296420
[11:23:16] h264: "Chapter 9" (9) at frame 50991 time 191377440
[11:23:27] h264: "Chapter 10" (10) at frame 55012 time 206471250
[11:23:42] h264: "Chapter 11" (11) at frame 60767 time 228074130
[11:24:04] h264: "Chapter 12" (12) at frame 69094 time 259331580
[11:24:04] encqsvWork: got chapter 12 before we could write chapter 12, dropping marker
[11:24:08] h264: "Chapter 13" (13) at frame 70585 time 264928410
[11:24:08] encqsvWork: got chapter 13 before we could write chapter 13, dropping marker
[11:24:32] h264: "Chapter 14" (14) at frame 80011 time 300311280
[11:24:41] h264: "Chapter 15" (15) at frame 83647 time 313959960
[11:24:58] h264: "Chapter 16" (16) at frame 89903 time 337443300
[11:25:12] h264: "Chapter 17" (17) at frame 95570 time 358715880
[11:25:12] encqsvWork: got chapter 17 before we could write chapter 17, dropping marker
[11:25:27] h264: "Chapter 18" (18) at frame 100838 time 378490590
[11:25:36] h264: "Chapter 19" (19) at frame 104405 time 391880250
[11:25:48] h264: "Chapter 20" (20) at frame 108544 time 407416950
[11:25:59] reader: done. 1 scr changes
[11:25:59] work: average encoding speed for job is 373.254791 fps
[11:25:59] sync: got 112874 frames, 56436 expected
[11:25:59] render: 56438 frames output, 56436 dropped and 0 duped for CFR/PFR
[11:25:59] render: lost time: 0 (0 frames)
[11:25:59] render: gained time: 0 (0 frames) (0 not accounted for)
[11:25:59] h264-decoder done: 112874 frames, 0 decoder errors, 0 drops
[11:25:59] enc_qsv done: frames: 56438 in, 56438 out
[11:25:59] dca-decoder done: 0 frames, 0 decoder errors, 0 drops
[11:25:59] mux: track 0, 56438 frames, 1116802441 bytes, 1897.80 kbps, fifo 2048
[11:25:59] mux: track 1, 220675 frames, 94372354 bytes, 160.37 kbps, fifo 8192
[11:25:59] libhb: work result = 0

Post by **s55** » Sat Dec 14, 2013 11:14 am

My guess is it's probably because you are using h264 software decoding rather than using QSV h264 decode support. So the decoder is maxing the CPU trying to feed the QSV encoder.

So there's nothing actually wrong here. It's working as intended.

You will likely get lower CPU usage if you re-enable QSV decoding in preferences.

Ricou73-fr · Post by **Ricou73-fr** » Sat Dec 14, 2013 1:24 pm

I have done the test, with software h264 i have 100% cpu usage (quad core @3600mhz and GPU is @350mhz) and encoding rate is around 140fps average, with full qsv (encode and decode) i had around 400fps and aprox 90% cpu usage (quad core @3600mhz and GPU is @800mhz). In your opinion, what is expected cpu usage when qsv is used ? I try with and without audio downmix but there is no change.

Yes i agree with you, it's work as intended, but i fact, thing that surprise me is before last week i have very different encoding rate. Last week software encoding was around 40fps and QSV is around 140fps. It's a very big gap (average fps multiply by 4).

Post by **s55** » Sat Dec 14, 2013 6:04 pm

I really don't understand what you think the problem is?

It's perfectly normal to have varying encode speeds and CPU usage depending on thousands of settings combinations, the source file and the hardware in use.
Even with QSV running, there is still a lot of code running on the CPU that could still fully utilize it. So sometimes you might see 20~30% cpu usage, sometimes you might see 100%.

You also state you rolled back and the behavior is the same. The QSV code has been bedded in for quite some time now and isn't take any new significant changes anymore.

Without having encode logs for every single file you see a difference for, we can't explain that to you as there is simply too many reasons why there could be a difference.

gmb · Post by **gmb** » Sun Dec 15, 2013 2:37 am

Such a high CPU is not normal for Quicksync Hardware. In several hundreds of videos I never saw 90% CPU load. Is there a video sample I can try?

Post by **JohnAStebbins** » Sun Dec 15, 2013 5:12 am

gmb wrote:Such a high CPU is not normal for Quicksync Hardware. In several hundreds of videos I never saw 90% CPU load. Is there a video sample I can try?

He was doing QSV encode, but *software* decode. High CPU usage would be expected in this scenario. He hasn't posted an activity log for his latest attempts, so there is no point in speculating what might be happening with those encodes.

Ricou73-fr · Post by **Ricou73-fr** » Sun Dec 15, 2013 7:00 am

Here is the log with QSV encode/decode , sorry to not have posting this before but i do a lot of test to try finding difference and with such cpu load, often i stop the test before the end and haven't a look to the log.
With this log, all processor are at 90% load all the time and GPU oscillate between 600Mhz and 900MHz (without QSV it's only at 350Mhz).
My post is for informing that after installing latest VLC player, i have a big change with handbrake usage, CPU load become heavy and preformance has been multiply by 4. I dont know if it's normal or not, please tell me your feeling about this.
Yes i am not using latest build, but i have try several version and even oldest have same behavior, so i use 5879 but 5927 have same performance
Encoding log

Code: Select all

HandBrake svn5879 (Nightly Build) - 64bit Version
OS: Microsoft Windows NT 6.1.7601 Service Pack 1
CPU: Intel(R) Core(TM) i5-3570K CPU @ 3.40GHz
Ram: 16260 MB, 
GPU Information:
  Intel(R) HD Graphics 4000 - 9.18.10.3257
  AMD Radeon HD 7800 Series - 13.152.0.0
Screen: 1280x1024
Temp Dir: f:\Temp\
Install Dir: F:\Program Files\Handbrake
Data Dir: C:\Users\Ricou\AppData\Roaming\HandBrake\HandBrake\0.0.0.5879

-------------------------------------------
CLI Query:  -i "F:\DVR\Matin Noel 2006.mkv" -t 1 --angle 1 -c 1-20 -o "F:\DVR\Matin Noel 2006-1.mp4"  -f mp4  -w 1200 --crop 0:0:0:2 --loose-anamorphic  --modulus 2 -e qsv_h264 -q 20 --cfr -a 1 -E av_aac -6 stereo -R Auto -B 160 -D 0 --gain 0 --audio-fallback ac3 --markers="f:\Temp\Matin Noel 2006-1-1-chapters.csv" --h264-level="4.0"  --h264-profile=main  -x target-usage=2:async-depth=4 --verbose=1
User Query: False

[07:45:14] CPU: Intel(R) Core(TM) i5-3570K CPU @ 3.40GHz
[07:45:14]  - Intel microarchitecture Ivy Bridge
[07:45:14]  - logical processor count: 4
[07:45:14] OpenCL device #1: Advanced Micro Devices, Inc. Pitcairn
[07:45:14]  - OpenCL version: 1.2 AMD-APP (1268.1)
[07:45:14]  - driver version: 1268.1 (VM)
[07:45:14]  - device type: GPU
[07:45:14]  - supported: yes
[07:45:14] Intel Quick Sync Video support: yes
[07:45:14]  - Intel Media SDK hardware: API 1.7 (minimum: 1.3)
[07:45:14]  - Preferred implementation: hardware (any)
[07:45:14] hb_scan: path=F:\DVR\Matin Noel 2006.mkv, title_index=1
libbluray/bdnav/index_parse.c:162: indx_parse(): error opening F:\DVR\Matin Noel 2006.mkv/BDMV/index.bdmv
libbluray/bdnav/index_parse.c:162: indx_parse(): error opening F:\DVR\Matin Noel 2006.mkv/BDMV/BACKUP/index.bdmv
libbluray/bluray.c:1725: nav_get_title_list(F:\DVR\Matin Noel 2006.mkv) failed (0000000000a3a0e0)
[07:45:14] bd: not a bd - trying as a stream/file instead
libdvdnav: Using dvdnav version 4.1.3
libdvdread: Encrypted DVD support unavailable.
libdvdnav:DVDOpenFileUDF:UDFFindFile /VIDEO_TS/VIDEO_TS.IFO failed
libdvdnav:DVDOpenFileUDF:UDFFindFile /VIDEO_TS/VIDEO_TS.BUP failed
libdvdread: Can't open file VIDEO_TS.IFO.
libdvdnav: vm: failed to read VIDEO_TS.IFO
[07:45:14] dvd: not a dvd - trying as a stream/file instead
Input #0, matroska,webm, from 'F:\DVR\Matin Noel 2006.mkv':
  Duration: 01:18:27.74, start: 0.000000, bitrate: N/A
    Chapter #0.0: start 0.000000, end 226.560000
    Metadata:
      title           : 00:00:00.000
    Chapter #0.1: start 226.560000, end 434.893000
    Metadata:
      title           : 00:03:46.560
    Chapter #0.2: start 434.893000, end 735.360000
    Metadata:
      title           : 00:07:14.893
    Chapter #0.3: start 735.360000, end 1010.551000
    Metadata:
      title           : 00:12:15.360
    Chapter #0.4: start 1010.551000, end 1313.646000
    Metadata:
      title           : 00:16:50.551
    Chapter #0.5: start 1313.646000, end 1573.489000
    Metadata:
      title           : 00:21:53.646
    Chapter #0.6: start 1573.489000, end 1947.737000
    Metadata:
      title           : 00:26:13.489
    Chapter #0.7: start 1947.737000, end 2126.416000
    Metadata:
      title           : 00:32:27.737
    Chapter #0.8: start 2126.416000, end 2294.125000
    Metadata:
      title           : 00:35:26.416
    Chapter #0.9: start 2294.125000, end 2534.157000
    Metadata:
      title           : 00:38:14.125
    Chapter #0.10: start 2534.157000, end 2881.462000
    Metadata:
      title           : 00:42:14.157
    Chapter #0.11: start 2881.462000, end 2943.566000
    Metadata:
      title           : 00:48:01.462
    Chapter #0.12: start 2943.566000, end 3336.667000
    Metadata:
      title           : 00:49:03.566
    Chapter #0.13: start 3336.667000, end 3488.318000
    Metadata:
      title           : 00:55:36.667
    Chapter #0.14: start 3488.318000, end 3749.287000
    Metadata:
      title           : 00:58:08.318
    Chapter #0.15: start 3749.287000, end 3985.732000
    Metadata:
      title           : 01:02:29.287
    Chapter #0.16: start 3985.732000, end 4205.410000
    Metadata:
      title           : 01:06:25.732
    Chapter #0.17: start 4205.410000, end 4354.100000
    Metadata:
      title           : 01:10:05.410
    Chapter #0.18: start 4354.100000, end 4526.731000
    Metadata:
      title           : 01:12:34.100
    Chapter #0.19: start 4526.731000, end 4707.744000
    Metadata:
      title           : 01:15:26.731
    Stream #0.0(eng): Video: h264 (High), yuv420p, 1200x720, PAR 1:1 DAR 5:3, 23.98 fps, 23.98 tbr, 1k tbn, 47.95 tbc (default)
    Stream #0.1(fre): Audio: dca (DTS), 48000 Hz, 5.1, fltp, 1536 kb/s (default)
    Metadata:
      title           : French DTS 1509 kbps
    Stream #0.2(fre): Subtitle: [0][0][0][0] / 0x0000 (default) (forced)
    Metadata:
      title           : French_forced
    Stream #0.3(fre): Subtitle: [0][0][0][0] / 0x0000
    Metadata:
      title           : French_Songs
    Stream #0.4(fre): Subtitle: [0][0][0][0] / 0x0000
    Metadata:
      title           : French
[07:45:14] scan: decoding previews for title 1
[07:45:14] scan: audio 0x1: dca, rate=48000Hz, bitrate=1536000 Francais (DTS) (5.1 ch)
[07:45:14] scan: 1 previews, 1200x720, 11.988 fps, autocrop = 0/0/0/0, aspect 1.67:1, PAR 1:1
[07:45:14] Title is likely interlaced or telecined (0 out of 1 previews). You should do something about that.
[07:45:14] libhb: scan thread found 1 valid title(s)
[07:45:14] 1 job(s) to process
[07:45:14] starting job
[07:45:14] sync: expecting 56436 video frames
[07:45:14] job configuration:
[07:45:14]  * source
[07:45:14]    + F:\DVR\Matin Noel 2006.mkv
[07:45:14]    + title 1, chapter(s) 1 to 20
[07:45:14]    + container: matroska,webm
[07:45:14]  * destination
[07:45:14]    + F:\DVR\Matin Noel 2006-1.mp4
[07:45:14]    + container: MPEG-4 (avformat)
[07:45:14]      + chapter markers
[07:45:14]  * video track
[07:45:14]    + decoder: h264
[07:45:14]    + filters
[07:45:14]      + Framerate Shaper (1:27000000:2252250)
[07:45:14]        + frame rate: 11.988 fps -> constant 11.988 fps
[07:45:14]      + Crop and Scale (1200:720:0:0:0:2)
[07:45:14]        + source: 1200 * 720, crop (0/0/0/2): 1198 * 720, scale: 1200 * 720
[07:45:14]    + loose anamorphic
[07:45:14]      + storage dimensions: 1200 * 720, mod 2
[07:45:14]      + pixel aspect ratio: 599 / 600
[07:45:14]      + display dimensions: 1198 * 720
[07:45:14]    + encoder: H.264 (Intel QSV)
[07:45:14]      + options: async-depth=4
[07:45:14]      + h264 profile: main
[07:45:14]      + h264 level: 4.0
[07:45:14]      + quality: 20.00 (QP)
[07:45:14]  * audio track 1
[07:45:14]    + decoder: Francais (DTS) (5.1 ch) (track 2, id 0x1)
[07:45:14]      + bitrate: 1536 kbps, samplerate: 48000 Hz
[07:45:14]    + mixdown: Stereo
[07:45:14]    + encoder: AAC (avcodec)
[07:45:14]      + bitrate: 160 kbps, samplerate: 48000 Hz
[07:45:14] reader: first SCR 0 id 0x0 DTS 0
[07:45:14] encqsvInit: hb_qsv_param_parse: bad key async-depth
[07:45:14] encqsvInit: using encode-only path
[07:45:14] encqsvInit: TargetUsage 2 AsyncDepth 4
[07:45:14] encqsvInit: GopRefDist 3 GopPicSize 32 NumRefFrame 2
[07:45:14] encqsvInit: BFrames on BPyramid off
[07:45:14] encqsvInit: RateControlMethod CQP with QPI 20 QPP 22 QPB 24
[07:45:14] encqsvInit: CAVLC off
[07:45:14] encqsvInit: H.264 profile Main @ level 4.0
[07:45:14] qsv_enc_init: using 'hardware (1)' implementation, API: 1.7
[07:45:29] h264: "Chapter 2" (2) at frame 5440 time 20390400
[07:45:29] encqsvWork: got chapter 2 before we could write chapter 2, dropping marker
[07:45:42] h264: "Chapter 3" (3) at frame 10435 time 39140370
[07:46:01] h264: "Chapter 4" (4) at frame 17640 time 66186180
[07:46:01] encqsvWork: got chapter 4 before we could write chapter 4, dropping marker
[07:46:18] h264: "Chapter 5" (5) at frame 24237 time 90949590
[07:46:37] h264: "Chapter 6" (6) at frame 31506 time 118235610
[07:46:53] h264: "Chapter 7" (7) at frame 37735 time 141617700
[07:47:17] h264: "Chapter 8" (8) at frame 46707 time 175296420
[07:47:28] h264: "Chapter 9" (9) at frame 50991 time 191377440
[07:47:38] h264: "Chapter 10" (10) at frame 55012 time 206471250
[07:47:54] h264: "Chapter 11" (11) at frame 60767 time 228074130
[07:48:15] h264: "Chapter 12" (12) at frame 69094 time 259331580
[07:48:16] encqsvWork: got chapter 12 before we could write chapter 12, dropping marker
[07:48:19] h264: "Chapter 13" (13) at frame 70585 time 264928410
[07:48:19] encqsvWork: got chapter 13 before we could write chapter 13, dropping marker
[07:48:43] h264: "Chapter 14" (14) at frame 80011 time 300311280
[07:48:53] h264: "Chapter 15" (15) at frame 83647 time 313959960
[07:49:11] h264: "Chapter 16" (16) at frame 89903 time 337443300
[07:49:25] h264: "Chapter 17" (17) at frame 95570 time 358715880
[07:49:25] encqsvWork: got chapter 17 before we could write chapter 17, dropping marker
[07:49:39] h264: "Chapter 18" (18) at frame 100838 time 378490590
[07:49:48] h264: "Chapter 19" (19) at frame 104405 time 391880250
[07:50:00] h264: "Chapter 20" (20) at frame 108544 time 407416950
[07:50:11] reader: done. 1 scr changes
[07:50:11] work: average encoding speed for job is 380.056427 fps
[07:50:11] sync: got 112874 frames, 56436 expected
[07:50:11] render: 56438 frames output, 56436 dropped and 0 duped for CFR/PFR
[07:50:11] render: lost time: 0 (0 frames)
[07:50:11] render: gained time: 0 (0 frames) (0 not accounted for)
[07:50:11] h264-decoder done: 112874 frames, 0 decoder errors, 0 drops
[07:50:11] enc_qsv done: frames: 56438 in, 56438 out
[07:50:12] dca-decoder done: 0 frames, 0 decoder errors, 0 drops
[07:50:12] mux: track 0, 56438 frames, 1116802441 bytes, 1897.80 kbps, fifo 2048
[07:50:12] mux: track 1, 220675 frames, 94372354 bytes, 160.37 kbps, fifo 8192
[07:50:12] libhb: work result = 0

Scan log

Code: Select all

HandBrake svn5879 (Nightly Build) - 64bit Version
OS: Microsoft Windows NT 6.1.7601 Service Pack 1
CPU: Intel(R) Core(TM) i5-3570K CPU @ 3.40GHz
Ram: 16260 MB, 
GPU Information:
  Intel(R) HD Graphics 4000 - 9.18.10.3257
  AMD Radeon HD 7800 Series - 13.152.0.0
Screen: 1280x1024
Temp Dir: f:\Temp\
Install Dir: F:\Program Files\Handbrake
Data Dir: C:\Users\Ricou\AppData\Roaming\HandBrake\HandBrake\0.0.0.5879

-------------------------------------------
[07:44:34] CPU: Intel(R) Core(TM) i5-3570K CPU @ 3.40GHz
[07:44:34]  - Intel microarchitecture Ivy Bridge
[07:44:34]  - logical processor count: 4
[07:44:35] OpenCL device #1: Advanced Micro Devices, Inc. Pitcairn
[07:44:35]  - OpenCL version: 1.2 AMD-APP (1268.1)
[07:44:35]  - driver version: 1268.1 (VM)
[07:44:35]  - device type: GPU
[07:44:35]  - supported: yes
[07:44:35] Intel Quick Sync Video support: yes
[07:44:35]  - Intel Media SDK hardware: API 1.7 (minimum: 1.3)
[07:44:35]  - Preferred implementation: hardware (any)
[07:44:35] hb_scan: path=F:\DVR\Matin Noel 2006.mkv, title_index=0
libbluray/bdnav/index_parse.c:162: indx_parse(): error opening F:\DVR\Matin Noel 2006.mkv/BDMV/index.bdmv
libbluray/bdnav/index_parse.c:162: indx_parse(): error opening F:\DVR\Matin Noel 2006.mkv/BDMV/BACKUP/index.bdmv
libbluray/bluray.c:1725: nav_get_title_list(F:\DVR\Matin Noel 2006.mkv) failed (0000000000a2d700)
[07:44:35] bd: not a bd - trying as a stream/file instead
libdvdnav: Using dvdnav version 4.1.3
libdvdread: Encrypted DVD support unavailable.
libdvdnav:DVDOpenFileUDF:UDFFindFile /VIDEO_TS/VIDEO_TS.IFO failed
libdvdnav:DVDOpenFileUDF:UDFFindFile /VIDEO_TS/VIDEO_TS.BUP failed
libdvdread: Can't open file VIDEO_TS.IFO.
libdvdnav: vm: failed to read VIDEO_TS.IFO
[07:44:35] dvd: not a dvd - trying as a stream/file instead
Input #0, matroska,webm, from 'F:\DVR\Matin Noel 2006.mkv':
  Duration: 01:18:27.74, start: 0.000000, bitrate: N/A
    Chapter #0.0: start 0.000000, end 226.560000
    Metadata:
      title           : 00:00:00.000
    Chapter #0.1: start 226.560000, end 434.893000
    Metadata:
      title           : 00:03:46.560
    Chapter #0.2: start 434.893000, end 735.360000
    Metadata:
      title           : 00:07:14.893
    Chapter #0.3: start 735.360000, end 1010.551000
    Metadata:
      title           : 00:12:15.360
    Chapter #0.4: start 1010.551000, end 1313.646000
    Metadata:
      title           : 00:16:50.551
    Chapter #0.5: start 1313.646000, end 1573.489000
    Metadata:
      title           : 00:21:53.646
    Chapter #0.6: start 1573.489000, end 1947.737000
    Metadata:
      title           : 00:26:13.489
    Chapter #0.7: start 1947.737000, end 2126.416000
    Metadata:
      title           : 00:32:27.737
    Chapter #0.8: start 2126.416000, end 2294.125000
    Metadata:
      title           : 00:35:26.416
    Chapter #0.9: start 2294.125000, end 2534.157000
    Metadata:
      title           : 00:38:14.125
    Chapter #0.10: start 2534.157000, end 2881.462000
    Metadata:
      title           : 00:42:14.157
    Chapter #0.11: start 2881.462000, end 2943.566000
    Metadata:
      title           : 00:48:01.462
    Chapter #0.12: start 2943.566000, end 3336.667000
    Metadata:
      title           : 00:49:03.566
    Chapter #0.13: start 3336.667000, end 3488.318000
    Metadata:
      title           : 00:55:36.667
    Chapter #0.14: start 3488.318000, end 3749.287000
    Metadata:
      title           : 00:58:08.318
    Chapter #0.15: start 3749.287000, end 3985.732000
    Metadata:
      title           : 01:02:29.287
    Chapter #0.16: start 3985.732000, end 4205.410000
    Metadata:
      title           : 01:06:25.732
    Chapter #0.17: start 4205.410000, end 4354.100000
    Metadata:
      title           : 01:10:05.410
    Chapter #0.18: start 4354.100000, end 4526.731000
    Metadata:
      title           : 01:12:34.100
    Chapter #0.19: start 4526.731000, end 4707.744000
    Metadata:
      title           : 01:15:26.731
    Stream #0.0(eng): Video: h264 (High), yuv420p, 1200x720, PAR 1:1 DAR 5:3, 23.98 fps, 23.98 tbr, 1k tbn, 47.95 tbc (default)
    Stream #0.1(fre): Audio: dca (DTS), 48000 Hz, 5.1, fltp, 1536 kb/s (default)
    Metadata:
      title           : French DTS 1509 kbps
    Stream #0.2(fre): Subtitle: [0][0][0][0] / 0x0000 (default) (forced)
    Metadata:
      title           : French_forced
    Stream #0.3(fre): Subtitle: [0][0][0][0] / 0x0000
    Metadata:
      title           : French_Songs
    Stream #0.4(fre): Subtitle: [0][0][0][0] / 0x0000
    Metadata:
      title           : French
[07:44:35] scan: decoding previews for title 1
[07:44:35] scan: audio 0x1: dca, rate=48000Hz, bitrate=1536000 Francais (DTS) (5.1 ch)
[07:44:35] scan: 10 previews, 1200x720, 23.976 fps, autocrop = 0/0/0/2, aspect 1.67:1, PAR 1:1
[07:44:35] libhb: scan thread found 1 valid title(s)
[07:45:14] hb_init: starting libhb thread
[07:45:14] CPU: Intel(R) Core(TM) i5-3570K CPU @ 3.40GHz
[07:45:14]  - Intel microarchitecture Ivy Bridge
[07:45:14]  - logical processor count: 4
[07:45:14] OpenCL device #1: Advanced Micro Devices, Inc. Pitcairn
[07:45:14]  - OpenCL version: 1.2 AMD-APP (1268.1)
[07:45:14]  - driver version: 1268.1 (VM)
[07:45:14]  - device type: GPU
[07:45:14]  - supported: yes
[07:45:14] Intel Quick Sync Video support: yes
[07:45:14]  - Intel Media SDK hardware: API 1.7 (minimum: 1.3)
[07:45:14]  - Preferred implementation: hardware (any)
[07:45:14] hb_scan: path=F:\DVR\Matin Noel 2006.mkv, title_index=1
libbluray/bdnav/index_parse.c:162: indx_parse(): error opening F:\DVR\Matin Noel 2006.mkv/BDMV/index.bdmv
libbluray/bdnav/index_parse.c:162: indx_parse(): error opening F:\DVR\Matin Noel 2006.mkv/BDMV/BACKUP/index.bdmv
libbluray/bluray.c:1725: nav_get_title_list(F:\DVR\Matin Noel 2006.mkv) failed (0000000000a3a0e0)
[07:45:14] bd: not a bd - trying as a stream/file instead
libdvdnav: Using dvdnav version 4.1.3
libdvdread: Encrypted DVD support unavailable.
libdvdnav:DVDOpenFileUDF:UDFFindFile /VIDEO_TS/VIDEO_TS.IFO failed
libdvdnav:DVDOpenFileUDF:UDFFindFile /VIDEO_TS/VIDEO_TS.BUP failed
libdvdread: Can't open file VIDEO_TS.IFO.
libdvdnav: vm: failed to read VIDEO_TS.IFO
[07:45:14] dvd: not a dvd - trying as a stream/file instead
Input #0, matroska,webm, from 'F:\DVR\Matin Noel 2006.mkv':
  Duration: 01:18:27.74, start: 0.000000, bitrate: N/A
    Chapter #0.0: start 0.000000, end 226.560000
    Metadata:
      title           : 00:00:00.000
    Chapter #0.1: start 226.560000, end 434.893000
    Metadata:
      title           : 00:03:46.560
    Chapter #0.2: start 434.893000, end 735.360000
    Metadata:
      title           : 00:07:14.893
    Chapter #0.3: start 735.360000, end 1010.551000
    Metadata:
      title           : 00:12:15.360
    Chapter #0.4: start 1010.551000, end 1313.646000
    Metadata:
      title           : 00:16:50.551
    Chapter #0.5: start 1313.646000, end 1573.489000
    Metadata:
      title           : 00:21:53.646
    Chapter #0.6: start 1573.489000, end 1947.737000
    Metadata:
      title           : 00:26:13.489
    Chapter #0.7: start 1947.737000, end 2126.416000
    Metadata:
      title           : 00:32:27.737
    Chapter #0.8: start 2126.416000, end 2294.125000
    Metadata:
      title           : 00:35:26.416
    Chapter #0.9: start 2294.125000, end 2534.157000
    Metadata:
      title           : 00:38:14.125
    Chapter #0.10: start 2534.157000, end 2881.462000
    Metadata:
      title           : 00:42:14.157
    Chapter #0.11: start 2881.462000, end 2943.566000
    Metadata:
      title           : 00:48:01.462
    Chapter #0.12: start 2943.566000, end 3336.667000
    Metadata:
      title           : 00:49:03.566
    Chapter #0.13: start 3336.667000, end 3488.318000
    Metadata:
      title           : 00:55:36.667
    Chapter #0.14: start 3488.318000, end 3749.287000
    Metadata:
      title           : 00:58:08.318
    Chapter #0.15: start 3749.287000, end 3985.732000
    Metadata:
      title           : 01:02:29.287
    Chapter #0.16: start 3985.732000, end 4205.410000
    Metadata:
      title           : 01:06:25.732
    Chapter #0.17: start 4205.410000, end 4354.100000
    Metadata:
      title           : 01:10:05.410
    Chapter #0.18: start 4354.100000, end 4526.731000
    Metadata:
      title           : 01:12:34.100
    Chapter #0.19: start 4526.731000, end 4707.744000
    Metadata:
      title           : 01:15:26.731
    Stream #0.0(eng): Video: h264 (High), yuv420p, 1200x720, PAR 1:1 DAR 5:3, 23.98 fps, 23.98 tbr, 1k tbn, 47.95 tbc (default)
    Stream #0.1(fre): Audio: dca (DTS), 48000 Hz, 5.1, fltp, 1536 kb/s (default)
    Metadata:
      title           : French DTS 1509 kbps
    Stream #0.2(fre): Subtitle: [0][0][0][0] / 0x0000 (default) (forced)
    Metadata:
      title           : French_forced
    Stream #0.3(fre): Subtitle: [0][0][0][0] / 0x0000
    Metadata:
      title           : French_Songs
    Stream #0.4(fre): Subtitle: [0][0][0][0] / 0x0000
    Metadata:
      title           : French
[07:45:14] scan: decoding previews for title 1
[07:45:14] scan: audio 0x1: dca, rate=48000Hz, bitrate=1536000 Francais (DTS) (5.1 ch)
[07:45:14] scan: 1 previews, 1200x720, 11.988 fps, autocrop = 0/0/0/0, aspect 1.67:1, PAR 1:1
[07:45:14] Title is likely interlaced or telecined (0 out of 1 previews). You should do something about that.
[07:45:14] libhb: scan thread found 1 valid title(s)
[07:45:14] 1 job(s) to process
[07:45:14] starting job
[07:45:14] sync: expecting 56436 video frames
[07:45:14] job configuration:
[07:45:14]  * source
[07:45:14]    + F:\DVR\Matin Noel 2006.mkv
[07:45:14]    + title 1, chapter(s) 1 to 20
[07:45:14]    + container: matroska,webm
[07:45:14]  * destination
[07:45:14]    + F:\DVR\Matin Noel 2006-1.mp4
[07:45:14]    + container: MPEG-4 (avformat)
[07:45:14]      + chapter markers
[07:45:14]  * video track
[07:45:14]    + decoder: h264
[07:45:14]    + filters
[07:45:14]      + Framerate Shaper (1:27000000:2252250)
[07:45:14]        + frame rate: 11.988 fps -> constant 11.988 fps
[07:45:14]      + Crop and Scale (1200:720:0:0:0:2)
[07:45:14]        + source: 1200 * 720, crop (0/0/0/2): 1198 * 720, scale: 1200 * 720
[07:45:14]    + loose anamorphic
[07:45:14]      + storage dimensions: 1200 * 720, mod 2
[07:45:14]      + pixel aspect ratio: 599 / 600
[07:45:14]      + display dimensions: 1198 * 720
[07:45:14]    + encoder: H.264 (Intel QSV)
[07:45:14]      + options: async-depth=4
[07:45:14]      + h264 profile: main
[07:45:14]      + h264 level: 4.0
[07:45:14]      + quality: 20.00 (QP)
[07:45:14]  * audio track 1
[07:45:14]    + decoder: Francais (DTS) (5.1 ch) (track 2, id 0x1)
[07:45:14]      + bitrate: 1536 kbps, samplerate: 48000 Hz
[07:45:14]    + mixdown: Stereo
[07:45:14]    + encoder: AAC (avcodec)
[07:45:14]      + bitrate: 160 kbps, samplerate: 48000 Hz
[07:45:14] reader: first SCR 0 id 0x0 DTS 0
[07:45:14] encqsvInit: hb_qsv_param_parse: bad key async-depth
[07:45:14] encqsvInit: using encode-only path
[07:45:14] encqsvInit: TargetUsage 2 AsyncDepth 4
[07:45:14] encqsvInit: GopRefDist 3 GopPicSize 32 NumRefFrame 2
[07:45:14] encqsvInit: BFrames on BPyramid off
[07:45:14] encqsvInit: RateControlMethod CQP with QPI 20 QPP 22 QPB 24
[07:45:14] encqsvInit: CAVLC off
[07:45:14] encqsvInit: H.264 profile Main @ level 4.0
[07:45:14] qsv_enc_init: using 'hardware (1)' implementation, API: 1.7
[07:45:29] h264: "Chapter 2" (2) at frame 5440 time 20390400
[07:45:29] encqsvWork: got chapter 2 before we could write chapter 2, dropping marker
[07:45:42] h264: "Chapter 3" (3) at frame 10435 time 39140370
[07:46:01] h264: "Chapter 4" (4) at frame 17640 time 66186180
[07:46:01] encqsvWork: got chapter 4 before we could write chapter 4, dropping marker
[07:46:18] h264: "Chapter 5" (5) at frame 24237 time 90949590
[07:46:37] h264: "Chapter 6" (6) at frame 31506 time 118235610
[07:46:53] h264: "Chapter 7" (7) at frame 37735 time 141617700
[07:47:17] h264: "Chapter 8" (8) at frame 46707 time 175296420
[07:47:28] h264: "Chapter 9" (9) at frame 50991 time 191377440
[07:47:38] h264: "Chapter 10" (10) at frame 55012 time 206471250
[07:47:54] h264: "Chapter 11" (11) at frame 60767 time 228074130
[07:48:15] h264: "Chapter 12" (12) at frame 69094 time 259331580
[07:48:16] encqsvWork: got chapter 12 before we could write chapter 12, dropping marker
[07:48:19] h264: "Chapter 13" (13) at frame 70585 time 264928410
[07:48:19] encqsvWork: got chapter 13 before we could write chapter 13, dropping marker
[07:48:43] h264: "Chapter 14" (14) at frame 80011 time 300311280
[07:48:53] h264: "Chapter 15" (15) at frame 83647 time 313959960
[07:49:11] h264: "Chapter 16" (16) at frame 89903 time 337443300
[07:49:25] h264: "Chapter 17" (17) at frame 95570 time 358715880
[07:49:25] encqsvWork: got chapter 17 before we could write chapter 17, dropping marker
[07:49:39] h264: "Chapter 18" (18) at frame 100838 time 378490590
[07:49:48] h264: "Chapter 19" (19) at frame 104405 time 391880250
[07:50:00] h264: "Chapter 20" (20) at frame 108544 time 407416950
[07:50:11] reader: done. 1 scr changes
[07:50:11] work: average encoding speed for job is 380.056427 fps
[07:50:11] sync: got 112874 frames, 56436 expected
[07:50:11] render: 56438 frames output, 56436 dropped and 0 duped for CFR/PFR
[07:50:11] render: lost time: 0 (0 frames)
[07:50:11] render: gained time: 0 (0 frames) (0 not accounted for)
[07:50:11] h264-decoder done: 112874 frames, 0 decoder errors, 0 drops
[07:50:11] enc_qsv done: frames: 56438 in, 56438 out
[07:50:12] dca-decoder done: 0 frames, 0 decoder errors, 0 drops
[07:50:12] mux: track 0, 56438 frames, 1116802441 bytes, 1897.80 kbps, fifo 2048
[07:50:12] mux: track 1, 220675 frames, 94372354 bytes, 160.37 kbps, fifo 8192
[07:50:12] libhb: work result = 0

gmb · Post by **gmb** » Sun Dec 15, 2013 9:03 am

JohnAStebbins wrote:He was doing QSV encode, but *software* decode. High CPU usage would be expected in this scenario. He hasn't posted an activity log for his latest attempts, so there is no point in speculating what might be happening with those encodes.

He told 90% CPU usage while doing a Quicksync encode+decode. 800 Mhz GPU is very low, this is not normal. Should be over 1 Ghz.

I have done the test, with software h264 i have 100% cpu usage (quad core @3600mhz and GPU is @350mhz) and encoding rate is around 140fps average, with full qsv (encode and decode) i had around 400fps and aprox 90% cpu usage (quad core @3600mhz and GPU is @800mhz).

Ricou73-fr · Post by **Ricou73-fr** » Sun Dec 15, 2013 10:59 am

In fact pooling interval for CPU-GPU freq was set to 5 sec during test, GPU freq oscillate from 600 to 1150Mhz when i set lower sampling time interval.
But CPU still always at 90% on all of quad core.

Post by **s55** » Sun Dec 15, 2013 2:43 pm

My post is for informing that after installing latest VLC player, i have a big change with handbrake usage, CPU load become heavy and preformance has been multiply by 4. I dont know if it's normal or not, please tell me your feeling about this.

HandBrake and VLC are two completely standalone applications. They can't affect each other. HandBrake does not use or require VLC.

800 Mhz GPU is very low, this is not normal. Should be over 1 Ghz.

Expected range is about 750 ~ 1250Mhz (maybe a bit higer with some SKU's). Typically, assuming there is no bottlenecks it will probably lean towards the higher end of that range but it very much differs from source to source.
There are however a number of bottleneck scenario's that can occur that can pull the encoder down. (Software decode, filters, audio decode/encoder etc etc etc)
I usually see mine hovering around the 900~1100 range quite erratically.

In fact pooling interval for CPU-GPU freq was set to 5 sec during test, GPU freq oscillate from 600 to 1150Mhz when i set lower sampling time interval.
But CPU still always at 90% on all of quad core.

Sounds like it's still using software decode, so high CPU usage is expected in these cases. Normally H.264 should offload but there is possibly something about your files that is triggering it to fallack to software decode. It may be there is some unsupported feature in Intel's Decoder.

Under optimal conditions, 20~30% CPU usage can be achieved but it's not always possible I'm afraid.

gmb · Post by **gmb** » Sun Dec 15, 2013 5:04 pm

What CPU? His 3570k goes up to 1150 Mhz in default state. I had a 3570k before I switched to Haswell, way below 1 Ghz is abnormal. Occasionally spikes below 1 Ghz are possible, I assumed we talk about an average frequency. A 5 sec interval is meaningless though, not accurate enough. With disabled Quicksync decoding I can see 90% CPU load as well on certain videos. QS decoding doesn't work or it is something else. Without a sample unknown.

Post by **s55** » Sun Dec 15, 2013 5:39 pm

4770K here which has a max frequency of 1250mhz assuming it's not heat/power constrained or bottlenecked.

Just checked,

The decoder is listed as h264, not the qsv one, so he is still doing software decode, hence the high CPU usage. So all is normal it seems.

Ricou73-fr · Post by **Ricou73-fr** » Sun Dec 15, 2013 6:21 pm

In fact, that surprise me is usualy i use handbrake to transcode file from my dvr (mp4-ts in my country, same channel all time) to mp4. Usualy (before latest week) encoding rate is around 140fps with QSV (and 40fps with CPU encoding). But yesterday when i transcode (same duration as it's weekly programmed schedule), fps has been multiply by 4, even with old version of handbrake.For testing purpose i use a personnal movie with same result
With QSV it raise up to 400fps and without it's around 140fps, so i suppose qsv do it's job.
The only visible change i remember on my system is a VLC update, as VLC come with a lot of DLL and copy it to $(WINDIR)\system32 i imagine one of them can have a side effect to handbrake.
For avoiding overheating alert (i have set very low limit at 60°C for personnal raison) , i have limited my GPU frequency to 1150Mhz.
s55 please, what is your usualy your average encoding fps ?
Perhaps my problem was before update with a lower fps than expected..don't know.

Post by **JohnAStebbins** » Sun Dec 15, 2013 6:22 pm

Hi,

Ricou73-fr wrote:Here is the log with QSV encode/decode...

Your activity log indicates you are still decoding in software...

Code: Select all

[07:45:14]    + decoder: h264

If you were using hardware decode, it would say...

Code: Select all

[07:45:14]    + decoder: h264_qsv

Post by **s55** » Sun Dec 15, 2013 6:58 pm

Perhaps my problem was before update with a lower fps than expected..don't know.

No way to know without old logs.

Large variances in encodes speeds are normal. It depends on the input source and settings used. you can easily end up with a range of 0.1fps to 1000+fps on the same computer. So there may have been no issue at all.

Ricou73-fr · Post by **Ricou73-fr** » Sun Dec 15, 2013 8:03 pm

Switching back to nighty 5927 and log show always decoder:h264 and never decoder:h264_qsv, i check in preference and box" Disable qsv decoder" is unchecked. Perhaps this is a begining of explanation and channel as change something in their dvb-t stream, as s55 said

Code: Select all

Sounds like it's still using software decode, so high CPU usage is expected in these cases. Normally H.264 should offload but there is possibly something about your files that is triggering it to fallack to software decode. It may be there is some unsupported feature in Intel's Decoder.

And in this case qsv decode is no more used because of format used in the stream, are they any more information can be obteined by log file ?

Deleted User 11865 · Post by **Deleted User 11865** » Sun Dec 15, 2013 8:34 pm

Given the codec and pix_fmt and since you're not using any specific filter, there's no reason for the QSV decoder to auto-disable itself. --disable-qsv-decoding isn't in the CLI query, either. Not sure what's going on, TBH.

Deleted User 11865 · Post by **Deleted User 11865** » Sun Dec 15, 2013 8:41 pm

Can you split your input with mkvmerge GUI and provide a short sample (30 seconds or less)?

Ricou73-fr · Post by **Ricou73-fr** » Mon Dec 16, 2013 6:17 pm

Where can i put such file ? do you know a free hosting service for such file ?
Usualy when i transmit file to some friend or customer i use dl.free.fr, this service is available for your country ?
Or perhaps something like depositfile ?
New informations I have made several try with dvr file (with smaller file).
Seem strange for me but, when i encode a file (mpg or ts) with handbrake and qsv encoder i have an mp4 (normal).
When i open again this mp4 with handbrake for a new encode process (still with qsv), i still have
[18:46:00] * video track
[18:46:00] + decoder: h264

and never decoder:h264_qsv

Here is complete log

Code: Select all

HandBrake svn5927 (Nightly Build) - 64bit Version
OS: Microsoft Windows NT 6.1.7601 Service Pack 1
CPU: Intel(R) Core(TM) i5-3570K CPU @ 3.40GHz
Ram: 16260 MB, 
GPU Information:
  Intel(R) HD Graphics 4000 - 9.18.10.3257
  AMD Radeon HD 7800 Series - 13.152.0.0
Screen: 1280x1024
Temp Dir: f:\Temp\
Install Dir: F:\Program Files\Handbrake
Data Dir: C:\Users\Ricou\AppData\Roaming\HandBrake\HandBrake\0.0.0.5927

-------------------------------------------

CLI Query:  -i "F:\DVR\100_mag_20131216_1840-1.mp4" -t 1 --angle 1 -c 1 -o "F:\DVR\100_mag_20131216_1840-1-1.mp4"  -f mp4  -w 720 --crop 0:0:0:0 --loose-anamorphic  --modulus 2 -e qsv_h264 -q 20 --cfr -a 1 -E av_aac -6 dpl2 -R Auto -B 160 -D 0 --gain 0 --audio-fallback ac3 --markers="f:\Temp\100_mag_20131216_1840-1-1-1-chapters.csv" --qsv-preset=balanced --h264-level="4.0"  --h264-profile=main  --verbose=1

[18:45:59] CPU: Intel(R) Core(TM) i5-3570K CPU @ 3.40GHz
[18:45:59]  - Intel microarchitecture Ivy Bridge
[18:45:59]  - logical processor count: 4
[18:45:59] OpenCL device #1: Advanced Micro Devices, Inc. Pitcairn
[18:45:59]  - OpenCL version: 1.2 AMD-APP (1268.1)
[18:45:59]  - driver version: 1268.1 (VM)
[18:45:59]  - device type:    GPU
[18:45:59]  - supported:      YES
[18:45:59] Intel Quick Sync Video support: yes
[18:45:59]  - Intel Media SDK hardware: API 1.7 (minimum: 1.3)
[18:45:59]  - Preferred implementation: hardware (any)
[18:45:59] hb_scan: path=F:\DVR\100_mag_20131216_1840-1.mp4, title_index=1
libbluray/bdnav/index_parse.c:162: indx_parse(): error opening F:\DVR\100_mag_20131216_1840-1.mp4/BDMV/index.bdmv
libbluray/bdnav/index_parse.c:162: indx_parse(): error opening F:\DVR\100_mag_20131216_1840-1.mp4/BDMV/BACKUP/index.bdmv
libbluray/bluray.c:1725: nav_get_title_list(F:\DVR\100_mag_20131216_1840-1.mp4) failed (000000002c2fea90)
[18:45:59] bd: not a bd - trying as a stream/file instead
libdvdnav: Using dvdnav version 4.1.3
libdvdread: Encrypted DVD support unavailable.
libdvdnav:DVDOpenFileUDF:UDFFindFile /VIDEO_TS/VIDEO_TS.IFO failed
libdvdnav:DVDOpenFileUDF:UDFFindFile /VIDEO_TS/VIDEO_TS.BUP failed
libdvdread: Can't open file VIDEO_TS.IFO.
libdvdnav: vm: failed to read VIDEO_TS.IFO
[18:45:59] dvd: not a dvd - trying as a stream/file instead
Input #0, mov,mp4,m4a,3gp,3g2,mj2, from 'F:\DVR\100_mag_20131216_1840-1.mp4':
  Metadata:
    major_brand     : isom
    minor_version   : 512
    compatible_brands: isomiso2avc1mp41
    encoder         : Lavf54.20.3
  Duration: 00:03:08.10, start: 0.058000, bitrate: 2237 kb/s
    Stream #0.0(und): Video: h264 (Main), yuv420p, 720x572 [PAR 64:45 DAR 256:143], 2073 kb/s, 12.50 fps, 12.50 tbr, 90k tbn, 25 tbc (default)
    Stream #0.1(und): Audio: aac, 48000 Hz, stereo, fltp, 160 kb/s (default)
[18:45:59] scan: decoding previews for title 1
[18:45:59] scan: audio 0x1: aac, rate=48000Hz, bitrate=160713 Unknown (aac) (2.0 ch)
[18:45:59] scan: 1 previews, 720x572, 6.250 fps, autocrop = 0/0/0/0, aspect 16:9, PAR 64:45
[18:45:59] Title is likely interlaced or telecined (1 out of 1 previews). You should do something about that.
[18:45:59] libhb: scan thread found 1 valid title(s)
[18:46:00] 1 job(s) to process
[18:46:00] starting job
[18:46:00] work: sanitizing track 1 mixdown Dolby Pro Logic II to Stereo
[18:46:00] sync: expecting 1175 video frames
[18:46:00] work: only 1 chapter, disabling chapter markers
[18:46:00] job configuration:
[18:46:00]  * source
[18:46:00]    + F:\DVR\100_mag_20131216_1840-1.mp4
[18:46:00]    + title 1, chapter(s) 1 to 1
[18:46:00]    + container: mov,mp4,m4a,3gp,3g2,mj2
[18:46:00]    + data rate: 2237 kbps
[18:46:00]  * destination
[18:46:00]    + F:\DVR\100_mag_20131216_1840-1-1.mp4
[18:46:00]    + container: MPEG-4 (avformat)
[18:46:00]  * video track
[18:46:00]    + decoder: h264
[18:46:00]      + bitrate 2073 kbps
[18:46:00]    + filters
[18:46:00]      + Framerate Shaper (1:27000000:4320000)
[18:46:00]        + frame rate: 6.250 fps -> constant 6.250 fps
[18:46:00]      + Crop and Scale (720:572:0:0:0:0)
[18:46:00]        + source: 720 * 572, crop (0/0/0/0): 720 * 572, scale: 720 * 572
[18:46:00]    + loose anamorphic
[18:46:00]      + storage dimensions: 720 * 572, mod 2
[18:46:00]      + pixel aspect ratio: 64 / 45
[18:46:00]      + display dimensions: 1024 * 572
[18:46:00]    + encoder: H.264 (Intel QSV)
[18:46:00]      + h264 profile: main
[18:46:00]      + h264 level: 4.0
[18:46:00]      + quality: 20.00 (QP)
[18:46:00]  * audio track 1
[18:46:00]    + decoder: Unknown (aac) (2.0 ch) (track 2, id 0x1)
[18:46:00]      + bitrate: 160 kbps, samplerate: 48000 Hz
[18:46:00]    + mixdown: Stereo
[18:46:00]    + encoder: AAC (avcodec)
[18:46:00]      + bitrate: 160 kbps, samplerate: 48000 Hz
[18:46:00] reader: first SCR 14400 id 0x0 DTS 7200
[18:46:00] encqsvInit: using encode-only path
[18:46:00] encqsvInit: TargetUsage 2 AsyncDepth 4
[18:46:00] encqsvInit: GopRefDist 4 GopPicSize 32 NumRefFrame 2
[18:46:00] encqsvInit: BFrames on BPyramid off
[18:46:00] encqsvInit: RateControlMethod CQP with QPI 20 QPP 22 QPB 24
[18:46:00] encqsvInit: CAVLC off
[18:46:00] encqsvInit: H.264 profile Main @ level 4.0
[18:46:00] sync: first pts is 7200
[18:46:00] qsv_enc_init: using 'hardware (1)' implementation, API: 1.7
[18:46:04] reader: done. 1 scr changes
[18:46:04] work: average encoding speed for job is 564.459900 fps
[18:46:04] sync: got 2350 frames, 1175 expected
[18:46:04] render: 1176 frames output, 1174 dropped and 0 duped for CFR/PFR
[18:46:04] render: lost time: 0 (0 frames)
[18:46:04] render: gained time: 0 (0 frames) (0 not accounted for)
[18:46:04] h264-decoder done: 2350 frames, 0 decoder errors, 0 drops
[18:46:04] enc_qsv done: frames: 1176 in, 1176 out
[18:46:04] aac-decoder done: 0 frames, 0 decoder errors, 0 drops
[18:46:04] mux: track 0, 1176 frames, 27329446 bytes, 1161.97 kbps, fifo 512
[18:46:04] mux: track 1, 8784 frames, 3775779 bytes, 160.53 kbps, fifo 4096
[18:46:04] libhb: work result = 0

Deleted User 11865 · Post by **Deleted User 11865** » Mon Dec 16, 2013 7:11 pm

Free's service is fine. Alternatives include Dropbox, Google Drive, etc.

HandBrake

QSV encoding is very agressive

QSV encoding is very agressive

Re: QSV encoding is very agressive

Re: QSV encoding is very agressive

Re: QSV encoding is very agressive

Re: QSV encoding is very agressive

Re: QSV encoding is very agressive

Re: QSV encoding is very agressive

Re: QSV encoding is very agressive

Re: QSV encoding is very agressive

Re: QSV encoding is very agressive

Re: QSV encoding is very agressive

Re: QSV encoding is very agressive

Re: QSV encoding is very agressive

Re: QSV encoding is very agressive

Re: QSV encoding is very agressive

Re: QSV encoding is very agressive

Re: QSV encoding is very agressive

Re: QSV encoding is very agressive

Re: QSV encoding is very agressive

Re: QSV encoding is very agressive

Re: QSV encoding is very agressive

Re: QSV encoding is very agressive