Wed Feb 3 20:10:03 [7173] INFO: starting v2.6.0 (64bit) Wed Feb 3 20:10:03 [7173] INFO: using libavcodec.so.58.54.100 with -1 threads Wed Feb 3 20:10:03 [7173] INFO: on /srv/vdr/video/Serien/Private_Eyes/04x01_-_041._Eine_neue_Tochter/2021-02-03.20.10.57-0.rec Wed Feb 3 20:10:13 [7173] INFO: broadcast aspectratio 16:9 (from info) Wed Feb 3 20:10:13 [7173] DEBUG: cMarkAdStandalone::GetBroadcastStart(): mount option noatime is not set Wed Feb 3 20:10:13 [7173] DEBUG: cMarkAdStandalone::GetBroadcastStart(): getting recording start from VDR info file modification time Wed Feb 3 20:10:01 2021 Wed Feb 3 20:10:13 [7173] DEBUG: cMarkAdStandalone::LoadInfo(): recording start at Wed Feb 3 20:10:01 2021 Wed Feb 3 20:10:13 [7173] DEBUG: cMarkAdStandalone::LoadInfo(): timer start at Wed Feb 3 20:15:00 2021 Wed Feb 3 20:10:13 [7173] DEBUG: cMarkAdStandalone::LoadInfo(): broadcast start 299s after recording start Wed Feb 3 20:10:13 [7173] DEBUG: cMarkAdStandalone::CheckLogo(): using logo directory /tmp Wed Feb 3 20:10:13 [7173] DEBUG: cMarkAdStandalone::CheckLogo(): searching logo for 13th_Street_HD Wed Feb 3 20:10:13 [7173] INFO: no logo found in logo directory, trying to find logo in recording directory Wed Feb 3 20:10:13 [7173] INFO: no logo found in recording directory, trying to extract logo from recording Wed Feb 3 20:10:13 [7173] DEBUG: ---------------------------------------------------------------------------- Wed Feb 3 20:10:13 [7173] DEBUG: cExtractLogo::SearchLogo(): start extract logo from frame 7475 with aspect ratio 16:9 Wed Feb 3 20:10:13 [7173] DEBUG: cDecoder::cDecoder(): init with 1 threads Wed Feb 3 20:10:13 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (211) read frames (-1) minFrame (0) Wed Feb 3 20:10:13 [7173] DEBUG: cExtractLogo::DeleteFrames(): delete frames from 0 to 7475 Wed Feb 3 20:10:13 [7173] DEBUG: cExtractLogo::SearchLogo(): we have no frames already stored Wed Feb 3 20:10:13 [7173] DEBUG: cDecoder::DecodeFile(): start decode file /srv/vdr/video/Serien/Private_Eyes/04x01_-_041._Eine_neue_Tochter/2021-02-03.20.10.57-0.rec/00001.ts Wed Feb 3 20:10:13 [7173] DEBUG: cDecoder::DecodeFile(): using decoder for stream 0: codec id 27 -> H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 Wed Feb 3 20:10:13 [7173] DEBUG: cDecoder::DecodeFile(): using decoder for stream 1: codec id 86019 -> ATSC A/52A (AC-3) Wed Feb 3 20:10:13 [7173] DEBUG: cDecoder::DecodeFile(): using decoder for stream 2: codec id 86019 -> ATSC A/52A (AC-3) Wed Feb 3 20:10:13 [7173] DEBUG: cDecoder::GetVideoType(): video coding format: H.264 Wed Feb 3 20:10:13 [7173] DEBUG: cExtractLogo::SearchLogo(): video resolution 1920x1080 Wed Feb 3 20:10:13 [7173] DEBUG: cExtractLogo::SearchLogo(): logo size 340x190 Wed Feb 3 20:10:13 [7173] DEBUG: cDecoder::GetFrameInfo(): audio channels of stream 2 changed from 0 to 2 at frame (-1) Wed Feb 3 20:10:13 [7173] DEBUG: cDecoder::GetFrameInfo(): audio channels of stream 1 changed from 0 to 5 at frame (2) Wed Feb 3 20:10:13 [7173] DEBUG: cDecoder::GetFrameInfo(): interlaced video format Wed Feb 3 20:10:13 [7173] DEBUG: cDecoder::GetFrameInfo(): aspect ratio changed from (0:0) to (16:9) at frame 5 Wed Feb 3 20:10:13 [7173] DEBUG: cExtractLogo::SearchLogo(): seek to frame 7475 Wed Feb 3 20:10:13 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (219) read frames (5) minFrame (7475) Wed Feb 3 20:10:13 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 1752 bytes, system time 03-02-2021 20:10:13 index time 03-02-2021 20:10:13, wait 60s Wed Feb 3 20:11:13 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (1720) read frames (5) minFrame (7475) Wed Feb 3 20:11:13 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 13760 bytes, system time 03-02-2021 20:11:13 index time 03-02-2021 20:11:13, wait 60s Wed Feb 3 20:12:13 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (3205) read frames (5) minFrame (7475) Wed Feb 3 20:12:13 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 25640 bytes, system time 03-02-2021 20:12:13 index time 03-02-2021 20:12:13, wait 60s Wed Feb 3 20:13:13 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (4712) read frames (5) minFrame (7475) Wed Feb 3 20:13:13 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 37696 bytes, system time 03-02-2021 20:13:13 index time 03-02-2021 20:13:13, wait 60s Wed Feb 3 20:14:13 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (6215) read frames (5) minFrame (7475) Wed Feb 3 20:14:13 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 49720 bytes, system time 03-02-2021 20:14:13 index time 03-02-2021 20:14:13, wait 60s Wed Feb 3 20:15:13 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (7706) read frames (5) minFrame (7475) Wed Feb 3 20:15:13 [7173] DEBUG: cDecoder::SeekToFrame(): (7475) Wed Feb 3 20:15:13 [7173] DEBUG: cIndex::GetIFrameBefore(): failed for frame (7475), index: first frame (0) last frame (0) Wed Feb 3 20:15:13 [7173] DEBUG: cDecoder::SeekFrame(): index does not yet contain frame ( 7475), decode from current frame (5) to build index Wed Feb 3 20:15:20 [7173] DEBUG: cDecoder::SeekToFrame(): successful Wed Feb 3 20:15:20 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (7894) read frames (7506) minFrame (0) Wed Feb 3 20:15:20 [7173] DEBUG: AVlog(): illegal short term buffer state detected Wed Feb 3 20:15:20 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (7894) read frames (7694) minFrame (0) Wed Feb 3 20:15:20 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 63152 bytes, system time 03-02-2021 20:15:20 index time 03-02-2021 20:15:20, wait 60s Wed Feb 3 20:16:20 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (9397) read frames (7694) minFrame (0) Wed Feb 3 20:16:22 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (9437) read frames (9197) minFrame (0) Wed Feb 3 20:16:22 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (9438) read frames (9237) minFrame (0) Wed Feb 3 20:16:22 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (9438) read frames (9238) minFrame (0) Wed Feb 3 20:16:22 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 75504 bytes, system time 03-02-2021 20:16:22 index time 03-02-2021 20:16:22, wait 60s Wed Feb 3 20:17:22 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (10938) read frames (9238) minFrame (0) Wed Feb 3 20:17:24 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (10982) read frames (10738) minFrame (0) Wed Feb 3 20:17:24 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (10989) read frames (10782) minFrame (0) Wed Feb 3 20:17:24 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (10989) read frames (10789) minFrame (0) Wed Feb 3 20:17:24 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 87912 bytes, system time 03-02-2021 20:17:24 index time 03-02-2021 20:17:24, wait 60s Wed Feb 3 20:18:24 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (12492) read frames (10789) minFrame (0) Wed Feb 3 20:18:26 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (12535) read frames (12292) minFrame (0) Wed Feb 3 20:18:26 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (12542) read frames (12335) minFrame (0) Wed Feb 3 20:18:26 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (12542) read frames (12342) minFrame (0) Wed Feb 3 20:18:26 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 100336 bytes, system time 03-02-2021 20:18:26 index time 03-02-2021 20:18:26, wait 60s Wed Feb 3 20:19:26 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (14043) read frames (12342) minFrame (0) Wed Feb 3 20:19:28 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (14086) read frames (13843) minFrame (0) Wed Feb 3 20:19:28 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (14086) read frames (13886) minFrame (0) Wed Feb 3 20:19:28 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 112688 bytes, system time 03-02-2021 20:19:28 index time 03-02-2021 20:19:28, wait 60s Wed Feb 3 20:20:28 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (15584) read frames (13886) minFrame (0) Wed Feb 3 20:20:30 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (15628) read frames (15384) minFrame (0) Wed Feb 3 20:20:30 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (15633) read frames (15428) minFrame (0) Wed Feb 3 20:20:30 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (15633) read frames (15433) minFrame (0) Wed Feb 3 20:20:30 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 125064 bytes, system time 03-02-2021 20:20:30 index time 03-02-2021 20:20:30, wait 60s Wed Feb 3 20:21:30 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (17137) read frames (15433) minFrame (0) Wed Feb 3 20:21:32 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (17176) read frames (16937) minFrame (0) Wed Feb 3 20:21:32 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (17176) read frames (16976) minFrame (0) Wed Feb 3 20:21:32 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 137408 bytes, system time 03-02-2021 20:21:32 index time 03-02-2021 20:21:32, wait 60s Wed Feb 3 20:22:32 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (18680) read frames (16976) minFrame (0) Wed Feb 3 20:22:33 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (18712) read frames (18480) minFrame (0) Wed Feb 3 20:22:33 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (18712) read frames (18512) minFrame (0) Wed Feb 3 20:22:33 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 149696 bytes, system time 03-02-2021 20:22:33 index time 03-02-2021 20:22:33, wait 60s Wed Feb 3 20:23:33 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (20212) read frames (18512) minFrame (0) Wed Feb 3 20:23:35 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (20263) read frames (20012) minFrame (0) Wed Feb 3 20:23:35 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (20263) read frames (20063) minFrame (0) Wed Feb 3 20:23:35 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 162104 bytes, system time 03-02-2021 20:23:35 index time 03-02-2021 20:23:35, wait 60s Wed Feb 3 20:24:35 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (21761) read frames (20063) minFrame (0) Wed Feb 3 20:24:37 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (21804) read frames (21561) minFrame (0) Wed Feb 3 20:24:37 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (21804) read frames (21604) minFrame (0) Wed Feb 3 20:24:37 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 174432 bytes, system time 03-02-2021 20:24:37 index time 03-02-2021 20:24:37, wait 60s Wed Feb 3 20:25:37 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (23312) read frames (21604) minFrame (0) Wed Feb 3 20:25:39 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (23363) read frames (23112) minFrame (0) Wed Feb 3 20:25:39 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (23363) read frames (23163) minFrame (0) Wed Feb 3 20:25:39 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 186904 bytes, system time 03-02-2021 20:25:39 index time 03-02-2021 20:25:39, wait 60s Wed Feb 3 20:26:39 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (24859) read frames (23163) minFrame (0) Wed Feb 3 20:26:41 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (24909) read frames (24659) minFrame (0) Wed Feb 3 20:26:41 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (24909) read frames (24709) minFrame (0) Wed Feb 3 20:26:41 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 199272 bytes, system time 03-02-2021 20:26:41 index time 03-02-2021 20:26:41, wait 60s Wed Feb 3 20:27:41 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (26411) read frames (24709) minFrame (0) Wed Feb 3 20:27:43 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (26452) read frames (26211) minFrame (0) Wed Feb 3 20:27:43 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (26453) read frames (26252) minFrame (0) Wed Feb 3 20:27:43 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (26453) read frames (26253) minFrame (0) Wed Feb 3 20:27:43 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 211624 bytes, system time 03-02-2021 20:27:43 index time 03-02-2021 20:27:43, wait 60s Wed Feb 3 20:28:43 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (27953) read frames (26253) minFrame (0) Wed Feb 3 20:28:45 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (28004) read frames (27753) minFrame (0) Wed Feb 3 20:28:45 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (28004) read frames (27804) minFrame (0) Wed Feb 3 20:28:45 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 224032 bytes, system time 03-02-2021 20:28:45 index time 03-02-2021 20:28:45, wait 60s Wed Feb 3 20:29:45 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (29504) read frames (27804) minFrame (0) Wed Feb 3 20:29:45 [7173] DEBUG: cExtractLogo::SearchLogo(): 1001 valid frames of 1001 frames read, got enough iFrames at frame (28005), start analyze Wed Feb 3 20:29:45 [7173] DEBUG: cExtractLogo::SearchLogo(): best guess found at frame -1 with 0 similars out of 3 valid frames at TOP_LEFT Wed Feb 3 20:29:45 [7173] DEBUG: cExtractLogo::SearchLogo(): best guess found at frame -1 with 0 similars out of 17 valid frames at TOP_RIGHT Wed Feb 3 20:29:45 [7173] DEBUG: cExtractLogo::SearchLogo(): best guess found at frame 13840 with 2 similars out of 23 valid frames at BOTTOM_LEFT Wed Feb 3 20:29:45 [7173] DEBUG: cExtractLogo::SearchLogo(): best guess found at frame -1 with 0 similars out of 25 valid frames at BOTTOM_RIGHT Wed Feb 3 20:29:45 [7173] DEBUG: cExtractLogo::SearchLogo(): no valid logo found, best logo at frame 13840 with 2 similars at corner BOTTOM_LEFT Wed Feb 3 20:29:45 [7173] DEBUG: cExtractLogo::SearchLogo(): failed, last frame 28005 Wed Feb 3 20:29:45 [7173] DEBUG: ---------------------------------------------------------------------------- Wed Feb 3 20:29:45 [7173] INFO: no logo found in recording, retry in 2nd recording part Wed Feb 3 20:29:45 [7173] DEBUG: ---------------------------------------------------------------------------- Wed Feb 3 20:29:45 [7173] DEBUG: cExtractLogo::SearchLogo(): start extract logo from frame 14975 with aspect ratio 16:9 Wed Feb 3 20:29:45 [7173] DEBUG: cDecoder::cDecoder(): init with 1 threads Wed Feb 3 20:29:45 [7173] DEBUG: cExtractLogo::DeleteFrames(): delete frames from 0 to 14975 Wed Feb 3 20:29:45 [7173] DEBUG: cExtractLogo::SearchLogo(): already have 11 frames from (14987) to frame (27672) Wed Feb 3 20:29:45 [7173] DEBUG: cDecoder::DecodeFile(): start decode file /srv/vdr/video/Serien/Private_Eyes/04x01_-_041._Eine_neue_Tochter/2021-02-03.20.10.57-0.rec/00001.ts Wed Feb 3 20:29:45 [7173] DEBUG: cDecoder::DecodeFile(): using decoder for stream 0: codec id 27 -> H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 Wed Feb 3 20:29:45 [7173] DEBUG: cDecoder::DecodeFile(): using decoder for stream 1: codec id 86019 -> ATSC A/52A (AC-3) Wed Feb 3 20:29:45 [7173] DEBUG: cDecoder::DecodeFile(): using decoder for stream 2: codec id 86019 -> ATSC A/52A (AC-3) Wed Feb 3 20:29:45 [7173] DEBUG: cDecoder::GetVideoType(): video coding format: H.264 Wed Feb 3 20:29:45 [7173] DEBUG: cExtractLogo::SearchLogo(): video resolution 1920x1080 Wed Feb 3 20:29:45 [7173] DEBUG: cExtractLogo::SearchLogo(): logo size 340x190 Wed Feb 3 20:29:45 [7173] DEBUG: cDecoder::GetFrameInfo(): audio channels of stream 2 changed from 0 to 2 at frame (-1) Wed Feb 3 20:29:45 [7173] DEBUG: cDecoder::GetFrameInfo(): audio channels of stream 1 changed from 0 to 5 at frame (2) Wed Feb 3 20:29:45 [7173] DEBUG: cDecoder::GetFrameInfo(): interlaced video format Wed Feb 3 20:29:45 [7173] DEBUG: cDecoder::GetFrameInfo(): aspect ratio changed from (0:0) to (16:9) at frame 5 Wed Feb 3 20:29:45 [7173] DEBUG: cExtractLogo::SearchLogo(): seek to frame 27672 Wed Feb 3 20:29:45 [7173] DEBUG: cDecoder::SeekToFrame(): (27672) Wed Feb 3 20:29:51 [7173] DEBUG: cDecoder::SeekToFrame(): successful Wed Feb 3 20:29:53 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (29720) read frames (29304) minFrame (0) Wed Feb 3 20:29:54 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (29725) read frames (29520) minFrame (0) Wed Feb 3 20:29:54 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (29725) read frames (29525) minFrame (0) Wed Feb 3 20:29:54 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 237800 bytes, system time 03-02-2021 20:29:54 index time 03-02-2021 20:29:53, wait 60s Wed Feb 3 20:30:54 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (31223) read frames (29525) minFrame (0) Wed Feb 3 20:30:55 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (31263) read frames (31023) minFrame (0) Wed Feb 3 20:30:55 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (31263) read frames (31063) minFrame (0) Wed Feb 3 20:30:55 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 250104 bytes, system time 03-02-2021 20:30:55 index time 03-02-2021 20:30:55, wait 60s Wed Feb 3 20:31:55 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (32768) read frames (31063) minFrame (0) Wed Feb 3 20:31:57 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (32812) read frames (32568) minFrame (0) Wed Feb 3 20:31:57 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (32812) read frames (32612) minFrame (0) Wed Feb 3 20:31:57 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 262496 bytes, system time 03-02-2021 20:31:57 index time 03-02-2021 20:31:57, wait 60s Wed Feb 3 20:32:57 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (34310) read frames (32612) minFrame (0) Wed Feb 3 20:32:59 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (34354) read frames (34110) minFrame (0) Wed Feb 3 20:32:59 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (34354) read frames (34154) minFrame (0) Wed Feb 3 20:32:59 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 274832 bytes, system time 03-02-2021 20:32:59 index time 03-02-2021 20:32:59, wait 60s Wed Feb 3 20:33:59 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (35851) read frames (34154) minFrame (0) Wed Feb 3 20:34:00 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (35895) read frames (35651) minFrame (0) Wed Feb 3 20:34:00 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (35895) read frames (35695) minFrame (0) Wed Feb 3 20:34:00 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 287160 bytes, system time 03-02-2021 20:34:00 index time 03-02-2021 20:34:00, wait 60s Wed Feb 3 20:35:00 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (37397) read frames (35695) minFrame (0) Wed Feb 3 20:35:02 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (37441) read frames (37197) minFrame (0) Wed Feb 3 20:35:02 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (37441) read frames (37241) minFrame (0) Wed Feb 3 20:35:02 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 299528 bytes, system time 03-02-2021 20:35:02 index time 03-02-2021 20:35:02, wait 60s Wed Feb 3 20:36:02 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (38943) read frames (37241) minFrame (0) Wed Feb 3 20:36:04 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (38980) read frames (38743) minFrame (0) Wed Feb 3 20:36:04 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (38980) read frames (38780) minFrame (0) Wed Feb 3 20:36:04 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 311840 bytes, system time 03-02-2021 20:36:04 index time 03-02-2021 20:36:04, wait 60s Wed Feb 3 20:37:04 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (40481) read frames (38780) minFrame (0) Wed Feb 3 20:37:05 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (40521) read frames (40281) minFrame (0) Wed Feb 3 20:37:05 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (40522) read frames (40321) minFrame (0) Wed Feb 3 20:37:05 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (40522) read frames (40322) minFrame (0) Wed Feb 3 20:37:05 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 324176 bytes, system time 03-02-2021 20:37:05 index time 03-02-2021 20:37:05, wait 60s Wed Feb 3 20:38:05 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (42023) read frames (40322) minFrame (0) Wed Feb 3 20:38:07 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (42062) read frames (41823) minFrame (0) Wed Feb 3 20:38:07 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (42062) read frames (41862) minFrame (0) Wed Feb 3 20:38:07 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 336496 bytes, system time 03-02-2021 20:38:07 index time 03-02-2021 20:38:07, wait 60s Wed Feb 3 20:39:07 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (43562) read frames (41862) minFrame (0) Wed Feb 3 20:39:08 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (43601) read frames (43362) minFrame (0) Wed Feb 3 20:39:09 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (43601) read frames (43401) minFrame (0) Wed Feb 3 20:39:09 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 348808 bytes, system time 03-02-2021 20:39:09 index time 03-02-2021 20:39:08, wait 60s Wed Feb 3 20:40:09 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (45098) read frames (43401) minFrame (0) Wed Feb 3 20:40:10 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (45134) read frames (44898) minFrame (0) Wed Feb 3 20:40:10 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (45134) read frames (44934) minFrame (0) Wed Feb 3 20:40:10 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 361072 bytes, system time 03-02-2021 20:40:10 index time 03-02-2021 20:40:10, wait 60s Wed Feb 3 20:41:10 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (46637) read frames (44934) minFrame (0) Wed Feb 3 20:41:11 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (46666) read frames (46437) minFrame (0) Wed Feb 3 20:41:11 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (46666) read frames (46466) minFrame (0) Wed Feb 3 20:41:11 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 373328 bytes, system time 03-02-2021 20:41:11 index time 03-02-2021 20:41:11, wait 60s Wed Feb 3 20:42:11 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (48167) read frames (46466) minFrame (0) Wed Feb 3 20:42:13 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (48201) read frames (47967) minFrame (0) Wed Feb 3 20:42:13 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (48204) read frames (48001) minFrame (0) Wed Feb 3 20:42:13 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (48204) read frames (48004) minFrame (0) Wed Feb 3 20:42:13 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 385632 bytes, system time 03-02-2021 20:42:13 index time 03-02-2021 20:42:13, wait 60s Wed Feb 3 20:43:13 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (49707) read frames (48004) minFrame (0) Wed Feb 3 20:43:13 [7173] DEBUG: cExtractLogo::SearchLogo(): 1001 valid frames of 990 frames read, got enough iFrames at frame (48323), start analyze Wed Feb 3 20:43:13 [7173] DEBUG: cExtractLogo::SearchLogo(): best guess found at frame -1 with 0 similars out of 13 valid frames at TOP_LEFT Wed Feb 3 20:43:13 [7173] DEBUG: cExtractLogo::SearchLogo(): best guess found at frame -1 with 0 similars out of 18 valid frames at TOP_RIGHT Wed Feb 3 20:43:13 [7173] DEBUG: cExtractLogo::SearchLogo(): best guess found at frame -1 with 0 similars out of 18 valid frames at BOTTOM_LEFT Wed Feb 3 20:43:13 [7173] DEBUG: cExtractLogo::SearchLogo(): best guess found at frame -1 with 0 similars out of 30 valid frames at BOTTOM_RIGHT Wed Feb 3 20:43:13 [7173] DEBUG: cExtractLogo::SearchLogo(): no logo found Wed Feb 3 20:43:13 [7173] DEBUG: cExtractLogo::SearchLogo(): failed, last frame 48323 Wed Feb 3 20:43:13 [7173] DEBUG: ---------------------------------------------------------------------------- Wed Feb 3 20:43:13 [7173] INFO: no logo found in recording, retry in 3nd recording part Wed Feb 3 20:43:13 [7173] DEBUG: ---------------------------------------------------------------------------- Wed Feb 3 20:43:13 [7173] DEBUG: cExtractLogo::SearchLogo(): start extract logo from frame 22475 with aspect ratio 16:9 Wed Feb 3 20:43:13 [7173] DEBUG: cDecoder::cDecoder(): init with 1 threads Wed Feb 3 20:43:13 [7173] DEBUG: cExtractLogo::DeleteFrames(): delete frames from 0 to 22475 Wed Feb 3 20:43:13 [7173] DEBUG: cExtractLogo::SearchLogo(): already have 25 frames from (24401) to frame (47651) Wed Feb 3 20:43:13 [7173] DEBUG: cDecoder::DecodeFile(): start decode file /srv/vdr/video/Serien/Private_Eyes/04x01_-_041._Eine_neue_Tochter/2021-02-03.20.10.57-0.rec/00001.ts Wed Feb 3 20:43:13 [7173] DEBUG: cDecoder::DecodeFile(): using decoder for stream 0: codec id 27 -> H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 Wed Feb 3 20:43:13 [7173] DEBUG: cDecoder::DecodeFile(): using decoder for stream 1: codec id 86019 -> ATSC A/52A (AC-3) Wed Feb 3 20:43:13 [7173] DEBUG: cDecoder::DecodeFile(): using decoder for stream 2: codec id 86019 -> ATSC A/52A (AC-3) Wed Feb 3 20:43:13 [7173] DEBUG: cDecoder::GetVideoType(): video coding format: H.264 Wed Feb 3 20:43:13 [7173] DEBUG: cExtractLogo::SearchLogo(): video resolution 1920x1080 Wed Feb 3 20:43:13 [7173] DEBUG: cExtractLogo::SearchLogo(): logo size 340x190 Wed Feb 3 20:43:13 [7173] DEBUG: cDecoder::GetFrameInfo(): audio channels of stream 2 changed from 0 to 2 at frame (-1) Wed Feb 3 20:43:13 [7173] DEBUG: cDecoder::GetFrameInfo(): audio channels of stream 1 changed from 0 to 5 at frame (2) Wed Feb 3 20:43:13 [7173] DEBUG: cDecoder::GetFrameInfo(): interlaced video format Wed Feb 3 20:43:13 [7173] DEBUG: cDecoder::GetFrameInfo(): aspect ratio changed from (0:0) to (16:9) at frame 5 Wed Feb 3 20:43:13 [7173] DEBUG: cExtractLogo::SearchLogo(): seek to frame 47651 Wed Feb 3 20:43:13 [7173] DEBUG: cDecoder::SeekToFrame(): (47651) Wed Feb 3 20:43:18 [7173] DEBUG: cDecoder::SeekToFrame(): successful Wed Feb 3 20:43:20 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (49888) read frames (49507) minFrame (0) Wed Feb 3 20:43:20 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (49892) read frames (49688) minFrame (0) Wed Feb 3 20:43:20 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (49892) read frames (49692) minFrame (0) Wed Feb 3 20:43:20 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 399136 bytes, system time 03-02-2021 20:43:20 index time 03-02-2021 20:43:20, wait 60s Wed Feb 3 20:44:20 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (51390) read frames (49692) minFrame (0) Wed Feb 3 20:44:22 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (51434) read frames (51190) minFrame (0) Wed Feb 3 20:44:22 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (51438) read frames (51234) minFrame (0) Wed Feb 3 20:44:22 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (51438) read frames (51238) minFrame (0) Wed Feb 3 20:44:22 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 411504 bytes, system time 03-02-2021 20:44:22 index time 03-02-2021 20:44:22, wait 60s Wed Feb 3 20:45:22 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (52940) read frames (51238) minFrame (0) Wed Feb 3 20:45:24 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (52985) read frames (52740) minFrame (0) Wed Feb 3 20:45:24 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (52985) read frames (52785) minFrame (0) Wed Feb 3 20:45:24 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 423880 bytes, system time 03-02-2021 20:45:24 index time 03-02-2021 20:45:24, wait 60s Wed Feb 3 20:46:24 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (54486) read frames (52785) minFrame (0) Wed Feb 3 20:46:26 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (54530) read frames (54286) minFrame (0) Wed Feb 3 20:46:26 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (54530) read frames (54330) minFrame (0) Wed Feb 3 20:46:26 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 436240 bytes, system time 03-02-2021 20:46:26 index time 03-02-2021 20:46:26, wait 60s Wed Feb 3 20:47:26 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (56033) read frames (54330) minFrame (0) Wed Feb 3 20:47:27 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (56074) read frames (55833) minFrame (0) Wed Feb 3 20:47:28 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (56077) read frames (55874) minFrame (0) Wed Feb 3 20:47:28 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (56077) read frames (55877) minFrame (0) Wed Feb 3 20:47:28 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 448616 bytes, system time 03-02-2021 20:47:28 index time 03-02-2021 20:47:28, wait 60s Wed Feb 3 20:48:28 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (57574) read frames (55877) minFrame (0) Wed Feb 3 20:48:29 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (57614) read frames (57374) minFrame (0) Wed Feb 3 20:48:29 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (57614) read frames (57414) minFrame (0) Wed Feb 3 20:48:29 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 460912 bytes, system time 03-02-2021 20:48:29 index time 03-02-2021 20:48:29, wait 60s Wed Feb 3 20:49:29 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (59114) read frames (57414) minFrame (0) Wed Feb 3 20:49:31 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (59149) read frames (58914) minFrame (0) Wed Feb 3 20:49:31 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (59149) read frames (58949) minFrame (0) Wed Feb 3 20:49:31 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 473192 bytes, system time 03-02-2021 20:49:31 index time 03-02-2021 20:49:31, wait 60s Wed Feb 3 20:50:31 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (60655) read frames (58949) minFrame (0) Wed Feb 3 20:50:32 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (60693) read frames (60455) minFrame (0) Wed Feb 3 20:50:32 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (60693) read frames (60493) minFrame (0) Wed Feb 3 20:50:32 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 485544 bytes, system time 03-02-2021 20:50:32 index time 03-02-2021 20:50:32, wait 60s Wed Feb 3 20:51:32 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (62194) read frames (60493) minFrame (0) Wed Feb 3 20:51:34 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (62236) read frames (61994) minFrame (0) Wed Feb 3 20:51:34 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (62236) read frames (62036) minFrame (0) Wed Feb 3 20:51:34 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 497888 bytes, system time 03-02-2021 20:51:34 index time 03-02-2021 20:51:34, wait 60s Wed Feb 3 20:52:34 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (63740) read frames (62036) minFrame (0) Wed Feb 3 20:52:36 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (63780) read frames (63540) minFrame (0) Wed Feb 3 20:52:36 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (63780) read frames (63580) minFrame (0) Wed Feb 3 20:52:36 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 510240 bytes, system time 03-02-2021 20:52:36 index time 03-02-2021 20:52:36, wait 60s Wed Feb 3 20:53:36 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (65287) read frames (63580) minFrame (0) Wed Feb 3 20:53:37 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (65323) read frames (65087) minFrame (0) Wed Feb 3 20:53:37 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (65323) read frames (65123) minFrame (0) Wed Feb 3 20:53:37 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 522584 bytes, system time 03-02-2021 20:53:37 index time 03-02-2021 20:53:37, wait 60s Wed Feb 3 20:54:37 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (66821) read frames (65123) minFrame (0) Wed Feb 3 20:54:39 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (66858) read frames (66621) minFrame (0) Wed Feb 3 20:54:39 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (66858) read frames (66658) minFrame (0) Wed Feb 3 20:54:39 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 534864 bytes, system time 03-02-2021 20:54:39 index time 03-02-2021 20:54:39, wait 60s Wed Feb 3 20:55:39 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (68335) read frames (66658) minFrame (0) Wed Feb 3 20:55:40 [7173] DEBUG: cExtractLogo::SearchLogo(): 1001 valid frames of 976 frames read, got enough iFrames at frame (67906), start analyze Wed Feb 3 20:55:40 [7173] DEBUG: cExtractLogo::SearchLogo(): best guess found at frame -1 with 0 similars out of 15 valid frames at TOP_LEFT Wed Feb 3 20:55:40 [7173] DEBUG: cExtractLogo::SearchLogo(): best guess found at frame -1 with 0 similars out of 36 valid frames at TOP_RIGHT Wed Feb 3 20:55:40 [7173] DEBUG: cExtractLogo::SearchLogo(): best guess found at frame -1 with 0 similars out of 29 valid frames at BOTTOM_LEFT Wed Feb 3 20:55:40 [7173] DEBUG: cExtractLogo::SearchLogo(): best guess found at frame -1 with 0 similars out of 33 valid frames at BOTTOM_RIGHT Wed Feb 3 20:55:40 [7173] DEBUG: cExtractLogo::SearchLogo(): no logo found Wed Feb 3 20:55:40 [7173] DEBUG: cExtractLogo::SearchLogo(): failed, last frame 67906 Wed Feb 3 20:55:40 [7173] DEBUG: ---------------------------------------------------------------------------- Wed Feb 3 20:55:40 [7173] INFO: no logo found in recording, retry in 4nd recording part Wed Feb 3 20:55:40 [7173] DEBUG: ---------------------------------------------------------------------------- Wed Feb 3 20:55:40 [7173] DEBUG: cExtractLogo::SearchLogo(): start extract logo from frame 29975 with aspect ratio 16:9 Wed Feb 3 20:55:40 [7173] DEBUG: cDecoder::cDecoder(): init with 1 threads Wed Feb 3 20:55:40 [7173] DEBUG: cExtractLogo::DeleteFrames(): delete frames from 0 to 29975 Wed Feb 3 20:55:40 [7173] DEBUG: cExtractLogo::SearchLogo(): already have 35 frames from (30043) to frame (66347) Wed Feb 3 20:55:40 [7173] DEBUG: cDecoder::DecodeFile(): start decode file /srv/vdr/video/Serien/Private_Eyes/04x01_-_041._Eine_neue_Tochter/2021-02-03.20.10.57-0.rec/00001.ts Wed Feb 3 20:55:40 [7173] DEBUG: cDecoder::DecodeFile(): using decoder for stream 0: codec id 27 -> H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 Wed Feb 3 20:55:40 [7173] DEBUG: cDecoder::DecodeFile(): using decoder for stream 1: codec id 86019 -> ATSC A/52A (AC-3) Wed Feb 3 20:55:40 [7173] DEBUG: cDecoder::DecodeFile(): using decoder for stream 2: codec id 86019 -> ATSC A/52A (AC-3) Wed Feb 3 20:55:40 [7173] DEBUG: cDecoder::GetVideoType(): video coding format: H.264 Wed Feb 3 20:55:40 [7173] DEBUG: cExtractLogo::SearchLogo(): video resolution 1920x1080 Wed Feb 3 20:55:40 [7173] DEBUG: cExtractLogo::SearchLogo(): logo size 340x190 Wed Feb 3 20:55:40 [7173] DEBUG: cDecoder::GetFrameInfo(): audio channels of stream 2 changed from 0 to 2 at frame (-1) Wed Feb 3 20:55:40 [7173] DEBUG: cDecoder::GetFrameInfo(): audio channels of stream 1 changed from 0 to 5 at frame (2) Wed Feb 3 20:55:40 [7173] DEBUG: cDecoder::GetFrameInfo(): interlaced video format Wed Feb 3 20:55:40 [7173] DEBUG: cDecoder::GetFrameInfo(): aspect ratio changed from (0:0) to (16:9) at frame 5 Wed Feb 3 20:55:40 [7173] DEBUG: cExtractLogo::SearchLogo(): seek to frame 66347 Wed Feb 3 20:55:40 [7173] DEBUG: cDecoder::SeekToFrame(): (66347) Wed Feb 3 20:55:45 [7173] DEBUG: cDecoder::SeekToFrame(): successful Wed Feb 3 20:55:47 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (68545) read frames (68135) minFrame (0) Wed Feb 3 20:55:47 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (68548) read frames (68345) minFrame (0) Wed Feb 3 20:55:47 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (68548) read frames (68348) minFrame (0) Wed Feb 3 20:55:47 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 548384 bytes, system time 03-02-2021 20:55:47 index time 03-02-2021 20:55:47, wait 60s Wed Feb 3 20:56:47 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (70046) read frames (68348) minFrame (0) Wed Feb 3 20:56:49 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (70086) read frames (69846) minFrame (0) Wed Feb 3 20:56:49 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (70086) read frames (69886) minFrame (0) Wed Feb 3 20:56:49 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 560688 bytes, system time 03-02-2021 20:56:49 index time 03-02-2021 20:56:49, wait 60s Wed Feb 3 20:57:49 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (71581) read frames (69886) minFrame (0) Wed Feb 3 20:57:50 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (71609) read frames (71381) minFrame (0) Wed Feb 3 20:57:50 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (71609) read frames (71409) minFrame (0) Wed Feb 3 20:57:50 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 572872 bytes, system time 03-02-2021 20:57:50 index time 03-02-2021 20:57:50, wait 60s Wed Feb 3 20:58:50 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (73116) read frames (71409) minFrame (0) Wed Feb 3 20:58:52 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (73146) read frames (72916) minFrame (0) Wed Feb 3 20:58:52 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (73150) read frames (72946) minFrame (0) Wed Feb 3 20:58:52 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (73150) read frames (72950) minFrame (0) Wed Feb 3 20:58:52 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 585200 bytes, system time 03-02-2021 20:58:52 index time 03-02-2021 20:58:52, wait 60s Wed Feb 3 20:59:52 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (74659) read frames (72950) minFrame (0) Wed Feb 3 20:59:55 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (74735) read frames (74459) minFrame (0) Wed Feb 3 20:59:55 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (74735) read frames (74535) minFrame (0) Wed Feb 3 20:59:55 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 597880 bytes, system time 03-02-2021 20:59:55 index time 03-02-2021 20:59:55, wait 60s Wed Feb 3 21:00:55 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (76236) read frames (74535) minFrame (0) Wed Feb 3 21:00:57 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (76281) read frames (76036) minFrame (0) Wed Feb 3 21:00:57 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (76281) read frames (76081) minFrame (0) Wed Feb 3 21:00:57 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 610248 bytes, system time 03-02-2021 21:00:57 index time 03-02-2021 21:00:57, wait 60s Wed Feb 3 21:01:57 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (77787) read frames (76081) minFrame (0) Wed Feb 3 21:01:58 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (77824) read frames (77587) minFrame (0) Wed Feb 3 21:01:58 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (77828) read frames (77624) minFrame (0) Wed Feb 3 21:01:58 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (77828) read frames (77628) minFrame (0) Wed Feb 3 21:01:58 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 622624 bytes, system time 03-02-2021 21:01:58 index time 03-02-2021 21:01:58, wait 60s Wed Feb 3 21:02:58 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (79330) read frames (77628) minFrame (0) Wed Feb 3 21:03:00 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (79361) read frames (79130) minFrame (0) Wed Feb 3 21:03:00 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (79363) read frames (79161) minFrame (0) Wed Feb 3 21:03:00 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (79363) read frames (79163) minFrame (0) Wed Feb 3 21:03:00 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 634904 bytes, system time 03-02-2021 21:03:00 index time 03-02-2021 21:03:00, wait 60s Wed Feb 3 21:04:00 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (80859) read frames (79163) minFrame (0) Wed Feb 3 21:04:02 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (80896) read frames (80659) minFrame (0) Wed Feb 3 21:04:02 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (80896) read frames (80696) minFrame (0) Wed Feb 3 21:04:02 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 647168 bytes, system time 03-02-2021 21:04:02 index time 03-02-2021 21:04:01, wait 60s Wed Feb 3 21:05:02 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (82403) read frames (80696) minFrame (0) Wed Feb 3 21:05:03 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (82449) read frames (82203) minFrame (0) Wed Feb 3 21:05:03 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (82449) read frames (82249) minFrame (0) Wed Feb 3 21:05:03 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 659592 bytes, system time 03-02-2021 21:05:03 index time 03-02-2021 21:05:03, wait 60s Wed Feb 3 21:06:03 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (83948) read frames (82249) minFrame (0) Wed Feb 3 21:06:05 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (83981) read frames (83748) minFrame (0) Wed Feb 3 21:06:05 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (83981) read frames (83781) minFrame (0) Wed Feb 3 21:06:05 [7173] DEBUG: cExtractLogo::WaitForFrames(): index file size 671848 bytes, system time 03-02-2021 21:06:05 index time 03-02-2021 21:06:04, wait 60s Wed Feb 3 21:07:05 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (85473) read frames (83781) minFrame (0) Wed Feb 3 21:07:06 [7173] DEBUG: cExtractLogo::SearchLogo(): 1001 valid frames of 966 frames read, got enough iFrames at frame (85234), start analyze Wed Feb 3 21:07:06 [7173] DEBUG: cExtractLogo::SearchLogo(): best guess found at frame -1 with 0 similars out of 14 valid frames at TOP_LEFT Wed Feb 3 21:07:06 [7173] DEBUG: cExtractLogo::SearchLogo(): best guess found at frame -1 with 0 similars out of 51 valid frames at TOP_RIGHT Wed Feb 3 21:07:06 [7173] DEBUG: cExtractLogo::SearchLogo(): best guess found at frame 81995 with 2 similars out of 44 valid frames at BOTTOM_LEFT Wed Feb 3 21:07:06 [7173] DEBUG: cExtractLogo::SearchLogo(): best guess found at frame 73066 with 1 similars out of 43 valid frames at BOTTOM_RIGHT Wed Feb 3 21:07:06 [7173] DEBUG: cExtractLogo::SearchLogo(): no valid logo found, best logo at frame 81995 with 2 similars at corner BOTTOM_LEFT Wed Feb 3 21:07:06 [7173] DEBUG: cExtractLogo::SearchLogo(): failed, last frame 85234 Wed Feb 3 21:07:06 [7173] DEBUG: ---------------------------------------------------------------------------- Wed Feb 3 21:07:06 [7173] DEBUG: cMarkAdStandalone::CheckLogo(): logo search failed Wed Feb 3 21:07:06 [7173] INFO: pre-timer 299s Wed Feb 3 21:07:06 [7173] INFO: broadcast length 45min Wed Feb 3 21:07:06 [7173] INFO: channel 13th_Street_HD Wed Feb 3 21:07:06 [7173] INFO: parameter --loglevel is set to 3 Wed Feb 3 21:07:06 [7173] DEBUG: markad process nice level 19 Wed Feb 3 21:07:06 [7173] DEBUG: markad IO priority class 3 Wed Feb 3 21:07:06 [7173] DEBUG: parameter --logocachedir is set to /tmp Wed Feb 3 21:07:06 [7173] DEBUG: parameter --threads is set to -1 Wed Feb 3 21:07:06 [7173] DEBUG: parameter --astopoffs is set to 0 Wed Feb 3 21:07:06 [7173] DEBUG: parameter --log2rec is set Wed Feb 3 21:07:06 [7173] DEBUG: parameter --autologo is set to 2 Wed Feb 3 21:07:06 [7173] DEBUG: parameter Before is set Wed Feb 3 21:07:06 [7173] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Wed Feb 3 21:07:06 [7173] DEBUG: cMarkAdStandalone::ProcessFile_cDecoder(): start processing files Wed Feb 3 21:07:06 [7173] DEBUG: cDecoder::cDecoder(): init with 1 threads Wed Feb 3 21:07:06 [7173] DEBUG: cDecoder::DecodeFile(): start decode file /srv/vdr/video/Serien/Private_Eyes/04x01_-_041._Eine_neue_Tochter/2021-02-03.20.10.57-0.rec/00001.ts Wed Feb 3 21:07:06 [7173] DEBUG: cDecoder::DecodeFile(): using decoder for stream 0: codec id 27 -> H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 Wed Feb 3 21:07:06 [7173] DEBUG: cDecoder::DecodeFile(): using decoder for stream 1: codec id 86019 -> ATSC A/52A (AC-3) Wed Feb 3 21:07:06 [7173] DEBUG: cDecoder::DecodeFile(): using decoder for stream 2: codec id 86019 -> ATSC A/52A (AC-3) Wed Feb 3 21:07:06 [7173] DEBUG: cDecoder::GetVideoType(): video coding format: H.264 Wed Feb 3 21:07:06 [7173] INFO: video hight: 1080 Wed Feb 3 21:07:06 [7173] INFO: video width: 1920 Wed Feb 3 21:07:06 [7173] INFO: average frame rate 25 frames per second Wed Feb 3 21:07:06 [7173] INFO: real frame rate 25 frames per second Wed Feb 3 21:07:06 [7173] DEBUG: cMarkAdStandalone::CalculateCheckPositions(): startframe 7475 (4min 59s) Wed Feb 3 21:07:06 [7173] DEBUG: cMarkAdStandalone::CalculateCheckPositions(): use frame rate 25 Wed Feb 3 21:07:06 [7173] DEBUG: cMarkAdStandalone::CalculateCheckPositions(): length of recording: 2700s ( 45min 0s) Wed Feb 3 21:07:06 [7173] DEBUG: cMarkAdStandalone::CalculateCheckPositions(): assumed start frame: 7475 ( 4min 59s) Wed Feb 3 21:07:06 [7173] DEBUG: cMarkAdStandalone::CalculateCheckPositions(): assumed stop frame: 74975 ( 49min 59s) Wed Feb 3 21:07:06 [7173] DEBUG: cMarkAdStandalone::CalculateCheckPositions(): chkSTART set to: 19475 ( 12min 59s) Wed Feb 3 21:07:06 [7173] DEBUG: cMarkAdStandalone::CalculateCheckPositions(): chkSTOP set to: 89975 ( 59min 59s) Wed Feb 3 21:07:06 [7173] DEBUG: cDecoder::GetFrameInfo(): audio channels of stream 2 changed from 0 to 2 at frame (-1) Wed Feb 3 21:07:06 [7173] DEBUG: cDecoder::GetFrameInfo(): audio channels of stream 1 changed from 0 to 5 at frame (2) Wed Feb 3 21:07:06 [7173] DEBUG: cDecoder::GetFrameInfo(): interlaced video format Wed Feb 3 21:07:06 [7173] DEBUG: cDecoder::GetFrameInfo(): aspect ratio changed from (0:0) to (16:9) at frame 5 Wed Feb 3 21:07:06 [7173] DEBUG: cMarkAdLogo::Process(): aspect ratio changed from 0:0 to 16:9, reload logo Wed Feb 3 21:07:06 [7173] DEBUG: cMarkAdLogo::Load(): try to find logo 13th_Street_HD-A16_9 plane 0 in /tmp Wed Feb 3 21:07:06 [7173] DEBUG: cMarkAdLogo::Load(): file not found for logo 13th_Street_HD-A16_9 plane 0 in /tmp Wed Feb 3 21:07:06 [7173] DEBUG: cMarkAdLogo::Load(): try to find logo 13th_Street_HD-A16_9 plane 0 in /srv/vdr/video/Serien/Private_Eyes/04x01_-_041._Eine_neue_Tochter/2021-02-03.20.10.57-0.rec Wed Feb 3 21:07:06 [7173] DEBUG: cMarkAdLogo::Load(): file not found for logo 13th_Street_HD-A16_9 plane 0 in /srv/vdr/video/Serien/Private_Eyes/04x01_-_041._Eine_neue_Tochter/2021-02-03.20.10.57-0.rec Wed Feb 3 21:07:06 [7173] INFO: no valid logo for 13th_Street_HD-A16_9 in logo cache and recording directory, extract logo from recording Wed Feb 3 21:07:06 [7173] DEBUG: ---------------------------------------------------------------------------- Wed Feb 3 21:07:06 [7173] DEBUG: cExtractLogo::SearchLogo(): start extract logo from frame 0 with aspect ratio 16:9 Wed Feb 3 21:07:06 [7173] DEBUG: cDecoder::cDecoder(): init with 1 threads Wed Feb 3 21:07:06 [7173] DEBUG: cExtractLogo::WaitForFrames(): frames recorded (85525) read frames (-1) minFrame (0) Wed Feb 3 21:07:06 [7173] DEBUG: cExtractLogo::SearchLogo(): we have no frames already stored Wed Feb 3 21:07:06 [7173] DEBUG: cDecoder::DecodeFile(): start decode file /srv/vdr/video/Serien/Private_Eyes/04x01_-_041._Eine_neue_Tochter/2021-02-03.20.10.57-0.rec/00001.ts Wed Feb 3 21:07:06 [7173] DEBUG: cDecoder::DecodeFile(): using decoder for stream 0: codec id 27 -> H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 Wed Feb 3 21:07:06 [7173] DEBUG: cDecoder::DecodeFile(): using decoder for stream 1: codec id 86019 -> ATSC A/52A (AC-3) Wed Feb 3 21:07:06 [7173] DEBUG: cDecoder::DecodeFile(): using decoder for stream 2: codec id 86019 -> ATSC A/52A (AC-3) Wed Feb 3 21:07:06 [7173] DEBUG: cDecoder::GetVideoType(): video coding format: H.264 Wed Feb 3 21:07:06 [7173] DEBUG: cExtractLogo::SearchLogo(): video resolution 1920x1080 Wed Feb 3 21:07:06 [7173] DEBUG: cExtractLogo::SearchLogo(): logo size 340x190 Wed Feb 3 21:07:06 [7173] DEBUG: cDecoder::GetFrameInfo(): interlaced video format Wed Feb 3 21:07:15 [7173] DEBUG: AVlog(): illegal short term buffer state detected Wed Feb 3 21:07:26 [7173] DEBUG: cExtractLogo::SearchLogo(): 1001 valid frames of 1001 frames read, got enough iFrames at frame (19294), start analyze Wed Feb 3 21:07:26 [7173] DEBUG: cExtractLogo::SearchLogo(): best guess found at frame 6348 with 5 similars out of 14 valid frames at TOP_LEFT Wed Feb 3 21:07:26 [7173] DEBUG: cExtractLogo::SearchLogo(): best guess found at frame 4277 with 3 similars out of 30 valid frames at TOP_RIGHT Wed Feb 3 21:07:26 [7173] DEBUG: cExtractLogo::SearchLogo(): best guess found at frame 5502 with 5 similars out of 28 valid frames at BOTTOM_LEFT Wed Feb 3 21:07:26 [7173] DEBUG: cExtractLogo::SearchLogo(): best guess found at frame 4592 with 15 similars out of 75 valid frames at BOTTOM_RIGHT Wed Feb 3 21:07:26 [7173] DEBUG: cExtractLogo::SearchLogo(): best corner is BOTTOM_RIGHT at frame 4592 with 15 similars Wed Feb 3 21:07:26 [7173] DEBUG: cExtractLogo::Resize(): logo size before resize: 340 width 190 height on corner BOTTOM_RIGHT Wed Feb 3 21:07:26 [7173] DEBUG: cExtractLogo::CutOut(): cut out 66p lines horizontal and 0p column vertical Wed Feb 3 21:07:26 [7173] DEBUG: cExtractLogo::CutOut(): logo size after cut out: 340 width 124 height on corner BOTTOM_RIGHT Wed Feb 3 21:07:26 [7173] DEBUG: cExtractLogo::CutOut(): cut out 0p lines horizontal and 52p column vertical Wed Feb 3 21:07:26 [7173] DEBUG: cExtractLogo::CutOut(): logo size after cut out: 288 width 124 height on corner BOTTOM_RIGHT Wed Feb 3 21:07:26 [7173] DEBUG: cExtractLogo::Resize(): logo size after 1. resize: 288 width 124 height on corner BOTTOM_RIGHT Wed Feb 3 21:07:26 [7173] DEBUG: cExtractLogo::CutOut(): logo size after cut out: 288 width 124 height on corner BOTTOM_RIGHT Wed Feb 3 21:07:26 [7173] DEBUG: cExtractLogo::CutOut(): logo size after cut out: 288 width 124 height on corner BOTTOM_RIGHT Wed Feb 3 21:07:26 [7173] DEBUG: cExtractLogo::Resize(): logo size after 2. resize: 288 width 124 height on corner BOTTOM_RIGHT Wed Feb 3 21:07:26 [7173] DEBUG: cExtractLogo::Resize(): video 1920x1080 with logo size 288 width 124 height on corner BOTTOM_RIGHT is valid Wed Feb 3 21:07:26 [7173] DEBUG: cExtractLogo::isLogoColourChange(): 150 valid frames in corner 3, 130 are white, ratio 86% Wed Feb 3 21:07:26 [7173] DEBUG: cExtractLogo::Save(): 2612 pixel in plane 0 Wed Feb 3 21:07:26 [7173] DEBUG: cExtractLogo::Save(): store logo in /srv/vdr/video/Serien/Private_Eyes/04x01_-_041._Eine_neue_Tochter/2021-02-03.20.10.57-0.rec/13th_Street_HD-A16_9-P0.pgm Wed Feb 3 21:07:26 [7173] INFO: Logo size for Channel: 13th_Street_HD 16:9 1920W 1080H: 288W 124H BOTTOM_RIGHT Wed Feb 3 21:07:26 [7173] DEBUG: cExtractLogo::Save(): not enough pixel (0) in plane 1 Wed Feb 3 21:07:26 [7173] DEBUG: cExtractLogo::Save(): not enough pixel (0) in plane 2 Wed Feb 3 21:07:26 [7173] DEBUG: cExtractLogo::SearchLogo(): finished successfully, last frame 19294 Wed Feb 3 21:07:26 [7173] DEBUG: ---------------------------------------------------------------------------- Wed Feb 3 21:07:26 [7173] DEBUG: cMarkAdLogo::Process(): new logo for 13th_Street_HD-A16_9 found in recording Wed Feb 3 21:07:26 [7173] DEBUG: cMarkAdLogo::Load(): try to find logo 13th_Street_HD-A16_9 plane 0 in /srv/vdr/video/Serien/Private_Eyes/04x01_-_041._Eine_neue_Tochter/2021-02-03.20.10.57-0.rec Wed Feb 3 21:07:26 [7173] DEBUG: cMarkAdLogo::Load(): file found for logo 13th_Street_HD-A16_9 plane 0 in /srv/vdr/video/Serien/Private_Eyes/04x01_-_041._Eine_neue_Tochter/2021-02-03.20.10.57-0.rec Wed Feb 3 21:07:26 [7173] INFO: logo 13th_Street_HD-A16_9 found in /srv/vdr/video/Serien/Private_Eyes/04x01_-_041._Eine_neue_Tochter/2021-02-03.20.10.57-0.rec Wed Feb 3 21:07:26 [7173] DEBUG: cMarkAdLogo::Load(): try to find logo 13th_Street_HD-A16_9 plane 1 in /srv/vdr/video/Serien/Private_Eyes/04x01_-_041._Eine_neue_Tochter/2021-02-03.20.10.57-0.rec Wed Feb 3 21:07:26 [7173] DEBUG: cMarkAdLogo::Load(): file not found for logo 13th_Street_HD-A16_9 plane 1 in /srv/vdr/video/Serien/Private_Eyes/04x01_-_041._Eine_neue_Tochter/2021-02-03.20.10.57-0.rec Wed Feb 3 21:07:26 [7173] DEBUG: cMarkAdLogo::Load(): try to find logo 13th_Street_HD-A16_9 plane 2 in /srv/vdr/video/Serien/Private_Eyes/04x01_-_041._Eine_neue_Tochter/2021-02-03.20.10.57-0.rec Wed Feb 3 21:07:26 [7173] DEBUG: cMarkAdLogo::Load(): file not found for logo 13th_Street_HD-A16_9 plane 2 in /srv/vdr/video/Serien/Private_Eyes/04x01_-_041._Eine_neue_Tochter/2021-02-03.20.10.57-0.rec Wed Feb 3 21:07:26 [7173] INFO: detected start of black screen (216) at 0:00:08.64 inBroadCast: 0 Wed Feb 3 21:07:27 [7173] INFO: detected end of black screen (576)* at 0:00:23.04 inBroadCast: 0 Wed Feb 3 21:07:27 [7173] INFO: detected start of black screen (768) at 0:00:30.71 inBroadCast: 0 Wed Feb 3 21:07:27 [7173] INFO: detected end of black screen (792)* at 0:00:31.68 inBroadCast: 0 Wed Feb 3 21:07:27 [7173] INFO: detected start of black screen (934) at 0:00:37.27 inBroadCast: 0 Wed Feb 3 21:07:27 [7173] INFO: detected end of black screen (958)* at 0:00:38.24 inBroadCast: 0 Wed Feb 3 21:07:27 [7173] INFO: detected start of black screen (1159) at 0:00:46.15 inBroadCast: 0 Wed Feb 3 21:07:27 [7173] INFO: detected end of black screen (1175)* at 0:00:46.79 inBroadCast: 0 Wed Feb 3 21:07:30 [7173] INFO: detected start of black screen (3302) at 0:02:11.36 inBroadCast: 0 Wed Feb 3 21:07:30 [7173] INFO: detected end of black screen (3323)* at 0:02:12.32 inBroadCast: 0 Wed Feb 3 21:07:30 [7173] INFO: detected start of black screen (3557) at 0:02:21.55 inBroadCast: 0 Wed Feb 3 21:07:30 [7173] INFO: detected end of black screen (3578)* at 0:02:22.52 inBroadCast: 0 Wed Feb 3 21:07:30 [7173] INFO: detected start of black screen (4062) at 0:02:41.75 inBroadCast: 0 Wed Feb 3 21:07:30 [7173] INFO: detected end of black screen (4083)* at 0:02:42.72 inBroadCast: 0 Wed Feb 3 21:07:31 [7173] INFO: detected start of black screen (4567) at 0:03:01.96 inBroadCast: 0 Wed Feb 3 21:07:31 [7173] INFO: detected end of black screen (4588)* at 0:03:02.91 inBroadCast: 0 Wed Feb 3 21:07:31 [7173] INFO: actual mark (4588) type 0x31 stronger then previous mark, deleting 4588 type 0x21 Wed Feb 3 21:07:31 [7173] INFO: detected logo start (4588)* at 0:03:02.91 inBroadCast: 1 Wed Feb 3 21:07:31 [7173] DEBUG: cMarkAdLogo::Detect(): black screen without logo detected at frame (4892) Wed Feb 3 21:07:31 [7173] INFO: detected logo stop (4892) at 0:03:15.08 inBroadCast: 0 Wed Feb 3 21:07:31 [7173] INFO: detected start of black screen (4947) at 0:03:17.16 inBroadCast: 0 Wed Feb 3 21:07:31 [7173] INFO: detected end of black screen (4968)* at 0:03:18.11 inBroadCast: 0 Wed Feb 3 21:07:31 [7173] INFO: detected start of black screen (5202) at 0:03:27.36 inBroadCast: 0 Wed Feb 3 21:07:31 [7173] INFO: detected end of black screen (5223)* at 0:03:28.32 inBroadCast: 0 Wed Feb 3 21:07:32 [7173] INFO: detected start of black screen (5457) at 0:03:37.55 inBroadCast: 0 Wed Feb 3 21:07:32 [7173] INFO: detected end of black screen (5478)* at 0:03:38.52 inBroadCast: 0 Wed Feb 3 21:07:32 [7173] INFO: detected start of black screen (5720) at 0:03:47.75 inBroadCast: 0 Wed Feb 3 21:07:32 [7173] INFO: detected end of black screen (5735)* at 0:03:48.36 inBroadCast: 0 Wed Feb 3 21:07:32 [7173] INFO: detected start of black screen (5975) at 0:03:57.96 inBroadCast: 0 Wed Feb 3 21:07:32 [7173] INFO: detected end of black screen (5996)* at 0:03:58.91 inBroadCast: 0 Wed Feb 3 21:07:32 [7173] INFO: detected start of black screen (6230) at 0:04:08.16 inBroadCast: 0 Wed Feb 3 21:07:32 [7173] INFO: detected end of black screen (6251)* at 0:04:09.11 inBroadCast: 0 Wed Feb 3 21:07:32 [7173] INFO: detected start of black screen (6485) at 0:04:18.35 inBroadCast: 0 Wed Feb 3 21:07:32 [7173] INFO: detected end of black screen (6506)* at 0:04:19.32 inBroadCast: 0 Wed Feb 3 21:07:33 [7173] INFO: detected start of black screen (6865) at 0:04:33.55 inBroadCast: 0 Wed Feb 3 21:07:33 [7173] INFO: detected end of black screen (6886)* at 0:04:34.51 inBroadCast: 0 Wed Feb 3 21:07:33 [7173] INFO: detected start of black screen (7370) at 0:04:53.76 inBroadCast: 0 Wed Feb 3 21:07:33 [7173] INFO: detected end of black screen (7391)* at 0:04:54.72 inBroadCast: 0 Wed Feb 3 21:07:33 [7173] DEBUG: AVlog(): illegal short term buffer state detected Wed Feb 3 21:07:34 [7173] INFO: detected start of black screen (8194) at 0:05:26.95 inBroadCast: 0 Wed Feb 3 21:07:34 [7173] INFO: detected end of black screen (8200)* at 0:05:27.20 inBroadCast: 0 Wed Feb 3 21:07:34 [7173] INFO: detected start of black screen (9218) at 0:06:07.92 inBroadCast: 0 Wed Feb 3 21:07:34 [7173] INFO: detected end of black screen (9239)* at 0:06:08.88 inBroadCast: 0 Wed Feb 3 21:07:38 [7173] INFO: detected start of black screen (12766) at 0:08:29.83 inBroadCast: 0 Wed Feb 3 21:07:38 [7173] INFO: detected end of black screen (12773)* at 0:08:30.11 inBroadCast: 0 Wed Feb 3 21:07:38 [7173] INFO: detected start of black screen (12786) at 0:08:30.64 inBroadCast: 0 Wed Feb 3 21:07:38 [7173] INFO: detected end of black screen (12807)* at 0:08:31.48 inBroadCast: 0 Wed Feb 3 21:07:54 [7173] INFO: detected start of black screen (30988) at 0:20:38.83 inBroadCast: 0 Wed Feb 3 21:07:54 [7173] DEBUG: clMarks::Save(): save marks, isRunningRecording=1 force=0 Wed Feb 3 21:07:54 [7173] INFO: detected end of black screen (31027)* at 0:20:40.11 inBroadCast: 0 Wed Feb 3 21:07:54 [7173] DEBUG: clMarks::Save(): save marks, isRunningRecording=1 force=0 Wed Feb 3 21:08:06 [7173] INFO: detected start of black screen (46381) at 0:30:53.68 inBroadCast: 0 Wed Feb 3 21:08:06 [7173] DEBUG: clMarks::Save(): save marks, isRunningRecording=1 force=0 Wed Feb 3 21:08:06 [7173] INFO: detected end of black screen (46405)* at 0:30:54.64 inBroadCast: 0 Wed Feb 3 21:08:06 [7173] DEBUG: clMarks::Save(): save marks, isRunningRecording=1 force=0 Wed Feb 3 21:08:15 [7173] INFO: detected start of black screen (58059) at 0:38:40.80 inBroadCast: 0 Wed Feb 3 21:08:15 [7173] DEBUG: clMarks::Save(): save marks, isRunningRecording=1 force=0 Wed Feb 3 21:08:15 [7173] INFO: detected end of black screen (58105)* at 0:38:42.36 inBroadCast: 0 Wed Feb 3 21:08:15 [7173] DEBUG: clMarks::Save(): save marks, isRunningRecording=1 force=0 Wed Feb 3 21:08:25 [7173] INFO: detected start of black screen (70845) at 0:47:12.84 inBroadCast: 0 Wed Feb 3 21:08:25 [7173] DEBUG: clMarks::Save(): save marks, isRunningRecording=1 force=0 Wed Feb 3 21:08:26 [7173] INFO: detected end of black screen (70989)* at 0:47:18.60 inBroadCast: 0 Wed Feb 3 21:08:26 [7173] DEBUG: clMarks::Save(): save marks, isRunningRecording=1 force=0 Wed Feb 3 21:08:26 [7173] INFO: detected start of black screen (71037) at 0:47:20.52 inBroadCast: 0 Wed Feb 3 21:08:26 [7173] DEBUG: clMarks::Save(): save marks, isRunningRecording=1 force=0 Wed Feb 3 21:08:26 [7173] INFO: detected end of black screen (71205)* at 0:47:27.23 inBroadCast: 0 Wed Feb 3 21:08:26 [7173] DEBUG: clMarks::Save(): save marks, isRunningRecording=1 force=0 Wed Feb 3 21:08:26 [7173] INFO: detected start of black screen (71229) at 0:47:28.19 inBroadCast: 0 Wed Feb 3 21:08:26 [7173] DEBUG: clMarks::Save(): save marks, isRunningRecording=1 force=0 Wed Feb 3 21:08:26 [7173] INFO: detected end of black screen (71253)* at 0:47:29.15 inBroadCast: 0 Wed Feb 3 21:08:26 [7173] DEBUG: clMarks::Save(): save marks, isRunningRecording=1 force=0 Wed Feb 3 21:08:26 [7173] INFO: detected start of black screen (71301) at 0:47:31.08 inBroadCast: 0 Wed Feb 3 21:08:26 [7173] DEBUG: clMarks::Save(): save marks, isRunningRecording=1 force=0 Wed Feb 3 21:08:26 [7173] INFO: detected end of black screen (71373)* at 0:47:33.95 inBroadCast: 0 Wed Feb 3 21:08:26 [7173] DEBUG: clMarks::Save(): save marks, isRunningRecording=1 force=0 Wed Feb 3 21:08:26 [7173] INFO: detected start of black screen (71548) at 0:47:40.84 inBroadCast: 0 Wed Feb 3 21:08:26 [7173] DEBUG: clMarks::Save(): save marks, isRunningRecording=1 force=0 Wed Feb 3 21:08:26 [7173] INFO: detected end of black screen (71564)* at 0:47:41.47 inBroadCast: 0 Wed Feb 3 21:08:26 [7173] DEBUG: clMarks::Save(): save marks, isRunningRecording=1 force=0 Wed Feb 3 21:08:27 [7173] INFO: detected start of black screen (72566) at 0:48:21.04 inBroadCast: 0 Wed Feb 3 21:08:27 [7173] DEBUG: clMarks::Save(): save marks, isRunningRecording=1 force=0 Wed Feb 3 21:08:27 [7173] INFO: detected end of black screen (72587)* at 0:48:22.00 inBroadCast: 0 Wed Feb 3 21:08:27 [7173] DEBUG: clMarks::Save(): save marks, isRunningRecording=1 force=0 Wed Feb 3 21:08:27 [7173] INFO: detected start of black screen (73077) at 0:48:41.47 inBroadCast: 0 Wed Feb 3 21:08:27 [7173] DEBUG: clMarks::Save(): save marks, isRunningRecording=1 force=0 Wed Feb 3 21:08:27 [7173] INFO: detected end of black screen (73087)* at 0:48:41.87 inBroadCast: 0 Wed Feb 3 21:08:27 [7173] DEBUG: clMarks::Save(): save marks, isRunningRecording=1 force=0 Wed Feb 3 21:08:30 [7173] INFO: detected start of black screen (74576) at 0:49:41.43 inBroadCast: 0 Wed Feb 3 21:08:30 [7173] DEBUG: clMarks::Save(): save marks, isRunningRecording=1 force=0 Wed Feb 3 21:08:30 [7173] INFO: detected end of black screen (74597)* at 0:49:42.39 inBroadCast: 0 Wed Feb 3 21:08:30 [7173] DEBUG: clMarks::Save(): save marks, isRunningRecording=1 force=0 Wed Feb 3 21:08:30 [7173] INFO: detected start of black screen (75081) at 0:50:01.63 inBroadCast: 0 Wed Feb 3 21:08:30 [7173] DEBUG: clMarks::Save(): save marks, isRunningRecording=1 force=0 Wed Feb 3 21:08:30 [7173] INFO: detected end of black screen (75102)* at 0:50:02.60 inBroadCast: 0 Wed Feb 3 21:08:30 [7173] DEBUG: clMarks::Save(): save marks, isRunningRecording=1 force=0 Wed Feb 3 21:08:31 [7173] INFO: detected start of black screen (75477) at 0:50:17.60 inBroadCast: 0 Wed Feb 3 21:08:31 [7173] DEBUG: clMarks::Save(): save marks, isRunningRecording=1 force=0 Wed Feb 3 21:08:31 [7173] INFO: detected end of black screen (75484)* at 0:50:17.76 inBroadCast: 0 Wed Feb 3 21:08:31 [7173] DEBUG: clMarks::Save(): save marks, isRunningRecording=1 force=0 Wed Feb 3 21:08:35 [7173] INFO: detected start of black screen (81075) at 0:54:01.39 inBroadCast: 0 Wed Feb 3 21:08:35 [7173] DEBUG: clMarks::Save(): save marks, isRunningRecording=1 force=0 Wed Feb 3 21:08:35 [7173] INFO: detected end of black screen (81082)* at 0:54:01.67 inBroadCast: 0 Wed Feb 3 21:08:35 [7173] DEBUG: clMarks::Save(): save marks, isRunningRecording=1 force=0 Wed Feb 3 21:08:35 [7173] INFO: detected start of black screen (81095) at 0:54:02.19 inBroadCast: 0 Wed Feb 3 21:08:35 [7173] DEBUG: clMarks::Save(): save marks, isRunningRecording=1 force=0 Wed Feb 3 21:08:35 [7173] INFO: detected end of black screen (81116)* at 0:54:03.04 inBroadCast: 0 Wed Feb 3 21:08:35 [7173] DEBUG: clMarks::Save(): save marks, isRunningRecording=1 force=0 Wed Feb 3 21:09:27 [7173] DEBUG: AVlog(): left block unavailable for requested intra mode Wed Feb 3 21:09:27 [7173] DEBUG: AVlog(): error while decoding MB 0 50, bytestream 9914 Wed Feb 3 21:10:29 [7173] DEBUG: cDecoder::GetNextFrame(): last frame of filenumber 1 is (89923), end time 3596080ms ( 59:56min) Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::ProcessFile_cDecoder(): recording ends unexpected before chkSTART (19475) at frame 89895 Wed Feb 3 21:10:29 [7173] INFO: got end of recording before recording length from info file reached Wed Feb 3 21:10:29 [7173] DEBUG: ======================================================================================================================= Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::CheckStart(): checking start at frame (89895) check start planed at (19475) Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::CheckStart(): assumed start frame 7475 Wed Feb 3 21:10:29 [7173] DEBUG: ************************************************************* Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 216 type 0x22 at 0:00:08.64 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 576 type 0x21 at 0:00:23.04 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 768 type 0x22 at 0:00:30.71 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 792 type 0x21 at 0:00:31.68 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 934 type 0x22 at 0:00:37.27 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 958 type 0x21 at 0:00:38.24 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 1159 type 0x22 at 0:00:46.15 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 1175 type 0x21 at 0:00:46.79 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 3302 type 0x22 at 0:02:11.36 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 3323 type 0x21 at 0:02:12.32 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 3557 type 0x22 at 0:02:21.55 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 3578 type 0x21 at 0:02:22.52 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 4062 type 0x22 at 0:02:41.75 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 4083 type 0x21 at 0:02:42.72 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 4567 type 0x22 at 0:03:01.96 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 4588 type 0x31 at 0:03:02.91 inBroadCast 1 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 4892 type 0x32 at 0:03:15.08 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 4947 type 0x22 at 0:03:17.16 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 4968 type 0x21 at 0:03:18.11 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 5202 type 0x22 at 0:03:27.36 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 5223 type 0x21 at 0:03:28.32 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 5457 type 0x22 at 0:03:37.55 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 5478 type 0x21 at 0:03:38.52 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 5720 type 0x22 at 0:03:47.75 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 5735 type 0x21 at 0:03:48.36 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 5975 type 0x22 at 0:03:57.96 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 5996 type 0x21 at 0:03:58.91 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 6230 type 0x22 at 0:04:08.16 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 6251 type 0x21 at 0:04:09.11 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 6485 type 0x22 at 0:04:18.35 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 6506 type 0x21 at 0:04:19.32 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 6865 type 0x22 at 0:04:33.55 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 6886 type 0x21 at 0:04:34.51 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 7370 type 0x22 at 0:04:53.76 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 7391 type 0x21 at 0:04:54.72 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 8194 type 0x22 at 0:05:26.95 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 8200 type 0x21 at 0:05:27.20 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 9218 type 0x22 at 0:06:07.92 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 9239 type 0x21 at 0:06:08.88 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 12766 type 0x22 at 0:08:29.83 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 12773 type 0x21 at 0:08:30.11 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 12786 type 0x22 at 0:08:30.64 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 12807 type 0x21 at 0:08:31.48 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 30988 type 0x22 at 0:20:38.83 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 31027 type 0x21 at 0:20:40.11 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 46381 type 0x22 at 0:30:53.68 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 46405 type 0x21 at 0:30:54.64 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 58059 type 0x22 at 0:38:40.80 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 58105 type 0x21 at 0:38:42.36 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 70845 type 0x22 at 0:47:12.84 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 70989 type 0x21 at 0:47:18.60 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 71037 type 0x22 at 0:47:20.52 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 71205 type 0x21 at 0:47:27.23 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 71229 type 0x22 at 0:47:28.19 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 71253 type 0x21 at 0:47:29.15 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 71301 type 0x22 at 0:47:31.08 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 71373 type 0x21 at 0:47:33.95 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 71548 type 0x22 at 0:47:40.84 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 71564 type 0x21 at 0:47:41.47 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 72566 type 0x22 at 0:48:21.04 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 72587 type 0x21 at 0:48:22.00 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 73077 type 0x22 at 0:48:41.47 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 73087 type 0x21 at 0:48:41.87 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 74576 type 0x22 at 0:49:41.43 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 74597 type 0x21 at 0:49:42.39 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 75081 type 0x22 at 0:50:01.63 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 75102 type 0x21 at 0:50:02.60 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 75477 type 0x22 at 0:50:17.60 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 75484 type 0x21 at 0:50:17.76 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 81075 type 0x22 at 0:54:01.39 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 81082 type 0x21 at 0:54:01.67 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 81095 type 0x22 at 0:54:02.19 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 81116 type 0x21 at 0:54:03.04 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: ************************************************************* Wed Feb 3 21:10:29 [7173] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::RemoveLogoChangeMarks(): start detect and remove logo stop/start mark pairs with special logo Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::RemoveLogoChangeMarks(): only 1 logo stop mark, do not delete any Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::RemoveLogoChangeMarks(): marks after detect and remove logo stop/start mark pairs with special logo Wed Feb 3 21:10:29 [7173] DEBUG: ************************************************************* Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 216 type 0x22 at 0:00:08.64 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 576 type 0x21 at 0:00:23.04 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 768 type 0x22 at 0:00:30.71 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 792 type 0x21 at 0:00:31.68 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 934 type 0x22 at 0:00:37.27 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 958 type 0x21 at 0:00:38.24 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 1159 type 0x22 at 0:00:46.15 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 1175 type 0x21 at 0:00:46.79 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 3302 type 0x22 at 0:02:11.36 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 3323 type 0x21 at 0:02:12.32 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 3557 type 0x22 at 0:02:21.55 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 3578 type 0x21 at 0:02:22.52 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 4062 type 0x22 at 0:02:41.75 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 4083 type 0x21 at 0:02:42.72 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 4567 type 0x22 at 0:03:01.96 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 4588 type 0x31 at 0:03:02.91 inBroadCast 1 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 4892 type 0x32 at 0:03:15.08 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 4947 type 0x22 at 0:03:17.16 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 4968 type 0x21 at 0:03:18.11 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 5202 type 0x22 at 0:03:27.36 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 5223 type 0x21 at 0:03:28.32 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 5457 type 0x22 at 0:03:37.55 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 5478 type 0x21 at 0:03:38.52 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 5720 type 0x22 at 0:03:47.75 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 5735 type 0x21 at 0:03:48.36 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 5975 type 0x22 at 0:03:57.96 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 5996 type 0x21 at 0:03:58.91 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 6230 type 0x22 at 0:04:08.16 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 6251 type 0x21 at 0:04:09.11 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 6485 type 0x22 at 0:04:18.35 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 6506 type 0x21 at 0:04:19.32 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 6865 type 0x22 at 0:04:33.55 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 6886 type 0x21 at 0:04:34.51 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 7370 type 0x22 at 0:04:53.76 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 7391 type 0x21 at 0:04:54.72 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 8194 type 0x22 at 0:05:26.95 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 8200 type 0x21 at 0:05:27.20 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 9218 type 0x22 at 0:06:07.92 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 9239 type 0x21 at 0:06:08.88 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 12766 type 0x22 at 0:08:29.83 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 12773 type 0x21 at 0:08:30.11 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 12786 type 0x22 at 0:08:30.64 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 12807 type 0x21 at 0:08:31.48 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 30988 type 0x22 at 0:20:38.83 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 31027 type 0x21 at 0:20:40.11 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 46381 type 0x22 at 0:30:53.68 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 46405 type 0x21 at 0:30:54.64 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 58059 type 0x22 at 0:38:40.80 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 58105 type 0x21 at 0:38:42.36 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 70845 type 0x22 at 0:47:12.84 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 70989 type 0x21 at 0:47:18.60 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 71037 type 0x22 at 0:47:20.52 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 71205 type 0x21 at 0:47:27.23 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 71229 type 0x22 at 0:47:28.19 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 71253 type 0x21 at 0:47:29.15 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 71301 type 0x22 at 0:47:31.08 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 71373 type 0x21 at 0:47:33.95 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 71548 type 0x22 at 0:47:40.84 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 71564 type 0x21 at 0:47:41.47 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 72566 type 0x22 at 0:48:21.04 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 72587 type 0x21 at 0:48:22.00 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 73077 type 0x22 at 0:48:41.47 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 73087 type 0x21 at 0:48:41.87 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 74576 type 0x22 at 0:49:41.43 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 74597 type 0x21 at 0:49:42.39 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 75081 type 0x22 at 0:50:01.63 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 75102 type 0x21 at 0:50:02.60 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 75477 type 0x22 at 0:50:17.60 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 75484 type 0x21 at 0:50:17.76 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 81075 type 0x22 at 0:54:01.39 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 81082 type 0x21 at 0:54:01.67 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 81095 type 0x22 at 0:54:02.19 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 81116 type 0x21 at 0:54:03.04 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: ************************************************************* Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::RemoveLogoChangeMarks(): end detect and remove logo stop/start mark pairs with special logo Wed Feb 3 21:10:29 [7173] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Wed Feb 3 21:10:29 [7173] INFO: broadcast with 5 audio channels of stream 1 Wed Feb 3 21:10:29 [7173] INFO: broadcast with 2 audio channels of stream 2 Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::CheckStart(): we are not in broadcast at frame (89895), trying to find channel start mark anyway Wed Feb 3 21:10:29 [7173] INFO: HD Video with aspectratio of 16:9 detected Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::CheckStart(): no horizontal border at start found, ignore horizontal border detection Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::CheckStart(): no vertical border at start found, ignore vertical border detection Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::CheckStart(): logo start mark found on position (4588) at 0:03:02.91 Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::CheckStart(): logo stop mark found very short after start mark on position (4892) at 0:03:15.08 Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::CalculateCheckPositions(): startframe 4588 (3min 3s) Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::CalculateCheckPositions(): use frame rate 25 Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::CalculateCheckPositions(): length of recording: 2700s ( 45min 0s) Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::CalculateCheckPositions(): assumed start frame: 4588 ( 3min 3s) Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::CalculateCheckPositions(): assumed stop frame: 72088 ( 48min 3s) Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::CalculateCheckPositions(): chkSTART set to: 16588 ( 11min 3s) Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::CalculateCheckPositions(): chkSTOP set to: 87088 ( 58min 3s) Wed Feb 3 21:10:29 [7173] INFO: using mark on position (4588) type 0x31 at 0:03:02.91 as start mark Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::CheckStart(): move all black screen marks except start mark to black screen list Wed Feb 3 21:10:29 [7173] DEBUG: clMarks::Save(): save marks, isRunningRecording=1 force=0 Wed Feb 3 21:10:29 [7173] DEBUG: ************************************************************* Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 4588 type 0x31 at 0:03:02.91 inBroadCast 1 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 4892 type 0x32 at 0:03:15.08 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: ************************************************************* Wed Feb 3 21:10:29 [7173] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::ProcessFile_cDecoder(): recording ends unexpected before chkSTOP (87088) at frame 89895 Wed Feb 3 21:10:29 [7173] INFO: got end of recording before recording length from info file reached Wed Feb 3 21:10:29 [7173] DEBUG: ======================================================================================================================= Wed Feb 3 21:10:29 [7173] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::CheckStop(): start check stop (89895) Wed Feb 3 21:10:29 [7173] DEBUG: assumed stop position (72088) at 0:48:02.19 Wed Feb 3 21:10:29 [7173] DEBUG: ************************************************************* Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 4588 type 0x31 at 0:03:02.91 inBroadCast 1 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 4892 type 0x32 at 0:03:15.08 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: ************************************************************* Wed Feb 3 21:10:29 [7173] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::RemoveLogoChangeMarks(): start detect and remove logo stop/start mark pairs with special logo Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::RemoveLogoChangeMarks(): only 1 logo stop mark, do not delete any Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::RemoveLogoChangeMarks(): marks after detect and remove logo stop/start mark pairs with special logo Wed Feb 3 21:10:29 [7173] DEBUG: ************************************************************* Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 4588 type 0x31 at 0:03:02.91 inBroadCast 1 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 4892 type 0x32 at 0:03:15.08 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: ************************************************************* Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::RemoveLogoChangeMarks(): end detect and remove logo stop/start mark pairs with special logo Wed Feb 3 21:10:29 [7173] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::CheckStop(): no MT_CHANNELSTOP mark found Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::CheckStop(): no MT_ASPECTSTOP mark found Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::CheckStop(): no MT_HBORDERSTOP mark found Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::CheckStop(): no MT_VBORDERSTOP mark found Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::CheckStop(): no MT_LOGOSTOP mark found Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::CheckStop(): no end mark found Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::CheckStop(): no stop mark found, add stop mark at the last frame (89895) Wed Feb 3 21:10:29 [7173] INFO: assuming stop (89895) at 0:59:54.95 inBroadCast: 0 Wed Feb 3 21:10:29 [7173] DEBUG: clMarks::Save(): save marks, isRunningRecording=1 force=0 Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::CheckStop(): move all black screen marks except start and end mark to black screen list Wed Feb 3 21:10:29 [7173] DEBUG: ************************************************************* Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 4588 type 0x31 at 0:03:02.91 inBroadCast 1 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 4892 type 0x32 at 0:03:15.08 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 89895 type 0x12 at 0:59:54.95 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: ************************************************************* Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::CheckStop(): end check stop Wed Feb 3 21:10:29 [7173] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Wed Feb 3 21:10:29 [7173] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::CheckMarks(): check marks first pass (delete logo marks if we have channel or border marks) Wed Feb 3 21:10:29 [7173] DEBUG: ************************************************************* Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 4588 type 0x31 at 0:03:02.91 inBroadCast 1 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 4892 type 0x32 at 0:03:15.08 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 89895 type 0x12 at 0:59:54.95 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: ************************************************************* Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::CheckMarks(): check marks 2nd pass (delete invalid black sceen marks) Wed Feb 3 21:10:29 [7173] DEBUG: ************************************************************* Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 4588 type 0x31 at 0:03:02.91 inBroadCast 1 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 4892 type 0x32 at 0:03:15.08 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 89895 type 0x12 at 0:59:54.95 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: ************************************************************* Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::CheckMarks(): check marks 2nd pass (detect previews in advertisement) Wed Feb 3 21:10:29 [7173] DEBUG: ************************************************************* Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 4588 type 0x31 at 0:03:02.91 inBroadCast 1 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 4892 type 0x32 at 0:03:15.08 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 89895 type 0x12 at 0:59:54.95 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: ************************************************************* Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::CheckMarks(): check marks 3nd pass (remove logo and hborder detection failure marks) Wed Feb 3 21:10:29 [7173] DEBUG: ************************************************************* Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 4588 type 0x31 at 0:03:02.91 inBroadCast 1 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 4892 type 0x32 at 0:03:15.08 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 89895 type 0x12 at 0:59:54.95 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: ************************************************************* Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::CheckMarks(): check marks 4nd pass (remove invalid marks) Wed Feb 3 21:10:29 [7173] DEBUG: ************************************************************* Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 4588 type 0x31 at 0:03:02.91 inBroadCast 1 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 4892 type 0x32 at 0:03:15.08 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 89895 type 0x12 at 0:59:54.95 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: ************************************************************* Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::CheckMarks(): stop mark (4892) followed by stop mark (89895) delete first Wed Feb 3 21:10:29 [7173] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::CheckMarks(): final marks: Wed Feb 3 21:10:29 [7173] DEBUG: ************************************************************* Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::DebugMarks(): current marks: Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 4588 type 0x31 at 0:03:02.91 inBroadCast 1 Wed Feb 3 21:10:29 [7173] DEBUG: mark at position 89895 type 0x12 at 0:59:54.95 inBroadCast 0 Wed Feb 3 21:10:29 [7173] DEBUG: ************************************************************* Wed Feb 3 21:10:29 [7173] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::ProcessFile_cDecoder(): end processing files Wed Feb 3 21:10:29 [7173] DEBUG: clMarks::Save(): save marks, isRunningRecording=1 force=0 Wed Feb 3 21:10:29 [7173] DEBUG: ======================================================================================================================= Wed Feb 3 21:10:29 [7173] INFO: start 2nd pass (detect overlaps) Wed Feb 3 21:10:29 [7173] DEBUG: cDecoder::DecodeFile(): start decode file /srv/vdr/video/Serien/Private_Eyes/04x01_-_041._Eine_neue_Tochter/2021-02-03.20.10.57-0.rec/00001.ts Wed Feb 3 21:10:29 [7173] DEBUG: end 2ndPass Wed Feb 3 21:10:29 [7173] DEBUG: ======================================================================================================================= Wed Feb 3 21:10:29 [7173] INFO: start 3nd pass (optimze logo marks) Wed Feb 3 21:10:29 [7173] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::Process3ndPass(): check last logo stop mark if closing credits follows Wed Feb 3 21:10:29 [7173] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::Process3ndPass(): check for advertising in frame with logo before logo stop mark Wed Feb 3 21:10:29 [7173] DEBUG: skip for this channel Wed Feb 3 21:10:29 [7173] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::Process3ndPass(): search for audio silence Wed Feb 3 21:10:29 [7173] DEBUG: cDecoder::DecodeFile(): start decode file /srv/vdr/video/Serien/Private_Eyes/04x01_-_041._Eine_neue_Tochter/2021-02-03.20.10.57-0.rec/00001.ts Wed Feb 3 21:10:29 [7173] DEBUG: cMarkAdStandalone::Process3ndPass(): detect audio silence before logo mark at frame ( 4588) type 0x31 at 0:03:02.91 range 5s Wed Feb 3 21:10:29 [7173] DEBUG: cDecoder::SeekToFrame(): (4463) Wed Feb 3 21:10:30 [7173] DEBUG: cDecoder::SeekToFrame(): successful Wed Feb 3 21:10:30 [7173] DEBUG: cDecoder::GetNextSilence(): could not get stream index of MP2 audio stream Wed Feb 3 21:10:30 [7173] DEBUG: cMarkAdStandalone::Process3ndPass(): no audio silence before logo mark at frame ( 4588) type 0x31 at 0:03:02.91 found Wed Feb 3 21:10:30 [7173] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Wed Feb 3 21:10:30 [7173] DEBUG: cMarkAdStandalone::Process3ndPass(): start search for blackscreen near logo marks Wed Feb 3 21:10:30 [7173] DEBUG: cMarkAdStandalone::Process3ndPass(): blackscreen (4588) distance (0) 0s (expect >0 and <=6s) before (-after) logo start mark (4588), keep mark Wed Feb 3 21:10:30 [7173] DEBUG: clMarks::Save(): save marks, isRunningRecording=1 force=1 Wed Feb 3 21:10:30 [7173] DEBUG: ----------------------------------------------------------------------------------------------------------------------- Wed Feb 3 21:10:30 [7173] DEBUG: time for decoding: 153s 488ms Wed Feb 3 21:10:30 [7173] DEBUG: time to find logo in recording: 3433s 306ms Wed Feb 3 21:10:30 [7173] INFO: pass 1: time 202s 737ms, frames 89923, fps 445 Wed Feb 3 21:10:30 [7173] INFO: pass 3: time 1s 254ms, frames 125, fps 125 Wed Feb 3 21:10:30 [7173] INFO: processed time 58:42 min with 25.6 fps