HandBrake / HandBrake

HandBrake's main development repository
https://handbrake.fr
Other
17.92k stars 1.34k forks source link

Encoding % display issue #2949

Closed Kashumee closed 4 years ago

Kashumee commented 4 years ago

Problem description:

When encoding an MKV file encoding pass shows 1/1 100% and estimated time adjusts to an absurd amount of time.

I was able to bypass this by Remuxing using OBS to MP4 and then handbraking it.

I think it's a display issue with incorrect estimates and percentages as the encoding pass ETAs around 13 minutes but I know the file will take over an hour.

HandBrake version (e.g., 1.3.0):

v1.3.3

Operating system and version (e.g., Ubuntu 19.10, macOS 10.15 Catalina, Windows 10 1909):

Windows 10 1909

Error message text and/or screenshot:

Not available right now as I am encoding. Encoding: Pass 1 of 1, 100% , FPS 160.0, Time remaining 03:15:16 (adaptation of what i would see)

After Remux properly displays % and estimated times etc.

HandBrake Activity Log:

An Activity Log is required for support. Please read https://handbrake.fr/docs/en/latest/help/activity-log.html for more information.

HandBrake 1.3.3 (2020061300)
OS: Microsoft Windows NT 10.0.18363.0
CPU: Intel(R) Core(TM) i7-8700K CPU @ 3.70GHz
Ram: 32702 MB, 
GPU Information:
  NVIDIA GeForce RTX 2070 SUPER - 26.21.14.4614
Screen: 1920x1080
Temp Dir: C:\Users\Kashumee\AppData\Local\Temp\
Install Dir: C:\Program Files\HandBrake
Data Dir: C:\Users\Kashumee\AppData\Roaming\HandBrake

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

# Starting Encode ...

[01:27:10] base preset: Vimeo YouTube HQ 2160p60 4K (Modified)
[13:27:10] hb_init: starting libhb thread
[13:27:10] Starting work at: Sat Jun 20 13:27:10 2020
[13:27:10] 1 job(s) to process
[13:27:10] json job:
{
  "Audio": {
    "AudioList": [
      {
        "Bitrate": 320,
        "DRC": 0.0,
        "Encoder": "av_aac",
        "Gain": 0.0,
        "Mixdown": 4,
        "NormalizeMixLevel": false,
        "Samplerate": 48000,
        "Name": "adv_aac0",
        "Track": 0,
        "DitherMethod": 0
      }
    ],
    "CopyMask": [
      "copy:aac",
      "copy:ac3",
      "copy:dtshd",
      "copy:dts",
      "copy:eac3",
      "copy:flac",
      "copy:mp3",
      "copy:truehd"
    ],
    "FallbackEncoder": "ac3"
  },
  "Destination": {
    "ChapterList": [
      {
        "Name": "Chapter 1"
      }
    ],
    "ChapterMarkers": true,
    "AlignAVStart": true,
    "File": "V:\\JD Pvp\\Kunlun t5 asc.mp4",
    "Mp4Options": {
      "IpodAtom": false,
      "Mp4Optimize": true
    },
    "Mux": "av_mp4"
  },
  "Filters": {
    "FilterList": [
      {
        "ID": 4,
        "Settings": {
          "mode": "7"
        }
      },
      {
        "ID": 3,
        "Settings": {
          "block-height": "16",
          "block-thresh": "40",
          "block-width": "16",
          "filter-mode": "2",
          "mode": "3",
          "motion-thresh": "1",
          "spatial-metric": "2",
          "spatial-thresh": "1"
        }
      },
      {
        "ID": 12,
        "Settings": {
          "crop-bottom": "0",
          "crop-left": "0",
          "crop-right": "0",
          "crop-top": "0",
          "height": "1080",
          "width": "1920"
        }
      },
      {
        "ID": 6,
        "Settings": {
          "mode": "1",
          "rate": "27000000/450000"
        }
      }
    ]
  },
  "PAR": {
    "Num": 1,
    "Den": 1
  },
  "Metadata": {},
  "SequenceID": 0,
  "Source": {
    "Angle": 1,
    "Range": {
      "Type": "chapter",
      "Start": 1,
      "End": 1
    },
    "Title": 1,
    "Path": "V:\\batch\\2020-06-14 21-03-42.mkv"
  },
  "Subtitle": {
    "Search": {
      "Burn": true,
      "Default": false,
      "Enable": true,
      "Forced": true
    },
    "SubtitleList": []
  },
  "Video": {
    "Encoder": "nvenc_h265",
    "Level": "auto",
    "TwoPass": false,
    "Turbo": false,
    "ColorMatrixCode": 0,
    "Options": "",
    "Preset": "slow",
    "Profile": "auto",
    "Quality": 22.0,
    "QSV": {
      "Decode": false,
      "AsyncDepth": 0
    }
  }
}
[13:27:10] CPU: Intel(R) Core(TM) i7-8700K CPU @ 3.70GHz
[13:27:10]  - Intel microarchitecture Kaby Lake
[13:27:10]  - logical processor count: 12
[13:27:10] Intel Quick Sync Video support: no
[13:27:10] hb_scan: path=V:\batch\2020-06-14 21-03-42.mkv, title_index=1
udfread ERROR: ECMA 167 Volume Recognition failed
src/libbluray/disc/disc.c:323: failed opening UDF image V:\batch\2020-06-14 21-03-42.mkv
src/libbluray/disc/disc.c:424: error opening file BDMV\index.bdmv
src/libbluray/disc/disc.c:424: error opening file BDMV\BACKUP\index.bdmv
src/libbluray/bluray.c:2585: nav_get_title_list(V:\batch\2020-06-14 21-03-42.mkv\) failed
[13:27:10] bd: not a bd - trying as a stream/file instead
libdvdnav: Using dvdnav version 6.0.1
libdvdread: Encrypted DVD support unavailable.
libdvdread:DVDOpenFileUDF:UDFFindFile /VIDEO_TS/VIDEO_TS.IFO failed
libdvdread:DVDOpenFileUDF:UDFFindFile /VIDEO_TS/VIDEO_TS.BUP failed
libdvdread: Can't open file VIDEO_TS.IFO.
libdvdnav: vm: failed to read VIDEO_TS.IFO
[13:27:10] dvd: not a dvd - trying as a stream/file instead
Input #0, matroska,webm, from 'V:\batch\2020-06-14 21-03-42.mkv':
  Metadata:
    ENCODER         : Lavf58.29.100
  Duration: 00:38:47.36, start: 0.000000, bitrate: 45168 kb/s
    Stream #0:0: Video: h264 (High), yuvj420p(pc, bt470bg/bt709/bt709, progressive), 1920x1080 [SAR 1:1 DAR 16:9], 180 fps, 180 tbr, 1k tbn, 360 tbc (default)
    Metadata:
      DURATION        : 00:38:47.362000000
    Stream #0:1: Audio: aac (LC), 44100 Hz, stereo, fltp (default)
    Metadata:
      title           : adv_aac0
      DURATION        : 00:38:47.336000000
[13:27:10] scan: decoding previews for title 1
[13:27:10] scan: audio 0x1: aac, rate=44100Hz, bitrate=1 Unknown (AAC LC) (2.0 ch)
[13:27:11] scan: 10 previews, 1920x1080, 23.976 fps, autocrop = 0/0/0/0, aspect 16:9, PAR 1:1
[13:27:11] scan: supported video decoders: avcodec qsv
[13:27:11] libhb: scan thread found 1 valid title(s)
[13:27:11] Skipping subtitle scan.  No suitable subtitle tracks.
[13:27:11] Starting Task: Encoding Pass
[13:27:11] Skipping crop/scale filter
[13:27:11] work: only 1 chapter, disabling chapter markers
[13:27:11] job configuration:
[13:27:11]  * source
[13:27:11]    + V:\batch\2020-06-14 21-03-42.mkv
[13:27:11]    + title 1, chapter(s) 1 to 1
[13:27:11]    + container: matroska,webm
[13:27:11]    + data rate: 45168 kbps
[13:27:11]  * destination
[13:27:11]    + V:\JD Pvp\Kunlun t5 asc.mp4
[13:27:11]    + container: MPEG-4 (libavformat)
[13:27:11]      + optimized for HTTP streaming (fast start)
[13:27:11]      + align initial A/V stream timestamps
[13:27:11]  * video track
[13:27:11]    + decoder: h264
[13:27:11]    + filters
[13:27:11]      + Comb Detect (mode=3:spatial-metric=2:motion-thresh=1:spatial-thresh=1:filter-mode=2:block-thresh=40:block-width=16:block-height=16)
[13:27:11]      + Decomb (mode=39)
[13:27:11]      + Framerate Shaper (mode=1:rate=27000000/450000)
[13:27:11]        + frame rate: 23.976 fps -> constant 60.000 fps
[13:27:11]    + Output geometry
[13:27:11]      + storage dimensions: 1920 x 1080
[13:27:11]      + pixel aspect ratio: 1 : 1
[13:27:11]      + display dimensions: 1920 x 1080
[13:27:11]    + encoder: H.265 (NVEnc)
[13:27:11]      + preset:  slow
[13:27:11]      + profile: auto
[13:27:11]      + level:   auto
[13:27:11]      + quality: 22.00 (CQ)
[13:27:11]      + color profile: 1-1-5
[13:27:11]  * audio track 1
[13:27:11]    + name: adv_aac0
[13:27:11]    + decoder: Unknown (AAC LC) (2.0 ch) (track 1, id 0x1)
[13:27:11]      + samplerate: 44100 Hz
[13:27:11]    + mixdown: Stereo
[13:27:11]    + dither: none
[13:27:11]    + encoder: AAC (libavcodec)
[13:27:11]      + bitrate: 320 kbps, samplerate: 48000 Hz
[13:27:11] sync: expecting 55800 video frames
[13:27:11] encavcodecInit: H.265 (Nvidia NVENC)
[13:27:11] encavcodec: encoding at rc=vbr 22.00
[13:27:11] encavcodec: encoding with stored aspect 1/1
[13:27:11] sync: first pts video is 0
[13:27:11] sync: "Chapter 1" (1) at frame 1 time 0
[13:27:12] sync: first pts audio 0x1 is 0

# Encode Stopped

[13:40:57] work: average encoding speed for job is 176.044724 fps
[13:40:57] comb detect: heavy 88 | light 790 | uncombed 144586 | total 145464
[13:40:58] decomb: deinterlaced 88 | blended 790 | unfiltered 144581 | total 145459
[13:40:58] vfr: 48485 frames output, 96970 dropped and 0 duped for CFR/PFR
[13:40:58] vfr: lost time: 0 (0 frames)
[13:40:58] vfr: gained time: 0 (0 frames) (0 not accounted for)
[13:40:58] aac-decoder done: 34817 frames, 0 decoder errors
[13:40:58] h264-decoder done: 145506 frames, 0 decoder errors
[13:40:58] sync: got 145466 frames, 55800 expected
[13:40:58] sync: framerate min 166.667 fps, max 200.000 fps, avg 180.000 fps
[13:40:58] mux: track 0, 48483 frames, 1535916823 bytes, 15205.84 kbps, fifo 512
[13:40:58] mux: track 1, 37862 frames, 28298994 bytes, 280.16 kbps, fifo 512
[13:40:58] Finished work at: Sat Jun 20 13:40:58 2020
[13:40:58] libhb: work result = 1

# Encode Completed ...
sr55 commented 4 years ago

Can you provide a full log please without the encode being stopped please.

After Remux properly displays % and estimated times etc.

You mean if you remux before encoding with HandBrake?

sr55 commented 4 years ago

We've not heard back in a while so we are closing this issue out. If you can provide the requested details or feedback we can re-open this issue.

I suspect this is just bad container metadata which is causing the calculations to be wrong since we are seeing much larger amount of frames than expected.

Thanks