Dienstag, 6. November 2007  21.01 Uhr CET
ProjectX 0.90.4.00 (30.03.2006)

-> working with collection 0
 
-> save normal log file
-> write all video data
-> write all other data
-> create *.info indexfile for Cuttermaran on demux: Cuttermaran info Version: 1.61ff
-> patch c.d.flagged infos of pictures
-> add sequence end code
-> set resolution in SDE 
-> PVA: strictly specs. for audio streams
-> VOB: determine diff. Cell timelines
-> TS: ignore scrambled packets
-> TS: enhanced search for open packets
-> TS: join file segments (of Dreambox®)
-> TS: generate PMT stream dependent
-> get only enclosed PES/TS packets
-> concatenate different recordings
-> ensure 1st PES-packet start with video
-> generate PCR/SCR from PTS
 
-> write output files to: 'C:\Workdir'

-> Input File 0:  'ftp://anonymous:@localhost:2853/testrec.ts' (999.999.999.999 bytes)
-> Filetype is TS (generic PES Container)
-> demux
-> Service ID 0xCB
-> PMT 0x21 refers to these usable streams:
Video:
PID: 0x200
Audio:
PID: 0x280(eng)
Teletext:
PID: 0x240(swe_s890 nor_s897 dan_s599 dut_s690 eng_i101 )
Subpict.:
n/a

!> PID 0x21 (PMT) (80464 #429) -> ignored
!> PID 0x0 (PAT) (107724 #574) -> ignored
ok> PID 0x200 has PES-ID 0xEA (MPEG Video) (184804 #984) 
ok> PID 0x280 has PES-ID 0xC0 (MPEG Audio) (216200 #1151) 
-> video basics: 544*576 @ 25fps @ 0.6735 (4:3) @ 15000000bps, vbvBuffer 81
-> starting export of video data @ GOP# 0
!> dropping useless B-Frames @ GOP# 0 / new Timecode 00:00:00.000
!> dropping GOP# 4 @ orig.PTS 08:27:42.542 (2741628842), errorcode: 24
!> Pics exp/cnt 12/10, inGOP PTS diff. 0ms, new Timecode 00:00:01.840
!> PTS difference of 43200 (00:00:00.480) to last exported GOP detected 
!> dropping useless B-Frames @ GOP# 5 / new Timecode 00:00:01.840
-> PID 0x200 => marked as scrambled data, packet 35062 @ 6591468 -> ignored
-> PID 0x200 => get clear data, packet 35063 @ 6591656
!> PID 0x200 -> packet 35063 @ pos. 6591656 out of sequence (15/14) (shifting..) (~00:00:10.880)
!> missing sync. byte @ 8988844
!> found sync. byte @ 8989392
!> missing sync. byte @ 13753500
!> found sync. byte @ 13754048
!> PID 0x200 -> packet 73156 @ pos. 13754236 out of sequence (5/4) (shifting..) (~00:00:24.320)
!> missing sync. byte @ 14291540
!> found sync. byte @ 14292088
!> PID 0x200 -> packet 76014 @ pos. 14292088 out of sequence (14/13) (shifting..) (~00:00:25.280)
!> missing sync. byte @ 14830708
!> found sync. byte @ 14831256
!> PID 0x200 -> packet 78879 @ pos. 14831256 out of sequence (8/7) (shifting..) (~00:00:26.240)
-> PID 0x280 => marked as scrambled data, packet 91755 @ 17251944 -> ignored
!> dropping GOP# 66 @ orig.PTS 08:28:12.302 (2744307242), errorcode: 24
!> Pics exp/cnt 11/8, inGOP PTS diff. 0ms, new Timecode 00:00:31.040
!> PTS difference of 43200 (00:00:00.480) to last exported GOP detected 
!> dropping useless B-Frames @ GOP# 67 / new Timecode 00:00:31.040
-> PID 0x280 => get clear data, packet 97633 @ 18357008
!> PID 0x280 -> packet 97633 @ pos. 18357008 out of sequence (8/0) (shifting..) (~00:00:32.400)
!> packet writing: length index out of bounds, shortened.. (280 / c0 / c0 / 139 -- 1472 / 16 / 2928) @ PTS 08:28:12.276
!> missing sync. byte @ 19056744
!> found sync. byte @ 19057292
!> PID 0x200 -> packet 101355 @ pos. 19057292 out of sequence (14/13) (shifting..) (~00:00:33.840)
!> missing sync. byte @ 19621668
!> found sync. byte @ 19622216
!> PID 0x200 -> packet 104357 @ pos. 19622216 out of sequence (5/4) (shifting..) (~00:00:34.800)
!> missing sync. byte @ 24385948
!> found sync. byte @ 24386496
!> PID 0x200 -> packet 129697 @ pos. 24386684 out of sequence (2/1) (shifting..) (~00:00:43.440)
!> missing sync. byte @ 24898044
!> found sync. byte @ 24898592
!> PID 0x200 -> packet 132417 @ pos. 24898592 out of sequence (13/12) (shifting..) (~00:00:44.880)
!> missing sync. byte @ 29662136
!> found sync. byte @ 29662684
!> PID 0x200 -> packet 157755 @ pos. 29662684 out of sequence (10/9) (shifting..) (~00:00:53.520)
-> PID 0x280 => marked as scrambled data, packet 176076 @ 33107032 -> ignored
!> dropping GOP# 129 @ orig.PTS 08:28:42.542 (2747028842), errorcode: 24
!> Pics exp/cnt 12/10, inGOP PTS diff. 0ms, new Timecode 00:01:00.720
!> PTS difference of 43200 (00:00:00.480) to last exported GOP detected 
!> dropping useless B-Frames @ GOP# 130 / new Timecode 00:01:00.720
-> PID 0x280 => get clear data, packet 181951 @ 34211532
!> PID 0x280 -> packet 181951 @ pos. 34211532 out of sequence (1/15) (shifting..) (~00:01:01.600)
!> packet writing: length index out of bounds, shortened.. (280 / c0 / c0 / 262 -- 2576 / 16 / 2928) @ PTS 08:28:42.276
!> missing sync. byte @ 34991544
!> found sync. byte @ 34992092
!> PID 0x200 -> packet 186101 @ pos. 34992280 out of sequence (0/15) (shifting..) (~00:01:03.040)
!> missing sync. byte @ 35530148
!> found sync. byte @ 35530696
!> PID 0x200 -> packet 188962 @ pos. 35530696 out of sequence (12/11) (shifting..) (~00:01:04.000)
!> missing sync. byte @ 39756184
!> found sync. byte @ 39756732
!> PID 0x200 -> packet 211438 @ pos. 39756732 out of sequence (13/12) (shifting..) (~00:01:12.160)
!> missing sync. byte @ 40294412
!> found sync. byte @ 40294960
!> PID 0x200 -> packet 214299 @ pos. 40295148 out of sequence (8/7) (shifting..) (~00:01:13.120)
!> missing sync. byte @ 40806884
!> found sync. byte @ 40807432
!> PID 0x200 -> packet 217021 @ pos. 40807432 out of sequence (5/4) (shifting..) (~00:01:14.080)
!> missing sync. byte @ 41371808
!> found sync. byte @ 41372356
!> PID 0x200 -> packet 220023 @ pos. 41372356 out of sequence (11/10) (shifting..) (~00:01:15.040)
-> PID 0x200 => marked as scrambled data, packet 232612 @ 43739088 -> ignored
-> PID 0x200 => get clear data, packet 232613 @ 43739276
!> PID 0x200 -> packet 232613 @ pos. 43739276 out of sequence (2/1) (shifting..) (~00:01:19.360)
!> missing sync. byte @ 45597656
!> found sync. byte @ 45598204
!> PID 0x200 -> packet 242498 @ pos. 45598204 out of sequence (1/0) (shifting..) (~00:01:23.200)
!> PID 0x200 -> packet 249946 @ pos. 46998428 out of sequence (9/5) (shifting..) (~00:01:25.600)
!> PID 0x280 -> packet 254421 @ pos. 47839728 out of sequence (6/4) (shifting..) (~00:01:27.480)
!> packet writing: length index out of bounds, shortened.. (280 / c0 / c0 / 369 -- 2576 / 16 / 2928) @ PTS 08:29:08.388
!> dropping GOP# 191 @ orig.PTS 08:29:12.302 (2749707242), errorcode: 24
!> Pics exp/cnt 11/9, inGOP PTS diff. 0ms, new Timecode 00:01:29.880
!> PTS difference of 43200 (00:00:00.480) to last exported GOP detected 
!> dropping useless B-Frames @ GOP# 192 / new Timecode 00:01:29.880
!> missing sync. byte @ 50874236
!> found sync. byte @ 50874784
!> PID 0x200 -> packet 270562 @ pos. 50874784 out of sequence (15/14) (shifting..) (~00:01:32.680)
!> missing sync. byte @ 51439724
!> found sync. byte @ 51440272
!> PID 0x200 -> packet 273568 @ pos. 51440460 out of sequence (9/8) (shifting..) (~00:01:33.640)
!> missing sync. byte @ 56204004
!> found sync. byte @ 56204552
!> PID 0x200 -> packet 298907 @ pos. 56204740 out of sequence (6/5) (shifting..) (~00:01:42.280)
!> missing sync. byte @ 56716100
!> found sync. byte @ 56716648
!> PID 0x200 -> packet 301627 @ pos. 56716648 out of sequence (1/0) (shifting..) (~00:01:43.240)
!> dropping GOP# 233 @ orig.PTS 08:29:32.462 (2751521642), errorcode: 24
!> Pics exp/cnt 12/11, inGOP PTS diff. 0ms, new Timecode 00:01:49.480
!> PTS difference of 43200 (00:00:00.480) to last exported GOP detected 
!> dropping useless B-Frames @ GOP# 234 / new Timecode 00:01:49.480
!> PID 0x200 -> packet 340316 @ pos. 63990180 out of sequence (1/9) (shifting..) (~00:01:56.600)
!> dropping GOP# 250 @ orig.PTS 08:29:40.622 (2752256042), errorcode: 24
!> Pics exp/cnt 12/11, inGOP PTS diff. 0ms, new Timecode 00:01:57.080
!> PTS difference of 43200 (00:00:00.480) to last exported GOP detected 
!> dropping useless B-Frames @ GOP# 251 / new Timecode 00:01:57.080
!> PID 0x280 -> packet 344788 @ pos. 64830916 out of sequence (12/10) (shifting..) (~00:01:57.480)
!> packet writing: length index out of bounds, shortened.. (280 / c0 / c0 / 500 -- 2576 / 16 / 2928) @ PTS 08:29:40.356
!> dropping GOP# 254 @ orig.PTS 08:29:42.542 (2752428842), errorcode: 24
!> Pics exp/cnt 12/9, inGOP PTS diff. 0ms, new Timecode 00:01:58.440
!> PTS difference of 43200 (00:00:00.480) to last exported GOP detected 
!> dropping useless B-Frames @ GOP# 255 / new Timecode 00:01:58.440
-> PID 0x280 => marked as scrambled data, packet 350903 @ 65980536 -> ignored
-> PID 0x280 => get clear data, packet 356781 @ 67085600
!> PID 0x280 -> packet 356781 @ pos. 67085600 out of sequence (3/14) (shifting..) (~00:02:01.240)
!> packet writing: length index out of bounds, shortened.. (280 / c0 / c0 / 516 -- 2024 / 16 / 2928) @ PTS 08:29:44.268
-> PID 0x200 => marked as scrambled data, packet 401732 @ 75536388 -> ignored
-> PID 0x200 => get clear data, packet 401733 @ 75536576
!> PID 0x200 -> packet 401733 @ pos. 75536576 out of sequence (15/14) (shifting..) (~00:02:17.080)
!> PID 0x200 -> packet 428260 @ pos. 80523652 out of sequence (7/14) (shifting..) (~00:02:26.680)
!> PID 0x280 -> packet 429237 @ pos. 80707328 out of sequence (13/10) (shifting..) (~00:02:27.160)
!> dropping GOP# 315 @ orig.PTS 08:30:11.822 (2755064042), errorcode: 24
!> Pics exp/cnt 12/10, inGOP PTS diff. 0ms, new Timecode 00:02:27.160
!> PTS difference of 43200 (00:00:00.480) to last exported GOP detected 
!> dropping useless B-Frames @ GOP# 316 / new Timecode 00:02:27.160
-> PID 0x280 => marked as scrambled data, packet 435269 @ 81841344 -> ignored
!> missing sync. byte @ 82676628
!> found sync. byte @ 82677176
!> PID 0x200 -> packet 439712 @ pos. 82677176 out of sequence (14/13) (shifting..) (~00:02:30.440)
-> PID 0x280 => get clear data, packet 441145 @ 82946580
!> PID 0x280 -> packet 441145 @ pos. 82946580 out of sequence (15/13) (shifting..) (~00:02:30.920)
!> packet writing: length index out of bounds, shortened.. (280 / c0 / c0 / 638 -- 2576 / 16 / 2928) @ PTS 08:30:14.268
-> PID 0x200 => marked as scrambled data, packet 486236 @ 91423688 -> ignored
-> PID 0x200 => get clear data, packet 486238 @ 91424064
!> PID 0x200 -> packet 486238 @ pos. 91424064 out of sequence (9/8) (shifting..) (~00:02:46.760)
!> missing sync. byte @ 92742696
!> found sync. byte @ 92743124
!> PID 0x200 -> packet 493253 @ pos. 92743312 out of sequence (3/2) (shifting..) (~00:02:49.160)
!> missing sync. byte @ 93280804
!> found sync. byte @ 93281352
!> PID 0x200 -> packet 496112 @ pos. 93281352 out of sequence (14/13) (shifting..) (~00:02:50.120)
!> PID 0x200 -> packet 518631 @ pos. 97514924 out of sequence (7/8) (shifting..) (~00:02:58.280)
!> PID 0x280 -> packet 519607 @ pos. 97698412 out of sequence (7/1) (shifting..) (~00:02:58.760)
!> packet writing: length index out of bounds, shortened.. (280 / c0 / c0 / 759 -- 1840 / 16 / 2928) @ PTS 08:30:43.788
!> dropping GOP# 382 @ orig.PTS 08:30:43.982 (2757958442), errorcode: 24
!> Pics exp/cnt 12/9, inGOP PTS diff. 0ms, new Timecode 00:02:58.760
!> missing sync. byte @ 98025720
!> found sync. byte @ 98026268
!> PID 0x200 -> packet 521349 @ pos. 98026456 out of sequence (5/4) (shifting..) (~00:02:58.760)
!> PTS difference of 43200 (00:00:00.480) to last exported GOP detected 
!> dropping useless B-Frames @ GOP# 383 / new Timecode 00:02:58.760
!> missing sync. byte @ 98538004
!> found sync. byte @ 98538552
-> PID 0x200 => marked as scrambled data, packet 598934 @ 112612984 -> ignored
-> PID 0x200 => get clear data, packet 598941 @ 112614300
!> PID 0x200 -> packet 598941 @ pos. 112614300 out of sequence (2/11) (shifting..) (~00:03:26.040)
!> PID 0x200 -> packet 606462 @ pos. 114028248 out of sequence (1/14) (shifting..) (~00:03:28.880)
!> dropping GOP# 447 @ orig.PTS 08:31:15.182 (2760766442), errorcode: 24
!> Pics exp/cnt 12/10, inGOP PTS diff. 0ms, new Timecode 00:03:29.360
!> PTS difference of 43200 (00:00:00.480) to last exported GOP detected 
!> dropping useless B-Frames @ GOP# 448 / new Timecode 00:03:29.360
!> PID 0x280 -> packet 609957 @ pos. 114685308 out of sequence (4/15) (shifting..) (~00:03:29.760)
!> packet writing: length index out of bounds, shortened.. (280 / c0 / c0 / 887 -- 2024 / 16 / 2928) @ PTS 08:31:15.036
!> dropping GOP# 514 @ orig.PTS 08:31:47.342 (2763660842), errorcode: 24
!> Pics exp/cnt 12/9, inGOP PTS diff. 0ms, new Timecode 00:04:00.960
!> PTS difference of 43200 (00:00:00.480) to last exported GOP detected 
!> dropping useless B-Frames @ GOP# 515 / new Timecode 00:04:00.960
!> PID 0x280 -> packet 700429 @ pos. 131694044 out of sequence (13/4) (shifting..) (~00:04:01.360)
!> missing sync. byte @ 133433608
!> found sync. byte @ 133434156
!> PID 0x200 -> packet 709683 @ pos. 133434344 out of sequence (7/6) (shifting..) (~00:04:04.720)
!> incomplete ts packet at EOF detected @ 134291436
packs: 704345 0% 134291456

-> Video: fr/ ct/ 1p/ cg/ og/ dg -> 6154/ 12/ 526/ 515/ 0/ 11
-> Video length: 6154 frames @ 00:04:06.160
-> GOP summary: min. 20, max. 24 fields; contains interlaced frames
-> avg. nom. bitrate 4004634bps (min/max: 3142800/4630000)
-> set first sequenceheader bitrate to 4630000bps
---> new File: C:\Workdir\testrec.m2v

--> MPEG Audio (0xC0) on PID 0x280
-> check CRC of AC-3 / MPEG-Audio L1,2
-> delete CRC in MPEG-Audio Layer1,2
-> add frames
Audio PTS: first packet 08:27:38.364, last packet 08:31:52.596
Video PTS: start 1.GOP 08:27:40.702, end last GOP 08:31:53.102
-> adjusting audio at video-timeline
!> missing syncword @  26352, @ 00:00:00.000
!> found syncword @ 26480
-> src_audio: MPEG-1, Layer2, 48000Hz, mono, 96kbps, CRC @ 00:00:00.000
!> missing syncword @  407505, @ 00:00:31.032
!> found syncword @ 407760
!> missing syncword @  766033, @ 00:01:00.480
!> found syncword @ 766240
!> 3 frame(s) (72ms) inserted @ 00:01:00.624
!> missing syncword @  1079873, @ 00:01:26.112
!> found syncword @ 1080080
!> 3 frame(s) (72ms) inserted @ 00:01:26.184
!> missing syncword @  1464273, @ 00:01:57.000
!> PTS without a frame (1464352/1464353)
!> found syncword @ 1464480
!> missing syncword @  1508545, @ 00:01:59.616
!> found syncword @ 1508776
!> 5 frame(s) (120ms) inserted @ 00:01:59.736
!> missing syncword @  1837673, @ 00:02:27.120
!> PTS without a frame (1838216/1838217)
!> found syncword @ 1838488
!> missing syncword @  1864697, @ 00:02:29.040
!> found syncword @ 1864904
!> 3 frame(s) (72ms) inserted @ 00:02:29.208
!> missing syncword @  2219145, @ 00:02:58.608
!> found syncword @ 2219480
!> 4 frame(s) (96ms) inserted @ 00:02:58.656
!> missing syncword @  2592441, @ 00:03:29.208
!> found syncword @ 2592960
!> 2 frame(s) (48ms) inserted @ 00:03:29.304
!> missing syncword @  2976001, @ 00:04:00.696
!> found syncword @ 2976376
!> missing syncword @  2977529, @ 00:04:00.792
!> PTS without a frame (2977744/2977745)
!> found syncword @ 2977968
!> 12 frame(s) (288ms) added @ 00:04:05.880
audio frames: wri/pre/skip/ins/add 10257/0/0/20/12 @ 00:04:06.168 done...
---> new File: 'C:\Workdir\testrec.mp2'

summary of created media files:
.Video (m2v):	6154 Frames	00:04:06.160		'C:\Workdir\testrec.m2v'
Audio 0 (mp2):	10257 Frames	00:04:06.168	0/0/20/12	'C:\Workdir\testrec.mp2'
=> 126.176.627 bytes written...
-> we have 186 warnings/errors.