GK: Encoded movie much too short

[defaulk9]

Hello everyone. I'm in need of some guidance here. I'm using Gordian Knot w/ x264.

Basically, I'm following the doom9 Gordian Knot Guide for x264 the only real difference is that I'm using Matroska instead of an AVI container.

When I start encoding, the first pass takes about 3hrs 50min, but the second one only takes 50min, and I only get a 16 minute long movie. (It's supposed to be almost 2 hours)

Has anybody seen this before or have an idea how I might go about further diagnosing this problem?

[niamh]

:logfile:

[defaulk9]

ok, here goes....


2/27/2005 1:14:43 PM: Job "H264 - 1 - BOURNE.mkv" started.

o x264 - First Pass V:\R4R\BOURNE_1\BOURNE.avs
0 x264 - Second Pass V:\R4R\BOURNE_1\BOURNE.avs
o Mux Audio & add Chapters info.
End of Job 1 (H264 - 1 - BOURNE.mkv).
_______________________________________________________________________________________________________________________

Gordian Knot
Encoding Job Data:

Type: EncX264_All
Container: Matroska File (MKV)
Number: 1
Name: H264 - 1 - BOURNE.mkv
Platform: WinXP (5.1.2600).2

Files:
VirtualDubModExe: C:\PROGRA~1\GordianKnot\VirtualDubMod\VirtualDubMod.exe
NandubExe: C:\PROGRA~1\GordianKnot\nandub\Nandub.exe
AviFinal: V:\R4R\BOURNE_1\BOURNE.mkv
AviMovie: V:\R4R\BOURNE_1\BOURNE_Movie.mkv
AviCredits: V:\R4R\BOURNE_1\BOURNE_Credits.mkv
MovieFS: V:\R4R\BOURNE_1\BOURNE.avs
CreditsFS:
Log : V:\R4R\BOURNE_1\BOURNE.log
Stats: V:\R4R\BOURNE_1\BOURNE.stats
Ecf : V:\R4R\BOURNE_1\BOURNE.ecf

Options:
Quality/DRF: 0
CreditsStart: 146733
UseEcf: 1
CreditsIVTC: 0
CreditsAppend: 0
DeleteInterm.: 0
EnforceBitrate: 0
AntiShit: 0

Calculator:
VideoSize: 617396 kbyte.
Audio1Size: 80925 kbyte.
Audio2Size: 0 kbyte.
Overhead: 2385 kbyte.
AviSize: 700706 kbyte (684 mbyte).
FilesSize: 733 kbyte.
TotalSize: 701440 kbyte (685 mbyte).
Interleaving: ogg
Bitrate: 776 k(=1000)Bits/s
Frames: 156146
FPS: 23.976
Duration: 148:33
Quality: 0.160 bits/(pixel*frame).
CompCheck3: 0.000 bits/(pixel*frame).
CompCheck5: 0.209 bits/(pixel*frame).
Resolution: 704 x 288

Audio 1:
Mode: Just Mux Source File.
SourceFile: V:\R4R\BOURNE_1\BOURNE Track 1 English DELAY 0ms.ogg
WavFile: V:\R4R\BOURNE_1\BOURNE Track 1 English DELAY 0ms.wav
Mp3File: V:\R4R\BOURNE_1\BOURNE Track 1 English DELAY 0ms.mp3
OggFile: V:\R4R\BOURNE_1\BOURNE Track 1 English DELAY 0ms_1.ogg
OggQuality: 0.200
OggLanguage: English
Azid:
Lame:
Delay: 0
Interval: 1
Preload: 500
Mux: 1
Recalc: 1
DeleteWav: 1

Audio 2:
none.

1:14:43 PM: Audio 1, determined: 80925 kb
1:14:43 PM: Audio 1, calc: 80925 kb
1:14:43 PM: New Bitrate for Movie = 776 k(=1000)Bits/s

Adding this script to C:\PROGRA~1\GordianKnot\VirtualDubMod\LastJob.vcf :

// $job "x264 First Pass"
// $input "V:\R4R\BOURNE_1\BOURNE.avs"
// $output "V:\R4R\BOURNE_1\BOURNE_Movie.mkv"
// $state 0
// $start_time 0 0
// $end_time 0 0
// $script

VirtualDub.Open("V:\\R4R\\BOURNE_1\\BOURNE.avs",0,0);
VirtualDub.video.SetDepth(24,24);
VirtualDub.video.SetMode(1);
VirtualDub.video.SetFrameRate(0,1);
VirtualDub.video.SetIVTC(0,0,-1,0);
VirtualDub.video.SetRange(0,0);
VirtualDub.video.SetCompression(0x34363278,0,10000,0);
VirtualDub.video.SetCompData(376,"AAAAACADAAAAAAAALlx4MjY0LnN0YXRzAABzAHQAYQB0AHMAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAgAwAAAQAAAAEAAAABAAAAAwAAAPoAAAAZAAAAGgAAAAEAAAABAAAAAQAAAAEAAAABAAAAAQAAAAEAAAAEAAAAAQAAAAAAAAAAAAAAKAAAAB4AAAA8AAAAAAAAAEgyNjQAAAAAAgAAAA==");
VirtualDub.video.filters.Clear();
VirtualDub.subset.Delete();
VirtualDub.SaveMKV("V:\\R4R\\BOURNE_1\\BOURNE_Movie.mkv");
VirtualDub.Close();

// $endjob
//
//--------------------------------------------------
// $done

1:14:43 PM: Started x264 - First Pass: V:\R4R\BOURNE_1\BOURNE.avs
5:04:51 PM: Finished x264 - First Pass: Duration: 3 hours, 50 minutes, 7 seconds.
5:04:51 PM: Trying to open Log-file.
5:04:51 PM: Success: Log-file open.
5:04:51 PM: Encoded: 156146 Frames.
5:04:51 PM: Speed: 11.309 Frames per Second.

Adding this script to C:\PROGRA~1\GordianKnot\VirtualDubMod\LastJob.vcf :

// $job "x264 Second Pass"
// $input "V:\R4R\BOURNE_1\BOURNE.avs"
// $output "V:\R4R\BOURNE_1\BOURNE_Movie.mkv"
// $state 0
// $start_time 0 0
// $end_time 0 0
// $script

VirtualDub.Open("V:\\R4R\\BOURNE_1\\BOURNE.avs",0,0);
VirtualDub.video.SetDepth(24,24);
VirtualDub.video.SetMode(1);
VirtualDub.video.SetFrameRate(0,1);
VirtualDub.video.SetIVTC(0,0,-1,0);
VirtualDub.video.SetRange(0,0);
VirtualDub.video.SetCompression(0x34363278,0,10000,0);
VirtualDub.video.SetCompData(376,"AAAAACADAAAAAAAALlx4MjY0LnN0YXRzAABzAHQAYQB0AHMAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAIAwAAAgAAAAEAAAABAAAAAwAAAPoAAAAZAAAAGgAAAAEAAAABAAAAAQAAAAEAAAABAAAAAQAAAAEAAAAEAAAAAQAAAAAAAAAAAAAAKAAAAB4AAAA8AAAAAAAAAEgyNjQAAAAAAgAAAA==");
VirtualDub.video.filters.Clear();
VirtualDub.subset.Delete();
VirtualDub.SaveMKV("V:\\R4R\\BOURNE_1\\BOURNE_Movie.mkv");
VirtualDub.Close();

// $endjob
//
//--------------------------------------------------
// $done

5:04:51 PM: Started x264 - Second Pass: V:\R4R\BOURNE_1\BOURNE.avs
5:54:45 PM: Finished x264 - Second Pass: Duration: 49 minutes, 53 seconds.
5:54:45 PM: Speed: 52.165 Frames per Second.

Adding this script to C:\PROGRA~1\GordianKnot\VirtualDubMod\LastJob.vcf :

// $job "DivX5 Append"
// $input "V:\R4R\BOURNE_1\BOURNE_Movie.mkv"
// $output "V:\R4R\BOURNE_1\BOURNE.mkv"
// $state 0
// $start_time 0 0
// $end_time 0 0
// $script

VirtualDub.Open("V:\\R4R\\BOURNE_1\\BOURNE_Movie.mkv",0,0);
VirtualDub.RemoveInputStreams();
VirtualDub.stream[0].SetSource("V:\\R4R\\BOURNE_1\\BOURNE Track 1 English DELAY 0ms.ogg",0x00000204);
VirtualDub.stream[0].AddComment(0x00010000,"","English");
VirtualDub.stream[0].SetMode(0);
VirtualDub.stream[0].SetInterleave(1,500,1,0,0);
VirtualDub.stream[0].SetClipMode(1,1);
VirtualDub.stream[0].SetConversion(0,0,0,0,0);
VirtualDub.stream[0].SetVolume();
VirtualDub.stream[0].SetCompression();
VirtualDub.video.SetDepth(24,24);
VirtualDub.video.SetMode(0);
VirtualDub.video.SetFrameRate(0,1);
VirtualDub.video.SetIVTC(0,0,-1,0);
VirtualDub.video.SetRange(0,0);
VirtualDub.video.SetCompression();
VirtualDub.video.filters.Clear();
VirtualDub.subset.Delete();
VirtualDub.video.AddChapter(0,1,"Chapter 1");
VirtualDub.video.AddChapter(270533,1,"Chapter 2");
VirtualDub.video.AddChapter(584500,1,"Chapter 3");
VirtualDub.video.AddChapter(922666,1,"Chapter 4");
VirtualDub.video.AddChapter(1320732,1,"Chapter 5");
VirtualDub.video.AddChapter(1413499,1,"Chapter 6");
VirtualDub.video.AddChapter(1751499,1,"Chapter 7");
VirtualDub.video.AddChapter(2111665,1,"Chapter 8");
VirtualDub.video.AddChapter(2283165,1,"Chapter 9");
VirtualDub.video.AddChapter(2695331,1,"Chapter 10");
VirtualDub.video.AddChapter(2877831,1,"Chapter 11");
VirtualDub.video.AddChapter(3168565,1,"Chapter 12");
VirtualDub.video.AddChapter(3323065,1,"Chapter 13");
VirtualDub.video.AddChapter(3658098,1,"Chapter 14");
VirtualDub.video.AddChapter(3755731,1,"Chapter 15");
VirtualDub.video.AddChapter(4007731,1,"Chapter 16");
VirtualDub.video.AddChapter(4429065,1,"Chapter 17");
VirtualDub.video.AddChapter(4688398,1,"Chapter 18");
VirtualDub.video.AddChapter(5087065,1,"Chapter 19");
VirtualDub.video.AddChapter(5257565,1,"Chapter 20");
VirtualDub.video.AddChapter(5580565,1,"Chapter 21");
VirtualDub.video.AddChapter(5685065,1,"Chapter 22");
VirtualDub.video.AddChapter(6008732,1,"Chapter 23");
VirtualDub.video.AddChapter(6113898,1,"Chapter 24");
VirtualDub.SaveMKV("V:\\R4R\\BOURNE_1\\BOURNE.mkv");
VirtualDub.Close();

// $endjob
//
//--------------------------------------------------
// $done

5:54:45 PM: Started Muxing Audio and adding Chapters info.: V:\R4R\BOURNE_1\BOURNE_Movie.mkv
5:55:12 PM: Finished Muxing Audio and adding Chapters info.: Duration: 26 seconds.

5:55:12 PM: Done.
5:55:12 PM: Movie = V:\R4R\BOURNE_1\BOURNE.mkv
Total Encoding Time: 4 hours, 40 minutes, 28 seconds.
2/27/2005 5:55:12 PM: Job "H264 - 1 - BOURNE.mkv" finished.
_______________________________________________________________________________________________________________________

[len0x]

Looks like a crash during second pass to me... x264 is not stable enough yet, so problems like this can be expected. Try latest x264 build (and remove all previous versions of it).

[defaulk9]

thanks. I'll try it and get back. Is there any way of verifying that it did indeed crash? Any log file of that that might give details?

[defaulk9]

Yep, that must have been the problem, since it works now. The weird thing is, I already had rev.144 of x264, but after the reistall, it works. Anyway, thanks for all of your help!