Stuck during muxing (?)

HandBrake for Windows support
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
oRBIT2002
Experienced
Posts: 90
Joined: Sun Nov 01, 2009 11:22 am

Stuck during muxing (?)

Post by oRBIT2002 »

Quite frequently Handbrake seems to get stuck at 100% (after second pass) and I have to press CTRL+C to abort the encoder. The result is a corrupt MKV and I have to remux it with mkvtoolnix to make it work properly. The issue that appears then is that my TVIX 6600N refuses to display any bitmapped subtitles that Handbrake embeds in the file. This works fine when Handbrake doesn't lock up so something obviously happens during the remux that the TVIX doesn't like..
Anyway. Is the 100% stuck issue something that's known? I've had issues with it for quite a few versions (I'm using the nightly builds at the moment).
This problem seem to be more or less random. Either a movie works or it doesn't.
mduell
Veteran User
Posts: 8198
Joined: Sat Apr 21, 2007 8:54 pm

Re: Stuck during muxing (?)

Post by mduell »

Why didn't you include an activity log as required by the forum rules at the top of every support forum? Would you prefer we play 20 questions?

If you're using 0.9.4, try the nightly.
oRBIT2002
Experienced
Posts: 90
Joined: Sun Nov 01, 2009 11:22 am

Re: Stuck during muxing (?)

Post by oRBIT2002 »

Here's the scan and encode-log. Handbrake says "100%" but nothing else happens.
However, when I did the encode with just 2-ref frames, 2-bframes the encode worked. But when I tried increasing the ref and b-frames and set "optimal b-frames", it stuck at 100% (below).

scanlog

Code: Select all

# Windows GUI svn3473 2010080701
# Running: Microsoft Windows NT 6.1.7600.0
# CPU: Intel(R) Core(TM) i7 CPU         920  @ 2.67GHz
# Ram: 2038 MB
# Screen: 1680x1050
# Temp Dir: C:\Users\Morgan\AppData\Local\Temp\
# Install Dir: C:\Program Files (x86)\Handbrake
# Data Dir: C:\Users\Morgan\AppData\Roaming\HandBrake\HandBrake\0.9.4.3482

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

[18:03:43] hb_init: checking cpu count
[18:03:43] hb_init: starting libhb thread
HandBrake svn3482 (2010081901) - MinGW i386 - http://handbrake.fr
8 CPUs detected
Opening E:\VIDEO_TS...
[18:03:43] hb_scan: path=E:\VIDEO_TS, title_index=0
[18:03:43] scan: trying to open with libdvdread
libdvdnav: Using dvdnav version 4.1.3
libdvdread: Encrypted DVD support unavailable.
libdvdread: Could not open input: Permission denied
libdvdread: Can't open E: for reading
libdvdread: Device (null) inaccessible, CSS authentication not available.
NAME OPEN FAILED
libdvdnav: Unable to find home directorylibdvdnav: DVD disk reports itself with Region mask 0x00000000. Regions: 1 2 3 4 5 6 7 8
libdvdread: Encrypted DVD support unavailable.
libdvdread: Could not open input: Permission denied
libdvdread: Can't open E: for reading
libdvdread: Device (null) inaccessible, CSS authentication not available.
[18:03:43] scan: DVD has 4 title(s)
[18:03:43] scan: scanning title 1
[18:03:43] scan: opening IFO for VTS 1
[18:03:43] pgc_id: 1, pgn: 1: pgc: 0x31ffd50
[18:03:43] scan: vts=1, ttn=1, cells=0->15, blocks=0->2040585, 2040586 blocks
[18:03:43] scan: duration is 01:35:02 (5702050 ms)
[18:03:43] scan: checking audio 1
[18:03:43] scan: id=80bd, lang=English (AC3), 3cc=eng ext=0
[18:03:43] scan: checking audio 2
[18:03:43] scan: id=81bd, lang=English (AC3), 3cc=eng ext=0
[18:03:43] scan: checking subtitle 1
[18:03:43] scan: id=20bd, lang=Svenska, 3cc=swe
[18:03:43] scan: checking subtitle 2
[18:03:43] scan: id=21bd, lang=Norsk, 3cc=nor
[18:03:43] scan: checking subtitle 3
[18:03:43] scan: id=22bd, lang=Dansk, 3cc=dan
[18:03:43] scan: checking subtitle 4
[18:03:43] scan: id=23bd, lang=Suomi, 3cc=fin
[18:03:43] scan: title 1 has 16 chapters
[18:03:43] scan: chap 1 c=0->0, b=0->133303 (133304), 396538 ms
[18:03:43] scan: chap 2 c=1->1, b=133304->273719 (140416), 371299 ms
[18:03:43] scan: chap 3 c=2->2, b=273720->433861 (160142), 417354 ms
[18:03:43] scan: chap 4 c=3->3, b=433862->544424 (110563), 290508 ms
[18:03:43] scan: chap 5 c=4->4, b=544425->724966 (180542), 466400 ms
[18:03:43] scan: chap 6 c=5->5, b=724967->843184 (118218), 308331 ms
[18:03:43] scan: chap 7 c=6->6, b=843185->952432 (109248), 327456 ms
[18:03:43] scan: chap 8 c=7->7, b=952433->1111513 (159081), 460546 ms
[18:03:43] scan: chap 9 c=8->8, b=1111514->1257613 (146100), 434526 ms
[18:03:43] scan: chap 10 c=9->9, b=1257614->1387635 (130022), 378454 ms
[18:03:43] scan: chap 11 c=10->10, b=1387636->1537496 (149861), 378324 ms
[18:03:43] scan: chap 12 c=11->11, b=1537497->1655509 (118013), 370648 ms
[18:03:43] scan: chap 13 c=12->12, b=1655510->1762641 (107132), 319520 ms
[18:03:43] scan: chap 14 c=13->13, b=1762642->1842793 (80152), 209437 ms
[18:03:43] scan: chap 15 c=14->14, b=1842794->1908642 (65849), 161211 ms
[18:03:43] scan: chap 16 c=15->15, b=1908643->2040585 (131943), 411489 ms
[18:03:43] scan: aspect = 0
[18:03:43] scan: scanning title 2
[18:03:43] scan: opening IFO for VTS 2
[18:03:43] pgc_id: 1, pgn: 1: pgc: 0x31ffc48
[18:03:43] scan: vts=2, ttn=1, cells=0->0, blocks=0->24501, 24502 blocks
[18:03:43] scan: duration is 00:01:10 (70280 ms)
[18:03:43] scan: checking audio 1
[18:03:43] scan: id=80bd, lang=Unknown (AC3), 3cc=und ext=0
[18:03:43] scan: title 2 has 1 chapters
[18:03:43] scan: chap 1 c=0->0, b=0->24501 (24502), 70280 ms
[18:03:43] scan: aspect = 0
[18:03:43] scan: scanning title 3
[18:03:43] scan: opening IFO for VTS 3
[18:03:43] pgc_id: 1, pgn: 1: pgc: 0x31ffc48
[18:03:43] scan: vts=3, ttn=1, cells=0->0, blocks=0->20438, 20439 blocks
[18:03:43] scan: duration is 00:01:00 (60250 ms)
[18:03:43] scan: checking audio 1
[18:03:43] scan: id=80bd, lang=Unknown (AC3), 3cc=und ext=0
[18:03:43] scan: title 3 has 1 chapters
[18:03:43] scan: chap 1 c=0->0, b=0->20438 (20439), 60250 ms
[18:03:43] scan: aspect = 0
[18:03:43] scan: scanning title 4
[18:03:43] scan: opening IFO for VTS 4
[18:03:43] pgc_id: 1, pgn: 1: pgc: 0x31ffc48
[18:03:43] scan: vts=4, ttn=1, cells=0->0, blocks=0->33639, 33640 blocks
[18:03:43] scan: duration is 00:01:25 (85180 ms)
[18:03:43] scan: checking audio 1
[18:03:43] scan: id=80bd, lang=Unknown (AC3), 3cc=und ext=0
[18:03:43] scan: title 4 has 1 chapters
[18:03:43] scan: chap 1 c=0->0, b=0->33639 (33640), 85180 ms
[18:03:43] scan: aspect = 0
libdvdnav: DVD disk reports itself with Region mask 0x00000000. Regions: 1 2 3 4 5 6 7 8
[18:03:43] scan: decoding previews for title 1
libdvdnav: DVD disk reports itself with Region mask 0x00000000. Regions: 1 2 3 4 5 6 7 8
[18:03:43] scan: title angle(s) 1
Scanning title 1 of 4...
Scanning title 1 of 4...
Scanning title 1 of 4...
Scanning title 1 of 4...
Scanning title 1 of 4...
[18:03:44] scan: audio 0x80bd: AC-3, rate=48000Hz, bitrate=448000 English (AC3) (5.1 ch)
[18:03:44] scan: audio 0x81bd: AC-3, rate=48000Hz, bitrate=224000 English (AC3) (2.0 ch)
Scanning title 1 of 4...
Scanning title 1 of 4...
Scanning title 1 of 4...
Scanning title 1 of 4...
Scanning title 1 of 4...
Scanning title 1 of 4...
Scanning title 1 of 4...
Scanning title 1 of 4...
Scanning title 1 of 4...
Scanning title 1 of 4...
Scanning title 1 of 4...
Scanning title 1 of 4...
Scanning title 1 of 4...
[18:03:47] scan: content PAR gives wrong aspect 2.37; using container aspect 1.78
[18:03:47] scan: 10 previews, 720x576, 25.000 fps, autocrop = 0/0/2/0, aspect 16:9, PAR 64:45
[18:03:47] scan: decoding previews for title 2
libdvdnav: DVD disk reports itself with Region mask 0x00000000. Regions: 1 2 3 4 5 6 7 8
[18:03:47] scan: title angle(s) 1
Scanning title 2 of 4...
[18:03:47] scan: audio 0x80bd: AC-3, rate=48000Hz, bitrate=192000 Unknown (AC3) (2.0 ch)
Scanning title 2 of 4...
Scanning title 2 of 4...
Scanning title 2 of 4...
Scanning title 2 of 4...
Scanning title 2 of 4...
Scanning title 2 of 4...
Scanning title 2 of 4...
Scanning title 2 of 4...
[18:03:49] scan: 10 previews, 720x576, 25.000 fps, autocrop = 2/2/0/0, aspect 16:9, PAR 64:45
[18:03:49] scan: decoding previews for title 3
libdvdnav: DVD disk reports itself with Region mask 0x00000000. Regions: 1 2 3 4 5 6 7 8
[18:03:49] scan: title angle(s) 1
Scanning title 3 of 4...
[18:03:49] scan: audio 0x80bd: AC-3, rate=48000Hz, bitrate=192000 Unknown (AC3) (2.0 ch)
Scanning title 3 of 4...
Scanning title 3 of 4...
Scanning title 3 of 4...
Scanning title 3 of 4...
Scanning title 3 of 4...
Scanning title 3 of 4...
[18:03:50] scan: 10 previews, 720x576, 25.000 fps, autocrop = 70/78/0/0, aspect 4:3, PAR 16:15
[18:03:50] scan: decoding previews for title 4
libdvdnav: DVD disk reports itself with Region mask 0x00000000. Regions: 1 2 3 4 5 6 7 8
[18:03:50] scan: title angle(s) 1
Scanning title 4 of 4...
[18:03:50] scan: audio 0x80bd: AC-3, rate=48000Hz, bitrate=192000 Unknown (AC3) (2.0 ch)
Scanning title 4 of 4...
Scanning title 4 of 4...
Scanning title 4 of 4...
Scanning title 4 of 4...
Scanning title 4 of 4...
Scanning title 4 of 4...
Scanning title 4 of 4...
[18:03:52] scan: 10 previews, 720x576, 25.000 fps, autocrop = 74/70/2/4, aspect 4:3, PAR 16:15
[18:03:52] scan: title (0) job->width:720, job->height:400
[18:03:52] scan: title (1) job->width:720, job->height:400
[18:03:52] scan: title (2) job->width:720, job->height:400
[18:03:52] scan: title (3) job->width:720, job->height:400
[18:03:52] libhb: scan thread found 4 valid title(s)
+ title 1:
  + Main Feature
  + vts 1, ttn 1, cells 0->15 (2040586 blocks)
  + angle(s) 1
  + duration: 01:35:02
  + size: 720x576, pixel aspect: 64/45, display aspect: 1.78, 25.000 fps
  + autocrop: 0/0/2/0
  + chapters:
    + 1: cells 0->0, 133304 blocks, duration 00:06:37
    + 2: cells 1->1, 140416 blocks, duration 00:06:11
    + 3: cells 2->2, 160142 blocks, duration 00:06:57
    + 4: cells 3->3, 110563 blocks, duration 00:04:51
    + 5: cells 4->4, 180542 blocks, duration 00:07:46
    + 6: cells 5->5, 118218 blocks, duration 00:05:08
    + 7: cells 6->6, 109248 blocks, duration 00:05:27
    + 8: cells 7->7, 159081 blocks, duration 00:07:41
    + 9: cells 8->8, 146100 blocks, duration 00:07:15
    + 10: cells 9->9, 130022 blocks, duration 00:06:18
    + 11: cells 10->10, 149861 blocks, duration 00:06:18
    + 12: cells 11->11, 118013 blocks, duration 00:06:11
    + 13: cells 12->12, 107132 blocks, duration 00:05:20
    + 14: cells 13->13, 80152 blocks, duration 00:03:29
    + 15: cells 14->14, 65849 blocks, duration 00:02:41
    + 16: cells 15->15, 131943 blocks, duration 00:06:51
  + audio tracks:
    + 1, English (AC3) (5.1 ch) (iso639-2: eng), 48000Hz, 448000bps
    + 2, English (AC3) (2.0 ch) (iso639-2: eng), 48000Hz, 224000bps
  + subtitle tracks:
    + 1, Svenska (iso639-2: swe) (Bitmap)
    + 2, Norsk (iso639-2: nor) (Bitmap)
    + 3, Dansk (iso639-2: dan) (Bitmap)
    + 4, Suomi (iso639-2: fin) (Bitmap)
+ title 2:
  + vts 2, ttn 1, cells 0->0 (24502 blocks)
  + angle(s) 1
  + duration: 00:01:10
  + size: 720x576, pixel aspect: 64/45, display aspect: 1.78, 25.000 fps
  + autocrop: 2/2/0/0
  + chapters:
    + 1: cells 0->0, 24502 blocks, duration 00:01:10
  + audio tracks:
    + 1, Unknown (AC3) (2.0 ch) (iso639-2: und), 48000Hz, 192000bps
  + subtitle tracks:
+ title 3:
  + vts 3, ttn 1, cells 0->0 (20439 blocks)
  + angle(s) 1
  + duration: 00:01:00
  + size: 720x576, pixel aspect: 16/15, display aspect: 1.33, 25.000 fps
  + autocrop: 70/78/0/0
  + chapters:
    + 1: cells 0->0, 20439 blocks, duration 00:01:00
  + audio tracks:
    + 1, Unknown (AC3) (2.0 ch) (iso639-2: und), 48000Hz, 192000bps
  + subtitle tracks:
+ title 4:
  + vts 4, ttn 1, cells 0->0 (33640 blocks)
  + angle(s) 1
  + duration: 00:01:25
  + size: 720x576, pixel aspect: 16/15, display aspect: 1.33, 25.000 fps
  + autocrop: 74/70/2/4
  + chapters:
    + 1: cells 0->0, 33640 blocks, duration 00:01:25
  + audio tracks:
    + 1, Unknown (AC3) (2.0 ch) (iso639-2: und), 48000Hz, 192000bps
  + subtitle tracks:
HandBrake has exited.

Encodelog

Code: Select all

# Windows GUI svn3482 2010081901
# Running: Microsoft Windows NT 6.1.7600.0
# CPU: Intel(R) Core(TM) i7 CPU         920  @ 2.67GHz
# Ram: 2038 MB
# Screen: 1680x1050
# Temp Dir: C:\Users\Morgan\AppData\Local\Temp\
# Install Dir: C:\Program Files (x86)\Handbrake
# Data Dir: C:\Users\Morgan\AppData\Roaming\HandBrake\HandBrake\0.9.4.3482

# CLI Query:  -i "E:\VIDEO_TS" -t 1 --angle 1 -c 1-16 -o "D:\Territory.576p.mkv"  -f mkv --strict-anamorphic  -e x264 -S 1024 -2  -T  -a 1 -E ac3 -6 auto -R Auto -B auto -D 0.0 --subtitle 1 --markers="C:\Users\Morgan\AppData\Local\Temp\Territory.576p-1-chapters.csv" -x ref=4:subq=6:mixed-refs=0:weightb=0:8x8dct=0:trellis=0:b-adapt=2 -v 1
# User Query: False
-------------------------------------------

[18:36:45] hb_init: checking cpu count
[18:36:45] hb_init: starting libhb thread
HandBrake svn3482 (2010081901) - MinGW i386 - http://handbrake.fr
8 CPUs detected
Opening E:\VIDEO_TS...
[18:36:45] hb_scan: path=E:\VIDEO_TS, title_index=1
[18:36:45] scan: trying to open with libdvdread
libdvdnav: Using dvdnav version 4.1.3
libdvdread: Encrypted DVD support unavailable.
libdvdread: Could not open input: Permission denied
libdvdread: Can't open E: for reading
libdvdread: Device (null) inaccessible, CSS authentication not available.
NAME OPEN FAILED
libdvdnav: Unable to find home directorylibdvdnav: DVD disk reports itself with Region mask 0x00000000. Regions: 1 2 3 4 5 6 7 8
libdvdread: Encrypted DVD support unavailable.
libdvdread: Could not open input: Permission denied
libdvdread: Can't open E: for reading
libdvdread: Device (null) inaccessible, CSS authentication not available.
[18:36:45] scan: DVD has 4 title(s)
[18:36:45] scan: scanning title 1
[18:36:45] scan: opening IFO for VTS 1
[18:36:45] pgc_id: 1, pgn: 1: pgc: 0x17d0378
[18:36:45] scan: vts=1, ttn=1, cells=0->15, blocks=0->2040585, 2040586 blocks
[18:36:45] scan: duration is 01:35:02 (5702050 ms)
[18:36:45] scan: checking audio 1
[18:36:45] scan: id=80bd, lang=English (AC3), 3cc=eng ext=0
[18:36:45] scan: checking audio 2
[18:36:45] scan: id=81bd, lang=English (AC3), 3cc=eng ext=0
[18:36:45] scan: checking subtitle 1
[18:36:45] scan: id=20bd, lang=Svenska, 3cc=swe
[18:36:45] scan: checking subtitle 2
[18:36:45] scan: id=21bd, lang=Norsk, 3cc=nor
[18:36:45] scan: checking subtitle 3
[18:36:45] scan: id=22bd, lang=Dansk, 3cc=dan
[18:36:45] scan: checking subtitle 4
[18:36:45] scan: id=23bd, lang=Suomi, 3cc=fin
[18:36:45] scan: title 1 has 16 chapters
[18:36:45] scan: chap 1 c=0->0, b=0->133303 (133304), 396538 ms
[18:36:45] scan: chap 2 c=1->1, b=133304->273719 (140416), 371299 ms
[18:36:45] scan: chap 3 c=2->2, b=273720->433861 (160142), 417354 ms
[18:36:45] scan: chap 4 c=3->3, b=433862->544424 (110563), 290508 ms
[18:36:45] scan: chap 5 c=4->4, b=544425->724966 (180542), 466400 ms
[18:36:45] scan: chap 6 c=5->5, b=724967->843184 (118218), 308331 ms
[18:36:45] scan: chap 7 c=6->6, b=843185->952432 (109248), 327456 ms
[18:36:45] scan: chap 8 c=7->7, b=952433->1111513 (159081), 460546 ms
[18:36:45] scan: chap 9 c=8->8, b=1111514->1257613 (146100), 434526 ms
[18:36:45] scan: chap 10 c=9->9, b=1257614->1387635 (130022), 378454 ms
[18:36:45] scan: chap 11 c=10->10, b=1387636->1537496 (149861), 378324 ms
[18:36:45] scan: chap 12 c=11->11, b=1537497->1655509 (118013), 370648 ms
[18:36:45] scan: chap 13 c=12->12, b=1655510->1762641 (107132), 319520 ms
[18:36:45] scan: chap 14 c=13->13, b=1762642->1842793 (80152), 209437 ms
[18:36:45] scan: chap 15 c=14->14, b=1842794->1908642 (65849), 161211 ms
[18:36:45] scan: chap 16 c=15->15, b=1908643->2040585 (131943), 411489 ms
[18:36:45] scan: aspect = 0
[18:36:45] scan: decoding previews for title 1
libdvdnav: DVD disk reports itself with Region mask 0x00000000. Regions: 1 2 3 4 5 6 7 8
[18:36:45] scan: title angle(s) 1
[18:36:45] scan: audio 0x80bd: AC-3, rate=48000Hz, bitrate=448000 English (AC3) (5.1 ch)
[18:36:45] scan: audio 0x81bd: AC-3, rate=48000Hz, bitrate=224000 English (AC3) (2.0 ch)
[18:36:46] scan: content PAR gives wrong aspect 2.37; using container aspect 1.78
[18:36:46] scan: 10 previews, 720x576, 25.000 fps, autocrop = 0/0/2/0, aspect 16:9, PAR 64:45
[18:36:46] scan: title (0) job->width:720, job->height:400
[18:36:46] libhb: scan thread found 1 valid title(s)
+ title 1:
  + vts 1, ttn 1, cells 0->15 (2040586 blocks)
  + angle(s) 1
  + duration: 01:35:02
  + size: 720x576, pixel aspect: 64/45, display aspect: 1.78, 25.000 fps
  + autocrop: 0/0/2/0
  + chapters:
    + 1: cells 0->0, 133304 blocks, duration 00:06:37
    + 2: cells 1->1, 140416 blocks, duration 00:06:11
    + 3: cells 2->2, 160142 blocks, duration 00:06:57
    + 4: cells 3->3, 110563 blocks, duration 00:04:51
    + 5: cells 4->4, 180542 blocks, duration 00:07:46
    + 6: cells 5->5, 118218 blocks, duration 00:05:08
    + 7: cells 6->6, 109248 blocks, duration 00:05:27
    + 8: cells 7->7, 159081 blocks, duration 00:07:41
    + 9: cells 8->8, 146100 blocks, duration 00:07:15
    + 10: cells 9->9, 130022 blocks, duration 00:06:18
    + 11: cells 10->10, 149861 blocks, duration 00:06:18
    + 12: cells 11->11, 118013 blocks, duration 00:06:11
    + 13: cells 12->12, 107132 blocks, duration 00:05:20
    + 14: cells 13->13, 80152 blocks, duration 00:03:29
    + 15: cells 14->14, 65849 blocks, duration 00:02:41
    + 16: cells 15->15, 131943 blocks, duration 00:06:51
  + audio tracks:
    + 1, English (AC3) (5.1 ch) (iso639-2: eng), 48000Hz, 448000bps
    + 2, English (AC3) (2.0 ch) (iso639-2: eng), 48000Hz, 224000bps
  + subtitle tracks:
    + 1, Svenska (iso639-2: swe) (Bitmap)
    + 2, Norsk (iso639-2: nor) (Bitmap)
    + 3, Dansk (iso639-2: dan) (Bitmap)
    + 4, Suomi (iso639-2: fin) (Bitmap)
Reading chapter markers from file C:\Users\Morgan\AppData\Local\Temp\Territory.576p-1-chapters.csv
Invalid sample rate 0, using input rate 48000
Calculated bitrate: 1055 kbps
Modified x264 options for pass 1 to append turbo options: ref=4:subq=6:mixed-refs=0:weightb=0:8x8dct=0:trellis=0:b-adapt=2:ref=1:subme=2:me=dia:analyse=none:trellis=0:no-fast-pskip=0:8x8dct=0:weightb=0
[18:36:46] 2 job(s) to process
[18:36:46] starting job
[18:36:46] sync: expecting 142576 video frames
[ac3 @ 0x39f0910]No channel layout specified. The encoder will guess the layout, but it might be incorrect.
[18:36:46] job configuration:
[18:36:46]  * source
[18:36:46]    + E:\VIDEO_TS
[18:36:46]    + title 1, chapter(s) 1 to 16
[18:36:46]  * destination
[18:36:46]    + D:\Territory.576p.mkv
[18:36:46]    + container: Matroska (.mkv)
[18:36:46]      + chapter markers
[18:36:46]  * video track
[18:36:46]    + decoder: mpeg2
[18:36:46]      + bitrate 8900 kbps
[18:36:46]    + frame rate: same as source (around 25.000 fps)
[18:36:46]    + strict anamorphic
[18:36:46]      + storage dimensions: 720 * 576 -> 718 * 576, crop 0/0/2/0, mod 0
[18:36:46]      + pixel aspect ratio: 64 / 45
[18:36:46]      + display dimensions: 1021 * 576
[18:36:46]    + encoder: x264
[18:36:46]      + options: ref=4:subq=6:mixed-refs=0:weightb=0:8x8dct=0:trellis=0:b-adapt=2:ref=1:subme=2:me=dia:analyse=none:trellis=0:no-fast-pskip=0:8x8dct=0:weightb=0
[18:36:46]      + bitrate: 1055 kbps, pass: 1
[18:36:46]  * audio track 0
[18:36:46]    + decoder: English (AC3) (5.1 ch) (track 1, id 80bd)
[18:36:46]      + bitrate: 448 kbps, samplerate: 48000 Hz
[18:36:46]    + AC3 passthrough
libdvdnav: Using dvdnav version 4.1.3
[18:36:46] encx264: encoding with stored aspect 64/45
x264 [info]: using SAR=64/45
x264 [info]: using cpu capabilities: MMX2 SSE2Fast SSSE3 FastShuffle SSE4.2
libdvdread: Encrypted DVD support unavailable.
libdvdread: Could not open input: Permission denied
libdvdread: Can't open E: for reading
libdvdread: Device (null) inaccessible, CSS authentication not available.
NAME OPEN FAILED
libdvdnav: Unable to find home directorylibdvdnav: DVD disk reports itself with Region mask 0x00000000. Regions: 1 2 3 4 5 6 7 8
libdvdread: Encrypted DVD support unavailable.
libdvdread: Could not open input: Permission denied
libdvdread: Can't open E: for reading
libdvdread: Device (null) inaccessible, CSS authentication not available.
libdvdnav: DVD disk reports itself with Region mask 0x00000000. Regions: 1 2 3 4 5 6 7 8
x264 [info]: profile Main, level 3.0
No accelerated IMDCT transform found
[18:36:47] reader: first SCR 146 id 224 DTS 28800
[18:36:47] mpeg2: "Chapter 1" (1) at frame 0 time 3600
[18:38:26] mpeg2: "Chapter 2" (2) at frame 9906 time 35665200
[18:40:07] mpeg2: "Chapter 3" (3) at frame 19201 time 69127200
[18:42:00] mpeg2: "Chapter 4" (4) at frame 29627 time 106660800
[18:43:17] mpeg2: "Chapter 5" (5) at frame 36894 time 132822000
[18:45:24] mpeg2: "Chapter 6" (6) at frame 48555 time 174801600
[18:46:47] mpeg2: "Chapter 7" (7) at frame 56277 time 202600800
[18:48:16] mpeg2: "Chapter 8" (8) at frame 64467 time 232084800
[18:50:24] mpeg2: "Chapter 9" (9) at frame 75972 time 273502800
[18:52:20] mpeg2: "Chapter 10" (10) at frame 86827 time 312580800
[18:54:02] mpeg2: "Chapter 11" (11) at frame 96291 time 346651200
[18:55:45] mpeg2: "Chapter 12" (12) at frame 105742 time 380674800
[18:57:25] mpeg2: "Chapter 13" (13) at frame 115011 time 414043200
[18:58:54] mpeg2: "Chapter 14" (14) at frame 122993 time 442778400
[18:59:49] mpeg2: "Chapter 15" (15) at frame 128225 time 461613600
[19:00:31] mpeg2: "Chapter 16" (16) at frame 132262 time 476146800
[19:01:43] reader: done. 0 scr changes
[19:01:44] 5702.440000s: Video -> Film
[19:01:44] work: average encoding speed for job is 95.190414 fps
[19:01:44] sync: got 142561 frames, 142576 expected
[19:01:44] mpeg2 done: 142561 frames
[19:01:44] render: lost time: 0 (0 frames)
[19:01:44] render: gained time: 0 (0 frames) (0 not accounted for)
x264 [info]: frame I:1459  Avg QP:20.12  size: 35188  PSNR Mean Y:44.43 U:48.86 V:49.76 Avg:45.35 Global:44.29
x264 [info]: frame P:44289 Avg QP:22.98  size:  9252  PSNR Mean Y:42.54 U:49.15 V:50.18 Avg:43.51 Global:41.90
x264 [info]: frame B:96813 Avg QP:25.35  size:  2866  PSNR Mean Y:41.08 U:49.30 V:50.35 Avg:42.28 Global:41.05
x264 [info]: consecutive B-frames:  1.7%  4.0% 49.2% 45.1%
x264 [info]: mb I  I16..4: 38.1%  0.0% 61.9%
x264 [info]: mb P  I16..4: 25.2%  0.0%  0.0%  P16..4: 50.0%  0.0%  0.0%  0.0%  0.0%    skip:24.8%
x264 [info]: mb B  I16..4:  4.7%  0.0%  0.0%  B16..8: 24.6%  0.0%  0.0%  direct:10.5%  skip:60.2%  L0:32.1% L1:51.3% BI:16.6%
x264 [info]: final ratefactor: 22.17
x264 [info]: coded y,uvDC,uvAC intra: 46.5% 39.0% 9.6% inter: 14.2% 9.3% 0.3%
x264 [info]: i16 v,h,dc,p: 38% 24% 26% 12%
x264 [info]: i4 v,h,dc,ddl,ddr,vr,hd,vl,hu: 25% 18% 17%  4%  9%  7%  6%  7%  7%
x264 [info]: i8c dc,h,v,p: 60% 17% 21%  3%
x264 [info]: Weighted P-Frames: Y:3.5%
x264 [info]: SSIM Mean Y:0.9648898 (14.546db)
x264 [info]: PSNR Mean Y:41.569 U:49.252 V:50.292 Avg:42.692 Global:41.324 kb/s:1036.15
[19:01:44] starting job
[19:01:44] sync: expecting 142561 video frames
[ac3 @ 0x95b59f0]No channel layout specified. The encoder will guess the layout, but it might be incorrect.
[19:01:44] job configuration:
[19:01:44]  * source
[19:01:44]    + E:\VIDEO_TS
[19:01:44]    + title 1, chapter(s) 1 to 16
[19:01:44]  * destination
[19:01:44]    + D:\Territory.576p.mkv
[19:01:44]    + container: Matroska (.mkv)
[19:01:44]      + chapter markers
[19:01:44]  * video track
[19:01:44]    + decoder: mpeg2
[19:01:44]      + bitrate 8900 kbps
[19:01:44]    + frame rate: same as source (around 25.000 fps)
[19:01:44]    + strict anamorphic
[19:01:44]      + storage dimensions: 720 * 576 -> 718 * 576, crop 0/0/2/0, mod 0
[19:01:44]      + pixel aspect ratio: 64 / 45
[19:01:44]      + display dimensions: 1021 * 576
[19:01:44]    + encoder: x264
[19:01:44]      + options: ref=4:subq=6:mixed-refs=0:weightb=0:8x8dct=0:trellis=0:b-adapt=2
[19:01:44]      + bitrate: 1055 kbps, pass: 2
[19:01:44]  * subtitle track 1, Svenska (id 20bd) Picture [VOBSUB] -> Pass-Through
[19:01:44]  * audio track 0
[19:01:44]    + decoder: English (AC3) (5.1 ch) (track 1, id 80bd)
[19:01:44]      + bitrate: 448 kbps, samplerate: 48000 Hz
[19:01:44]    + AC3 passthrough
libdvdnav: Using dvdnav version 4.1.3
[19:01:44] encx264: encoding with stored aspect 64/45
x264 [info]: using SAR=64/45
x264 [info]: using cpu capabilities: MMX2 SSE2Fast SSSE3 FastShuffle SSE4.2
libdvdread: Encrypted DVD support unavailable.
libdvdread: Could not open input: Permission denied
libdvdread: Can't open E: for reading
libdvdread: Device (null) inaccessible, CSS authentication not available.
NAME OPEN FAILED
libdvdnav: Unable to find home directorylibdvdnav: DVD disk reports itself with Region mask 0x00000000. Regions: 1 2 3 4 5 6 7 8
libdvdread: Encrypted DVD support unavailable.
libdvdread: Could not open input: Permission denied
libdvdread: Can't open E: for reading
libdvdread: Device (null) inaccessible, CSS authentication not available.
libdvdnav: DVD disk reports itself with Region mask 0x00000000. Regions: 1 2 3 4 5 6 7 8
[19:01:44] reader: first SCR 146 id 224 DTS 28800
[19:01:44] mpeg2: "Chapter 1" (1) at frame 0 time 3600
x264 [info]: profile Main, level 3.0
No accelerated IMDCT transform found
[19:02:59] mpeg2: "Chapter 2" (2) at frame 9906 time 35665200
[19:04:17] mpeg2: "Chapter 3" (3) at frame 19201 time 69127200
[19:05:44] mpeg2: "Chapter 4" (4) at frame 29627 time 106660800
[19:06:43] mpeg2: "Chapter 5" (5) at frame 36894 time 132822000
[19:08:21] mpeg2: "Chapter 6" (6) at frame 48555 time 174801600
[19:09:26] mpeg2: "Chapter 7" (7) at frame 56277 time 202600800
[19:10:19] mpeg2: "Chapter 8" (8) at frame 64467 time 232084800
[19:11:49] mpeg2: "Chapter 9" (9) at frame 75972 time 273502800
[19:13:02] mpeg2: "Chapter 10" (10) at frame 86827 time 312580800
[19:14:13] mpeg2: "Chapter 11" (11) at frame 96291 time 346651200
[19:15:28] mpeg2: "Chapter 12" (12) at frame 105742 time 380674800
[19:16:31] mpeg2: "Chapter 13" (13) at frame 115011 time 414043200
[19:17:36] mpeg2: "Chapter 14" (14) at frame 122993 time 442778400
[19:18:11] mpeg2: "Chapter 15" (15) at frame 128225 time 461613600
[19:18:42] mpeg2: "Chapter 16" (16) at frame 132262 time 476146800
[19:19:21] reader: done. 0 scr changes
[19:19:21] 5702.440000s: Video -> Film

oRBIT2002
Experienced
Posts: 90
Joined: Sun Nov 01, 2009 11:22 am

Re: Stuck during muxing (?)

Post by oRBIT2002 »

I was just successful in reproducing the issue by just encoding the last chapter of the movie above. By setting the number of reference frames to certain higher values, the encode stucks at 99.99% or 100%. I tried using 5,8 or 10 reference frames, and the problem occured. However with 4 ref-frames the encode was ok. Strange since I only used 4 ref-frames in the full movie and the bug still appeared.

EDIT: Just discovered that the bug only seems to appear when encoding with subtitles (bitmapped). Without subtitles, the encode succeeded even with 16-ref frames.
oRBIT2002
Experienced
Posts: 90
Joined: Sun Nov 01, 2009 11:22 am

Re: Stuck during muxing (?)

Post by oRBIT2002 »

So, anyone looking at this, or should it be moved to "bugs" perhaps?
User avatar
s55
HandBrake Team
Posts: 10357
Joined: Sun Dec 24, 2006 1:05 pm

Re: Stuck during muxing (?)

Post by s55 »

It's been reported as a bug by others. There is no fix for it yet although reports have said that running the encode again may work.

In otherwords, it's on our radar, but there is no fix yet nor an ETA for one.
Gadget
Posts: 1
Joined: Wed Aug 25, 2010 4:55 pm

Re: Stuck during muxing (?)

Post by Gadget »

I hit a similar issue recently with 0.9.4, it would encode and then hang on 'muxing'. Tried out the latest nightly build and initially it seemed to have the same issue, would encode to 100% then appear to hang without completing. However it was actually still working in the background and would eventually complete after a further 10 minutes (the encode itself took 10mins as well, so not sure if it was carrying out a second pass of some kind).

I've just resolved my problem - I was encoding on one machine with the output directory set to a network share on another PC. If I change the output directory to a local one on the encoding PC, the pause at the end of the encoding process is about 5 seconds rather than 10 minutes.

Your problem may be completely different but thought I'd post just in case it helps.
oRBIT2002
Experienced
Posts: 90
Joined: Sun Nov 01, 2009 11:22 am

Re: Stuck during muxing (?)

Post by oRBIT2002 »

I've left my computer on for about an hour, then I gave up and aborted so I think this is something else..
mkelley
Bright Spark User
Posts: 389
Joined: Fri Dec 25, 2009 2:00 am

Re: Stuck during muxing (?)

Post by mkelley »

It's definitely something with subs, because the few times I've experienced this I just remove the subs (or switch to closed captions) and everything is just fine.

And sometimes (*sometimes*) just running it through again without putting it in a queue works, as noted above.
User avatar
JohnAStebbins
HandBrake Team
Posts: 5725
Joined: Sat Feb 09, 2008 7:21 pm

Re: Stuck during muxing (?)

Post by JohnAStebbins »

I think I have fixed this.
http://trac.handbrake.fr/changeset/3525

If you have sources that you can reliably reproduce this problem with, please give them another try (after the next nightly) and let me know how it goes.
bproffit
Posts: 8
Joined: Tue Dec 15, 2009 7:50 pm

Re: Stuck during muxing (?)

Post by bproffit »

In case it's of any help, here's the log of one that hung muxing on me overnight:

[03:04:27] starting job
[03:04:27] job configuration:
[03:04:27] * source
[03:04:27] + /Users/Brian/Desktop/VIDEO_TS
[03:04:27] + title 2, chapter(s) 1 to 5
[03:04:27] * destination
[03:04:27] + /Volumes/Public/Video/TV/Warehouse 13/S1E02 Resonance.m4v
[03:04:27] + container: MPEG-4 (.mp4 and .m4v)
[03:04:27] + chapter markers
[03:04:27] * video track
[03:04:27] + decoder: mpeg2
[03:04:27] + bitrate 9800 kbps
[03:04:27] + frame rate: same as source (around 23.976 fps)
[03:04:27] + loose anamorphic
[03:04:27] + modulus: 0
[03:04:27] + storage dimensions: 720 * 480 -> 720 * 480, crop 0/0/0/0
[03:04:27] + pixel aspect ratio: 853 / 720
[03:04:27] + display dimensions: 853 * 480
[03:04:27] + filters
[03:04:27] + Detelecine (pullup) (default settings)
[03:04:27] + Decomb (default settings)
[03:04:27] + encoder: x264
[03:04:27] + options: b-adapt=2:rc-lookahead=50
[03:04:27] + bitrate: 1500 kbps, pass: 2
[03:04:27] * audio track 0
[03:04:27] + decoder: English (AC3) (5.1 ch) (track 1, id 80bd)
[03:04:27] + bitrate: 448 kbps, samplerate: 48000 Hz
[03:04:27] + mixdown: Dolby Pro Logic II
[03:04:27] + encoder: ca_aac
[03:04:27] + bitrate: 160 kbps, samplerate: 48000 Hz
[03:04:27] * audio track 1
[03:04:27] + decoder: English (AC3) (5.1 ch) (track 1, id 80bd)
[03:04:27] + bitrate: 448 kbps, samplerate: 48000 Hz
[03:04:27] + AC3 passthrough
[03:04:27] encx264: keyint-min: 24, keyint-max: 240
[03:04:27] encx264: encoding with stored aspect 853/720
x264 [info]: using SAR=853/720
x264 [info]: using cpu capabilities: MMX2 SSE2Fast SSSE3 FastShuffle SSE4.1 Cache64
libdvdnav: Using dvdnav version 4.1.3
libdvdread: Using libdvdcss version 1.2.10 for DVD access
[03:04:27] yadif thread started for segment 1
[03:04:27] yadif thread started for segment 0
[03:04:27] decomb thread started for segment 0
libdvdread: Couldn't find device name.
[03:04:27] decomb thread started for segment 1
libdvdnav: Can't read name block. Probably not a DVD-ROM device.
libdvdnav: Unable to find map file '/Users/Brian/.dvdnav/.map'
libdvdnav: DVD disk reports itself with Region mask 0x00fe0000. Regions: 1
libdvdread: Using libdvdcss version 1.2.10 for DVD access
libdvdread: Couldn't find device name.
[03:04:28] reader: first SCR 146 id 224 DTS 22254
[03:04:28] mpeg2: "Chapter 1" (1) at frame 0 time 3003
x264 [info]: profile High, level 3.0
No accelerated IMDCT transform found
No accelerated IMDCT transform found
[03:04:30] sync: expecting 64742 video frames
[ac3 @ 0x101db1e00]No channel layout specified. The encoder will guess the layout, but it might be incorrect.
[03:04:30] sync: first pts is 3003
[03:06:25] 60.960888s: Film -> Video
[03:06:33] 65.148415s: Video -> Film
[03:12:15] 247.647400s: Film -> Video
[03:12:17] 248.665070s: Video -> Film
[03:15:02] 339.572571s: Film -> Video
[03:15:08] 342.425415s: Video -> Film
[03:18:17] 448.381256s: Film -> Video
[03:19:18] 479.228760s: Video -> Film
[03:19:33] mpeg2: "Chapter 2" (2) at frame 11905 time 43816773
[03:48:29] 1426.508301s: Film -> Video
[03:48:31] mpeg2: "Chapter 3" (3) at frame 34470 time 128474346
[03:48:31] 1427.492676s: Video -> Film
[04:02:17] 1888.987061s: Film -> Video
[04:02:20] 1890.471802s: Video -> Film
[04:10:57] 2166.747803s: Film -> Video
[04:11:54] 2195.109619s: Video -> Film
[04:14:11] 2264.679199s: Film -> Video
[04:14:23] 2270.184570s: Video -> Film
[04:14:23] mpeg2: "Chapter 4" (4) at frame 54895 time 204349645
[04:26:03] 2653.567627s: Film -> Video
[04:26:19] reader: done. 1 scr changes
[04:26:25] mpeg2: "Chapter 5" (5) at frame 64742 time 240813573
[04:26:25] 2675.706299s: Video -> Film
[04:26:26] sync: got 64742 frames, 64742 expected
[04:26:26] work: average encoding speed for job is 13.169923 fps
x264 [error]: Incomplete MB-tree stats file.
[04:26:26] mux: track 0, 64276 frames, 501707289 bytes, 1500.06 kbps, fifo 32
[04:26:26] mux: track 1, 125421 frames, 54969598 bytes, 164.35 kbps, fifo 512
[04:26:26] mux: track 2, 83614 frames, 149836288 bytes, 448.00 kbps, fifo 512
[04:26:26] mpeg2 done: 64743 frames
[04:26:26] render: lost time: 1358861 (452 frames)
[04:26:26] render: gained time: 1358861 (1784 frames) (0 not accounted for)
[04:26:26] render: average dropped frame duration: 3006
[04:26:26] encx264: 1 frames had to be split (64289 in, 64289 out)
Post Reply