Tue Dec 21 15:12:57 [39152] INFO: starting markad v3.0.18 (64bit) Tue Dec 21 15:12:57 [39152] INFO: using libavcodec.so.59.12.100 with 4 threads Tue Dec 21 15:12:57 [39152] INFO: on /media/hd/plexmedia/markad_work/heute/Tagesschau/2021-12-18.20.00.1-0.rec Tue Dec 21 15:12:57 [39152] INFO: aspect ratio 16:9 (from vdr info) Tue Dec 21 15:12:57 [39152] INFO: broadcast with DolbyDigital2.0 (from vdr info) Tue Dec 21 15:12:57 [39152] DEBUG: cMarkAdStandalone::isVPSTimer(): markad.vps not found Tue Dec 21 15:12:57 [39152] DEBUG: cMarkAdStandalone::GetRecordingStart(): mount option noatime is set, use atime from directory /media/hd/plexmedia/markad_work/heute/Tagesschau/2021-12-18.20.00.1-0.rec to get creation time Tue Dec 21 15:12:57 [39152] DEBUG: cMarkAdStandalone::GetRecordingStart(): got no valid directory creation time, maybe recording was copied Tue Dec 21 15:13:44 2021 Tue Dec 21 15:12:57 [39152] DEBUG: cMarkAdStandalone::GetRecordingStart(): broadcast start time from vdr info file Sat Dec 18 20:00:00 2021 Tue Dec 21 15:12:57 [39152] DEBUG: cMarkAdStandalone::GetRecordingStart(): getting recording start from VDR info file modification time Sat Dec 18 20:11:18 2021 Tue Dec 21 15:12:57 [39152] DEBUG: cMarkAdStandalone::LoadInfo(): recording start at Sat Dec 18 20:11:18 2021 Tue Dec 21 15:12:57 [39152] DEBUG: cMarkAdStandalone::LoadInfo(): timer start at Sat Dec 18 20:00:00 2021 Tue Dec 21 15:12:57 [39152] INFO: missed broadcast start by 11:18 min, event length 900s Tue Dec 21 15:12:57 [39152] INFO: corrected length 222s Tue Dec 21 15:12:57 [39152] DEBUG: cMarkAdStandalone::LoadInfo(): broadcast start -678s after recording start Tue Dec 21 15:12:57 [39152] DEBUG: cMarkAdStandalone::CheckLogo(): using logo directory /var/lib/markad Tue Dec 21 15:12:57 [39152] DEBUG: cMarkAdStandalone::CheckLogo(): searching logo for Das_Erste_HD Tue Dec 21 15:12:57 [39152] INFO: pre-timer: 0:11:18h Tue Dec 21 15:12:57 [39152] INFO: broadcast length: 0:03:42h Tue Dec 21 15:12:57 [39152] INFO: channel: Das_Erste_HD Tue Dec 21 15:12:57 [39152] DEBUG: parameter --loglevel is set to 3 Tue Dec 21 15:12:57 [39152] DEBUG: markad process nice level 19 Tue Dec 21 15:12:57 [39152] DEBUG: markad IO priority class 3 Tue Dec 21 15:12:57 [39152] DEBUG: parameter --logocachedir is set to /var/lib/markad Tue Dec 21 15:12:57 [39152] DEBUG: parameter --threads is set to 4 Tue Dec 21 15:12:57 [39152] DEBUG: parameter --astopoffs is set to 0 Tue Dec 21 15:12:57 [39152] DEBUG: parameter --log2rec is set Tue Dec 21 15:12:57 [39152] DEBUG: parameter --vps is set Tue Dec 21 15:12:57 [39152] DEBUG: parameter --autologo is set to 2 Tue Dec 21 15:12:57 [39152] DEBUG: ======================================================================================================================= Tue Dec 21 15:12:57 [39152] DEBUG: cMarkAdStandalone::ProcessFiles(): start processing files Tue Dec 21 15:12:57 [39152] DEBUG: cDecoder::cDecoder(): create new decoder instance Tue Dec 21 15:12:57 [39152] DEBUG: cDecoder::cDecoder(): init with 4 threads Tue Dec 21 15:12:57 [39152] DEBUG: cDecoder::DecodeFile(): filename: /media/hd/plexmedia/markad_work/heute/Tagesschau/2021-12-18.20.00.1-0.rec/00001.ts Tue Dec 21 15:12:57 [39152] DEBUG: cDecoder::DecodeFile(): opened file /media/hd/plexmedia/markad_work/heute/Tagesschau/2021-12-18.20.00.1-0.rec/00001.ts Tue Dec 21 15:12:57 [39152] DEBUG: cDecoder::DecodeFile(): using decoder for stream 0: codec id 27 -> H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 Tue Dec 21 15:12:57 [39152] DEBUG: cDecoder::DecodeFile(): average framerate 50/1 Tue Dec 21 15:12:57 [39152] DEBUG: cDecoder::DecodeFile(): real framerate 50/1 Tue Dec 21 15:12:57 [39152] DEBUG: cDecoder::DecodeFile(): using decoder for stream 1: codec id 86016 -> MP2 (MPEG audio layer 2) Tue Dec 21 15:12:57 [39152] DEBUG: cDecoder::DecodeFile(): using decoder for stream 2: codec id 86016 -> MP2 (MPEG audio layer 2) Tue Dec 21 15:12:57 [39152] DEBUG: cDecoder::DecodeFile(): using decoder for stream 3: codec id 86019 -> ATSC A/52A (AC-3) Tue Dec 21 15:12:57 [39152] DEBUG: cDecoder::DecodeFile(): using decoder for stream 4: codec id 94209 -> DVB subtitles Tue Dec 21 15:12:57 [39152] DEBUG: cDecoder::GetVideoType(): video coding format: H.264 Tue Dec 21 15:12:57 [39152] INFO: video hight: 720 Tue Dec 21 15:12:57 [39152] INFO: video width: 1280 Tue Dec 21 15:12:57 [39152] INFO: average frame rate: 50 frames per second Tue Dec 21 15:12:57 [39152] INFO: real frame rate: 50 frames per second Tue Dec 21 15:12:57 [39152] DEBUG: cMarkAdStandalone::CalculateCheckPositions(): startframe -33900 (-11min -18s) Tue Dec 21 15:12:57 [39152] INFO: recording started too late, set start mark to start of recording Tue Dec 21 15:12:57 [39152] DEBUG: cIndex::GetTimeFromFrame(): frame index not initialized Tue Dec 21 15:12:57 [39152] DEBUG: cMarks::IndexToHMSF(): failed to get time from frame (1) Tue Dec 21 15:12:57 [39152] DEBUG: cMarkAdStandalone::AddMark(): inBroadCast now: 1 Tue Dec 21 15:12:57 [39152] DEBUG: cMarkAdStandalone::CalculateCheckPositions(): use frame rate 50 Tue Dec 21 15:12:57 [39152] DEBUG: cMarkAdStandalone::CalculateCheckPositions(): length of recording: 222s ( 3min 42s) Tue Dec 21 15:12:57 [39152] DEBUG: cMarkAdStandalone::CalculateCheckPositions(): assumed start frame: 18000 ( 6min 0s) Tue Dec 21 15:12:57 [39152] DEBUG: cMarkAdStandalone::CalculateCheckPositions(): assumed stop frame: 29100 ( 9min 42s) Tue Dec 21 15:12:57 [39152] DEBUG: cMarkAdStandalone::CalculateCheckPositions(): chkSTART set to: 42000 ( 14min 0s) Tue Dec 21 15:12:57 [39152] DEBUG: cMarkAdStandalone::CalculateCheckPositions(): chkSTOP set to: 59100 ( 19min 42s) Tue Dec 21 15:12:57 [39152] DEBUG: cDecoder::GetFrameInfo(): audio channels of stream 3 changed from 0 to 2 at frame (4) PTS 1229036314 Tue Dec 21 15:12:57 [39152] DEBUG: cMarkAdAudio::ChannelChange(): new audio stream 3 start at frame (4) Tue Dec 21 15:12:57 [39152] DEBUG: cDecoder::GetFrameInfo(): non interlaced video format Tue Dec 21 15:12:57 [39152] DEBUG: cDecoder::GetFrameInfo(): aspect ratio changed from (0:0) to (16:9) at frame 6 Tue Dec 21 15:12:57 [39152] DEBUG: cMarkAdLogo::Process(): aspect ratio changed from 0:0 to 16:9, reload logo Tue Dec 21 15:12:57 [39152] DEBUG: cMarkAdLogo::Load(): try to find logo Das_Erste_HD-A16_9 plane 0 in /var/lib/markad Tue Dec 21 15:12:57 [39152] DEBUG: cMarkAdLogo::Load(): file found for logo Das_Erste_HD-A16_9 plane 0 in /var/lib/markad Tue Dec 21 15:12:57 [39152] DEBUG: cMarkAdLogo::Load(): logo plane 0 has 716 pixel Tue Dec 21 15:12:57 [39152] DEBUG: cMarkAdLogo::Load(): logo pixel ratio of plane 0 is: 43 per mille Tue Dec 21 15:12:57 [39152] INFO: logo for Das_Erste_HD 16:9 found in /var/lib/markad Tue Dec 21 15:12:57 [39152] DEBUG: cMarkAdLogo::Load(): try to find logo Das_Erste_HD-A16_9 plane 1 in /var/lib/markad Tue Dec 21 15:12:57 [39152] DEBUG: cMarkAdLogo::Load(): file not found for logo Das_Erste_HD-A16_9 plane 1 in /var/lib/markad Tue Dec 21 15:12:57 [39152] DEBUG: cMarkAdLogo::Load(): try to find logo Das_Erste_HD-A16_9 plane 2 in /var/lib/markad Tue Dec 21 15:12:57 [39152] DEBUG: cMarkAdLogo::Load(): file not found for logo Das_Erste_HD-A16_9 plane 2 in /var/lib/markad Tue Dec 21 15:12:57 [39152] DEBUG: cMarkAdLogo::ReduceBrightness(): logo area: xstart 1134 xend 1177, ystart 51 yend 114 Tue Dec 21 15:12:57 [39152] DEBUG: cMarkAdStandalone::AddMark(): previous recording mark (1) is stronger than actual black screen mark (0), distance 20ms, deleting (0) Tue Dec 21 15:12:57 [39152] INFO: detected logo start ( 978)* at 0:00:19.55 Tue Dec 21 15:12:57 [39152] DEBUG: cMarkAdStandalone::AddMark(): inBroadCast now: 1 Tue Dec 21 15:12:57 [39152] DEBUG: detected start of black screen ( 1142) at 0:00:22.97 inBroadCast: 1 Tue Dec 21 15:12:57 [39152] DEBUG: cMarkAdStandalone::AddMark(): inBroadCast now: 1 Tue Dec 21 15:12:57 [39152] DEBUG: detected end of black screen ( 1168)* at 0:00:23.36 inBroadCast: 1 Tue Dec 21 15:12:57 [39152] DEBUG: cMarkAdStandalone::AddMark(): inBroadCast now: 1 Tue Dec 21 15:12:58 [39152] DEBUG: detected start of black screen ( 3146) at 0:01:03.06 inBroadCast: 1 Tue Dec 21 15:12:58 [39152] DEBUG: cMarkAdStandalone::AddMark(): inBroadCast now: 1 Tue Dec 21 15:12:58 [39152] DEBUG: detected end of black screen ( 3178)* at 0:01:03.70 inBroadCast: 1 Tue Dec 21 15:12:58 [39152] DEBUG: cMarkAdStandalone::AddMark(): inBroadCast now: 1 Tue Dec 21 15:12:59 [39152] DEBUG: cDecoder::GetNextPacket(): DTS continuity error at frame (4186), difference 40ms should be 20ms, decoding errors 1 Tue Dec 21 15:12:59 [39152] DEBUG: detected start of black screen ( 4281) at 0:01:25.63 inBroadCast: 1 Tue Dec 21 15:12:59 [39152] DEBUG: cMarkAdStandalone::AddMark(): inBroadCast now: 1 Tue Dec 21 15:12:59 [39152] DEBUG: detected end of black screen ( 4313)* at 0:01:26.41 inBroadCast: 1 Tue Dec 21 15:12:59 [39152] DEBUG: cMarkAdStandalone::AddMark(): inBroadCast now: 1 Tue Dec 21 15:12:59 [39152] DEBUG: cMarkAdLogo::Detect(): black screen without logo detected at frame (5022) Tue Dec 21 15:12:59 [39152] INFO: detected logo stop ( 4998) at 0:01:40.12 Tue Dec 21 15:12:59 [39152] DEBUG: cMarkAdStandalone::AddMark(): inBroadCast now: 0 Tue Dec 21 15:12:59 [39152] INFO: detected logo start ( 5196)* at 0:01:44.08 Tue Dec 21 15:12:59 [39152] DEBUG: cMarkAdStandalone::AddMark(): inBroadCast now: 1 Tue Dec 21 15:13:04 [39152] DEBUG: cDecoder::GetNextPacket(): DTS continuity error at frame (14746), difference 40ms should be 20ms, decoding errors 2 Tue Dec 21 15:13:04 [39152] DEBUG: AVlog(): Junk in packet Tue Dec 21 15:13:04 [39152] DEBUG: AVlog(): left block unavailable for requested intra4x4 mode -1 Tue Dec 21 15:13:04 [39152] DEBUG: AVlog(): error while decoding MB 0 43, bytestream 6497 Tue Dec 21 15:13:09 [39152] DEBUG: cDecoder::GetNextPacket(): DTS continuity error at frame (24653), difference 40ms should be 20ms, decoding errors 3 Tue Dec 21 15:13:09 [39152] DEBUG: AVlog(): Junk in packet Tue Dec 21 15:13:17 [39152] DEBUG: cDecoder::GetNextPacket(): DTS continuity error at frame (39144), difference 960ms should be 20ms, decoding errors 4 Tue Dec 21 15:13:17 [39152] DEBUG: AVlog(): Junk in packet Tue Dec 21 15:13:18 [39152] DEBUG: ======================================================================================================================= Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::CheckStart(): checking start at frame (42007) check start planed at (42000) Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::CheckStart(): assumed start frame 18000 Tue Dec 21 15:13:18 [39152] DEBUG: ************************************************************* Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Tue Dec 21 15:13:18 [39152] DEBUG: mark at position 1 type 0xD1 at 0:00:00.00 inBroadCast 1 Tue Dec 21 15:13:18 [39152] DEBUG: mark at position 978 type 0x31 at 0:00:19.55 inBroadCast 1 Tue Dec 21 15:13:18 [39152] DEBUG: mark at position 1142 type 0x22 at 0:00:22.97 inBroadCast 1 Tue Dec 21 15:13:18 [39152] DEBUG: mark at position 1168 type 0x21 at 0:00:23.36 inBroadCast 1 Tue Dec 21 15:13:18 [39152] DEBUG: mark at position 3146 type 0x22 at 0:01:03.06 inBroadCast 1 Tue Dec 21 15:13:18 [39152] DEBUG: mark at position 3178 type 0x21 at 0:01:03.70 inBroadCast 1 Tue Dec 21 15:13:18 [39152] DEBUG: mark at position 4281 type 0x22 at 0:01:25.63 inBroadCast 1 Tue Dec 21 15:13:18 [39152] DEBUG: mark at position 4313 type 0x21 at 0:01:26.41 inBroadCast 1 Tue Dec 21 15:13:18 [39152] DEBUG: mark at position 4998 type 0x32 at 0:01:40.12 inBroadCast 0 Tue Dec 21 15:13:18 [39152] DEBUG: mark at position 5196 type 0x31 at 0:01:44.08 inBroadCast 1 Tue Dec 21 15:13:18 [39152] DEBUG: ************************************************************* Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::CheckStart(): found MT_RECORDINGSTART (1), use this as start mark for the incomplete recording Tue Dec 21 15:13:18 [39152] INFO: AC3 audio with 2 channels on stream 3 Tue Dec 21 15:13:18 [39152] INFO: Video with aspect ratio of 16:9 detected Tue Dec 21 15:13:18 [39152] INFO: using recording start mark on position (1) at 0:00:00.00 as first start mark Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::CheckStart(): delete all black screen marks except start mark Tue Dec 21 15:13:18 [39152] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::CheckStartMark(): check for short start/stop pairs at start Tue Dec 21 15:13:18 [39152] DEBUG: ************************************************************* Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Tue Dec 21 15:13:18 [39152] DEBUG: mark at position 1 type 0xD1 at 0:00:00.00 inBroadCast 1 Tue Dec 21 15:13:18 [39152] DEBUG: ************************************************************* Tue Dec 21 15:13:18 [39152] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::CalculateCheckPositions(): startframe 1 (0min 0s) Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::CalculateCheckPositions(): use frame rate 50 Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::CalculateCheckPositions(): length of recording: 222s ( 3min 42s) Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::CalculateCheckPositions(): assumed start frame: 1 ( 0min 0s) Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::CalculateCheckPositions(): assumed stop frame: 11101 ( 3min 42s) Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::CalculateCheckPositions(): chkSTART set to: 24001 ( 8min 0s) Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::CalculateCheckPositions(): chkSTOP set to: 41101 ( 13min 42s) Tue Dec 21 15:13:18 [39152] DEBUG: ************************************************************* Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Tue Dec 21 15:13:18 [39152] DEBUG: mark at position 1 type 0xD1 at 0:00:00.00 inBroadCast 1 Tue Dec 21 15:13:18 [39152] DEBUG: ************************************************************* Tue Dec 21 15:13:18 [39152] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::ProcessFrame(): enter end part at frame (42039) Tue Dec 21 15:13:18 [39152] DEBUG: ======================================================================================================================= Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::CheckStop(): start check stop (42039) Tue Dec 21 15:13:18 [39152] DEBUG: assumed stop position (11101) at 0:03:42.33 Tue Dec 21 15:13:18 [39152] DEBUG: ************************************************************* Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Tue Dec 21 15:13:18 [39152] DEBUG: mark at position 1 type 0xD1 at 0:00:00.00 inBroadCast 1 Tue Dec 21 15:13:18 [39152] DEBUG: ************************************************************* Tue Dec 21 15:13:18 [39152] DEBUG: ======================================================================================================================= Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::RemoveLogoChangeMarks(): start detect and remove logo stop/start mark pairs with special logo Tue Dec 21 15:13:18 [39152] DEBUG: cEvaluateLogoStopStartPair::cEvaluateLogoStopStartPair(): start with iStart 0, chkSTART 24001, iStopA 11101 Tue Dec 21 15:13:18 [39152] DEBUG: cDecoder::cDecoder(): create new decoder instance Tue Dec 21 15:13:18 [39152] DEBUG: cDecoder::cDecoder(): init with 4 threads Tue Dec 21 15:13:18 [39152] DEBUG: cDecoder::DecodeFile(): filename: /media/hd/plexmedia/markad_work/heute/Tagesschau/2021-12-18.20.00.1-0.rec/00001.ts Tue Dec 21 15:13:18 [39152] DEBUG: cDecoder::DecodeFile(): opened file /media/hd/plexmedia/markad_work/heute/Tagesschau/2021-12-18.20.00.1-0.rec/00001.ts Tue Dec 21 15:13:18 [39152] DEBUG: cDecoder::DecodeFile(): using decoder for stream 0: codec id 27 -> H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 Tue Dec 21 15:13:18 [39152] DEBUG: cDecoder::DecodeFile(): average framerate 50/1 Tue Dec 21 15:13:18 [39152] DEBUG: cDecoder::DecodeFile(): real framerate 50/1 Tue Dec 21 15:13:18 [39152] DEBUG: cDecoder::DecodeFile(): using decoder for stream 1: codec id 86016 -> MP2 (MPEG audio layer 2) Tue Dec 21 15:13:18 [39152] DEBUG: cDecoder::DecodeFile(): using decoder for stream 2: codec id 86016 -> MP2 (MPEG audio layer 2) Tue Dec 21 15:13:18 [39152] DEBUG: cDecoder::DecodeFile(): using decoder for stream 3: codec id 86019 -> ATSC A/52A (AC-3) Tue Dec 21 15:13:18 [39152] DEBUG: cDecoder::DecodeFile(): using decoder for stream 4: codec id 94209 -> DVB subtitles Tue Dec 21 15:13:18 [39152] DEBUG: cDecoder::~cDecoder(): decoder instance deleted Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::RemoveLogoChangeMarks(): marks after detect and remove logo stop/start mark pairs with special logo Tue Dec 21 15:13:18 [39152] DEBUG: ************************************************************* Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Tue Dec 21 15:13:18 [39152] DEBUG: mark at position 1 type 0xD1 at 0:00:00.00 inBroadCast 1 Tue Dec 21 15:13:18 [39152] DEBUG: ************************************************************* Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::RemoveLogoChangeMarks(): end detect and remove logo stop/start mark pairs with special logo Tue Dec 21 15:13:18 [39152] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Tue Dec 21 15:13:18 [39152] DEBUG: ======================================================================================================================= Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::CheckStop(): start end end mark selection Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::CheckStop(): no MT_CHANNELSTOP mark found Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::CheckStop(): no MT_ASPECTSTOP mark found Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::CheckStop(): no MT_HBORDERSTOP mark found Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::CheckStop(): no MT_VBORDERSTOP mark found Tue Dec 21 15:13:18 [39152] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::CheckStop(): check logo end mark (cleanup very short logo start/stop pairs around possible logo end marks) Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::CheckStop(): no more logo stop mark found Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::CheckStop(): no MT_LOGOSTOP mark found Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::CheckStop(): no end mark found Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::CheckStop(): no stop mark found, add stop mark at the last frame (42039) Tue Dec 21 15:13:18 [39152] INFO: assuming stop ( 42039) at 0:14:01.91 Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::AddMark(): inBroadCast now: 0 Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::CheckStop(): delete all marks after final stop mark at (42039) Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::CheckStop(): move all black screen marks except start and end mark to black screen list Tue Dec 21 15:13:18 [39152] DEBUG: ************************************************************* Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Tue Dec 21 15:13:18 [39152] DEBUG: mark at position 1 type 0xD1 at 0:00:00.00 inBroadCast 1 Tue Dec 21 15:13:18 [39152] DEBUG: mark at position 42039 type 0x12 at 0:14:01.91 inBroadCast 0 Tue Dec 21 15:13:18 [39152] DEBUG: ************************************************************* Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::CheckStop(): end check stop Tue Dec 21 15:13:18 [39152] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Tue Dec 21 15:13:18 [39152] DEBUG: cDecoder::DecodeFile(): filename: /media/hd/plexmedia/markad_work/heute/Tagesschau/2021-12-18.20.00.1-0.rec/00002.ts Tue Dec 21 15:13:18 [39152] DEBUG: ======================================================================================================================= Tue Dec 21 15:13:18 [39152] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::CheckMarks(): remove invalid marks Tue Dec 21 15:13:18 [39152] DEBUG: ************************************************************* Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Tue Dec 21 15:13:18 [39152] DEBUG: mark at position 1 type 0xD1 at 0:00:00.00 inBroadCast 1 Tue Dec 21 15:13:18 [39152] DEBUG: mark at position 42039 type 0x12 at 0:14:01.91 inBroadCast 0 Tue Dec 21 15:13:18 [39152] DEBUG: ************************************************************* Tue Dec 21 15:13:18 [39152] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::CheckMarks(): delete logo marks if we have channel or border marks Tue Dec 21 15:13:18 [39152] DEBUG: ************************************************************* Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Tue Dec 21 15:13:18 [39152] DEBUG: mark at position 1 type 0xD1 at 0:00:00.00 inBroadCast 1 Tue Dec 21 15:13:18 [39152] DEBUG: mark at position 42039 type 0x12 at 0:14:01.91 inBroadCast 0 Tue Dec 21 15:13:18 [39152] DEBUG: ************************************************************* Tue Dec 21 15:13:18 [39152] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::CheckMarks(): delete invalid black sceen marks Tue Dec 21 15:13:18 [39152] DEBUG: ************************************************************* Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Tue Dec 21 15:13:18 [39152] DEBUG: mark at position 1 type 0xD1 at 0:00:00.00 inBroadCast 1 Tue Dec 21 15:13:18 [39152] DEBUG: mark at position 42039 type 0x12 at 0:14:01.91 inBroadCast 0 Tue Dec 21 15:13:18 [39152] DEBUG: ************************************************************* Tue Dec 21 15:13:18 [39152] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::CheckMarks(): delete very short logo stop/start pairs Tue Dec 21 15:13:18 [39152] DEBUG: ************************************************************* Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Tue Dec 21 15:13:18 [39152] DEBUG: mark at position 1 type 0xD1 at 0:00:00.00 inBroadCast 1 Tue Dec 21 15:13:18 [39152] DEBUG: mark at position 42039 type 0x12 at 0:14:01.91 inBroadCast 0 Tue Dec 21 15:13:18 [39152] DEBUG: ************************************************************* Tue Dec 21 15:13:18 [39152] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::CheckMarks(): detect previews in advertisement Tue Dec 21 15:13:18 [39152] DEBUG: ************************************************************* Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Tue Dec 21 15:13:18 [39152] DEBUG: mark at position 1 type 0xD1 at 0:00:00.00 inBroadCast 1 Tue Dec 21 15:13:18 [39152] DEBUG: mark at position 42039 type 0x12 at 0:14:01.91 inBroadCast 0 Tue Dec 21 15:13:18 [39152] DEBUG: ************************************************************* Tue Dec 21 15:13:18 [39152] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::CheckMarks(): check border marks Tue Dec 21 15:13:18 [39152] DEBUG: ************************************************************* Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Tue Dec 21 15:13:18 [39152] DEBUG: mark at position 1 type 0xD1 at 0:00:00.00 inBroadCast 1 Tue Dec 21 15:13:18 [39152] DEBUG: mark at position 42039 type 0x12 at 0:14:01.91 inBroadCast 0 Tue Dec 21 15:13:18 [39152] DEBUG: ************************************************************* Tue Dec 21 15:13:18 [39152] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::CheckStartMark(): check for short start/stop pairs at start Tue Dec 21 15:13:18 [39152] DEBUG: ************************************************************* Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Tue Dec 21 15:13:18 [39152] DEBUG: mark at position 1 type 0xD1 at 0:00:00.00 inBroadCast 1 Tue Dec 21 15:13:18 [39152] DEBUG: mark at position 42039 type 0x12 at 0:14:01.91 inBroadCast 0 Tue Dec 21 15:13:18 [39152] DEBUG: ************************************************************* Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::CheckStartMark(): first broadcast length 840s from (1) to (42039) (expect <=8s) Tue Dec 21 15:13:18 [39152] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::CheckMarks(): check for near better end mark in case of recording length is too big Tue Dec 21 15:13:18 [39152] DEBUG: ************************************************************* Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Tue Dec 21 15:13:18 [39152] DEBUG: mark at position 1 type 0xD1 at 0:00:00.00 inBroadCast 1 Tue Dec 21 15:13:18 [39152] DEBUG: mark at position 42039 type 0x12 at 0:14:01.91 inBroadCast 0 Tue Dec 21 15:13:18 [39152] DEBUG: ************************************************************* Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::CheckMarks(): last broadcast length 840s from (1) to (42039) Tue Dec 21 15:13:18 [39152] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::CheckMarks(): remove logo and hborder detection failure marks Tue Dec 21 15:13:18 [39152] DEBUG: ************************************************************* Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Tue Dec 21 15:13:18 [39152] DEBUG: mark at position 1 type 0xD1 at 0:00:00.00 inBroadCast 1 Tue Dec 21 15:13:18 [39152] DEBUG: mark at position 42039 type 0x12 at 0:14:01.91 inBroadCast 0 Tue Dec 21 15:13:18 [39152] DEBUG: ************************************************************* Tue Dec 21 15:13:18 [39152] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Tue Dec 21 15:13:18 [39152] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::CheckMarks(): apply VPS events Tue Dec 21 15:13:18 [39152] DEBUG: ************************************************************* Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Tue Dec 21 15:13:18 [39152] DEBUG: mark at position 1 type 0xD1 at 0:00:00.00 inBroadCast 1 Tue Dec 21 15:13:18 [39152] DEBUG: mark at position 42039 type 0x12 at 0:14:01.91 inBroadCast 0 Tue Dec 21 15:13:18 [39152] DEBUG: ************************************************************* Tue Dec 21 15:13:18 [39152] DEBUG: cMarks::LoadVPS(): /media/hd/plexmedia/markad_work/heute/Tagesschau/2021-12-18.20.00.1-0.rec/markad.vps not found Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::CheckMarks(): no VPS start event found Tue Dec 21 15:13:18 [39152] DEBUG: cMarks::LoadVPS(): /media/hd/plexmedia/markad_work/heute/Tagesschau/2021-12-18.20.00.1-0.rec/markad.vps not found Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::CheckMarks(): no VPS pause start event found Tue Dec 21 15:13:18 [39152] DEBUG: cMarks::LoadVPS(): /media/hd/plexmedia/markad_work/heute/Tagesschau/2021-12-18.20.00.1-0.rec/markad.vps not found Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::CheckMarks(): no VPS pause stop event found Tue Dec 21 15:13:18 [39152] DEBUG: cMarks::LoadVPS(): /media/hd/plexmedia/markad_work/heute/Tagesschau/2021-12-18.20.00.1-0.rec/markad.vps not found Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::CheckMarks(): no VPS stop event found Tue Dec 21 15:13:18 [39152] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::CheckMarks(): final marks: Tue Dec 21 15:13:18 [39152] DEBUG: ************************************************************* Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Tue Dec 21 15:13:18 [39152] DEBUG: mark at position 1 type 0xD1 at 0:00:00.00 inBroadCast 1 Tue Dec 21 15:13:18 [39152] DEBUG: mark at position 42039 type 0x12 at 0:14:01.91 inBroadCast 0 Tue Dec 21 15:13:18 [39152] DEBUG: ************************************************************* Tue Dec 21 15:13:18 [39152] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::ProcessFiles(): end processing files Tue Dec 21 15:13:18 [39152] DEBUG: ======================================================================================================================= Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::LogoMarkOptimization(): start logo mark optimization Tue Dec 21 15:13:18 [39152] DEBUG: ======================================================================================================================= Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::LogoMarkOptimization(): check for advertising in frame with logo after logo start and before logo stop mark and check for introduction logo Tue Dec 21 15:13:18 [39152] DEBUG: cDecoder::DecodeFile(): filename: /media/hd/plexmedia/markad_work/heute/Tagesschau/2021-12-18.20.00.1-0.rec/00001.ts Tue Dec 21 15:13:18 [39152] DEBUG: cDecoder::DecodeFile(): opened file /media/hd/plexmedia/markad_work/heute/Tagesschau/2021-12-18.20.00.1-0.rec/00001.ts Tue Dec 21 15:13:18 [39152] DEBUG: cDecoder::DecodeFile(): using decoder for stream 0: codec id 27 -> H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 Tue Dec 21 15:13:18 [39152] DEBUG: cDecoder::DecodeFile(): average framerate 50/1 Tue Dec 21 15:13:18 [39152] DEBUG: cDecoder::DecodeFile(): real framerate 50/1 Tue Dec 21 15:13:18 [39152] DEBUG: cDecoder::DecodeFile(): using decoder for stream 1: codec id 86016 -> MP2 (MPEG audio layer 2) Tue Dec 21 15:13:18 [39152] DEBUG: cDecoder::DecodeFile(): using decoder for stream 2: codec id 86016 -> MP2 (MPEG audio layer 2) Tue Dec 21 15:13:18 [39152] DEBUG: cDecoder::DecodeFile(): using decoder for stream 3: codec id 86019 -> ATSC A/52A (AC-3) Tue Dec 21 15:13:18 [39152] DEBUG: cDecoder::DecodeFile(): using decoder for stream 4: codec id 94209 -> DVB subtitles Tue Dec 21 15:13:18 [39152] DEBUG: ======================================================================================================================= Tue Dec 21 15:13:18 [39152] DEBUG: cMarkAdStandalone::LogoMarkOptimization(): search for audio silence around logo marks Tue Dec 21 15:13:18 [39152] DEBUG: cDecoder::DecodeFile(): filename: /media/hd/plexmedia/markad_work/heute/Tagesschau/2021-12-18.20.00.1-0.rec/00001.ts Tue Dec 21 15:13:18 [39152] DEBUG: cDecoder::DecodeFile(): opened file /media/hd/plexmedia/markad_work/heute/Tagesschau/2021-12-18.20.00.1-0.rec/00001.ts Tue Dec 21 15:13:19 [39152] DEBUG: cDecoder::DecodeFile(): using decoder for stream 0: codec id 27 -> H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 Tue Dec 21 15:13:19 [39152] DEBUG: cDecoder::DecodeFile(): average framerate 50/1 Tue Dec 21 15:13:19 [39152] DEBUG: cDecoder::DecodeFile(): real framerate 50/1 Tue Dec 21 15:13:19 [39152] DEBUG: cDecoder::DecodeFile(): using decoder for stream 1: codec id 86016 -> MP2 (MPEG audio layer 2) Tue Dec 21 15:13:19 [39152] DEBUG: cDecoder::DecodeFile(): using decoder for stream 2: codec id 86016 -> MP2 (MPEG audio layer 2) Tue Dec 21 15:13:19 [39152] DEBUG: cDecoder::DecodeFile(): using decoder for stream 3: codec id 86019 -> ATSC A/52A (AC-3) Tue Dec 21 15:13:19 [39152] DEBUG: cDecoder::DecodeFile(): using decoder for stream 4: codec id 94209 -> DVB subtitles Tue Dec 21 15:13:19 [39152] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Tue Dec 21 15:13:19 [39152] DEBUG: cMarkAdStandalone::LogoMarkOptimization(): start search for black screen near logo marks Tue Dec 21 15:13:19 [39152] DEBUG: ======================================================================================================================= Tue Dec 21 15:13:19 [39152] DEBUG: ProcessOverlap(): start overlap detection Tue Dec 21 15:13:19 [39152] DEBUG: ************************************************************* Tue Dec 21 15:13:19 [39152] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Tue Dec 21 15:13:19 [39152] DEBUG: mark at position 1 type 0xD1 at 0:00:00.00 inBroadCast 1 Tue Dec 21 15:13:19 [39152] DEBUG: mark at position 42039 type 0x12 at 0:14:01.91 inBroadCast 0 Tue Dec 21 15:13:19 [39152] DEBUG: ************************************************************* Tue Dec 21 15:13:19 [39152] DEBUG: cDecoder::DecodeFile(): filename: /media/hd/plexmedia/markad_work/heute/Tagesschau/2021-12-18.20.00.1-0.rec/00001.ts Tue Dec 21 15:13:19 [39152] DEBUG: cDecoder::DecodeFile(): opened file /media/hd/plexmedia/markad_work/heute/Tagesschau/2021-12-18.20.00.1-0.rec/00001.ts Tue Dec 21 15:13:19 [39152] DEBUG: cDecoder::DecodeFile(): using decoder for stream 0: codec id 27 -> H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 Tue Dec 21 15:13:19 [39152] DEBUG: cDecoder::DecodeFile(): average framerate 50/1 Tue Dec 21 15:13:19 [39152] DEBUG: cDecoder::DecodeFile(): real framerate 50/1 Tue Dec 21 15:13:19 [39152] DEBUG: cDecoder::DecodeFile(): using decoder for stream 1: codec id 86016 -> MP2 (MPEG audio layer 2) Tue Dec 21 15:13:19 [39152] DEBUG: cDecoder::DecodeFile(): using decoder for stream 2: codec id 86016 -> MP2 (MPEG audio layer 2) Tue Dec 21 15:13:19 [39152] DEBUG: cDecoder::DecodeFile(): using decoder for stream 3: codec id 86019 -> ATSC A/52A (AC-3) Tue Dec 21 15:13:19 [39152] DEBUG: cDecoder::DecodeFile(): using decoder for stream 4: codec id 94209 -> DVB subtitles Tue Dec 21 15:13:19 [39152] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Tue Dec 21 15:13:19 [39152] DEBUG: cMarkAdStandalone::LogoMarkOptimization(): check last logo stop mark if closing credits follows Tue Dec 21 15:13:19 [39152] DEBUG: end Overlap Tue Dec 21 15:13:19 [39152] DEBUG: cMarks::Save(): save marks, isRunningRecording=0 force=1 Tue Dec 21 15:13:19 [39152] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Tue Dec 21 15:13:19 [39152] DEBUG: time for decoding: 19s 565ms Tue Dec 21 15:13:19 [39152] DEBUG: time to find logo changes: 0s 79ms Tue Dec 21 15:13:19 [39152] DEBUG: pass 1: time 21s 644ms, frames 42038, fps 2001 Tue Dec 21 15:13:19 [39152] INFO: processed time 0:21 min with 1922 fps Tue Dec 21 15:13:19 [39152] ERROR: decoding errors: 4 Tue Dec 21 15:13:19 [39152] DEBUG: cDecoder::~cDecoder(): decoder instance deleted