Intermittent video problem.

HandBrake for Mac 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
golias
Enlightened
Posts: 105
Joined: Wed Jan 03, 2007 7:29 pm

Intermittent video problem.

Post by golias »

Okay, so I'm ripping Firefly episodes using mkv, h.264, constant quality 70%, AC-3 Audio, anamorphic (strict), comb filter (default), and the following options:

Code: Select all

ref=1:bframes=2:direct=auto:subq=8:analyse=all:8x8dct=1:trellis=1:no-fast-pskip=1:fil=1
The results look fantastic... EXCEPT every so often I'll get a couple seconds of video along the lines of this screen shot:
Image

Notice the severe motion "tearing" on most of the bottom of the screen.

This moment looks exactly the same played back on Quicktime, VLC, or Plax.

It's only 23 seconds into the episode, so I figure I can do a quick rip of JUST THAT FIRST CHAPTER, complete with a log file, so I can include log info with this post.

But then the rip of that 90-second chapter alone came out perfect, even though all the settings were identical, so I guess it's not something predictable. :/

I'm now doing a new rip of episode 3, beginning to end, and generating a log file to go with it. After it's done, I'll update this thread with the results and the log file.

In the meanwhile, does anybody have any theories about what's going wrong?

(EDIT: I forgot to mention. I see this problem whether I play the file back in full-screen mode or in a window. Again, regardless of what player I use.)
jbrjake
Veteran User
Posts: 4805
Joined: Wed Dec 13, 2006 1:38 am

Re: Intermittent video problem.

Post by jbrjake »

This shouldn't be happening with current code, but then, you didn't say what version you're using...
golias
Enlightened
Posts: 105
Joined: Wed Jan 03, 2007 7:29 pm

Re: Intermittent video problem.

Post by golias »

jbrjake wrote:This shouldn't be happening with current code, but then, you didn't say what version you're using...
Sorry. It's Version 0.9.3 (2008112300)
golias
Enlightened
Posts: 105
Joined: Wed Jan 03, 2007 7:29 pm

Re: Intermittent video problem.

Post by golias »

Okay, I ripped episode 3 again. Exact same settings, this time storing a log. Playback was good up until about 7:32 when it hit another glitch moment like the one above.

Here's the log.

Code: Select all

HandBrake Activity Log for /Volumes/よみこ/Video/TV Shows/Firefly/03 Firefly - S01E03.mkv: 2009-01-07 12:04:24 -0600
Handbrake Version: 0.9.3 (2008112300)

[12:04:24] macgui: scanning specifically for title: 3
[12:04:24] macgui: performNewQueueScan currentQueueEncodeIndex is: 0
[12:04:24] hb_scan: path=/Users/dave/DVD Rips/FIREFLY_D1, title_index=3
[12:04:24] scan: trying to open with libdvdread
[12:04:24] scan: DVD has 10 title(s)
[12:04:24] scan: scanning title 3
[12:04:24] scan: opening IFO for VTS 7
[12:04:24] pgc_id: 1, pgn: 1: pgc: 0x16770f20
[12:04:24] scan: vts=7, ttn=1, cells=0->14, blocks=0->939996, 939997 blocks
[12:04:24] scan: duration is 00:43:53 (2633020 ms)
[12:04:24] scan: checking audio 1
[12:04:24] scan: id=80bd, lang=English (AC3), 3cc=eng ext=1
[12:04:24] scan: checking audio 2
[12:04:24] scan: id=81bd, lang=Francais (AC3), 3cc=fra ext=1
[12:04:24] scan: checking audio 3
[12:04:24] scan: id=82bd, lang=Espanol (AC3), 3cc=spa ext=1
[12:04:24] scan: checking subtitle 1
[12:04:24] scan: id=24bd, lang=English (Closed Caption), 3cc=eng
[12:04:24] scan: checking subtitle 2
[12:04:24] scan: id=25bd, lang=Espanol, 3cc=spa
[12:04:24] scan: checking subtitle 3
[12:04:24] scan: id=26bd, lang=Francais (Forced Caption), 3cc=fra
[12:04:24] scan: checking subtitle 4
[12:04:24] scan: id=27bd, lang=Espanol (Forced Caption), 3cc=spa
[12:04:24] scan: title 3 has 13 chapters
[12:04:24] scan: chap 1 c=0->0, b=0->80347 (80348), 184337 ms
[12:04:24] scan: chap 2 c=1->1, b=80348->101153 (20806), 52099 ms
[12:04:24] scan: chap 3 c=2->2, b=101154->225732 (124579), 357791 ms
[12:04:24] scan: chap 4 c=3->4, b=225733->339817 (114085), 359815 ms
[12:04:24] scan: chap 5 c=5->5, b=339818->422243 (82426), 218552 ms
[12:04:24] scan: chap 6 c=6->6, b=422244->484454 (62211), 182333 ms
[12:04:24] scan: chap 7 c=7->7, b=484455->566800 (82346), 235571 ms
[12:04:24] scan: chap 8 c=8->8, b=566801->667494 (100694), 266468 ms
[12:04:24] scan: chap 9 c=9->10, b=667495->801087 (133593), 387029 ms
[12:04:24] scan: chap 10 c=11->11, b=801088->866022 (64935), 175467 ms
[12:04:24] scan: chap 11 c=12->12, b=866023->933463 (67441), 175301 ms
[12:04:24] scan: chap 12 c=13->13, b=933464->939991 (6528), 38075 ms
[12:04:24] scan: chap 13 c=14->14, b=939992->939996 (5), 176 ms
[12:04:24] scan: aspect = 0
[12:04:24] scan: decoding previews for title 3
[12:04:24] scan: audio 0x82bd: AC-3, rate=48000Hz, bitrate=192000 Espanol (AC3) (Dolby Surround)
[12:04:24] scan: audio 0x80bd: AC-3, rate=48000Hz, bitrate=192000 English (AC3) (Dolby Surround)
[12:04:24] scan: audio 0x81bd: AC-3, rate=48000Hz, bitrate=192000 Francais (AC3) (Dolby Surround)
[12:04:24] 196.637421s: Video -> Film
[12:04:25] scan: 10 previews, 720x480, 23.976 fps, autocrop = 0/0/0/0, aspect 16:9, PAR 32:27
[12:04:25] scan: title (0) job->width:720, job->height:400
[12:04:25] libhb: scan thread found 1 valid title(s)
[12:04:25] macgui: ScanDone state received from fQueueEncodeLibhb
[12:04:25] macgui: processNewQueueEncode title list is: 1
[12:04:25] macgui: Preset: Anamorphic, AC3, mkv
[12:04:25] macgui: processNewQueueEncode number of passes expected is: 1
[12:04:25] macgui: prepareJob exiting
[12:04:25] 1 job(s) to process
[12:04:25] starting job
[12:04:25] job configuration:
[12:04:25]  * source
[12:04:25]    + /Users/dave/DVD Rips/FIREFLY_D1
[12:04:25]    + title 3, chapter(s) 1 to 13
[12:04:25]  * destination
[12:04:25]    + /Volumes/よみこ/Video/TV Shows/Firefly/03 Firefly - S01E03.mkv
[12:04:25]    + container: Matroska (.mkv)
[12:04:25]      + chapter markers
[12:04:25]  * video track
[12:04:25]    + decoder: mpeg2
[12:04:25]      + bitrate 9800 kbps
[12:04:25]    + frame rate: same as source (around 23.976 fps)
[12:04:25]    + strict anamorphic
[12:04:25]      + storage dimensions: 720 * 480 -> 720 * 480, crop 0/0/0/0
[12:04:25]      + pixel aspect ratio: 32 / 27
[12:04:25]      + display dimensions: 853 * 480
[12:04:25]    + filter
[12:04:25]      + Deinterlaces selectively with yadif/mcdeint and lowpass5 blending (1:2:6:9:80:16:16)
[12:04:25]    + encoder: x264
[12:04:25]      + options: ref=1:bframes=2:direct=auto:subq=8:analyse=all:8x8dct=1:trellis=1:no-fast-pskip=1:fil=1
[12:04:25]      + quality: 0.70
[12:04:25]  * audio track 0
[12:04:25]    + decoder: English (AC3) (Dolby Surround) (track 1, id 80bd)
[12:04:25]      + bitrate: 192 kbps, samplerate: 48000 Hz
[12:04:25]    + AC3 passthrough
[12:04:25] yadif thread started for segment 0
[12:04:25] yadif thread started for segment 1
[12:04:25] decomb thread started for segment 0
[12:04:25] decomb thread started for segment 1
[12:04:25] encx264: keyint-min: 24, keyint-max: 240
[12:04:25] x264 options: Unknown suboption fil
[12:04:25] encx264: encoding with stored aspect 32/27
[12:04:25] encx264: Encoding at constant RF 15.299999
x264 [info]: using SAR=32/27
x264 [info]: using cpu capabilities: MMX2 SSE2Fast SSSE3 Cache64
x264 [info]: profile High, level 3.0
No accelerated IMDCT transform found
[12:04:25] sync: expecting 63153 video frames
[12:04:25] reader: first SCR 146
[12:04:25] mpeg2: "Chapter  1" (1) at frame 0 time 3003
[12:04:25] sync: first pts is 3003
[12:14:06] mpeg2: "Chapter  2" (2) at frame 4432 time 16639623
[12:16:13] mpeg2: "Chapter  3" (3) at frame 5688 time 21354333
[12:34:11] mpeg2: "Chapter  4" (4) at frame 14268 time 53561508
[12:53:31] mpeg2: "Chapter  5" (5) at frame 22912 time 86007825
[13:05:22] mpeg2: "Chapter  6" (6) at frame 28156 time 105692490
[13:15:00] mpeg2: "Chapter  7" (7) at frame 32540 time 122148930
[13:26:52] mpeg2: "Chapter  8" (8) at frame 38184 time 143335095
[13:39:52] mpeg2: "Chapter  9" (9) at frame 44576 time 167329065
[13:57:24] mpeg2: "Chapter 10" (10) at frame 53872 time 202222816
[14:05:34] mpeg2: "Chapter 11" (11) at frame 58076 time 218003581
[14:14:55] mpeg2: "Chapter 12" (12) at frame 62276 time 233769331
[14:15:18] dvd: end of cell 14 at block 939992
[14:15:18] reader: done. 3 scr changes
[14:15:21] mpeg2: "Chapter 13" (13) at frame 63196 time 237222780
[14:15:22] sync: got 63196 frames, 63153 expected
[14:15:22] work: average encoding speed for job is 8.042570 fps
[14:15:22] mpeg2 done: 63197 frames
[14:15:22] render: lost time: 0 (0 frames)
[14:15:22] render: gained time: 0 (0 frames) (0 not accounted for)
x264 [info]: slice I:892   Avg QP:11.81  size: 68529  PSNR Mean Y:52.06 U:53.03 V:54.09 Avg:52.33 Global:51.78
x264 [info]: slice P:31341 Avg QP:12.79  size: 38649  PSNR Mean Y:49.43 U:51.13 V:52.19 Avg:49.95 Global:49.37
x264 [info]: slice B:30963 Avg QP:15.08  size: 16086  PSNR Mean Y:47.93 U:50.18 V:51.55 Avg:48.53 Global:47.87
x264 [info]: consecutive B-frames: 18.4% 28.4% 53.2%
x264 [info]: mb I  I16..4:  5.1% 90.0%  4.9%
x264 [info]: mb P  I16..4:  0.9% 40.0%  1.3%  P16..4: 23.9% 17.4% 11.3%  1.1%  1.5%    skip: 2.4%
x264 [info]: mb B  I16..4:  0.1%  7.2%  0.1%  B16..8: 50.8%  4.6%  7.9%  direct:12.0%  skip:17.3%  L0:35.0% L1:27.3% BI:37.7%
x264 [info]: 8x8 transform  intra:94.7%  inter:67.2%
x264 [info]: direct mvs  spatial:98.5%  temporal:1.5%
x264 [info]: SSIM Mean Y:0.9904116
x264 [info]: PSNR Mean Y:48.731 U:50.690 V:51.905 Avg:49.285 Global:48.588 kb/s:5373.73
[14:15:22] decomb: yadif deinterlaced 0 | blend deinterlaced 0 | unfiltered 63195 | total 63195
[14:15:22] libhb: work result = 0
golias
Enlightened
Posts: 105
Joined: Wed Jan 03, 2007 7:29 pm

Re: Intermittent video problem.

Post by golias »

Any ideas? Any other info you need? Anyone?
jbrjake
Veteran User
Posts: 4805
Joined: Wed Dec 13, 2006 1:38 am

Re: Intermittent video problem.

Post by jbrjake »

Again....this shouldn't be happening with current code. There have been a number of x264 changes since November.
golias
Enlightened
Posts: 105
Joined: Wed Jan 03, 2007 7:29 pm

Re: Intermittent video problem.

Post by golias »

jbrjake wrote:Again....this shouldn't be happening with current code. There have been a number of x264 changes since November.
And again... I'm using the most current public release, so clearly it is happening with current code.
golias
Enlightened
Posts: 105
Joined: Wed Jan 03, 2007 7:29 pm

Re: Intermittent video problem.

Post by golias »

Would you like my playback software versions, too? Here they all are.

QuickTime™ Version 7.5.5 (990.7)
QuickTime Player Version 7.5.5 (249.13)
Perian 1.1.1
VLC Version 0.9.8 Grishenko (Intel)
Plex Version 0.7.5
OS X Version 10.5.6 Build 9G55

So, everything is up-to-this-very-minute there.

Is there some not-yet-available version of HB which you think I should be compiling from the dev versions, or is there a way to avoid this issue with the current 0.9.3 version?
jbrjake
Veteran User
Posts: 4805
Joined: Wed Dec 13, 2006 1:38 am

Re: Intermittent video problem.

Post by jbrjake »

By current code I mean, literally, current code. The SVN head.
golias
Enlightened
Posts: 105
Joined: Wed Jan 03, 2007 7:29 pm

Re: Intermittent video problem.

Post by golias »

jbrjake wrote:By current code I mean, literally, current code. The SVN head.
Ah. So this is a known 0.9.3 flaw which has been addressed?

Do you recommend that I download and compile the latest revision, or will there be a new public release in the immediate future?

(I think I still have the SVN links somewhere, assuming they haven't changed in the last couple years... although my current living-room Mac doesn't have the X-tools installed at the moment, as far as I recall.)
jbrjake
Veteran User
Posts: 4805
Joined: Wed Dec 13, 2006 1:38 am

Re: Intermittent video problem.

Post by jbrjake »

I'm assuming it's the same issue we all discussed in an earlier thread shortly after 0.9.3 was released, when rhester suggested to you it might be an x264 problem.

Are you encoding on an Intel or PPC Mac?
golias
Enlightened
Posts: 105
Joined: Wed Jan 03, 2007 7:29 pm

Re: Intermittent video problem.

Post by golias »

jbrjake wrote:I'm assuming it's the same issue we all discussed in an earlier thread shortly after 0.9.3 was released, when rhester suggested to you it might be an x264 problem.

Are you encoding on an Intel or PPC Mac?
I'm doing both my encoding and playback on a Core2 Duo 2.0 Mac mini.

I just downloaded the latest "stable" release from the SVN, as you suggested. I'm still getting bad frames like this. (Same file, same settings.) Here's the log from this latest attempt:

Code: Select all

HandBrake Activity Log for /Volumes/よみこ/Video/TV Shows/Firefly/03 Firefly - S01E03.mkv: 2009-01-10 06:27:14 -0600
Handbrake Version: svn2070 (2009010901)

[06:27:14] macgui: scanning specifically for title: 3
[06:27:14] macgui: performNewQueueScan currentQueueEncodeIndex is: 0
[06:27:14] hb_scan: path=/Users/dave/DVD Rips/FIREFLY_D1, title_index=3
[06:27:14] scan: trying to open with libdvdread
[06:27:14] scan: DVD has 10 title(s)
[06:27:14] scan: scanning title 3
[06:27:14] scan: opening IFO for VTS 7
[06:27:14] pgc_id: 1, pgn: 1: pgc: 0x18820310
[06:27:14] scan: vts=7, ttn=1, cells=0->14, blocks=0->939996, 939997 blocks
[06:27:14] scan: duration is 00:43:53 (2633020 ms)
[06:27:14] scan: checking audio 1
[06:27:14] scan: id=80bd, lang=English (AC3), 3cc=eng ext=1
[06:27:14] scan: checking audio 2
[06:27:14] scan: id=81bd, lang=Francais (AC3), 3cc=fra ext=1
[06:27:14] scan: checking audio 3
[06:27:14] scan: id=82bd, lang=Espanol (AC3), 3cc=spa ext=1
[06:27:14] scan: checking subtitle 1
[06:27:14] scan: id=24bd, lang=English (Closed Caption), 3cc=eng
[06:27:14] scan: checking subtitle 2
[06:27:14] scan: id=25bd, lang=Espanol, 3cc=spa
[06:27:14] scan: checking subtitle 3
[06:27:14] scan: id=26bd, lang=Francais (Forced Caption), 3cc=fra
[06:27:14] scan: checking subtitle 4
[06:27:14] scan: id=27bd, lang=Espanol (Forced Caption), 3cc=spa
[06:27:14] scan: title 3 has 13 chapters
[06:27:14] scan: chap 1 c=0->0, b=0->80347 (80348), 184337 ms
[06:27:14] scan: chap 2 c=1->1, b=80348->101153 (20806), 52099 ms
[06:27:14] scan: chap 3 c=2->2, b=101154->225732 (124579), 357791 ms
[06:27:14] scan: chap 4 c=3->4, b=225733->339817 (114085), 359815 ms
[06:27:14] scan: chap 5 c=5->5, b=339818->422243 (82426), 218552 ms
[06:27:14] scan: chap 6 c=6->6, b=422244->484454 (62211), 182333 ms
[06:27:14] scan: chap 7 c=7->7, b=484455->566800 (82346), 235571 ms
[06:27:14] scan: chap 8 c=8->8, b=566801->667494 (100694), 266468 ms
[06:27:14] scan: chap 9 c=9->10, b=667495->801087 (133593), 387029 ms
[06:27:14] scan: chap 10 c=11->11, b=801088->866022 (64935), 175467 ms
[06:27:14] scan: chap 11 c=12->12, b=866023->933463 (67441), 175301 ms
[06:27:14] scan: chap 12 c=13->13, b=933464->939991 (6528), 38075 ms
[06:27:14] scan: chap 13 c=14->14, b=939992->939996 (5), 176 ms
[06:27:14] scan: aspect = 0
[06:27:14] scan: decoding previews for title 3
[06:27:14] scan: audio 0x82bd: AC-3, rate=48000Hz, bitrate=192000 Espanol (AC3) (Dolby Surround)
[06:27:14] scan: audio 0x80bd: AC-3, rate=48000Hz, bitrate=192000 English (AC3) (Dolby Surround)
[06:27:14] scan: audio 0x81bd: AC-3, rate=48000Hz, bitrate=192000 Francais (AC3) (Dolby Surround)
[06:27:14] 196.637421s: Video -> Film
[06:27:14] scan: 10 previews, 720x480, 23.976 fps, autocrop = 0/0/0/0, aspect 16:9, PAR 32:27
[06:27:14] scan: title (0) job->width:720, job->height:400
[06:27:14] libhb: scan thread found 1 valid title(s)
[06:27:14] macgui: ScanDone state received from fQueueEncodeLibhb
[06:27:14] macgui: processNewQueueEncode title list is: 1
[06:27:14] macgui: Preset: Anamorphic, AC3, mkv
[06:27:14] macgui: processNewQueueEncode number of passes expected is: 1
[06:27:14] macgui: prepareJob exiting
[06:27:14] 1 job(s) to process
[06:27:14] starting job
[06:27:14] job configuration:
[06:27:14]  * source
[06:27:14]    + /Users/dave/DVD Rips/FIREFLY_D1
[06:27:14]    + title 3, chapter(s) 1 to 13
[06:27:14]  * destination
[06:27:14]    + /Volumes/よみこ/Video/TV Shows/Firefly/03 Firefly - S01E03.mkv
[06:27:14]    + container: Matroska (.mkv)
[06:27:14]      + chapter markers
[06:27:14]  * video track
[06:27:14]    + decoder: mpeg2
[06:27:14]      + bitrate 9800 kbps
[06:27:14]    + frame rate: same as source (around 23.976 fps)
[06:27:14]    + strict anamorphic
[06:27:14]      + storage dimensions: 720 * 480 -> 720 * 480, crop 0/0/0/0
[06:27:14]      + pixel aspect ratio: 32 / 27
[06:27:14]      + display dimensions: 853 * 480
[06:27:14]    + filter
[06:27:14]      + Deinterlaces selectively with yadif/mcdeint and lowpass5 blending (1:2:6:9:80:16:16)
[06:27:14]    + encoder: x264
[06:27:14]      + options: ref=1:bframes=2:direct=auto:subq=8:analyse=all:8x8dct=1:trellis=1:no-fast-pskip=1:fil=1
[06:27:14]      + quality: 0.70
[06:27:14]  * audio track 0
[06:27:14]    + decoder: English (AC3) (Dolby Surround) (track 1, id 80bd)
[06:27:14]      + bitrate: 192 kbps, samplerate: 48000 Hz
[06:27:14]    + AC3 passthrough
[06:27:14] yadif thread started for segment 0
[06:27:14] yadif thread started for segment 1
[06:27:14] decomb thread started for segment 0
[06:27:14] decomb thread started for segment 1
[06:27:14] encx264: keyint-min: 24, keyint-max: 240
[06:27:14] x264 options: Unknown suboption fil
[06:27:14] encx264: encoding with stored aspect 32/27
[06:27:14] encx264: Encoding at constant RF 15.299999
x264 [info]: using SAR=32/27
[06:27:14] reader: first SCR 146
x264 [info]: using cpu capabilities: MMX2 SSE2Fast SSSE3 Cache64
[06:27:14] mpeg2: "Chapter  1" (1) at frame 0 time 3003
x264 [info]: profile High, level 3.0
No accelerated IMDCT transform found
[06:27:15] sync: expecting 63153 video frames
[06:27:15] sync: first pts is 3003
[06:37:06] mpeg2: "Chapter  2" (2) at frame 4432 time 16639623
[06:39:18] mpeg2: "Chapter  3" (3) at frame 5688 time 21354333
[06:57:58] mpeg2: "Chapter  4" (4) at frame 14268 time 53561508
[07:18:46] mpeg2: "Chapter  5" (5) at frame 22912 time 86007825
[07:31:43] mpeg2: "Chapter  6" (6) at frame 28156 time 105692490
[07:41:22] mpeg2: "Chapter  7" (7) at frame 32540 time 122148930
[07:53:09] mpeg2: "Chapter  8" (8) at frame 38184 time 143335095
[08:05:55] mpeg2: "Chapter  9" (9) at frame 44576 time 167329065
[08:23:02] mpeg2: "Chapter 10" (10) at frame 53872 time 202222816
[08:30:57] mpeg2: "Chapter 11" (11) at frame 58076 time 218003581
[08:40:09] mpeg2: "Chapter 12" (12) at frame 62276 time 233769331
[08:40:32] dvd: end of cell 14 at block 939992
[08:40:32] reader: done. 3 scr changes
[08:40:35] mpeg2: "Chapter 13" (13) at frame 63196 time 237222780
[08:40:36] sync: got 63196 frames, 63153 expected
[08:40:36] work: average encoding speed for job is 7.897265 fps
[08:40:36] mpeg2 done: 63197 frames
[08:40:36] render: lost time: 0 (0 frames)
[08:40:36] render: gained time: 0 (0 frames) (0 not accounted for)
x264 [info]: slice I:892   Avg QP:11.81  size: 68529  PSNR Mean Y:52.06 U:53.03 V:54.09 Avg:52.33 Global:51.78
x264 [info]: slice P:31341 Avg QP:12.79  size: 38649  PSNR Mean Y:49.43 U:51.13 V:52.19 Avg:49.95 Global:49.37
x264 [info]: slice B:30963 Avg QP:15.08  size: 16086  PSNR Mean Y:47.93 U:50.18 V:51.55 Avg:48.53 Global:47.87
x264 [info]: consecutive B-frames: 18.4% 28.4% 53.2%
x264 [info]: mb I  I16..4:  5.1% 90.0%  4.9%
x264 [info]: mb P  I16..4:  0.9% 40.0%  1.3%  P16..4: 23.9% 17.4% 11.3%  1.1%  1.5%    skip: 2.4%
x264 [info]: mb B  I16..4:  0.1%  7.2%  0.1%  B16..8: 50.8%  4.6%  7.9%  direct:12.0%  skip:17.3%  L0:35.0% L1:27.3% BI:37.7%
x264 [info]: 8x8 transform  intra:94.7%  inter:67.2%
x264 [info]: direct mvs  spatial:98.5%  temporal:1.5%
x264 [info]: SSIM Mean Y:0.9904116
x264 [info]: PSNR Mean Y:48.731 U:50.690 V:51.905 Avg:49.285 Global:48.588 kb/s:5373.71
[08:40:36] decomb: yadif deinterlaced 0 | blend deinterlaced 0 | unfiltered 63195 | total 63195
[08:40:36] libhb: work result = 0
golias
Enlightened
Posts: 105
Joined: Wed Jan 03, 2007 7:29 pm

Re: Intermittent video problem.

Post by golias »

Okay, I've got a real, REAL bad feeling that I know what the problem is. I'm posting it here because others might find it instructive.

Right around the same time that HB went up to 0.9.3, I got rid of all my old little 300 GB drives and replaced them with a single 2TB MyBook, connected by FireWire to the mini. This drive is the basket which all my eggs are in now. I treat the original DVD's in my collection as my backups.

Another hardware change around the same time: My mini motherboard failed, and was replaced under warranty by Apple.

Getting a sinking feeling that I had eliminated both HandBrake AND my playback software as the problems, I was getting a growing suspicion that I might have a hardware problem on my hands.

So I did a test rip yesterday. Same settings, same file, but to my LOCAL drive (which is an internal SATA).

Perfect. No flaws whatsoever!

This means that my problem is one of two things:

1. The communications bus on the mini is causing write errors via FireWire and USB2. I didn't have extended AppleCare on the mini and it has expired, but since this is a new-ish logic board, perhaps I can get them to fix it free anyway. (Assuming it turns out to be the problem.)

2. The MyBook is a piece of turd, utterly unfit for use as a media storage device (either because of its bus, or because of the two internal drives themsevles.) If so, I'll try to see of some kind of advanced disk repair software can find and fix the problem. If not, I'll buy a new drive (such as a LaCie), and turn this into a RAID 1 backup system (hopefully setting it up as a mirrored RAID will result in 1 TB of reliable storage rather than 2 TB of storage that I can't count on.)

So I am now doing a new test, using my laptop and the MyBook, to determine which it is. Wish me luck. :/


(EDIT) Test complete. It is confirmed. My MyBook is what is farting all over the video files. This is bad news for me for two reasons. 1. All my media files are on this drive. Most will probably need to be re-ripped. 2. Replacing the drive will cost me money.

But it's good news for HB. Clearly it's working as advertised. Sorry if all this troubleshooting felt like a waste of time, but I had to eliminate all the software-related possibilities before looking at the more expensive scenarios. :/
golias
Enlightened
Posts: 105
Joined: Wed Jan 03, 2007 7:29 pm

Re: Intermittent video problem.

Post by golias »

Ah, crap. I spoke too soon. The file I saved to the local drive DOES have a couple playback glitches. My eyes must have missed them when I was watching the first time.

So now I'm back to square one, I guess. :(

No matter which of my two computers I'm using, the mini or the MacBook, and no matter what drive I save to, these same issues keep cropping up. I'm going round in cirlces.

Is it perhaps an Intel bug? Either with the Core 2 Duo or perhaps with the GMA 950 video card, when it comes to playing back h.264? Both my macs have that in common. I'm clutching at straws here, I realize, but I'm running out of ideas.
Last edited by golias on Tue Jan 13, 2009 12:00 am, edited 1 time in total.
golias
Enlightened
Posts: 105
Joined: Wed Jan 03, 2007 7:29 pm

Re: Intermittent video problem.

Post by golias »

Oh, and here's the log for the local-drive test I did, in case it helps:

Code: Select all

HandBrake Activity Log for /Users/dave/HB Test/03 Firefly - S01E03.mkv: 2009-01-10 08:56:21 -0600
Handbrake Version: svn2070 (2009010901)

[08:56:21] macgui: Rip: Pending queue count is 0
[08:56:21] macgui: Rip: No pending jobs, so sending this one to doAddToQueue
[08:56:21] macgui: Rip: Going right to performNewQueueScan
[08:56:21] macgui: scanning specifically for title: 3
[08:56:21] macgui: performNewQueueScan currentQueueEncodeIndex is: 1
[08:56:21] hb_scan: path=/Users/dave/DVD Rips/FIREFLY_D1, title_index=3
[08:56:21] scan: trying to open with libdvdread
[08:56:22] scan: DVD has 10 title(s)
[08:56:22] scan: scanning title 3
[08:56:22] scan: opening IFO for VTS 7
[08:56:22] pgc_id: 1, pgn: 1: pgc: 0x169e91c0
[08:56:22] scan: vts=7, ttn=1, cells=0->14, blocks=0->939996, 939997 blocks
[08:56:22] scan: duration is 00:43:53 (2633020 ms)
[08:56:22] scan: checking audio 1
[08:56:22] scan: id=80bd, lang=English (AC3), 3cc=eng ext=1
[08:56:22] scan: checking audio 2
[08:56:22] scan: id=81bd, lang=Francais (AC3), 3cc=fra ext=1
[08:56:22] scan: checking audio 3
[08:56:22] scan: id=82bd, lang=Espanol (AC3), 3cc=spa ext=1
[08:56:22] scan: checking subtitle 1
[08:56:22] scan: id=24bd, lang=English (Closed Caption), 3cc=eng
[08:56:22] scan: checking subtitle 2
[08:56:22] scan: id=25bd, lang=Espanol, 3cc=spa
[08:56:22] scan: checking subtitle 3
[08:56:22] scan: id=26bd, lang=Francais (Forced Caption), 3cc=fra
[08:56:22] scan: checking subtitle 4
[08:56:22] scan: id=27bd, lang=Espanol (Forced Caption), 3cc=spa
[08:56:22] scan: title 3 has 13 chapters
[08:56:22] scan: chap 1 c=0->0, b=0->80347 (80348), 184337 ms
[08:56:22] scan: chap 2 c=1->1, b=80348->101153 (20806), 52099 ms
[08:56:22] scan: chap 3 c=2->2, b=101154->225732 (124579), 357791 ms
[08:56:22] scan: chap 4 c=3->4, b=225733->339817 (114085), 359815 ms
[08:56:22] scan: chap 5 c=5->5, b=339818->422243 (82426), 218552 ms
[08:56:22] scan: chap 6 c=6->6, b=422244->484454 (62211), 182333 ms
[08:56:22] scan: chap 7 c=7->7, b=484455->566800 (82346), 235571 ms
[08:56:22] scan: chap 8 c=8->8, b=566801->667494 (100694), 266468 ms
[08:56:22] scan: chap 9 c=9->10, b=667495->801087 (133593), 387029 ms
[08:56:22] scan: chap 10 c=11->11, b=801088->866022 (64935), 175467 ms
[08:56:22] scan: chap 11 c=12->12, b=866023->933463 (67441), 175301 ms
[08:56:22] scan: chap 12 c=13->13, b=933464->939991 (6528), 38075 ms
[08:56:22] scan: chap 13 c=14->14, b=939992->939996 (5), 176 ms
[08:56:22] scan: aspect = 0
[08:56:22] scan: decoding previews for title 3
[08:56:22] scan: audio 0x82bd: AC-3, rate=48000Hz, bitrate=192000 Espanol (AC3) (Dolby Surround)
[08:56:22] scan: audio 0x80bd: AC-3, rate=48000Hz, bitrate=192000 English (AC3) (Dolby Surround)
[08:56:22] scan: audio 0x81bd: AC-3, rate=48000Hz, bitrate=192000 Francais (AC3) (Dolby Surround)
[08:56:23] scan: 10 previews, 720x480, 23.976 fps, autocrop = 0/0/0/0, aspect 16:9, PAR 32:27
[08:56:23] scan: title (0) job->width:720, job->height:400
[08:56:23] libhb: scan thread found 1 valid title(s)
[08:56:24] macgui: currentScanCount received from fQueueEncodeLibhb
[08:56:24] macgui: ScanDone state received from fQueueEncodeLibhb
[08:56:24] macgui: processNewQueueEncode title list is: 1
[08:56:24] macgui: Preset: Anamorphic, AC3, mkv
[08:56:24] macgui: processNewQueueEncode number of passes expected is: 1
[08:56:24] macgui: prepareJob exiting
[08:56:24] 1 job(s) to process
[08:56:24] starting job
[08:56:24] job configuration:
[08:56:24]  * source
[08:56:24]    + /Users/dave/DVD Rips/FIREFLY_D1
[08:56:24]    + title 3, chapter(s) 1 to 13
[08:56:24]  * destination
[08:56:24]    + /Users/dave/HB Test/03 Firefly - S01E03.mkv
[08:56:24]    + container: Matroska (.mkv)
[08:56:24]      + chapter markers
[08:56:24]  * video track
[08:56:24]    + decoder: mpeg2
[08:56:24]      + bitrate 9800 kbps
[08:56:24]    + frame rate: same as source (around 23.976 fps)
[08:56:24]    + strict anamorphic
[08:56:24]      + storage dimensions: 720 * 480 -> 720 * 480, crop 0/0/0/0
[08:56:24]      + pixel aspect ratio: 32 / 27
[08:56:24]      + display dimensions: 853 * 480
[08:56:24]    + filter
[08:56:24]      + Deinterlaces selectively with yadif/mcdeint and lowpass5 blending (1:2:6:9:80:16:16)
[08:56:24]    + encoder: x264
[08:56:24]      + options: ref=1:bframes=2:direct=auto:subq=8:analyse=all:8x8dct=1:trellis=1:no-fast-pskip=1:fil=1
[08:56:24]      + quality: 0.70
[08:56:24]  * audio track 0
[08:56:24]    + decoder: English (AC3) (Dolby Surround) (track 1, id 80bd)
[08:56:24]      + bitrate: 192 kbps, samplerate: 48000 Hz
[08:56:24]    + AC3 passthrough
[08:56:24] yadif thread started for segment 0
[08:56:24] yadif thread started for segment 1
[08:56:24] decomb thread started for segment 0
[08:56:24] decomb thread started for segment 1
[08:56:24] encx264: keyint-min: 24, keyint-max: 240
[08:56:24] x264 options: Unknown suboption fil
[08:56:24] encx264: encoding with stored aspect 32/27
[08:56:24] encx264: Encoding at constant RF 15.299999
x264 [info]: using SAR=32/27
x264 [info]: using cpu capabilities: MMX2 SSE2Fast SSSE3 Cache64
x264 [info]: profile High, level 3.0
No accelerated IMDCT transform found
[08:56:24] sync: expecting 63153 video frames
[08:56:24] reader: first SCR 146
[08:56:24] mpeg2: "Chapter  1" (1) at frame 0 time 3003
[08:56:24] sync: first pts is 3003
[09:06:52] mpeg2: "Chapter  2" (2) at frame 4432 time 16639623
[09:09:16] mpeg2: "Chapter  3" (3) at frame 5688 time 21354333
[09:28:42] mpeg2: "Chapter  4" (4) at frame 14268 time 53561508
[09:49:35] mpeg2: "Chapter  5" (5) at frame 22912 time 86007825
[10:01:44] mpeg2: "Chapter  6" (6) at frame 28156 time 105692490
[10:11:19] mpeg2: "Chapter  7" (7) at frame 32540 time 122148930
[10:23:07] mpeg2: "Chapter  8" (8) at frame 38184 time 143335095
[10:36:06] mpeg2: "Chapter  9" (9) at frame 44576 time 167329065
[10:53:38] mpeg2: "Chapter 10" (10) at frame 53872 time 202222816
[11:01:46] mpeg2: "Chapter 11" (11) at frame 58076 time 218003581
[11:11:06] mpeg2: "Chapter 12" (12) at frame 62276 time 233769331
[11:11:28] dvd: end of cell 14 at block 939992
[11:11:28] reader: done. 3 scr changes
[11:11:31] mpeg2: "Chapter 13" (13) at frame 63196 time 237222780
[11:11:32] sync: got 63196 frames, 63153 expected
[11:11:32] work: average encoding speed for job is 7.792611 fps
[11:11:32] mpeg2 done: 63197 frames
[11:11:32] render: lost time: 0 (0 frames)
[11:11:32] render: gained time: 0 (0 frames) (0 not accounted for)
x264 [info]: slice I:892   Avg QP:11.81  size: 68529  PSNR Mean Y:52.06 U:53.03 V:54.09 Avg:52.33 Global:51.78
x264 [info]: slice P:31341 Avg QP:12.79  size: 38649  PSNR Mean Y:49.43 U:51.13 V:52.19 Avg:49.95 Global:49.37
x264 [info]: slice B:30963 Avg QP:15.08  size: 16086  PSNR Mean Y:47.93 U:50.18 V:51.55 Avg:48.53 Global:47.87
x264 [info]: consecutive B-frames: 18.4% 28.4% 53.2%
x264 [info]: mb I  I16..4:  5.1% 90.0%  4.9%
x264 [info]: mb P  I16..4:  0.9% 40.0%  1.3%  P16..4: 23.9% 17.4% 11.3%  1.1%  1.5%    skip: 2.4%
x264 [info]: mb B  I16..4:  0.1%  7.2%  0.1%  B16..8: 50.8%  4.6%  7.9%  direct:12.0%  skip:17.3%  L0:35.0% L1:27.3% BI:37.7%
x264 [info]: 8x8 transform  intra:94.7%  inter:67.2%
x264 [info]: direct mvs  spatial:98.5%  temporal:1.5%
x264 [info]: SSIM Mean Y:0.9904116
x264 [info]: PSNR Mean Y:48.731 U:50.690 V:51.905 Avg:49.285 Global:48.588 kb/s:5373.72
[11:11:32] decomb: yadif deinterlaced 0 | blend deinterlaced 0 | unfiltered 63195 | total 63195
[11:11:32] libhb: work result = 0
golias
Enlightened
Posts: 105
Joined: Wed Jan 03, 2007 7:29 pm

Re: Intermittent video problem.

Post by golias »

golias wrote:Ah, crap. I spoke too soon. The file I saved to the local drive DOES have a couple playback glitches. My eyes must have missed them when I was watching the first time.
After EXHAUSTIVE testing, I've determined that the issues on that one file I copied to the local drive were unrelated. Then I found some interesting posts over on the Plex forum which supported what I was thinking.

Here's the bottom line: If you are going to build a large media library, STAY AWAY from the 2TB MyBook drives from Western Digital.

These drives are essentially a pair of 5400 RPM "Green" 1TB SATA drives in a RAID 0 array. It can connect to your mac via USB 2, eSATA, FW400 or TW800.

Each of these drives is made up of four platters, so you essentially have eight 250MB platters sharing a single logical volume.

For most uses, these drives do just fine, but it appears when you write LARGE files a little bit at a time, such as creating a Handbrake rip or downloading a multi-GB torrent file, it ends up mangling small chunks of those files.

This is more guess-work than theory, but it seems that once the drive gets a little bit on the full side with mostly large files, it can start to get very fragmented and distribute new incoming files all over it's many platters (in spite of the efforts of HFS+ to keep files together as much as possible)... Which would be perfectly fine, except one of the reasons these drives are "Green" (which is nice: less power consumption, less heat, less noise, warm fuzzies, etc.) is because they tend to park the heads A LOT more often than you would normally want from a high-performance drive serving up media files. Also, it does seem to mangle the files a little bit in the writing process somehow.

I found a pair of single-unit 7200 RPM 1.5 TB Seagate drives at Best Buy for $187 a pop. They are a pain to set up for Firewire use (I had to flip to my Windows partition to run the config software and turn the "sleep after 15 minutes" feature off), but my mysterious video problem appears to be solved at last.

As for the WD... I'm either going to re-format it as RAID 1, to be used as a 1TB backup drive, or else I'll sell it off to somebody who will use it for something less demanding than media files. All's well that ends well.

Thanks for all your help to those who aided with the troubleshooting. It might seem like a waste of time, but for me at least, it was worth it to eliminate software from the possible sources of the problem. Maybe my story can save somebody else a lot of aggravation.
Post Reply