HandBrakeCLI Regression: 1.8.x not passing through AC3 audio track

Discussion of the HandBrake command line interface (CLI)
Forum rules
An Activity Log is required for support requests. Please read How-to get an activity log? for details on how and why this should be provided.
Post Reply
mackworth2
Posts: 8
Joined: Sun Sep 25, 2016 7:03 am

HandBrakeCLI Regression: 1.8.x not passing through AC3 audio track

Post by mackworth2 »

Description of problem or question:

Converting a particular video in HandBrakeCLI 1.8.2 (and 1.8.0) in AC3 passthrough mode results in no audio track. Same video works fine in HandbrakeCLI 1.7.3.

Note that this is the same video [viewtopic.php?t=43774]referenced in a 1.8.2 GUI crash[/url], which was fixed in the latest nightly build. The nightly GUI now runs and properly converts the file with audio; unfortunately, the matching nightly CLI still results in no audio track.

So, even though --scan shows the input audio track, the bad logs show that the output job configuration is missing the output audio track.

Unfortunately, the source is a 9GB MP2 file, but I can make it available if necessary, or try to cut it back if you have a suggestion on how to do that in a way that might preserve the problem.

Steps to reproduce the problem (If Applicable):

Code: Select all

./HandbrakeCLI -e vt_h265_10bit -E copy --audio-copy-mask ac3 -i stones.mpg -o stones181.mp4 &> handbrake.log
HandBrake version (e.g., 1.0.0):

HBCLI 1.7.3: passes. (Log below)
HBCLI 1.8.0: no audio
HBCLI 1.8.2: no audio (Log below)
HBCLI today's nightly: no audio
HBGUI 1.8.2: crashes upon launch
HBGUI today's nightly: passes (Log below)

Operating system and version
macOS Sonoma 14.6.1 (23G93

HandBrake Activity Log 1.7.3:

Code: Select all

[08:49:31] Compile-time hardening features are enabled
[08:49:31] hb_init: starting libhb thread
[08:49:31] thread 16f563000 started ("libhb")
HandBrake 1.7.3 (2024021100) - Darwin arm64 - https://handbrake.fr
8 CPUs detected
Opening /Users/hugh/Downloads/videos/stones.mpg...
[08:49:31] CPU: Unknown
[08:49:31]  - logical processor count: 8
[08:49:31] hb_scan: path=/Users/hugh/Downloads/videos/stones.mpg, title_index=1
udfread ERROR: ECMA 167 Volume Recognition failed
disc.c:333: failed opening UDF image /Users/hugh/Downloads/videos/stones.mpg
disc.c:437: error opening file BDMV/index.bdmv
disc.c:437: error opening file BDMV/BACKUP/index.bdmv
[08:49:31] bd: not a bd - trying as a stream/file instead
libdvdread: DVDOpenFileUDF:UDFFindFile /VIDEO_TS/VIDEO_TS.IFO failed
libdvdnav: vm: vm: failed to read VIDEO_TS.IFO
[08:49:31] dvd: not a dvd - trying as a stream/file instead
[08:49:31] file is MPEG Program Stream
[08:49:31] Found program stream map
<<many duplicates of "Found program stream map"
[08:49:31] Found program stream map
[08:49:31] Found the following streams
[08:49:31]     Video Streams : 
[08:49:31]       0xe0-0x0 type MPEG2 (0x2)
[08:49:31]     Audio Streams : 
[08:49:31]       0xbd-0x0 type AC3 (0x81)
[08:49:31]       0xbd-0x80 type AC3 (0x81)
[08:49:31]     Subtitle Streams : 
[08:49:31]     Other Streams : 
[08:49:31] stream id 0xbd (type 0x81 substream 0x0) audio 0xbd
[08:49:31] stream id 0xbd (type 0x81 substream 0x80) audio 0x8000bd
[08:49:31] scan: decoding previews for title 1
[08:49:31] file is MPEG Program Stream
[08:49:31] Found program stream map
<<many duplicates of "Found program stream map"
[08:49:31] Found program stream map
[08:49:31] scan: audio 0x8000bd: ac3, rate=48000Hz, bitrate=384000 Unknown (AC3, 2.0 ch, 384 kbps)

Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %[08:49:35] stream: 11 good frames, 0 errors (0%)
[08:49:35] using bitstream PAR 1:1
[08:49:35] scan: 10 previews, 1920x1080, 29.970 fps, autocrop = 126/138/0/0, aspect 16:9, PAR 1:1, color profile: 1-1-1, chroma location: left
[08:49:35] scan: removing audio 0xbd because no bitrate found
[08:49:35] libhb: scan thread found 1 valid title(s)
+ Using preset: CLI Default
+ title 1:
  + stream: /Users/hugh/Downloads/videos/stones.mpg
  + duration: 01:39:50
  + size: 1920x1080, pixel aspect: 1/1, display aspect: 1.78, 29.970 fps
  + autocrop: 126/138/0/0
  + chapters:
    + 1: duration 01:39:50
  + audio tracks:
    + 1, Unknown (AC3, 2.0 ch, 384 kbps) (iso639-2: und), 48000Hz, 384000bps
  + subtitle tracks:
    + 1, Unknown, Closed Caption [CC608]
[08:49:35] Starting work at: Mon Aug 26 08:49:35 2024

[08:49:35] 1 job(s) to process
[08:49:35] json job:
{
    "Audio": {
        "AudioList": [
            {
                "Bitrate": 0,
                "DRC": 0.0,
                "Encoder": "copy:ac3",
                "Mixdown": "none",
                "PresetEncoder": "copy",
                "Quality": -3.0,
                "Samplerate": 0,
                "Track": 0
            }
        ],
        "CopyMask": [
            "copy:ac3"
        ],
        "FallbackEncoder": "ca_aac"
    },
    "Destination": {
        "AlignAVStart": false,
        "ChapterList": [
            {
                "Duration": {
                    "Hours": 1,
                    "Minutes": 39,
                    "Seconds": 50,
                    "Ticks": 539142550
                },
                "Name": "Chapter 1"
            }
        ],
        "ChapterMarkers": false,
        "File": "/Users/hugh/Movies/TiVoShows/Test/stones.mp4",
        "InlineParameterSets": false,
        "Mux": "m4v",
        "Options": {
            "IpodAtom": false,
            "Optimize": false
        }
    },
    "Filters": {
        "FilterList": [
            {
                "ID": 10,
                "Settings": {
                    "mode": 0
                }
            },
            {
                "ID": 19,
                "Settings": {
                    "crop-bottom": 138,
                    "crop-left": 0,
                    "crop-right": 0,
                    "crop-top": 126,
                    "height": 816,
                    "width": 1920
                }
            }
        ]
    },
    "Metadata": {},
    "PAR": {
        "Den": 1,
        "Num": 1
    },
    "SequenceID": 0,
    "Source": {
        "Angle": 0,
        "HWDecode": 0,
        "Path": "/Users/hugh/Downloads/videos/stones.mpg",
        "Range": {
            "End": 1,
            "Start": 1,
            "Type": "chapter"
        },
        "Title": 1
    },
    "Subtitle": {
        "Search": {
            "Burn": true,
            "Default": false,
            "Enable": false,
            "Forced": false
        },
        "SubtitleList": []
    },
    "Video": {
        "ChromaLocation": 1,
        "ColorInputFormat": 0,
        "ColorMatrix": 1,
        "ColorOutputFormat": 0,
        "ColorPrimaries": 1,
        "ColorRange": 1,
        "ColorTransfer": 1,
        "Encoder": "vt_h265_10bit",
        "HardwareDecode": 0,
        "MultiPass": false,
        "QSV": {
            "AdapterIndex": 0,
            "AsyncDepth": 0,
            "Decode": false
        },
        "Quality": 22.0,
        "Turbo": false
    }
}
[08:49:35] Starting Task: Encoding Pass
[08:49:35] job configuration:
[08:49:35]  * source
[08:49:35]    + /Users/hugh/Downloads/videos/stones.mpg
[08:49:35]    + title 1, chapter(s) 1 to 1
[08:49:35]  * destination
[08:49:35]    + /Users/hugh/Movies/TiVoShows/Test/stones.mp4
[08:49:35]    + container: MPEG-4 (libavformat)
[08:49:35]  * video track
[08:49:35]    + decoder: mpeg2video 8-bit (yuv420p)
[08:49:35]      + bitrate 200 kbps
[08:49:35]    + filters
[08:49:35]      + Framerate Shaper (mode=0)
[08:49:35]        + frame rate: same as source (around 29.970 fps)
[08:49:35]      + Crop and Scale (width=1920:height=816:crop-top=126:crop-bottom=138:crop-left=0:crop-right=0)
[08:49:35]        + source: 1920 * 1080, crop (126/138/0/0): 1920 * 816, scale: 1920 * 816
[08:49:35]      + Format (format=p010le)
[08:49:35]    + Output geometry
[08:49:35]      + storage dimensions: 1920 x 816
[08:49:35]      + pixel aspect ratio: 1 : 1
[08:49:35]      + display dimensions: 1920 x 816
[08:49:35]    + encoder: H.265 10-bit (VideoToolbox)
[08:49:35]      + quality: 22.00 (CQ)
[08:49:35]      + color profile: 1-1-1
[08:49:35]      + chroma location: left
[08:49:35]  * audio track 1
[08:49:35]    + decoder: Unknown (AC3, 2.0 ch, 384 kbps) (track 1, id 0x8000bd)
[08:49:35]      + bitrate: 384 kbps, samplerate: 48000 Hz
[08:49:35]    + AC3 Passthru
[08:49:35] file is MPEG Program Stream
[08:49:35] Found program stream map
[08:49:35] Found program stream map
[08:49:35] Found program stream map
[08:49:35] Found program stream map
[08:49:35] Found program stream map
[08:49:35] Found program stream map
...rest deleted...
HandBrake Activity Log 1.8.2

Code: Select all

[08:53:28] Compile-time hardening features are enabled
[08:53:28] hb_init: starting libhb thread
[08:53:28] thread 16fd0f000 started ("libhb")
HandBrake 1.8.2 (2024081000) - Darwin arm64 - https://handbrake.fr
8 CPUs detected
Opening /Users/hugh/Downloads/videos/stones.mpg...
[08:53:28] CPU: Apple M1
[08:53:28]  - logical processor count: 8
[08:53:28] hb_scan: path=/Users/hugh/Downloads/videos/stones.mpg, title_index=1
udfread ERROR: ECMA 167 Volume Recognition failed
disc.c:333: failed opening UDF image /Users/hugh/Downloads/videos/stones.mpg
disc.c:437: error opening file BDMV/index.bdmv
disc.c:437: error opening file BDMV/BACKUP/index.bdmv
[08:53:28] bd: not a bd - trying as a stream/file instead
libdvdread: DVDOpenFileUDF:UDFFindFile /VIDEO_TS/VIDEO_TS.IFO failed
libdvdnav: vm: vm: failed to read VIDEO_TS.IFO
[08:53:28] dvd: not a dvd - trying as a stream/file instead
[08:53:28] file is MPEG Program Stream
[08:53:28] Found program stream map
<<many duplicates of "Found program stream map"
[08:53:28] Found program stream map
[08:53:28] Found the following streams
[08:53:28]     Video Streams : 
[08:53:28]       0xe0-0x0 type MPEG2 (0x2)
[08:53:28]     Audio Streams : 
[08:53:28]       0xbd-0x0 type AC3 (0x81)
[08:53:28]       0xbd-0x80 type AC3 (0x81)
[08:53:28]     Subtitle Streams : 
[08:53:28]     Other Streams : 
[08:53:28] stream id 0xbd (type 0x81 substream 0x0) audio 0xbd
[08:53:28] stream id 0xbd (type 0x81 substream 0x80) audio 0x8000bd
[08:53:28] scan: decoding previews for title 1
[08:53:28] file is MPEG Program Stream
[08:53:28] Found program stream map
<<many duplicates of "Found program stream map"
[08:53:28] Found program stream map
[08:53:28] scan: audio 0x8000bd: ac3, rate=48000Hz, bitrate=384000 Unknown (AC3, 2.0 ch, 384 kbps)

Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 3, 30.00 %[08:53:32] stream: 11 good frames, 0 errors (0%)
[08:53:32] using bitstream PAR 1:1
[08:53:32] scan: 10 previews, 1920x1080, 29.970 fps, autocrop = 126/138/0/0, aspect 16:9, PAR 1:1, color profile: 1-1-1, chroma location: left
[08:53:32] scan: removing audio 0xbd because no bitrate found
[08:53:32] libhb: scan thread found 1 valid title(s)
+ Using preset: CLI Default
+ title 1:
  + stream: /Users/hugh/Downloads/videos/stones.mpg
  + duration: 01:39:50
  + size: 1920x1080, pixel aspect: 1/1, display aspect: 1.78, 29.970 fps
  + autocrop: 126/138/0/0
  + chapters:
    + 1: duration 01:39:50
  + audio tracks:
    + 1, Unknown (AC3, 2.0 ch, 384 kbps) (iso639-2: und), 48000Hz, 384000bps
  + subtitle tracks:
    + 1, Unknown, Closed Caption [CC608]
[08:53:32] Starting work at: Mon Aug 26 08:53:32 2024

[08:53:32] 1 job(s) to process
[08:53:32] json job:
{
    "Audio": {
        "AudioList": [
            {
                "Bitrate": 0,
                "DRC": 0.0,
                "Encoder": "copy:ac3",
                "Mixdown": "none",
                "PresetEncoder": "copy",
                "Quality": -3.0,
                "Samplerate": 0,
                "Track": 1
            }
        ],
        "CopyMask": [
            "copy:ac3"
        ],
        "FallbackEncoder": "ca_aac"
    },
    "Destination": {
        "AlignAVStart": false,
        "ChapterList": [
            {
                "Duration": {
                    "Hours": 1,
                    "Minutes": 39,
                    "Seconds": 50,
                    "Ticks": 539142550
                },
                "Name": "Chapter 1"
            }
        ],
        "ChapterMarkers": false,
        "File": "/Users/hugh/Movies/TiVoShows/Test/stonesNew.mp4",
        "InlineParameterSets": false,
        "Mux": "m4v",
        "Options": {
            "IpodAtom": false,
            "Optimize": false
        }
    },
    "Filters": {
        "FilterList": [
            {
                "ID": 11,
                "Settings": {
                    "mode": 0
                }
            },
            {
                "ID": 20,
                "Settings": {
                    "crop-bottom": 138,
                    "crop-left": 0,
                    "crop-right": 0,
                    "crop-top": 126,
                    "height": 816,
                    "width": 1920
                }
            }
        ]
    },
    "Metadata": {},
    "PAR": {
        "Den": 1,
        "Num": 1
    },
    "SequenceID": 0,
    "Source": {
        "Angle": 0,
        "HWDecode": 0,
        "Path": "/Users/hugh/Downloads/videos/stones.mpg",
        "Range": {
            "End": 1,
            "Start": 1,
            "Type": "chapter"
        },
        "Title": 1
    },
    "Subtitle": {
        "Search": {
            "Burn": true,
            "Default": false,
            "Enable": false,
            "Forced": false
        },
        "SubtitleList": []
    },
    "Video": {
        "ChromaLocation": 1,
        "ColorInputFormat": 0,
        "ColorMatrix": 1,
        "ColorOutputFormat": 0,
        "ColorPrimaries": 1,
        "ColorRange": 1,
        "ColorTransfer": 1,
        "Encoder": "vt_h265_10bit",
        "HardwareDecode": 0,
        "MultiPass": false,
        "QSV": {
            "AdapterIndex": 0,
            "AsyncDepth": 0,
            "Decode": false
        },
        "Quality": 22.0,
        "Turbo": false
    }
}
[08:53:32] Starting Task: Encoding Pass
[08:53:32] job configuration:
[08:53:32]  * source
[08:53:32]    + /Users/hugh/Downloads/videos/stones.mpg
[08:53:32]    + title 1, chapter(s) 1 to 1
[08:53:32]  * destination
[08:53:32]    + /Users/hugh/Movies/TiVoShows/Test/stonesNew.mp4
[08:53:32]    + container: MPEG-4 (libavformat)
[08:53:32]  * video track
[08:53:32]    + decoder: mpeg2video 8-bit (yuv420p)
[08:53:32]      + bitrate 200 kbps
[08:53:32]    + filters
[08:53:32]      + Framerate Shaper (mode=0)
[08:53:32]        + frame rate: same as source (around 29.970 fps)
[08:53:32]      + Crop and Scale (width=1920:height=816:crop-top=126:crop-bottom=138:crop-left=0:crop-right=0)
[08:53:32]        + source: 1920 * 1080, crop (126/138/0/0): 1920 * 816, scale: 1920 * 816
[08:53:32]      + Format (format=p010le)
[08:53:32]    + Output geometry
[08:53:32]      + storage dimensions: 1920 x 816
[08:53:32]      + pixel aspect ratio: 1 : 1
[08:53:32]      + display dimensions: 1920 x 816
[08:53:32]    + encoder: H.265 10-bit (VideoToolbox)
[08:53:32]      + quality: 22.00 (CQ)
[08:53:32]      + color profile: 1-1-1
[08:53:32]      + color range: tv
[08:53:32]      + chroma location: left
[08:53:32] file is MPEG Program Stream
[08:53:32] Found program stream map
[08:53:32] Found program stream map
[08:53:32] Found program stream map
[08:53:32] Found program stream map
...rest deleted...
HandBrake Activity Log Nightly GUI

Code: Select all

[15:51:54] macgui: Handbrake Version: 20240826083600-8fc890347-master (2024082601)
[15:51:54] Compile-time hardening features are enabled
[15:51:54] macgui: built-in presets updated
[15:51:54] hb_init: starting libhb thread
[15:51:54] macgui: Failed to create bookmark: Error Domain=NSCocoaErrorDomain Code=256 "Could not open() the item" UserInfo={NSURL=file:///Users/hugh/Library/Containers/fr.handbrake.HandBrake/Data/Movies/, NSDebugDescription=Could not open() the item}
[15:52:15] macgui: ScanCore scanning titles with a duration of 10 seconds or more
[15:52:15] CPU: Apple M1
[15:52:15]  - logical processor count: 8
[15:52:15] hb_scan: path=/Users/hugh/Downloads/videos/stones.mpg, title_index=0
udfread ERROR: ECMA 167 Volume Recognition failed
disc.c:333: failed opening UDF image /Users/hugh/Downloads/videos/stones.mpg
disc.c:437: error opening file BDMV/index.bdmv
disc.c:437: error opening file BDMV/BACKUP/index.bdmv
[15:52:15] bd: not a bd - trying as a stream/file instead
libdvdread: DVDOpenFileUDF:UDFFindFile /VIDEO_TS/VIDEO_TS.IFO failed
libdvdnav: vm: vm: failed to read VIDEO_TS.IFO
[15:52:15] dvd: not a dvd - trying as a stream/file instead
[15:52:15] file is MPEG Program Stream
[15:52:15] Found program stream map
<<many duplicates of "Found program stream map"
[15:52:15] Found program stream map
[15:52:15] Found the following streams
[15:52:15]     Video Streams : 
[15:52:15]       0xe0-0x0 type MPEG2 (0x2)
[15:52:15]     Audio Streams : 
[15:52:15]       0xbd-0x0 type AC3 (0x81)
[15:52:15]       0xbd-0x80 type AC3 (0x81)
[15:52:15]     Subtitle Streams : 
[15:52:15]     Other Streams : 
[15:52:15] stream id 0xbd (type 0x81 substream 0x0) audio 0xbd
[15:52:15] stream id 0xbd (type 0x81 substream 0x80) audio 0x8000bd
[15:52:15] scan: decoding previews for title 1
[15:52:15] file is MPEG Program Stream
[15:52:15] Found program stream map
<<many duplicates of "Found program stream map"
[15:52:15] Found program stream map
[15:52:15] scan: audio 0x8000bd: ac3, rate=48000Hz, bitrate=384000 Unknown (AC3, 2.0 ch, 384 kbps)
[15:52:19] stream: 11 good frames, 0 errors (0%)
[15:52:19] using bitstream PAR 1:1
[15:52:19] scan: 10 previews, 1920x1080, 29.970 fps, autocrop = 126/138/0/0, aspect 16:9, PAR 1:1, color profile: 1-1-1, chroma location: left
[15:52:19] scan: removing audio 0xbd because no bitrate found
[15:52:19] libhb: scan thread found 1 valid title(s)
[15:52:19] macgui: ScanCore scan done
[swscaler @ 0x1200b0000] [swscaler @ 0x1200c0000] No accelerated colorspace conversion found from yuv420p to bgra.
[swscaler @ 0x1200b0000] [swscaler @ 0x1200d0000] No accelerated colorspace conversion found from yuv420p to bgra.
[swscaler @ 0x1200b0000] [swscaler @ 0x1200e0000] No accelerated colorspace conversion found from yuv420p to bgra.
[swscaler @ 0x1200b0000] [swscaler @ 0x1201a8000] No accelerated colorspace conversion found from yuv420p to bgra.
[swscaler @ 0x1200b0000] [swscaler @ 0x1201b8000] No accelerated colorspace conversion found from yuv420p to bgra.
[swscaler @ 0x1200b0000] [swscaler @ 0x1201c8000] No accelerated colorspace conversion found from yuv420p to bgra.
[swscaler @ 0x1200b0000] [swscaler @ 0x1201d8000] No accelerated colorspace conversion found from yuv420p to bgra.
[swscaler @ 0x1200b0000] [swscaler @ 0x1201e8000] No accelerated colorspace conversion found from yuv420p to bgra.
[swscaler @ 0x1200b0000] [swscaler @ 0x1201f8000] No accelerated colorspace conversion found from yuv420p to bgra.
[swscaler @ 0x138018000] [swscaler @ 0x138028000] No accelerated colorspace conversion found from yuv420p to bgra.
[swscaler @ 0x138018000] [swscaler @ 0x138070000] No accelerated colorspace conversion found from yuv420p to bgra.
[swscaler @ 0x138018000] [swscaler @ 0x138080000] No accelerated colorspace conversion found from yuv420p to bgra.
[swscaler @ 0x138018000] [swscaler @ 0x138090000] No accelerated colorspace conversion found from yuv420p to bgra.
[swscaler @ 0x138018000] [swscaler @ 0x1380a0000] No accelerated colorspace conversion found from yuv420p to bgra.
[swscaler @ 0x138018000] [swscaler @ 0x1380b0000] No accelerated colorspace conversion found from yuv420p to bgra.
[swscaler @ 0x138018000] [swscaler @ 0x1380c0000] No accelerated colorspace conversion found from yuv420p to bgra.
[swscaler @ 0x138018000] [swscaler @ 0x1380d0000] No accelerated colorspace conversion found from yuv420p to bgra.
[swscaler @ 0x138018000] [swscaler @ 0x1380e0000] No accelerated colorspace conversion found from yuv420p to bgra.
[swscaler @ 0x130008000] [swscaler @ 0x130018000] No accelerated colorspace conversion found from yuv420p to bgra.
[swscaler @ 0x130008000] [swscaler @ 0x130098000] No accelerated colorspace conversion found from yuv420p to bgra.
[swscaler @ 0x130008000] [swscaler @ 0x1300a8000] No accelerated colorspace conversion found from yuv420p to bgra.
[swscaler @ 0x130008000] [swscaler @ 0x1300b8000] No accelerated colorspace conversion found from yuv420p to bgra.
[swscaler @ 0x130008000] [swscaler @ 0x1300c8000] No accelerated colorspace conversion found from yuv420p to bgra.
[swscaler @ 0x130008000] [swscaler @ 0x1300d8000] No accelerated colorspace conversion found from yuv420p to bgra.
[swscaler @ 0x130008000] [swscaler @ 0x1300e8000] No accelerated colorspace conversion found from yuv420p to bgra.
[swscaler @ 0x130008000] [swscaler @ 0x1300f8000] No accelerated colorspace conversion found from yuv420p to bgra.
[swscaler @ 0x130008000] [swscaler @ 0x130108000] No accelerated colorspace conversion found from yuv420p to bgra.
[15:55:13] Compile-time hardening features are enabled
[15:55:13] hb_init: starting libhb thread
[15:55:13] macgui: fr.handbrake.HandBrakeXPCService scanning specifically for title: 1
[15:55:13] CPU: Apple M1
[15:55:13]  - logical processor count: 8
[15:55:13] hb_scan: path=/Users/hugh/Downloads/videos/stones.mpg, title_index=1
udfread ERROR: ECMA 167 Volume Recognition failed
disc.c:333: failed opening UDF image /Users/hugh/Downloads/videos/stones.mpg
disc.c:437: error opening file BDMV/index.bdmv
disc.c:437: error opening file BDMV/BACKUP/index.bdmv
[15:55:13] bd: not a bd - trying as a stream/file instead
libdvdread: DVDOpenFileUDF:UDFFindFile /VIDEO_TS/VIDEO_TS.IFO failed
libdvdnav: vm: vm: failed to read VIDEO_TS.IFO
[15:55:13] dvd: not a dvd - trying as a stream/file instead
[15:55:13] file is MPEG Program Stream
[15:55:13] Found program stream map
<<many duplicates of "Found program stream map"
[15:55:13] Found program stream map
[15:55:13] Found the following streams
[15:55:13]     Video Streams : 
[15:55:13]       0xe0-0x0 type MPEG2 (0x2)
[15:55:13]     Audio Streams : 
[15:55:13]       0xbd-0x0 type AC3 (0x81)
[15:55:13]       0xbd-0x80 type AC3 (0x81)
[15:55:13]     Subtitle Streams : 
[15:55:13]     Other Streams : 
[15:55:13] stream id 0xbd (type 0x81 substream 0x0) audio 0xbd
[15:55:13] stream id 0xbd (type 0x81 substream 0x80) audio 0x8000bd
[15:55:13] scan: decoding previews for title 1
[15:55:13] file is MPEG Program Stream
[15:55:13] Found program stream map
<<many duplicates of "Found program stream map"
[15:55:13] Found program stream map
[15:55:13] scan: audio 0x8000bd: ac3, rate=48000Hz, bitrate=384000 Unknown (AC3, 2.0 ch, 384 kbps)
[15:55:16] stream: 11 good frames, 0 errors (0%)
[15:55:16] using bitstream PAR 1:1
[15:55:16] scan: 10 previews, 1920x1080, 29.970 fps, autocrop = 126/138/0/0, aspect 16:9, PAR 1:1, color profile: 1-1-1, chroma location: left
[15:55:16] scan: removing audio 0xbd because no bitrate found
[15:55:17] libhb: scan thread found 1 valid title(s)
[15:55:17] macgui: fr.handbrake.HandBrakeXPCService scan done
[15:55:17] macgui: fr.handbrake.HandBrakeXPCService started encoding stonesGUI.mp4
[15:55:17] macgui: fr.handbrake.HandBrakeXPCService with preset H.265 Apple VideoToolbox 1080p (Modified)
[15:55:17] Starting work at: Mon Aug 26 15:55:17 2024

[15:55:17] 1 job(s) to process
[15:55:17] Starting Task: Encoding Pass
[15:55:17] work: only 1 chapter, disabling chapter markers
[15:55:17] job configuration:
[15:55:17]  * source
[15:55:17]    + /Users/hugh/Downloads/videos/stones.mpg
[15:55:17]    + title 1, chapter(s) 1 to 1
[15:55:17]  * destination
[15:55:17]    + /Users/hugh/Downloads/videos/stonesGUI.mp4
[15:55:17]    + container: MPEG-4 (libavformat)
[15:55:17]  * video track
[15:55:17]    + decoder: mpeg2video 8-bit (yuv420p)
[15:55:17]      + bitrate 200 kbps
[15:55:17]    + filters
[15:55:17]      + Framerate Shaper (mode=0:rate=27000000/900900)
[15:55:17]        + frame rate: same as source (around 29.970 fps)
[15:55:17]      + Crop and Scale (width=1280:height=720:crop-top=126:crop-bottom=138:crop-left=0:crop-right=0)
[15:55:17]        + source: 1920 * 1080, crop (126/138/0/0): 1920 * 816, scale: 1280 * 720
[15:55:17]    + Output geometry
[15:55:17]      + storage dimensions: 1280 x 720
[15:55:17]      + pixel aspect ratio: 45 : 34
[15:55:17]      + display dimensions: 1694 x 720
[15:55:17]    + encoder: H.265 (VideoToolbox)
[15:55:17]      + preset:  speed
[15:55:17]      + profile: auto
[15:55:17]      + quality: 60.00 (CQ)
[15:55:17]      + color profile: 1-1-1
[15:55:17]      + color range: tv
[15:55:17]      + chroma location: left
[15:55:17]  * audio track 1
[15:55:17]    + decoder: Unknown (AC3, 2.0 ch, 384 kbps) (track 2, id 0x8000bd)
[15:55:17]      + bitrate: 384 kbps, samplerate: 48000 Hz
[15:55:17]    + AC3 Passthru
[15:55:17] file is MPEG Program Stream
[15:55:17] Found program stream map
[15:55:17] Found program stream map
[15:55:17] Found program stream map
[15:55:17] Found program stream map

...rest deleted...
Rodeo314
Enlightened
Posts: 107
Joined: Wed Jan 17, 2024 3:44 am

Re: HandBrakeCLI Regression: 1.8.x not passing through AC3 audio track

Post by Rodeo314 »

mackworth2 wrote: Mon Aug 26, 2024 11:36 pm HBCLI today's nightly: no audio
That's not expected, we would need to see a log for that please.
mackworth2
Posts: 8
Joined: Sun Sep 25, 2016 7:03 am

Re: HandBrakeCLI Regression: 1.8.x not passing through AC3 audio track

Post by mackworth2 »

Sorry for delay; I didn't get a notification that you had replied reply.

Here's the log for the 8-26 nightly. I don't see any material differences from 1.8.2.
(I reran just now with 8-30 nightly as well; log included for completeness below)

Code: Select all

[12:48:25] Compile-time hardening features are enabled
[12:48:26] hb_init: starting libhb thread
[12:48:26] thread 16b28b000 started ("libhb")
HandBrake 20240826083600-8fc890347-master (2024082601) - Darwin arm64 - https://handbrake.fr
8 CPUs detected
Opening ../videos/stones.mpg...
[12:48:26] CPU: Apple M1
[12:48:26]  - logical processor count: 8
[12:48:26] hb_scan: path=../videos/stones.mpg, title_index=1
udfread ERROR: ECMA 167 Volume Recognition failed
disc.c:333: failed opening UDF image ../videos/stones.mpg
disc.c:437: error opening file BDMV/index.bdmv
disc.c:437: error opening file BDMV/BACKUP/index.bdmv
[12:48:26] bd: not a bd - trying as a stream/file instead
libdvdread: DVDOpenFileUDF:UDFFindFile /VIDEO_TS/VIDEO_TS.IFO failed
libdvdnav: vm: vm: failed to read VIDEO_TS.IFO
[12:48:26] dvd: not a dvd - trying as a stream/file instead
[12:48:26] file is MPEG Program Stream
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found the following streams
[12:48:26]     Video Streams : 
[12:48:26]       0xe0-0x0 type MPEG2 (0x2)
[12:48:26]     Audio Streams : 
[12:48:26]       0xbd-0x0 type AC3 (0x81)
[12:48:26]       0xbd-0x80 type AC3 (0x81)
[12:48:26]     Subtitle Streams : 
[12:48:26]     Other Streams : 
[12:48:26] stream id 0xbd (type 0x81 substream 0x0) audio 0xbd
[12:48:26] stream id 0xbd (type 0x81 substream 0x80) audio 0x8000bd
[12:48:26] scan: decoding previews for title 1
[12:48:26] file is MPEG Program Stream
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] Found program stream map
[12:48:26] scan: audio 0x8000bd: ac3, rate=48000Hz, bitrate=384000 Unknown (AC3, 2.0 ch, 384 kbps)

Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 8, 80.00 %[12:48:30] stream: 11 good frames, 0 errors (0%)
[12:48:30] using bitstream PAR 1:1
[12:48:30] scan: 10 previews, 1920x1080, 29.970 fps, autocrop = 126/138/0/0, aspect 16:9, PAR 1:1, color profile: 1-1-1, chroma location: left
[12:48:30] scan: removing audio 0xbd because no bitrate found
[12:48:30] libhb: scan thread found 1 valid title(s)
+ Using preset: CLI Default
+ title 1:
  + stream: ../videos/stones.mpg
  + duration: 01:39:50
  + size: 1920x1080, pixel aspect: 1/1, display aspect: 1.78, 29.970 fps
  + autocrop: 126/138/0/0
  + chapters:
    + 1: duration 01:39:50
  + audio tracks:
    + 1, Unknown (AC3, 2.0 ch, 384 kbps) (iso639-2: und), 48000Hz, 384000bps
  + subtitle tracks:
    + 1, Unknown, Closed Caption [CC608]
[12:48:30] Starting work at: Mon Aug 26 12:48:30 2024

[12:48:30] 1 job(s) to process
[12:48:30] json job:
{
    "Audio": {
        "AudioList": [
            {
                "Bitrate": 0,
                "DRC": 0.0,
                "Encoder": "copy:ac3",
                "Mixdown": "none",
                "PresetEncoder": "copy",
                "Quality": -3.0,
                "Samplerate": 0,
                "Track": 1
            }
        ],
        "CopyMask": [
            "copy:ac3"
        ],
        "FallbackEncoder": "ca_aac"
    },
    "Destination": {
        "AlignAVStart": false,
        "ChapterList": [
            {
                "Duration": {
                    "Hours": 1,
                    "Minutes": 39,
                    "Seconds": 50,
                    "Ticks": 539142550
                },
                "Name": "Chapter 1"
            }
        ],
        "ChapterMarkers": false,
        "File": "../videos/stonesnightly1.mp4",
        "InlineParameterSets": false,
        "Mux": "m4v",
        "Options": {
            "IpodAtom": false,
            "Optimize": false
        }
    },
    "Filters": {
        "FilterList": [
            {
                "ID": 11,
                "Settings": {
                    "mode": 0
                }
            },
            {
                "ID": 20,
                "Settings": {
                    "crop-bottom": 138,
                    "crop-left": 0,
                    "crop-right": 0,
                    "crop-top": 126,
                    "height": 816,
                    "width": 1920
                }
            }
        ]
    },
    "Metadata": {},
    "PAR": {
        "Den": 1,
        "Num": 1
    },
    "SequenceID": 0,
    "Source": {
        "Angle": 0,
        "HWDecode": 0,
        "KeepDuplicateTitles": false,
        "Path": "../videos/stones.mpg",
        "Range": {
            "End": 1,
            "Start": 1,
            "Type": "chapter"
        },
        "Title": 1
    },
    "Subtitle": {
        "Search": {
            "Burn": true,
            "Default": false,
            "Enable": false,
            "Forced": false
        },
        "SubtitleList": []
    },
    "Video": {
        "ChromaLocation": 1,
        "ColorInputFormat": 0,
        "ColorMatrix": 1,
        "ColorOutputFormat": 0,
        "ColorPrimaries": 1,
        "ColorRange": 1,
        "ColorTransfer": 1,
        "Encoder": "vt_h265_10bit",
        "HardwareDecode": 0,
        "MultiPass": false,
        "QSV": {
            "AdapterIndex": 0,
            "AsyncDepth": 0,
            "Decode": false
        },
        "Quality": 22.0,
        "Turbo": false
    }
}
[12:48:30] Starting Task: Encoding Pass
[12:48:30] job configuration:
[12:48:30]  * source
[12:48:30]    + ../videos/stones.mpg
[12:48:30]    + title 1, chapter(s) 1 to 1
[12:48:30]  * destination
[12:48:30]    + ../videos/stonesnightly1.mp4
[12:48:30]    + container: MPEG-4 (libavformat)
[12:48:30]  * video track
[12:48:30]    + decoder: mpeg2video 8-bit (yuv420p)
[12:48:30]      + bitrate 200 kbps
[12:48:30]    + filters
[12:48:30]      + Framerate Shaper (mode=0)
[12:48:30]        + frame rate: same as source (around 29.970 fps)
[12:48:30]      + Crop and Scale (width=1920:height=816:crop-top=126:crop-bottom=138:crop-left=0:crop-right=0)
[12:48:30]        + source: 1920 * 1080, crop (126/138/0/0): 1920 * 816, scale: 1920 * 816
[12:48:30]      + Format (format=p010le)
[12:48:30]    + Output geometry
[12:48:30]      + storage dimensions: 1920 x 816
[12:48:30]      + pixel aspect ratio: 1 : 1
[12:48:30]      + display dimensions: 1920 x 816
[12:48:30]    + encoder: H.265 10-bit (VideoToolbox)
[12:48:30]      + quality: 22.00 (CQ)
[12:48:30]      + color profile: 1-1-1
[12:48:30]      + color range: tv
[12:48:30]      + chroma location: left
[12:48:30] file is MPEG Program Stream
[12:48:30] Found program stream map
[12:48:30] Found program stream map
[12:48:30] Found program stream map
[12:48:30] Found program stream map
[12:48:30] Found program stream map
[12:48:30] Found program stream map
[12:48:30] Found program stream map
[12:48:30] Found program stream map
[12:48:30] Found program stream map
[12:48:30] Found program stream map
[12:48:30] Found program stream map
[12:48:30] Found program stream map
[12:48:30] Found program stream map
[12:48:30] Found program stream map
[12:48:30] Found program stream map
[12:48:30] Found program stream map
[12:48:30] Found program stream map
[12:48:30] Found program stream map
[12:48:30] Found program stream map
[12:48:30] Found program stream map
[12:48:30] Found program stream map
[12:48:30] Found program stream map
[12:48:30] Found program stream map
[12:48:30] Found program stream map
[12:48:30] Found program stream map
[12:48:30] Found program stream map
[12:48:30] Found program stream map
[12:48:30] Found program stream map
[12:48:30] Found program stream map
[12:48:30] Found program stream map
[12:48:30] Found program stream map
[12:48:30] Found program stream map
[12:48:30] Found program stream map
[12:48:30] sync: expecting 179534 video frames
[12:48:30] encvt_Init: encoding with constant quality 22.000000
[12:48:30] encvt_Init: com.apple.videotoolbox.videoencoder.ave.hevc
[12:48:30] sync: first pts video is 0
libdvdread: Can't open file VIDEO_TS.IFO.

Encoding: task 1 of 1, 0.03 %
Encoding: task 1 of 1, 0.08 %
Encoding: task 1 of 1, 0.12 %
Encoding: task 1 of 1, 0.16 %
Encoding: task 1 of 1, 0.20 %
Encoding: task 1 of 1, 0.25 %
Encoding: task 1 of 1, 0.28 %
Encoding: task 1 of 1, 0.33 %
Encoding: task 1 of 1, 0.38 %
Encoding: task 1 of 1, 0.42 %
Encoding: task 1 of 1, 0.46 %
Encoding: task 1 of 1, 0.50 %
Encoding: task 1 of 1, 0.54 %
Encoding: task 1 of 1, 0.58 % (244.88 fps, avg 247.61 fps, ETA 00h12m00s)
Encoding: task 1 of 1, 0.63 % (244.88 fps, avg 247.61 fps, ETA 00h12m00s)
Encoding: task 1 of 1, 0.67 % (244.88 fps, avg 247.61 fps, ETA 00h12m00s)
Encoding: task 1 of 1, 0.71 % (244.88 fps, avg 247.61 fps, ETA 00h12m00s)
Encoding: task 1 of 1, 0.75 % (243.24 fps, avg 246.19 fps, ETA 00h12m04s)
Encoding: task 1 of 1, 0.79 % (243.24 fps, avg 246.19 fps, ETA 00h12m04s)
Encoding: task 1 of 1, 0.84 % (243.24 fps, avg 246.19 fps, ETA 00h12m04s)
Encoding: task 1 of 1, 0.88 % (242.86 fps, avg 245.79 fps, ETA 00h12m04s)
Encoding: task 1 of 1, 0.92 % (242.86 fps, avg 245.79 fps, ETA 00h12m04s)
Encoding: task 1 of 1, 0.96 % (242.86 fps, avg 245.79 fps, ETA 00h12m04s)
[[Delete rest of log]]
Here's the log for the 8/30 nightly of HandBrakeCLI. Command line:

Code: Select all

/HandbrakeCLI -e vt_h265_10bit -E copy --audio-copy-mask ac3 -i stones.mpg -o stones.mp4 &> handbrake.log

Code: Select all


[17:25:16] Compile-time hardening features are enabled
[17:25:16] hb_init: starting libhb thread
[17:25:16] thread 16d56b000 started ("libhb")
HandBrake 20240828070454-8362b8b28-master (2024083001) - Darwin arm64 - https://handbrake.fr
8 CPUs detected
Opening stones.mpg...
[17:25:16] CPU: Apple M1
[17:25:16]  - logical processor count: 8
[17:25:16] hb_scan: path=stones.mpg, title_index=1
udfread ERROR: ECMA 167 Volume Recognition failed
disc.c:333: failed opening UDF image stones.mpg
disc.c:437: error opening file BDMV/index.bdmv
disc.c:437: error opening file BDMV/BACKUP/index.bdmv
[17:25:16] bd: not a bd - trying as a stream/file instead
libdvdread: DVDOpenFileUDF:UDFFindFile /VIDEO_TS/VIDEO_TS.IFO failed
libdvdnav: vm: vm: failed to read VIDEO_TS.IFO
[17:25:16] dvd: not a dvd - trying as a stream/file instead
[17:25:16] file is MPEG Program Stream
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found the following streams
[17:25:16]     Video Streams : 
[17:25:16]       0xe0-0x0 type MPEG2 (0x2)
[17:25:16]     Audio Streams : 
[17:25:16]       0xbd-0x0 type AC3 (0x81)
[17:25:16]       0xbd-0x80 type AC3 (0x81)
[17:25:16]     Subtitle Streams : 
[17:25:16]     Other Streams : 
[17:25:16] stream id 0xbd (type 0x81 substream 0x0) audio 0xbd
[17:25:16] stream id 0xbd (type 0x81 substream 0x80) audio 0x8000bd
[17:25:16] scan: decoding previews for title 1
[17:25:16] file is MPEG Program Stream
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] Found program stream map
[17:25:16] scan: audio 0x8000bd: ac3, rate=48000Hz, bitrate=384000 Unknown (AC3, 2.0 ch, 384 kbps)

Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 1, 10.00 %
Scanning title 1 of 1, preview 10, 100.00 %[17:25:20] stream: 11 good frames, 0 errors (0%)
[17:25:20] using bitstream PAR 1:1
[17:25:20] scan: 10 previews, 1920x1080, 29.970 fps, autocrop = 126/138/0/0, aspect 16:9, PAR 1:1, color profile: 1-1-1, chroma location: left
[17:25:20] scan: removing audio 0xbd because no bitrate found
[17:25:20] libhb: scan thread found 1 valid title(s)
+ Using preset: CLI Default
+ title 1:
  + stream: stones.mpg
  + duration: 01:39:50
  + size: 1920x1080, pixel aspect: 1/1, display aspect: 1.78, 29.970 fps
  + autocrop: 126/138/0/0
  + chapters:
    + 1: duration 01:39:50
  + audio tracks:
    + 1, Unknown (AC3, 2.0 ch, 384 kbps) (iso639-2: und), 48000Hz, 384000bps
  + subtitle tracks:
    + 1, Unknown, Closed Caption [CC608]
[17:25:20] Starting work at: Sat Aug 31 17:25:20 2024

[17:25:20] 1 job(s) to process
[17:25:20] json job:
{
    "Audio": {
        "AudioList": [
            {
                "Bitrate": 0,
                "DRC": 0.0,
                "Encoder": "copy:ac3",
                "Mixdown": "none",
                "PresetEncoder": "copy",
                "Quality": -3.0,
                "Samplerate": 0,
                "Track": 1
            }
        ],
        "CopyMask": [
            "copy:ac3"
        ],
        "FallbackEncoder": "ca_aac"
    },
    "Destination": {
        "AlignAVStart": false,
        "ChapterList": [
            {
                "Duration": {
                    "Hours": 1,
                    "Minutes": 39,
                    "Seconds": 50,
                    "Ticks": 539142550
                },
                "Name": "Chapter 1"
            }
        ],
        "ChapterMarkers": false,
        "File": "stones.mp4",
        "InlineParameterSets": false,
        "Mux": "m4v",
        "Options": {
            "IpodAtom": false,
            "Optimize": false
        }
    },
    "Filters": {
        "FilterList": [
            {
                "ID": 11,
                "Settings": {
                    "mode": 0
                }
            },
            {
                "ID": 20,
                "Settings": {
                    "crop-bottom": 138,
                    "crop-left": 0,
                    "crop-right": 0,
                    "crop-top": 126,
                    "height": 816,
                    "width": 1920
                }
            }
        ]
    },
    "Metadata": {},
    "PAR": {
        "Den": 1,
        "Num": 1
    },
    "SequenceID": 0,
    "Source": {
        "Angle": 0,
        "HWDecode": 0,
        "KeepDuplicateTitles": false,
        "Path": "stones.mpg",
        "Range": {
            "End": 1,
            "Start": 1,
            "Type": "chapter"
        },
        "Title": 1
    },
    "Subtitle": {
        "Search": {
            "Burn": true,
            "Default": false,
            "Enable": false,
            "Forced": false
        },
        "SubtitleList": []
    },
    "Video": {
        "ChromaLocation": 1,
        "ColorInputFormat": 0,
        "ColorMatrix": 1,
        "ColorOutputFormat": 0,
        "ColorPrimaries": 1,
        "ColorRange": 1,
        "ColorTransfer": 1,
        "Encoder": "vt_h265_10bit",
        "HardwareDecode": 0,
        "MultiPass": false,
        "QSV": {
            "AdapterIndex": 0,
            "AsyncDepth": 0,
            "Decode": false
        },
        "Quality": 22.0,
        "Turbo": false
    }
}
[17:25:20] Starting Task: Encoding Pass
[17:25:20] job configuration:
[17:25:20]  * source
[17:25:20]    + stones.mpg
[17:25:20]    + title 1, chapter(s) 1 to 1
[17:25:20]  * destination
[17:25:20]    + stones.mp4
[17:25:20]    + container: MPEG-4 (libavformat)
[17:25:20]  * video track
[17:25:20]    + decoder: mpeg2video 8-bit (yuv420p)
[17:25:20]      + bitrate 200 kbps
[17:25:20]    + filters
[17:25:20]      + Framerate Shaper (mode=0)
[17:25:20]        + frame rate: same as source (around 29.970 fps)
[17:25:20]      + Crop and Scale (width=1920:height=816:crop-top=126:crop-bottom=138:crop-left=0:crop-right=0)
[17:25:20]        + source: 1920 * 1080, crop (126/138/0/0): 1920 * 816, scale: 1920 * 816
[17:25:20]      + Format (format=p010le)
[17:25:20]    + Output geometry
[17:25:20]      + storage dimensions: 1920 x 816
[17:25:20]      + pixel aspect ratio: 1 : 1
[17:25:20]      + display dimensions: 1920 x 816
[17:25:20]    + encoder: H.265 10-bit (VideoToolbox)
[17:25:20]      + quality: 22.00 (CQ)
[17:25:20]      + color profile: 1-1-1
[17:25:20]      + color range: tv
[17:25:20]      + chroma location: left
[17:25:20] file is MPEG Program Stream
[17:25:20] Found program stream map
[17:25:20] Found program stream map
[17:25:20] Found program stream map
[17:25:20] Found program stream map
[17:25:20] Found program stream map
[17:25:20] Found program stream map
[17:25:20] Found program stream map
[17:25:20] Found program stream map
[17:25:20] Found program stream map
[17:25:20] Found program stream map
[17:25:20] Found program stream map
[17:25:20] Found program stream map
[17:25:20] Found program stream map
[17:25:20] Found program stream map
[17:25:20] Found program stream map
[17:25:20] Found program stream map
[17:25:20] Found program stream map
[17:25:20] Found program stream map
[17:25:20] Found program stream map
[17:25:20] Found program stream map
[17:25:20] Found program stream map
[17:25:20] Found program stream map
[17:25:20] Found program stream map
[17:25:20] Found program stream map
[17:25:20] Found program stream map
[17:25:20] Found program stream map
[17:25:20] Found program stream map
[17:25:20] Found program stream map
[17:25:20] Found program stream map
[17:25:20] Found program stream map
[17:25:20] Found program stream map
[17:25:20] Found program stream map
[17:25:20] Found program stream map
[17:25:20] sync: expecting 179534 video frames
[17:25:20] encvt_Init: encoding with constant quality 22.000000
[17:25:20] encvt_Init: com.apple.videotoolbox.videoencoder.ave.hevc
[17:25:20] sync: first pts video is 0
libdvdread: Can't open file VIDEO_TS.IFO.

Encoding: task 1 of 1, 0.03 %
Encoding: task 1 of 1, 0.07 %
Encoding: task 1 of 1, 0.12 %
Encoding: task 1 of 1, 0.16 %
Encoding: task 1 of 1, 0.20 %
Encoding: task 1 of 1, 0.24 %
Encoding: task 1 of 1, 0.28 %
Encoding: task 1 of 1, 0.32 %
Encoding: task 1 of 1, 0.37 %
Encoding: task 1 of 1, 0.42 %
Encoding: task 1 of 1, 0.46 %
Encoding: task 1 of 1, 0.49 %
Encoding: task 1 of 1, 0.54 %
Encoding: task 1 of 1, 0.58 % (250.08 fps, avg 250.08 fps, ETA 00h11m54s)
Encoding: task 1 of 1, 0.62 % (243.94 fps, avg 247.96 fps, ETA 00h11m59s)
Encoding: task 1 of 1, 0.66 % (243.94 fps, avg 247.96 fps, ETA 00h11m59s)
Encoding: task 1 of 1, 0.70 % (243.94 fps, avg 247.96 fps, ETA 00h11m59s)
Encoding: task 1 of 1, 0.74 % (243.09 fps, avg 246.93 fps, ETA 00h12m01s)
Encoding: task 1 of 1, 0.78 % (243.09 fps, avg 246.93 fps, ETA 00h12m01s)
Encoding: task 1 of 1, 0.83 % (243.09 fps, avg 246.93 fps, ETA 00h12m01s)
Encoding: task 1 of 1, 0.87 % (242.24 fps, avg 246.13 fps, ETA 00h12m03s)
Encoding: task 1 of 1, 0.91 % (242.24 fps, avg 246.13 fps, ETA 00h12m03s)
Encoding: task 1 of 1, 0.95 % (242.24 fps, avg 246.13 fps, ETA 00h12m03s)

[[deleted rest of log.]]
Rodeo314
Enlightened
Posts: 107
Joined: Wed Jan 17, 2024 3:44 am

Re: HandBrakeCLI Regression: 1.8.x not passing through AC3 audio track

Post by Rodeo314 »

Nevermind, I misread the previous logs.

Code: Select all

scan: removing audio 0xbd because no bitrate found
…is present in all logs including version 1.7.3, it's audio 0x8000bd that gets encoded.

Still, odd, the JSON job should be encoding an audio track:

Code: Select all

"Audio": {
        "AudioList": [
            {
                "Bitrate": 0,
                "DRC": 0.0,
                "Encoder": "copy:ac3",
                "Mixdown": "none",
                "PresetEncoder": "copy",
                "Quality": -3.0,
                "Samplerate": 0,
                "Track": 1
            }
        ],
        "CopyMask": [
            "copy:ac3"
        ],
        "FallbackEncoder": "ca_aac"
    },
But there's nothing in the job configuration. So there appears to be some issue, just not the one I was thinking of.

Not sure what it might be TBH, but another developer might be able to chime in.
RedAero
Posts: 4
Joined: Thu Apr 11, 2019 2:29 pm

Re: HandBrakeCLI Regression: 1.8.x not passing through AC3 audio track

Post by RedAero »

I'm getting similarly missing audio recently from a bunch of files. Also passthrough, but AAC LTP, not AC3. Activity logs are almost all blank for some reason - I managed to get one out by setting the log level higher, but it does not have the same bitrate error. What it does have, however, is nearly 8000 lines of

[aac_adtstoasc @ 000001b723fb5d40] Error parsing ADTS frame header!
rollin_eng
Veteran User
Posts: 4957
Joined: Wed May 04, 2011 11:06 pm

Re: HandBrakeCLI Regression: 1.8.x not passing through AC3 audio track

Post by rollin_eng »

RedAero wrote: Tue Oct 15, 2024 4:39 pm I managed to get one out by setting the log level higher, but it does not have the same bitrate error. What it does have, however, is nearly 8000 lines of

[aac_adtstoasc @ 000001b723fb5d40] Error parsing ADTS frame header!
Could you please post your HB logs, minus the 8000 error lines, instructions can be found here:

https://handbrake.fr/docs/en/latest/hel ... y-log.html
RedAero
Posts: 4
Joined: Thu Apr 11, 2019 2:29 pm

Re: HandBrakeCLI Regression: 1.8.x not passing through AC3 audio track

Post by RedAero »

Here's one. There were a couple non. ADTS error lines in the removed bit but it's kind of hard to check.

Code: Select all

HandBrake 1.8.2 (2024081000)
OS: Microsoft Windows NT 10.0.19045.0
CPU: AMD Ryzen 7 5800X 8-Core Processor             
Ram: 49077 MB, 
GPU Information:
  NVIDIA GeForce RTX 3070 - 32.0.15.6590
Screen: 1920x1080
Temp Dir: C:\Users\Admin\AppData\Local\Temp\
Install Dir: C:\Program Files\HandBrake\
Data Dir: C:\Users\Admin\AppData\Roaming\HandBrake

-------------------------------------------
[18:31:44] hb_init: starting libhb thread
avformatMux: track 1 av_bsf_receive_packet failed
Last error repeated 24 times
avformatMux: track 1 av_bsf_receive_packet failed

 # Starting Scan ...

[aac_adtstoasc @ 000001b723fb5d40] Error parsing ADTS frame header!
[18:31:44] thread 16 started ("libhb")
[aac_adtstoasc @ 000001b723fb5d40] Error parsing ADTS frame header!
[aac_adtstoasc @ 000001b723fb5d40] Error parsing ADTS frame header!
[aac_adtstoasc @ 000001b723fb5d40] Error parsing ADTS frame header!
[aac_adtstoasc @ 000001b723fb5d40] Error parsing ADTS frame header!
[aac_adtstoasc @ 000001b723fb5d40] Error parsing ADTS frame header!
[18:31:44] CPU: Unknown
[18:31:44]  - logical processor count: 16
[18:31:44] Intel Quick Sync Video support: no
[18:31:44] hb_scan: path=J:\Compress\fhhd.mp4, title_index=0
[18:31:44] thread 17 started ("scan")
Input #0, mov,mp4,m4a,3gp,3g2,mj2, from 'J:\Compress\fhhd.mp4':
  Metadata:
    major_brand     : isom
    minor_version   : 512
    compatible_brands: isomiso2avc1mp41
    encoder         : Lavf57.71.100
  Duration: 00:25:01.85, start: 0.000000, bitrate: 6930 kb/s
  Stream #0:0[0x1](und): Video: h264 (Constrained Baseline) (avc1 / 0x31637661), yuv420p(progressive), 1440x1080 [SAR 4:3 DAR 16:9], 6800 kb/s, 25 fps, 25 tbr, 12800 tbn (default)
      Metadata:
        handler_name    : VideoHandler
        vendor_id       : [0][0][0][0]
  Stream #0:1[0x2](eng): Audio: aac (mp4a / 0x6134706D), 48000 Hz, stereo, fltp, 125 kb/s (default)
      Metadata:
        handler_name    : SoundHandler
        vendor_id       : [0][0][0][0]
[18:31:44] Found ffmpeg 0 chapters, container=mov,mp4,m4a,3gp,3g2,mj2
[18:31:44] scan: decoding previews for title 1
[18:31:44] scan: preview 1
[aac_adtstoasc @ 000001b733bff1c0] Error parsing ADTS frame header!
[18:31:44] fifo_close: trashing 0 buffer(s)
[18:31:44] scan: audio 0x1: aac, rate=48000Hz, bitrate=125375 English (AAC, 2.0 ch, 125 kbps)
[18:31:44] scan: preview 2
[18:31:44] scan: preview 3
[aac_adtstoasc @ 000001b723fb5d40] Error parsing ADTS frame header!
[aac_adtstoasc @ 000001b723fb5d40] Error parsing ADTS frame header!
[aac_adtstoasc @ 000001b723fb5d40] Error parsing ADTS frame header!
[aac_adtstoasc @ 000001b723fb5d40] Error parsing ADTS frame header!
[aac_adtstoasc @ 000001b723fb5d40] Error parsing ADTS frame header!
[aac_adtstoasc @ 000001b723fb5d40] Error parsing ADTS frame header!
[aac_adtstoasc @ 000001b723fb5d40] Error parsing ADTS frame header!
[aac_adtstoasc @ 000001b723fb5d40] Error parsing ADTS frame header!
[18:31:44] scan: preview 4
[18:31:44] scan: preview 5
[18:31:44] scan: preview 6
[18:31:44] scan: preview 7
[18:31:44] scan: preview 8
[18:31:44] scan: preview 9
[aac_adtstoasc @ 000001b723fb5d40] Error parsing ADTS frame header!
[aac_adtstoasc @ 000001b723fb5d40] Error parsing ADTS frame header!
[aac_adtstoasc @ 000001b723fb5d40] Error parsing ADTS frame header!
[aac_adtstoasc @ 000001b723fb5d40] Error parsing ADTS frame header!
[aac_adtstoasc @ 000001b723fb5d40] Error parsing ADTS frame header!
[aac_adtstoasc @ 000001b723fb5d40] Error parsing ADTS frame header!
[18:31:44] scan: preview 10
[18:31:44] using bitstream PAR 4:3
[18:31:44] crop: [0] 0/0/0/0
[18:31:44] crop: [1] 0/0/0/0
[18:31:44] crop: [2] 0/0/0/0
[18:31:44] crop: [3] 0/0/0/0
[18:31:44] crop: [4] 0/0/0/0
[18:31:44] crop: [5] 0/0/0/0
[18:31:44] crop: [6] 0/0/0/0
[18:31:44] crop: [7] 0/0/0/0
[18:31:44] crop: [8] 0/0/0/0
[18:31:44] crop: less_than_median_frame_count: 0,
[18:31:44] scan: 10 previews, 1440x1080, 25.000 fps, autocrop = 0/0/0/0, aspect 16:9, PAR 4:3, color profile: 1-1-1, chroma location: left
[18:31:44] scan: supported video decoders: avcodec hwaccel
[18:31:44] Freed 1 buffers of size 1024
[18:31:44] Freed 28 buffers of size 2048
[18:31:44] Freed 15 buffers of size 4096
[18:31:44] Freed 21 buffers of size 8192
[18:31:44] Freed 11 buffers of size 16384
[18:31:44] Freed 28 buffers of size 32768
[18:31:44] Freed 20 buffers of size 65536
[18:31:44] Freed 4 buffers of size 131072
[18:31:44] Freed 1 buffers of size 262144
[18:31:44] Allocated 36060160 bytes of buffers on this pass and Freed 3486720 bytes, 32573440 bytes leaked
[18:31:44] thread 17 exited ("scan")
[18:31:44] thread 17 joined ("scan")
[18:31:44] libhb: scan thread found 1 valid title(s)

 # Scan Finished ...

[aac_adtstoasc @ 000001b723fb5d40] Error parsing ADTS frame header!
[aac_adtstoasc @ 000001b723fb5d40] Error parsing ADTS frame header!
[aac_adtstoasc @ 000001b723fb5d40] Error parsing ADTS frame header!
[aac_adtstoasc @ 000001b723fb5d40] Error parsing ADTS frame header!
[aac_adtstoasc @ 000001b723fb5d40] Error parsing ADTS frame header!
[aac_adtstoasc @ 000001b723fb5d40] Error parsing ADTS frame header!
[18:31:45] fifo_close: trashing 0 buffer(s)
[18:31:45] fifo_close: trashing 1 buffer(s)
[aac_adtstoasc @ 000001b723fb5d40] Error parsing ADTS frame header!
avformatMux: track 1 av_bsf_receive_packet failed
Last error repeated 25 times
avformatMux: track 1 av_bsf_receive_packet failed
[aac_adtstoasc @ 000001b723fb5d40] Error parsing ADTS frame header!
[aac_adtstoasc @ 000001b723fb5d40] Error parsing ADTS frame header!
[aac_adtstoasc @ 000001b723fb5d40] Error parsing ADTS frame header!
-- lines removed here --
[aac_adtstoasc @ 000001b723fb5d40] Error parsing ADTS frame header!
[18:34:24] thread d exited ("Muxer")
[18:34:24] thread d joined ("Muxer")
[18:34:24] work: average encoding speed for job is 23.368637 fps
[18:34:25] thread b exited ("Video Synchronization")
[18:34:25] thread 7 exited ("Muxer")
[18:34:25] thread 6 exited ("Audio Synchronization")
[18:34:25] thread 9 exited ("Audio decoder (libavcodec)")
[18:34:25] thread a exited ("Video decoder (libavcodec)")
[18:34:25] thread f exited ("AVFilter")
[18:34:25] thread e exited ("Framerate Shaper")
[18:34:25] thread e joined ("Framerate Shaper")
[18:34:25] vfr: 13685 frames output, 0 dropped and 0 duped for CFR/PFR
[18:34:25] vfr: lost time: 0 (0 frames)
[18:34:25] vfr: gained time: 0 (0 frames) (0 not accounted for)
[18:34:25] fifo_close: trashing 0 buffer(s)
[18:34:25] thread f joined ("AVFilter")
[18:34:25] thread 8 joined ("Reader")
[18:34:25] thread 9 joined ("Audio decoder (libavcodec)")
[18:34:25] thread a joined ("Video decoder (libavcodec)")
[18:34:25] thread b joined ("Video Synchronization")
[18:34:25] thread c exited ("H.265/HEVC encoder (libx265)")
[18:34:25] thread c joined ("H.265/HEVC encoder (libx265)")
[18:34:25] aac-decoder done: 21384 frames, 0 decoder errors
[18:34:25] h264-decoder done: 13685 frames, 0 decoder errors
[18:34:25] sync: got 13685 frames, 13686 expected
[18:34:25] sync: framerate min 30.000 fps, max 30.000 fps, avg 30.000 fps
[18:34:25] thread 6 joined ("Audio Synchronization")
x265 [info]: frame I:    231, Avg QP:23.10  kb/s: 8954.18
x265 [info]: frame P:   3092, Avg QP:24.78  kb/s: 5391.33
x265 [info]: frame B:  10362, Avg QP:28.82  kb/s: 1609.10
x265 [info]: Weighted P-Frames: Y:4.7% UV:3.8%
encoded 13685 frames in 586.36s (23.34 fps), 2587.64 kb/s, Avg QP:27.81
[18:34:25] mux: file size, 147781627 bytes
[18:34:25] mux: track 0, 13685 frames, 147604110 bytes, 2588.22 kbps, fifo 2048
[18:34:25] mux: track 1, 21384 frames, 7149832 bytes, 125.37 kbps, fifo 2048
[18:34:25] mux: overhead, 526012832022528.00 bytes per frame
[18:34:25] thread 7 joined ("Muxer")
[18:34:25] fifo_close: trashing 0 buffer(s)
[18:34:25] fifo_close: trashing 0 buffer(s)
[18:34:25] fifo_close: trashing 0 buffer(s)
[18:34:25] fifo_close: trashing 0 buffer(s)
[18:34:25] fifo_close: trashing 0 buffer(s)
[18:34:25] fifo_close: trashing 0 buffer(s)
[18:34:25] fifo_close: trashing 0 buffer(s)
[18:34:25] fifo_close: trashing 0 buffer(s)
[18:34:25] fifo_close: trashing 0 buffer(s)
[18:34:25] fifo_close: trashing 0 buffer(s)
[18:34:25] Freed 35 buffers of size 1024
[18:34:25] Freed 32 buffers of size 2048
[18:34:25] Freed 32 buffers of size 4096
[18:34:25] Freed 32 buffers of size 8192
[18:34:25] Freed 32 buffers of size 16384
[18:34:25] Freed 32 buffers of size 32768
[18:34:25] Freed 32 buffers of size 65536
[18:34:25] Freed 21 buffers of size 131072
[18:34:25] Freed 1 buffers of size 262144
[18:34:25] Freed 1 buffers of size 524288
[18:34:25] Freed 1 buffers of size 4194304
[18:34:25] Allocated 1221632 bytes of buffers on this pass and Freed 11897856 bytes, -10676224 bytes leaked
[18:34:25] Finished work at: Tue Oct 15 18:34:25 2024
[18:34:25] thread 4 exited ("work")
[18:34:25] thread 4 joined ("work")
[18:34:25] libhb: work result = 0

 # Job Completed!

I also just downloaded 1.7.3 portable, the same file won't even start encoding with the same settings. It errors out with a Failed to Initialize, with this in the middle.

[aac_adtstoasc @ 000001bede424800] Error parsing AudioSpecificConfig extradata!

There's every chance that the audio is malformed, of course, but it plays, and I can use avidemux to transfer it between the files.
Post Reply