Sat Dec 18 15:11:26 [163162] INFO: starting markad v3.0.18-BM2LTS (6c73e7c) (64bit) Sat Dec 18 15:11:26 [163162] INFO: using libavcodec.so.58.91.100 with 4 threads Sat Dec 18 15:11:26 [163162] INFO: on /media/hd/recordings/Irgendwann_ist_auch_mal_gut/2021-12-07.00.10.2-0.rec Sat Dec 18 15:11:26 [163162] INFO: aspect ratio 16:9 (from vdr info) Sat Dec 18 15:11:26 [163162] INFO: broadcast with DolbyDigital2.0 (from vdr info) Sat Dec 18 15:11:26 [163162] DEBUG: cMarkAdStandalone::GetRecordingStart(): mount option noatime is set, use atime from directory /media/hd/recordings/Irgendwann_ist_auch_mal_gut/2021-12-07.00.10.2-0.rec to get creation time Sat Dec 18 15:11:26 [163162] DEBUG: cMarkAdStandalone::GetRecordingStart(): got no valid directory creation time, maybe recording was copied Sat Dec 18 15:11:05 2021 Sat Dec 18 15:11:26 [163162] DEBUG: cMarkAdStandalone::GetRecordingStart(): broadcast start time from vdr info file Tue Dec 7 00:10:00 2021 Sat Dec 18 15:11:26 [163162] DEBUG: cMarkAdStandalone::GetRecordingStart(): getting recording start from VDR info file modification time Tue Dec 7 01:36:03 2021 Sat Dec 18 15:11:26 [163162] DEBUG: cMarkAdStandalone::LoadInfo(): recording start at Tue Dec 7 01:36:03 2021 Sat Dec 18 15:11:26 [163162] DEBUG: cMarkAdStandalone::LoadInfo(): timer start at Tue Dec 7 00:10:00 2021 Sat Dec 18 15:11:26 [163162] INFO: VPS controlled recording start Sat Dec 18 15:11:26 [163162] DEBUG: cMarkAdStandalone::LoadInfo(): found VPS start event at offset 35s Sat Dec 18 15:11:26 [163162] DEBUG: cMarkAdStandalone::LoadInfo(): broadcast start 35s after recording start Sat Dec 18 15:11:26 [163162] DEBUG: cMarkAdStandalone::CheckLogo(): using logo directory /var/lib/markad Sat Dec 18 15:11:26 [163162] DEBUG: cMarkAdStandalone::CheckLogo(): searching logo for ZDF_HD Sat Dec 18 15:11:26 [163162] INFO: pre-timer: 0:00:35h Sat Dec 18 15:11:26 [163162] INFO: broadcast length: 1:30:00h Sat Dec 18 15:11:26 [163162] INFO: channel: ZDF_HD Sat Dec 18 15:11:26 [163162] DEBUG: parameter --loglevel is set to 3 Sat Dec 18 15:11:26 [163162] DEBUG: markad process nice level 19 Sat Dec 18 15:11:26 [163162] DEBUG: markad IO priority class 3 Sat Dec 18 15:11:26 [163162] DEBUG: parameter --logocachedir is set to /var/lib/markad Sat Dec 18 15:11:26 [163162] DEBUG: parameter --threads is set to 4 Sat Dec 18 15:11:26 [163162] DEBUG: parameter --astopoffs is set to 10 Sat Dec 18 15:11:26 [163162] DEBUG: parameter --log2rec is set Sat Dec 18 15:11:26 [163162] DEBUG: parameter --vps is set Sat Dec 18 15:11:26 [163162] DEBUG: parameter --cut is set Sat Dec 18 15:11:26 [163162] DEBUG: parameter --ac3reencode is set Sat Dec 18 15:11:26 [163162] DEBUG: parameter --autologo is set to 2 Sat Dec 18 15:11:26 [163162] DEBUG: parameter --fulldecode is set Sat Dec 18 15:11:26 [163162] DEBUG: ======================================================================================================================= Sat Dec 18 15:11:26 [163162] DEBUG: cMarkAdStandalone::ProcessFiles(): start processing files Sat Dec 18 15:11:26 [163162] DEBUG: cDecoder::cDecoder(): create new decoder instance Sat Dec 18 15:11:26 [163162] DEBUG: cDecoder::cDecoder(): init with 4 threads Sat Dec 18 15:11:26 [163162] DEBUG: cDecoder::DecodeFile(): filename: /media/hd/recordings/Irgendwann_ist_auch_mal_gut/2021-12-07.00.10.2-0.rec/00001.ts Sat Dec 18 15:11:26 [163162] DEBUG: cDecoder::DecodeFile(): opened file /media/hd/recordings/Irgendwann_ist_auch_mal_gut/2021-12-07.00.10.2-0.rec/00001.ts Sat Dec 18 15:11:27 [163162] DEBUG: cDecoder::DecodeFile(): using decoder for stream 0: codec id 27 -> H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 Sat Dec 18 15:11:27 [163162] DEBUG: cDecoder::DecodeFile(): average framerate 50/1 Sat Dec 18 15:11:27 [163162] DEBUG: cDecoder::DecodeFile(): real framerate 50/1 Sat Dec 18 15:11:27 [163162] DEBUG: cDecoder::DecodeFile(): using decoder for stream 1: codec id 86016 -> MP2 (MPEG audio layer 2) Sat Dec 18 15:11:27 [163162] DEBUG: cDecoder::DecodeFile(): using decoder for stream 2: codec id 86016 -> MP2 (MPEG audio layer 2) Sat Dec 18 15:11:27 [163162] DEBUG: cDecoder::DecodeFile(): using decoder for stream 3: codec id 86016 -> MP2 (MPEG audio layer 2) Sat Dec 18 15:11:27 [163162] DEBUG: cDecoder::DecodeFile(): using decoder for stream 4: codec id 86019 -> ATSC A/52A (AC-3) Sat Dec 18 15:11:27 [163162] DEBUG: cDecoder::DecodeFile(): using decoder for stream 5: codec id 94209 -> DVB subtitles Sat Dec 18 15:11:27 [163162] DEBUG: cDecoder::GetVideoType(): video coding format: H.264 Sat Dec 18 15:11:27 [163162] INFO: video hight: 720 Sat Dec 18 15:11:27 [163162] INFO: video width: 1280 Sat Dec 18 15:11:27 [163162] INFO: average frame rate: 50 frames per second Sat Dec 18 15:11:27 [163162] INFO: real frame rate: 50 frames per second Sat Dec 18 15:11:27 [163162] DEBUG: cMarkAdStandalone::CalculateCheckPositions(): startframe 1750 (0min 35s) Sat Dec 18 15:11:27 [163162] DEBUG: cMarkAdStandalone::CalculateCheckPositions(): use frame rate 50 Sat Dec 18 15:11:27 [163162] DEBUG: cMarkAdStandalone::CalculateCheckPositions(): length of recording: 5400s ( 90min 0s) Sat Dec 18 15:11:27 [163162] DEBUG: cMarkAdStandalone::CalculateCheckPositions(): assumed start frame: 1750 ( 0min 35s) Sat Dec 18 15:11:27 [163162] DEBUG: cMarkAdStandalone::CalculateCheckPositions(): assumed stop frame: 272250 ( 90min 45s) Sat Dec 18 15:11:27 [163162] DEBUG: cMarkAdStandalone::CalculateCheckPositions(): chkSTART set to: 25750 ( 8min 35s) Sat Dec 18 15:11:27 [163162] DEBUG: cMarkAdStandalone::CalculateCheckPositions(): chkSTOP set to: 301750 (100min 35s) Sat Dec 18 15:11:27 [163162] DEBUG: cDecoder::GetFrameInfo(): audio channels of stream 4 changed from 0 to 2 at frame (4) PTS 5587110993 Sat Dec 18 15:11:27 [163162] DEBUG: cDecoder::GetFrameInfo(): non interlaced video format Sat Dec 18 15:11:27 [163162] DEBUG: cDecoder::GetFrameInfo(): aspect ratio changed from (0:0) to (16:9) at frame 5 Sat Dec 18 15:11:27 [163162] DEBUG: cMarkAdLogo::Process(): aspect ratio changed from 0:0 to 16:9, reload logo Sat Dec 18 15:11:27 [163162] DEBUG: cMarkAdLogo::Load(): try to find logo ZDF_HD-A16_9 plane 0 in /var/lib/markad Sat Dec 18 15:11:27 [163162] DEBUG: cMarkAdLogo::Load(): file found for logo ZDF_HD-A16_9 plane 0 in /var/lib/markad Sat Dec 18 15:11:27 [163162] DEBUG: cMarkAdLogo::Load(): logo plane 0 has 1191 pixel Sat Dec 18 15:11:27 [163162] DEBUG: cMarkAdLogo::Load(): logo pixel ratio of plane 0 is: 68 per mille Sat Dec 18 15:11:27 [163162] INFO: logo for ZDF_HD 16:9 found in /var/lib/markad Sat Dec 18 15:11:27 [163162] DEBUG: cMarkAdLogo::Load(): try to find logo ZDF_HD-A16_9 plane 1 in /var/lib/markad Sat Dec 18 15:11:27 [163162] DEBUG: cMarkAdLogo::Load(): file not found for logo ZDF_HD-A16_9 plane 1 in /var/lib/markad Sat Dec 18 15:11:27 [163162] DEBUG: cMarkAdLogo::Load(): try to find logo ZDF_HD-A16_9 plane 2 in /var/lib/markad Sat Dec 18 15:11:27 [163162] DEBUG: cMarkAdLogo::Load(): file not found for logo ZDF_HD-A16_9 plane 2 in /var/lib/markad Sat Dec 18 15:11:27 [163162] DEBUG: detected end of black screen ( 5)* at 0:00:00.00 inBroadCast: 0 Sat Dec 18 15:11:27 [163162] DEBUG: cMarkAdStandalone::AddMark(): inBroadCast now: 0 Sat Dec 18 15:11:27 [163162] DEBUG: cMarkAdAudio::ChannelChange(): new audio stream 4 start at frame (4) Sat Dec 18 15:11:27 [163162] DEBUG: cMarkAdLogo::ReduceBrightness(): logo area: xstart 64 xend 186, ystart 50 yend 94 Sat Dec 18 15:11:27 [163162] INFO: detected logo start ( 131)* at 0:00:02.51 Sat Dec 18 15:11:27 [163162] DEBUG: cMarkAdStandalone::AddMark(): inBroadCast now: 1 Sat Dec 18 15:11:27 [163162] INFO: detected logo stop ( 312) at 0:00:06.19 Sat Dec 18 15:11:27 [163162] DEBUG: cMarkAdStandalone::AddMark(): inBroadCast now: 0 Sat Dec 18 15:11:32 [163162] INFO: detected logo start ( 2025)* at 0:00:40.11 Sat Dec 18 15:11:32 [163162] DEBUG: cMarkAdStandalone::AddMark(): inBroadCast now: 1 Sat Dec 18 15:11:32 [163162] INFO: detected logo stop ( 2208) at 0:00:44.06 Sat Dec 18 15:11:32 [163162] DEBUG: cMarkAdStandalone::AddMark(): inBroadCast now: 0 Sat Dec 18 15:11:32 [163162] INFO: detected logo start ( 2328)* at 0:00:46.43 Sat Dec 18 15:11:32 [163162] DEBUG: cMarkAdStandalone::AddMark(): inBroadCast now: 1 Sat Dec 18 15:11:41 [163162] INFO: detected start of horiz. borders ( 2226)* at 0:00:44.45 Sat Dec 18 15:11:41 [163162] DEBUG: cMarkAdStandalone::AddMark(): inBroadCast now: 1 Sat Dec 18 15:12:34 [163162] DEBUG: ======================================================================================================================= Sat Dec 18 15:12:34 [163162] DEBUG: cMarkAdStandalone::CheckStart(): checking start at frame (25751) check start planed at (25750) Sat Dec 18 15:12:34 [163162] DEBUG: cMarkAdStandalone::CheckStart(): assumed start frame 1750 Sat Dec 18 15:12:34 [163162] DEBUG: ************************************************************* Sat Dec 18 15:12:34 [163162] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Sat Dec 18 15:12:34 [163162] DEBUG: mark at position 5 type 0x21 at 0:00:00.00 inBroadCast 0 Sat Dec 18 15:12:34 [163162] DEBUG: mark at position 131 type 0x31 at 0:00:02.51 inBroadCast 1 Sat Dec 18 15:12:34 [163162] DEBUG: mark at position 312 type 0x32 at 0:00:06.19 inBroadCast 0 Sat Dec 18 15:12:34 [163162] DEBUG: mark at position 2025 type 0x31 at 0:00:40.77 inBroadCast 1 Sat Dec 18 15:12:34 [163162] DEBUG: mark at position 2208 type 0x32 at 0:00:44.06 inBroadCast 0 Sat Dec 18 15:12:34 [163162] DEBUG: mark at position 2226 type 0x51 at 0:00:44.45 inBroadCast 1 Sat Dec 18 15:12:34 [163162] DEBUG: mark at position 2328 type 0x31 at 0:00:46.43 inBroadCast 1 Sat Dec 18 15:12:34 [163162] DEBUG: ************************************************************* Sat Dec 18 15:12:34 [163162] INFO: AC3 audio with 2 channels on stream 4 Sat Dec 18 15:12:34 [163162] INFO: HD video with aspect ratio of 16:9 detected Sat Dec 18 15:12:34 [163162] DEBUG: cMarkAdStandalone::CheckStart(): horizontal border start found at (2226) Sat Dec 18 15:12:34 [163162] DEBUG: cMarkAdStandalone::CheckStart(): delete VBORDER marks if any Sat Dec 18 15:12:34 [163162] INFO: using horizontal border start mark on position (2226) at 0:00:44.45 as first start mark Sat Dec 18 15:12:34 [163162] INFO: found horizontal borders, logo detection disabled Sat Dec 18 15:12:34 [163162] DEBUG: cMarkAdStandalone::CheckStart(): delete all black screen marks except start mark Sat Dec 18 15:12:34 [163162] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Sat Dec 18 15:12:34 [163162] DEBUG: cMarkAdStandalone::CheckStartMark(): check for short start/stop pairs at start Sat Dec 18 15:12:34 [163162] DEBUG: ************************************************************* Sat Dec 18 15:12:34 [163162] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Sat Dec 18 15:12:34 [163162] DEBUG: mark at position 2226 type 0x51 at 0:00:44.45 inBroadCast 1 Sat Dec 18 15:12:34 [163162] DEBUG: mark at position 2328 type 0x31 at 0:00:46.43 inBroadCast 1 Sat Dec 18 15:12:34 [163162] DEBUG: ************************************************************* Sat Dec 18 15:12:34 [163162] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Sat Dec 18 15:12:34 [163162] DEBUG: cMarkAdStandalone::CalculateCheckPositions(): startframe 2226 (0min 44s) Sat Dec 18 15:12:34 [163162] DEBUG: cMarkAdStandalone::CalculateCheckPositions(): use frame rate 50 Sat Dec 18 15:12:34 [163162] DEBUG: cMarkAdStandalone::CalculateCheckPositions(): length of recording: 5400s ( 90min 0s) Sat Dec 18 15:12:34 [163162] DEBUG: cMarkAdStandalone::CalculateCheckPositions(): assumed start frame: 2226 ( 0min 44s) Sat Dec 18 15:12:34 [163162] DEBUG: cMarkAdStandalone::CalculateCheckPositions(): assumed stop frame: 272726 ( 90min 54s) Sat Dec 18 15:12:34 [163162] DEBUG: cMarkAdStandalone::CalculateCheckPositions(): chkSTART set to: 26226 ( 8min 44s) Sat Dec 18 15:12:34 [163162] DEBUG: cMarkAdStandalone::CalculateCheckPositions(): chkSTOP set to: 302226 (100min 44s) Sat Dec 18 15:12:34 [163162] DEBUG: ************************************************************* Sat Dec 18 15:12:34 [163162] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Sat Dec 18 15:12:34 [163162] DEBUG: mark at position 2226 type 0x51 at 0:00:44.45 inBroadCast 1 Sat Dec 18 15:12:34 [163162] DEBUG: mark at position 2328 type 0x31 at 0:00:46.43 inBroadCast 1 Sat Dec 18 15:12:34 [163162] DEBUG: ************************************************************* Sat Dec 18 15:12:34 [163162] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Sat Dec 18 15:14:30 [163162] DEBUG: AVlog(): left block unavailable for requested intra mode Sat Dec 18 15:14:30 [163162] DEBUG: AVlog(): error while decoding MB 0 6, bytestream 39748 Sat Dec 18 15:14:30 [163162] DEBUG: cDecoder::GetNextPacket(): DTS continuity error at frame (70292), difference 480ms should be 20ms, decoding errors 1 Sat Dec 18 15:14:30 [163162] DEBUG: AVlog(): Junk in packet Sat Dec 18 15:16:32 [163162] DEBUG: cDecoder::GetNextPacket(): DTS continuity error at frame (117071), difference 40ms should be 20ms, decoding errors 2 Sat Dec 18 15:16:32 [163162] DEBUG: AVlog(): error while decoding MB 65 18, bytestream -10 Sat Dec 18 15:21:37 [163162] DEBUG: cDecoder::GetNextPacket(): DTS continuity error at frame (229576), difference 120ms should be 20ms, decoding errors 3 Sat Dec 18 15:21:37 [163162] DEBUG: AVlog(): left block unavailable for requested intra mode Sat Dec 18 15:21:37 [163162] DEBUG: AVlog(): error while decoding MB 0 11, bytestream 77015 Sat Dec 18 15:21:37 [163162] DEBUG: cDecoder::DecodePacket(): decoding of frame (229580) from stream 0 failed: decode_error_flags 8, decoding errors 4 Sat Dec 18 15:21:37 [163162] DEBUG: AVlog(): Junk in packet Sat Dec 18 15:21:48 [163162] DEBUG: cDecoder::GetNextPacket(): DTS continuity error at frame (234017), difference 80ms should be 20ms, decoding errors 5 Sat Dec 18 15:21:48 [163162] DEBUG: cDecoder::GetNextPacket(): DTS continuity error at frame (234029), difference 40ms should be 20ms, decoding errors 6 Sat Dec 18 15:21:48 [163162] DEBUG: AVlog(): left block unavailable for requested intra4x4 mode -1 Sat Dec 18 15:21:48 [163162] DEBUG: AVlog(): error while decoding MB 0 18, bytestream 35363 Sat Dec 18 15:21:48 [163162] INFO: detected stop of horiz. borders (234032) at 1:18:00.85 Sat Dec 18 15:21:48 [163162] DEBUG: cMarkAdStandalone::AddMark(): inBroadCast now: 0 Sat Dec 18 15:21:48 [163162] DEBUG: cDecoder::GetNextPacket(): DTS continuity error at frame (234034), difference 80ms should be 20ms, decoding errors 7 Sat Dec 18 15:21:48 [163162] DEBUG: cDecoder::DecodePacket(): decoding of frame (234036) from stream 0 failed: decode_error_flags 4, decoding errors 8 Sat Dec 18 15:21:48 [163162] DEBUG: AVlog(): reference picture missing during reorder Sat Dec 18 15:21:48 [163162] DEBUG: AVlog(): Missing reference picture, default is 65582 Sat Dec 18 15:21:48 [163162] DEBUG: cDecoder::GetNextPacket(): DTS continuity error at frame (234038), difference 780ms should be 20ms, decoding errors 9 Sat Dec 18 15:21:57 [163162] INFO: detected start of horiz. borders (234081)* at 1:18:03.00 Sat Dec 18 15:21:57 [163162] DEBUG: cMarkAdStandalone::AddMark(): inBroadCast now: 1 Sat Dec 18 15:22:40 [163162] DEBUG: cDecoder::GetNextPacket(): DTS continuity error at frame (253659), difference 240ms should be 20ms, decoding errors 10 Sat Dec 18 15:22:40 [163162] DEBUG: AVlog(): Junk in packet Sat Dec 18 15:22:58 [163162] DEBUG: cMarkAdStandalone::ProcessFrame(): enter end part at frame (260727) Sat Dec 18 15:22:58 [163162] INFO: restart logo and black screen detection at frame (260727) Sat Dec 18 15:22:58 [163162] DEBUG: cMarkAdLogo::Process(): aspect ratio changed from 0:0 to 16:9, reload logo Sat Dec 18 15:22:58 [163162] DEBUG: cMarkAdLogo::Load(): try to find logo ZDF_HD-A16_9 plane 0 in /var/lib/markad Sat Dec 18 15:22:58 [163162] DEBUG: cMarkAdLogo::Load(): file found for logo ZDF_HD-A16_9 plane 0 in /var/lib/markad Sat Dec 18 15:22:58 [163162] DEBUG: cMarkAdLogo::Load(): logo plane 0 has 1191 pixel Sat Dec 18 15:22:58 [163162] DEBUG: cMarkAdLogo::Load(): logo pixel ratio of plane 0 is: 68 per mille Sat Dec 18 15:22:58 [163162] INFO: logo for ZDF_HD 16:9 found in /var/lib/markad Sat Dec 18 15:22:58 [163162] DEBUG: cMarkAdLogo::Load(): try to find logo ZDF_HD-A16_9 plane 1 in /var/lib/markad Sat Dec 18 15:22:58 [163162] DEBUG: cMarkAdLogo::Load(): file not found for logo ZDF_HD-A16_9 plane 1 in /var/lib/markad Sat Dec 18 15:22:58 [163162] DEBUG: cMarkAdLogo::Load(): try to find logo ZDF_HD-A16_9 plane 2 in /var/lib/markad Sat Dec 18 15:22:58 [163162] DEBUG: cMarkAdLogo::Load(): file not found for logo ZDF_HD-A16_9 plane 2 in /var/lib/markad Sat Dec 18 15:22:58 [163162] DEBUG: detected end of black screen (260727)* at 1:26:56.24 inBroadCast: 1 Sat Dec 18 15:22:58 [163162] DEBUG: cMarkAdStandalone::AddMark(): inBroadCast now: 1 Sat Dec 18 15:23:49 [163162] DEBUG: detected start of black screen (279136) at 1:33:04.35 inBroadCast: 1 Sat Dec 18 15:23:49 [163162] DEBUG: cMarkAdStandalone::AddMark(): inBroadCast now: 1 Sat Dec 18 15:23:50 [163162] DEBUG: detected end of black screen (279850)* at 1:33:18.58 inBroadCast: 1 Sat Dec 18 15:23:50 [163162] DEBUG: cMarkAdStandalone::AddMark(): inBroadCast now: 1 Sat Dec 18 15:23:51 [163162] DEBUG: detected start of black screen (280442) at 1:33:30.45 inBroadCast: 1 Sat Dec 18 15:23:51 [163162] DEBUG: cMarkAdStandalone::AddMark(): inBroadCast now: 1 Sat Dec 18 15:23:52 [163162] DEBUG: detected end of black screen (281337)* at 1:33:48.25 inBroadCast: 1 Sat Dec 18 15:23:52 [163162] DEBUG: cMarkAdStandalone::AddMark(): inBroadCast now: 1 Sat Dec 18 15:23:52 [163162] INFO: detected stop of horiz. borders (281339) at 1:33:48.25 Sat Dec 18 15:23:52 [163162] DEBUG: cMarkAdStandalone::AddMark(): inBroadCast now: 0 Sat Dec 18 15:23:53 [163162] DEBUG: cMarkAdLogo::Detect(): black screen without logo detected at frame (282856) Sat Dec 18 15:23:53 [163162] INFO: detected logo stop (282854) at 1:34:18.62 Sat Dec 18 15:23:53 [163162] DEBUG: cMarkAdStandalone::AddMark(): inBroadCast now: 0 Sat Dec 18 15:23:53 [163162] DEBUG: cDecoder::GetNextPacket(): last frame of filenumber 1 is (282932), end time 5660320ms ( 94:20min) Sat Dec 18 15:23:53 [163162] DEBUG: cDecoder::DecodeFile(): filename: /media/hd/recordings/Irgendwann_ist_auch_mal_gut/2021-12-07.00.10.2-0.rec/00002.ts Sat Dec 18 15:23:53 [163162] DEBUG: AVlog(): error while decoding MB 44 20, bytestream -49 Sat Dec 18 15:23:53 [163162] DEBUG: ======================================================================================================================= Sat Dec 18 15:23:53 [163162] DEBUG: cMarkAdStandalone::CheckStop(): start check stop (282932) Sat Dec 18 15:23:53 [163162] DEBUG: assumed stop position (272726) at 1:30:56.62 Sat Dec 18 15:23:53 [163162] DEBUG: ************************************************************* Sat Dec 18 15:23:53 [163162] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Sat Dec 18 15:23:53 [163162] DEBUG: mark at position 2226 type 0x51 at 0:00:44.45 inBroadCast 1 Sat Dec 18 15:23:53 [163162] DEBUG: mark at position 2328 type 0x31 at 0:00:46.43 inBroadCast 1 Sat Dec 18 15:23:53 [163162] DEBUG: mark at position 234032 type 0x52 at 1:18:00.85 inBroadCast 0 Sat Dec 18 15:23:53 [163162] DEBUG: mark at position 234081 type 0x51 at 1:18:03.00 inBroadCast 1 Sat Dec 18 15:23:53 [163162] DEBUG: mark at position 260727 type 0x21 at 1:26:56.24 inBroadCast 1 Sat Dec 18 15:23:53 [163162] DEBUG: mark at position 279136 type 0x22 at 1:33:04.35 inBroadCast 1 Sat Dec 18 15:23:53 [163162] DEBUG: mark at position 279850 type 0x21 at 1:33:18.58 inBroadCast 1 Sat Dec 18 15:23:53 [163162] DEBUG: mark at position 280442 type 0x22 at 1:33:30.45 inBroadCast 1 Sat Dec 18 15:23:53 [163162] DEBUG: mark at position 281337 type 0x21 at 1:33:48.25 inBroadCast 1 Sat Dec 18 15:23:53 [163162] DEBUG: mark at position 281339 type 0x52 at 1:33:48.25 inBroadCast 0 Sat Dec 18 15:23:53 [163162] DEBUG: mark at position 282854 type 0x32 at 1:34:18.62 inBroadCast 0 Sat Dec 18 15:23:53 [163162] DEBUG: ************************************************************* Sat Dec 18 15:23:53 [163162] DEBUG: ======================================================================================================================= Sat Dec 18 15:23:53 [163162] DEBUG: cMarkAdStandalone::RemoveLogoChangeMarks(): start detect and remove logo stop/start mark pairs with special logo Sat Dec 18 15:23:53 [163162] DEBUG: cEvaluateLogoStopStartPair::cEvaluateLogoStopStartPair(): start with iStart 0, chkSTART 26226, iStopA 272726 Sat Dec 18 15:23:53 [163162] DEBUG: cDecoder::cDecoder(): create new decoder instance Sat Dec 18 15:23:53 [163162] DEBUG: cDecoder::cDecoder(): init with 4 threads Sat Dec 18 15:23:53 [163162] DEBUG: cDecoder::DecodeFile(): filename: /media/hd/recordings/Irgendwann_ist_auch_mal_gut/2021-12-07.00.10.2-0.rec/00001.ts Sat Dec 18 15:23:53 [163162] DEBUG: cDecoder::DecodeFile(): opened file /media/hd/recordings/Irgendwann_ist_auch_mal_gut/2021-12-07.00.10.2-0.rec/00001.ts Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): using decoder for stream 0: codec id 27 -> H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): average framerate 50/1 Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): real framerate 50/1 Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): using decoder for stream 1: codec id 86016 -> MP2 (MPEG audio layer 2) Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): using decoder for stream 2: codec id 86016 -> MP2 (MPEG audio layer 2) Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): using decoder for stream 3: codec id 86016 -> MP2 (MPEG audio layer 2) Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): using decoder for stream 4: codec id 86019 -> ATSC A/52A (AC-3) Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): using decoder for stream 5: codec id 94209 -> DVB subtitles Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::~cDecoder(): decoder instance deleted Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::RemoveLogoChangeMarks(): marks after detect and remove logo stop/start mark pairs with special logo Sat Dec 18 15:23:54 [163162] DEBUG: ************************************************************* Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 2226 type 0x51 at 0:00:44.45 inBroadCast 1 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 2328 type 0x31 at 0:00:46.43 inBroadCast 1 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 234032 type 0x52 at 1:18:00.85 inBroadCast 0 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 234081 type 0x51 at 1:18:03.00 inBroadCast 1 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 260727 type 0x21 at 1:26:56.24 inBroadCast 1 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 279136 type 0x22 at 1:33:04.35 inBroadCast 1 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 279850 type 0x21 at 1:33:18.58 inBroadCast 1 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 280442 type 0x22 at 1:33:30.45 inBroadCast 1 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 281337 type 0x21 at 1:33:48.25 inBroadCast 1 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 281339 type 0x52 at 1:33:48.25 inBroadCast 0 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 282854 type 0x32 at 1:34:18.62 inBroadCast 0 Sat Dec 18 15:23:54 [163162] DEBUG: ************************************************************* Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::RemoveLogoChangeMarks(): end detect and remove logo stop/start mark pairs with special logo Sat Dec 18 15:23:54 [163162] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Sat Dec 18 15:23:54 [163162] DEBUG: ======================================================================================================================= Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::CheckStop(): start end end mark selection Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::CheckStop(): no MT_CHANNELSTOP mark found Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::CheckStop(): no MT_ASPECTSTOP mark found Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::CheckStop(): MT_HBORDERSTOP found at frame 281339 Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::CheckStop(): found end mark at (281339) Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::CheckStop(): found stronger end mark (281339) delete mark (279136) Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::CheckStop(): found stronger end mark (281339) delete mark (279850) Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::CheckStop(): found stronger end mark (281339) delete mark (280442) Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::CheckStop(): found stronger end mark (281339) delete mark (281337) Sat Dec 18 15:23:54 [163162] INFO: using horizontal border stop mark on position (281339) at 1:33:48.25 as end mark Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::CheckStop(): delete all marks after final stop mark at (281339) Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::CheckStop(): move all black screen marks except start and end mark to black screen list Sat Dec 18 15:23:54 [163162] DEBUG: ************************************************************* Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 2226 type 0x51 at 0:00:44.45 inBroadCast 1 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 2328 type 0x31 at 0:00:46.43 inBroadCast 1 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 234032 type 0x52 at 1:18:00.85 inBroadCast 0 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 234081 type 0x51 at 1:18:03.00 inBroadCast 1 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 281339 type 0x52 at 1:33:48.25 inBroadCast 0 Sat Dec 18 15:23:54 [163162] DEBUG: ************************************************************* Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::CheckStop(): end check stop Sat Dec 18 15:23:54 [163162] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Sat Dec 18 15:23:54 [163162] DEBUG: ======================================================================================================================= Sat Dec 18 15:23:54 [163162] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::CheckMarks(): remove invalid marks Sat Dec 18 15:23:54 [163162] DEBUG: ************************************************************* Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 2226 type 0x51 at 0:00:44.45 inBroadCast 1 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 2328 type 0x31 at 0:00:46.43 inBroadCast 1 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 234032 type 0x52 at 1:18:00.85 inBroadCast 0 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 234081 type 0x51 at 1:18:03.00 inBroadCast 1 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 281339 type 0x52 at 1:33:48.25 inBroadCast 0 Sat Dec 18 15:23:54 [163162] DEBUG: ************************************************************* Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::CheckMarks(): mark (2226) type count 2, followed by same mark (2328) type count 1 Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::CheckMarks(): delete stop mark (2328) Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::CheckMarks(): check advertising from stop (234032) to start (234081), length 0s Sat Dec 18 15:23:54 [163162] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::CheckMarks(): delete logo marks if we have channel or border marks Sat Dec 18 15:23:54 [163162] DEBUG: ************************************************************* Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 2226 type 0x51 at 0:00:44.45 inBroadCast 1 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 234032 type 0x52 at 1:18:00.85 inBroadCast 0 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 234081 type 0x51 at 1:18:03.00 inBroadCast 1 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 281339 type 0x52 at 1:33:48.25 inBroadCast 0 Sat Dec 18 15:23:54 [163162] DEBUG: ************************************************************* Sat Dec 18 15:23:54 [163162] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::CheckMarks(): delete invalid black sceen marks Sat Dec 18 15:23:54 [163162] DEBUG: ************************************************************* Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 2226 type 0x51 at 0:00:44.45 inBroadCast 1 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 234032 type 0x52 at 1:18:00.85 inBroadCast 0 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 234081 type 0x51 at 1:18:03.00 inBroadCast 1 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 281339 type 0x52 at 1:33:48.25 inBroadCast 0 Sat Dec 18 15:23:54 [163162] DEBUG: ************************************************************* Sat Dec 18 15:23:54 [163162] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::CheckMarks(): delete very short logo stop/start pairs Sat Dec 18 15:23:54 [163162] DEBUG: ************************************************************* Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 2226 type 0x51 at 0:00:44.45 inBroadCast 1 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 234032 type 0x52 at 1:18:00.85 inBroadCast 0 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 234081 type 0x51 at 1:18:03.00 inBroadCast 1 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 281339 type 0x52 at 1:33:48.25 inBroadCast 0 Sat Dec 18 15:23:54 [163162] DEBUG: ************************************************************* Sat Dec 18 15:23:54 [163162] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::CheckMarks(): detect previews in advertisement Sat Dec 18 15:23:54 [163162] DEBUG: ************************************************************* Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 2226 type 0x51 at 0:00:44.45 inBroadCast 1 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 234032 type 0x52 at 1:18:00.85 inBroadCast 0 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 234081 type 0x51 at 1:18:03.00 inBroadCast 1 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 281339 type 0x52 at 1:33:48.25 inBroadCast 0 Sat Dec 18 15:23:54 [163162] DEBUG: ************************************************************* Sat Dec 18 15:23:54 [163162] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::CheckMarks(): check border marks Sat Dec 18 15:23:54 [163162] DEBUG: ************************************************************* Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 2226 type 0x51 at 0:00:44.45 inBroadCast 1 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 234032 type 0x52 at 1:18:00.85 inBroadCast 0 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 234081 type 0x51 at 1:18:03.00 inBroadCast 1 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 281339 type 0x52 at 1:33:48.25 inBroadCast 0 Sat Dec 18 15:23:54 [163162] DEBUG: ************************************************************* Sat Dec 18 15:23:54 [163162] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::CheckStartMark(): check for short start/stop pairs at start Sat Dec 18 15:23:54 [163162] DEBUG: ************************************************************* Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 2226 type 0x51 at 0:00:44.45 inBroadCast 1 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 234032 type 0x52 at 1:18:00.85 inBroadCast 0 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 234081 type 0x51 at 1:18:03.00 inBroadCast 1 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 281339 type 0x52 at 1:33:48.25 inBroadCast 0 Sat Dec 18 15:23:54 [163162] DEBUG: ************************************************************* Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::CheckStartMark(): first broadcast length 4636s from (2226) to (234032) (expect <=8s) Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::CheckStartMark(): first advertising length 980ms from (234032) to (234081) Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::CheckStartMark(): very short first advertising, this can be a logo detection failure Sat Dec 18 15:23:54 [163162] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::CheckMarks(): check for near better end mark in case of recording length is too big Sat Dec 18 15:23:54 [163162] DEBUG: ************************************************************* Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 2226 type 0x51 at 0:00:44.45 inBroadCast 1 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 234032 type 0x52 at 1:18:00.85 inBroadCast 0 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 234081 type 0x51 at 1:18:03.00 inBroadCast 1 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 281339 type 0x52 at 1:33:48.25 inBroadCast 0 Sat Dec 18 15:23:54 [163162] DEBUG: ************************************************************* Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::CheckMarks(): last broadcast length 945s from (234081) to (281339) Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::CheckMarks(): last advertising length 0s (expect <=390s) from (234032) to (234081) Sat Dec 18 15:23:54 [163162] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::CheckMarks(): remove logo and hborder detection failure marks Sat Dec 18 15:23:54 [163162] DEBUG: ************************************************************* Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 2226 type 0x51 at 0:00:44.45 inBroadCast 1 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 234032 type 0x52 at 1:18:00.85 inBroadCast 0 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 234081 type 0x51 at 1:18:03.00 inBroadCast 1 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 281339 type 0x52 at 1:33:48.25 inBroadCast 0 Sat Dec 18 15:23:54 [163162] DEBUG: ************************************************************* Sat Dec 18 15:23:54 [163162] INFO: mark distance between horizontal STOP and START too short (1.0s), deleting 234032,234081 Sat Dec 18 15:23:54 [163162] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Sat Dec 18 15:23:54 [163162] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::CheckMarks(): apply VPS events Sat Dec 18 15:23:54 [163162] DEBUG: ************************************************************* Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 2226 type 0x51 at 0:00:44.45 inBroadCast 1 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 281339 type 0x52 at 1:33:48.25 inBroadCast 0 Sat Dec 18 15:23:54 [163162] DEBUG: ************************************************************* Sat Dec 18 15:23:54 [163162] INFO: VPS start event at 0:00:35 Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::AddMarkVPS(): found VPS start at frame (1723) at 0:00:34.52 Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::AddMarkVPS(): keep mark at frame (2226) type 0x51 at 0:00:44.45 Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::CheckMarks(): no VPS pause start event found Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::CheckMarks(): no VPS pause stop event found Sat Dec 18 15:23:54 [163162] INFO: VPS stop event at 1:34:19 Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::AddMarkVPS(): found VPS stop at frame (282843) at 1:34:18.62 Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::AddMarkVPS(): keep mark at frame (281339) type 0x52 at 1:33:48.25 Sat Dec 18 15:23:54 [163162] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::CheckMarks(): final marks: Sat Dec 18 15:23:54 [163162] DEBUG: ************************************************************* Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 2226 type 0x51 at 0:00:44.45 inBroadCast 1 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 281339 type 0x52 at 1:33:48.25 inBroadCast 0 Sat Dec 18 15:23:54 [163162] DEBUG: ************************************************************* Sat Dec 18 15:23:54 [163162] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::ProcessFiles(): end processing files Sat Dec 18 15:23:54 [163162] DEBUG: ======================================================================================================================= Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::LogoMarkOptimization(): start logo mark optimization Sat Dec 18 15:23:54 [163162] DEBUG: ======================================================================================================================= Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::LogoMarkOptimization(): check for advertising in frame with logo after logo start and before logo stop mark and check for introduction logo Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): filename: /media/hd/recordings/Irgendwann_ist_auch_mal_gut/2021-12-07.00.10.2-0.rec/00001.ts Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): opened file /media/hd/recordings/Irgendwann_ist_auch_mal_gut/2021-12-07.00.10.2-0.rec/00001.ts Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): using decoder for stream 0: codec id 27 -> H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): average framerate 50/1 Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): real framerate 50/1 Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): using decoder for stream 1: codec id 86016 -> MP2 (MPEG audio layer 2) Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): using decoder for stream 2: codec id 86016 -> MP2 (MPEG audio layer 2) Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): using decoder for stream 3: codec id 86016 -> MP2 (MPEG audio layer 2) Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): using decoder for stream 4: codec id 86019 -> ATSC A/52A (AC-3) Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): using decoder for stream 5: codec id 94209 -> DVB subtitles Sat Dec 18 15:23:54 [163162] DEBUG: ======================================================================================================================= Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::LogoMarkOptimization(): search for audio silence around logo marks Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): filename: /media/hd/recordings/Irgendwann_ist_auch_mal_gut/2021-12-07.00.10.2-0.rec/00001.ts Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): opened file /media/hd/recordings/Irgendwann_ist_auch_mal_gut/2021-12-07.00.10.2-0.rec/00001.ts Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): using decoder for stream 0: codec id 27 -> H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): average framerate 50/1 Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): real framerate 50/1 Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): using decoder for stream 1: codec id 86016 -> MP2 (MPEG audio layer 2) Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): using decoder for stream 2: codec id 86016 -> MP2 (MPEG audio layer 2) Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): using decoder for stream 3: codec id 86016 -> MP2 (MPEG audio layer 2) Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): using decoder for stream 4: codec id 86019 -> ATSC A/52A (AC-3) Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): using decoder for stream 5: codec id 94209 -> DVB subtitles Sat Dec 18 15:23:54 [163162] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::LogoMarkOptimization(): start search for black screen near logo marks Sat Dec 18 15:23:54 [163162] DEBUG: ======================================================================================================================= Sat Dec 18 15:23:54 [163162] DEBUG: ProcessOverlap(): start overlap detection Sat Dec 18 15:23:54 [163162] DEBUG: ************************************************************* Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 2226 type 0x51 at 0:00:44.45 inBroadCast 1 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 281339 type 0x52 at 1:33:48.25 inBroadCast 0 Sat Dec 18 15:23:54 [163162] DEBUG: ************************************************************* Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): filename: /media/hd/recordings/Irgendwann_ist_auch_mal_gut/2021-12-07.00.10.2-0.rec/00001.ts Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): opened file /media/hd/recordings/Irgendwann_ist_auch_mal_gut/2021-12-07.00.10.2-0.rec/00001.ts Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): using decoder for stream 0: codec id 27 -> H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): average framerate 50/1 Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): real framerate 50/1 Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): using decoder for stream 1: codec id 86016 -> MP2 (MPEG audio layer 2) Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): using decoder for stream 2: codec id 86016 -> MP2 (MPEG audio layer 2) Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): using decoder for stream 3: codec id 86016 -> MP2 (MPEG audio layer 2) Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): using decoder for stream 4: codec id 86019 -> ATSC A/52A (AC-3) Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): using decoder for stream 5: codec id 94209 -> DVB subtitles Sat Dec 18 15:23:54 [163162] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::LogoMarkOptimization(): check last logo stop mark if closing credits follows Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::LogoMarkOptimization(): search for closing credits Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::MoveLastStopAfterClosingCredits(): check closing credits without logo after position (281339) Sat Dec 18 15:23:54 [163162] DEBUG: cDetectLogoStopStart::Detect(): channel not in list for special logo detection Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::MoveLastStopAfterClosingCredits(): no closing credits found Sat Dec 18 15:23:54 [163162] DEBUG: end Overlap Sat Dec 18 15:23:54 [163162] DEBUG: ======================================================================================================================= Sat Dec 18 15:23:54 [163162] INFO: start cut video based on marks Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::MarkadCut(): final marks are: Sat Dec 18 15:23:54 [163162] DEBUG: ************************************************************* Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 2226 type 0x51 at 0:00:44.45 inBroadCast 1 Sat Dec 18 15:23:54 [163162] DEBUG: mark at position 281339 type 0x52 at 1:33:48.25 inBroadCast 0 Sat Dec 18 15:23:54 [163162] DEBUG: ************************************************************* Sat Dec 18 15:23:54 [163162] DEBUG: cEncoder::cEncoder(): init with 4 threads Sat Dec 18 15:23:54 [163162] DEBUG: cMarkAdStandalone::MarkadCut(): start pass 0 Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): filename: /media/hd/recordings/Irgendwann_ist_auch_mal_gut/2021-12-07.00.10.2-0.rec/00001.ts Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): opened file /media/hd/recordings/Irgendwann_ist_auch_mal_gut/2021-12-07.00.10.2-0.rec/00001.ts Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): using decoder for stream 0: codec id 27 -> H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): average framerate 50/1 Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): real framerate 50/1 Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): using decoder for stream 1: codec id 86016 -> MP2 (MPEG audio layer 2) Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): using decoder for stream 2: codec id 86016 -> MP2 (MPEG audio layer 2) Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): using decoder for stream 3: codec id 86016 -> MP2 (MPEG audio layer 2) Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): using decoder for stream 4: codec id 86019 -> ATSC A/52A (AC-3) Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::DecodeFile(): using decoder for stream 5: codec id 94209 -> DVB subtitles Sat Dec 18 15:23:54 [163162] DEBUG: cDecoder::SeekToFrame(): (2256) Sat Dec 18 15:23:55 [163162] DEBUG: cDecoder::SeekToFrame(): successful Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::OpenFile(): cutName 'Irgendwann_ist_auch_mal_gut' Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::OpenFile(): write to '/media/hd/recordings/Irgendwann_ist_auch_mal_gut/2021-12-07.00.10.2-0.rec/Irgendwann_ist_auch_mal_gut.ts' Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::OpenFile(): output format MPEG-TS (MPEG-2 Transport Stream) Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::OpenFile(): best video: stream 0 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::OpenFile(): best audio: stream 4 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::OpenFile(): source stream 0 -----> target stream 0 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): using encoder id 27 'libx264 H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10' for output stream 0 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): video input codec stream 0 avg framerate 50/1 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): video input codec stream 0 real framerate 50/1 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): video input codec stream 0 keyint_min 25 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): video input format stream 0 bit_rate 15165014 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): video input codec stream 0 bit_rate 0 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): video input codec stream 0 rc_max_rate 0 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): video input codec stream 0 bit_rate_tolerance 4000000 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): video input codec stream 0 global_quality 0 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): video input codec stream 0 sample_rate 0 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): video input codec stream 0 gop_size 12 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): video input codec stream 0 level 40 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): video input codec stream 0 aspect ratio 1:1 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): target video bit rate 14077014 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): video output stream 0 pix_fmt 0 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): video output stream 0 keyint_min 1 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): video output stream 0 max_b_frames 7 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): video output stream 0 bit_rate 14077014 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): video output stream 0 rc_max_rate 0 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): video output stream 0 bit_rate_tolerance 4000000 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): video output stream 0 level 40 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): video output stream 0 framerate 50/1 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): video output stream 0 gop_size 32 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): video output stream 0 level 40 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): video output stream 0 aspect ratio 1:1 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): output stream 0 timebase 1/50 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): avcodec_open2 for stream 0 successful Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::OpenFile(): source stream 1 -----> target stream 1 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): using encoder id 86016 'MP2 (MPEG audio layer 2)' for output stream 1 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): input codec sample rate 48000, timebase 1/48000 for stream 1 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): audio output codec parameter for stream 1: bit_rate 256000 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): output stream 1 timebase 1/48000 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): avcodec_open2 for stream 1 successful Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::OpenFile(): source stream 2 -----> target stream 2 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): using encoder id 86016 'MP2 (MPEG audio layer 2)' for output stream 2 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): input codec sample rate 48000, timebase 1/48000 for stream 2 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): audio output codec parameter for stream 2: bit_rate 192000 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): output stream 2 timebase 1/48000 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): avcodec_open2 for stream 2 successful Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::OpenFile(): source stream 3 -----> target stream 3 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): using encoder id 86016 'MP2 (MPEG audio layer 2)' for output stream 3 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): input codec sample rate 48000, timebase 1/48000 for stream 3 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): audio output codec parameter for stream 3: bit_rate 192000 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): output stream 3 timebase 1/48000 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): avcodec_open2 for stream 3 successful Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::OpenFile(): source stream 4 -----> target stream 4 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): using encoder id 86019 'ATSC A/52A (AC-3)' for output stream 4 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): input codec sample rate 48000, timebase 1/48000 for stream 4 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): audio output codec parameter for stream 4: bit_rate 448000 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): output stream 4 timebase 1/48000 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): avcodec_open2 for stream 4 successful Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): AC3 input found at stream 4, initialize volume filter for output stream 4 Sat Dec 18 15:23:55 [163162] DEBUG: cAC3VolumeFilter::Init(): Could not initialize the abuffer filter -22 Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::InitEncoderCodec(): ptr_cAC3VolumeFilter->Init() failed Sat Dec 18 15:23:55 [163162] DEBUG: cEncoder::OpenFile(): InitEncoderCodec failed Sat Dec 18 15:23:55 [163162] ERROR: failed to open output file Sat Dec 18 15:23:55 [163162] DEBUG: cMarks::Save(): save marks, isRunningRecording=0 force=1 Sat Dec 18 15:23:55 [163162] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Sat Dec 18 15:23:55 [163162] DEBUG: time for decoding: 666s 874ms Sat Dec 18 15:23:55 [163162] DEBUG: time to find logo changes: 0s 207ms Sat Dec 18 15:23:55 [163162] DEBUG: pass 1: time 747s 201ms, frames 282932, fps 378 Sat Dec 18 15:23:55 [163162] DEBUG: pass 4: time 1s 133ms, frames 0, fps 0 Sat Dec 18 15:23:55 [163162] INFO: processed time 12:29 min with 378 fps Sat Dec 18 15:23:56 [163162] ERROR: decoding errors: 10 Sat Dec 18 15:23:56 [163162] DEBUG: cDecoder::~cDecoder(): decoder instance deleted