Project

General

Profile

Actions
Copy link

Bug #1108

closed

Markad bricht ab

Added by MegaV0lt over 11 years ago. Updated over 10 years ago.

Status:
Closed
Priority:
Normal
Assignee:
Joe_D
Target version:
0.1.5
Start date:
10/25/2012
Due date:
% Done:

100%

Estimated time:

Description

Markad bricht manchmal ab, obwohl die Aufnahme läuft:

Tue Oct 23 21:08:00 [30183] starting v0.1.5pre (32bit)
Tue Oct 23 21:08:00 [30183] on /mnt/data/video/2_Broke_Girls/Johnny_und_Cash/2012-10-23.21.08.56-0.rec
Tue Oct 23 21:08:10 [30183] getting broadcast start from directory atime
Tue Oct 23 21:08:10 [30183] pre-timer 7m
Tue Oct 23 21:08:10 [30183] broadcast length 32m
Tue Oct 23 21:08:10 [30183] found H264-video (0x01ff)
Tue Oct 23 21:08:10 [30183] found AC3 (0x0203)
Tue Oct 23 21:08:10 [30183] using libavcodec.so.52.122.0 with 2 threads
Tue Oct 23 21:08:10 [30183] using codec H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10
Tue Oct 23 21:08:10 [30183] channel ProSieben_HD
Tue Oct 23 21:08:10 [30183] processing file 00001
Tue Oct 23 21:08:10 [30183] HDTV 1920x1080i25
Tue Oct 23 21:08:25 [30183] detected logo start (28)*
Tue Oct 23 21:08:26 [30183] stop of recording (484)
Tue Oct 23 21:08:26 [30183] ALERT: stopping before end of broadcast
Tue Oct 23 21:08:26 [30183] processed time 1.43s, 532/0 frames, 371.0 fps, 14.8 pps
Stop of recording stimmt nicht! Die Aufnahme lief komplett durch. Es gab auch keine Unterbrechzng (000001.ts ist 2GB groß)

Files

vdr-markad-0.1.5pre.tgz (118 KB) vdr-markad-0.1.5pre.tgz Joe_D, 12/11/2012 11:31 PM
Actions
Copy link
 #1

Updated by Joe_D over 11 years ago

  • Status changed from New to Feedback
  • Assignee set to Joe_D
  • Target version set to 0.1.5
  • % Done changed from 0 to 20

Bitte letzte GIT-Version ausprobieren...

Actions
Copy link
 #2

Updated by MegaV0lt over 11 years ago

Letzte GIT-Stand ist nun drauf. Ich werde das beobachten und mich melden, so bald der Fehler wieder auftritt.

Actions
Copy link
 #3

Updated by MegaV0lt over 11 years ago

Leider schon die erste Fehlermeldung:

http://i.imgur.com/Kc7O7.png <-Screen vom Ordner mit Dateien

Fri Nov  9 00:37:01 [27277] starting v0.1.5pre (32bit)
Fri Nov  9 00:37:01 [27277] on /mnt/data/video/Breaking_Bad/Buyout/2012-11-09.00.37.33-0.rec
Fri Nov  9 00:37:11 [27277] getting broadcast start from directory atime
Fri Nov  9 00:37:11 [27277] no logo found, logo detection disabled
Fri Nov  9 00:37:11 [27277] marks can/will be weak!
Fri Nov  9 00:37:11 [27277] pre-timer 3m
Fri Nov  9 00:37:11 [27277] broadcast length 45m
Fri Nov  9 00:37:11 [27277] found H264-video (0x00ff)
Fri Nov  9 00:37:11 [27277] found AC3 (0x0104)
Fri Nov  9 00:37:11 [27277] using libavcodec.so.52.122.0 with 2 threads
Fri Nov  9 00:37:11 [27277] using codec H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10
Fri Nov  9 00:37:11 [27277] channel AXN_HD
Fri Nov  9 00:37:11 [27277] processing file 00001
Fri Nov  9 00:37:11 [27277] HDTV 1920x1080i25
Fri Nov  9 00:37:27 [27277] failed to open 00002.ts
Fri Nov  9 00:37:27 [27277] stop of recording (508)
Fri Nov  9 00:37:27 [27277] ALERT: stopping before end of broadcast
Fri Nov  9 00:37:27 [27277] processed time 1.74s, 562/0 frames, 322.8 fps, 12.9 pps
Actions
Copy link
 #4

Updated by MegaV0lt over 11 years ago

Um 0:37:11 will markad die 2.ts öffnen. Die gibt es aber noch gar nicht! Die 1.ts wird bis 1:03:00 geschrieben... Das kann doch eigentlich nicht sein?

Actions
Copy link
 #5

Updated by MegaV0lt over 11 years ago

Wieder der gleiche Fehler. Ein paar Aufnahmen haben geklappt und dann wieder Abbruch. Markad will die 00002.ts öffnen, obwohl die erst über 30 Minuten später angelegt wird...

Sun Nov 11 21:11:00 [19665] starting v0.1.5pre (32bit)
Sun Nov 11 21:11:00 [19665] on /mnt/data/video/The_Mentalist/High_School_Drama/2012-11-11.21.11.54-0.rec
Sun Nov 11 21:11:10 [19665] getting broadcast start from directory atime
Sun Nov 11 21:11:10 [19665] pre-timer 5m
Sun Nov 11 21:11:10 [19665] broadcast length 60m
Sun Nov 11 21:11:10 [19665] found H264-video (0x00ff)
Sun Nov 11 21:11:10 [19665] found AC3 (0x0103)
Sun Nov 11 21:11:10 [19665] using libavcodec.so.52.122.0 with 2 threads
Sun Nov 11 21:11:10 [19665] using codec H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10
Sun Nov 11 21:11:10 [19665] channel SAT_1_HD
Sun Nov 11 21:11:10 [19665] processing file 00001
Sun Nov 11 21:11:10 [19665] HDTV 1920x1080i25
Sun Nov 11 21:11:11 [19665] detected logo start (40)*
Sun Nov 11 21:11:27 [19665] failed to open 00002.ts
Sun Nov 11 21:11:27 [19665] stop of recording (512)
Sun Nov 11 21:11:27 [19665] ALERT: stopping before end of broadcast
Sun Nov 11 21:11:27 [19665] processed time 1.65s, 549/0 frames, 332.1 fps, 13.3 pps

Actions
Copy link
 #6

Updated by Joe_D over 11 years ago

Passiert das auch wenn markad auf die Aufnahme nachträglich angewendet wird?

Actions
Copy link
 #7

Updated by MegaV0lt over 11 years ago

Nein, hier die logs:

Fri Nov  9 21:35:00 [25164] starting v0.1.5pre (32bit)
Fri Nov  9 21:35:00 [25164] on /mnt/data/video/Hawthorne/Dunkle_Freuden/2012-11-09.21.35.55-0.rec
Fri Nov  9 21:35:11 [25164] getting broadcast start from directory atime
Fri Nov  9 21:35:11 [25164] pre-timer 10m
Fri Nov  9 21:35:11 [25164] broadcast length 41m
Fri Nov  9 21:35:11 [25164] found H264-video (0x03ff)
Fri Nov  9 21:35:11 [25164] found AC3 (0x0403)
Fri Nov  9 21:35:11 [25164] using libavcodec.so.52.122.0 with 2 threads
Fri Nov  9 21:35:11 [25164] using codec H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10
Fri Nov  9 21:35:11 [25164] channel SIXX_HD
Fri Nov  9 21:35:11 [25164] processing file 00001
Fri Nov  9 21:35:11 [25164] HDTV 1920x1080i25
Fri Nov  9 21:35:11 [25164] failed to open 00002.ts
Fri Nov  9 21:35:11 [25164] processed time 0.94s, 201/0 frames, 214.0 fps, 8.6 pps

und nach manuellem Start "hdvdr01 ~ # markad -v -R - /video/Hawthorne/Dunkle_Freuden/2012-11-09.21.35.55-0.rec/
" 
Mon Nov 12 14:17:10 [3760] starting v0.1.5pre (32bit)
Mon Nov 12 14:17:10 [3760] on /mnt/data/video/Hawthorne/Dunkle_Freuden/2012-11-09.21.35.55-0.rec
Mon Nov 12 14:17:10 [3760] getting broadcast start from directory atime
Mon Nov 12 14:17:10 [3760] pre-timer 10m
Mon Nov 12 14:17:10 [3760] broadcast length 41m
Mon Nov 12 14:17:10 [3760] found H264-video (0x03ff)
Mon Nov 12 14:17:10 [3760] found AC3 (0x0403)
Mon Nov 12 14:17:10 [3760] using libavcodec.so.52.122.0 with 2 threads
Mon Nov 12 14:17:10 [3760] using codec H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10
Mon Nov 12 14:17:10 [3760] channel SIXX_HD
Mon Nov 12 14:17:10 [3760] processing file 00001
Mon Nov 12 14:17:10 [3760] HDTV 1920x1080i25
Mon Nov 12 14:17:13 [3760] detected logo start (854)*
Mon Nov 12 14:17:57 [3760] audio channel change from 2 to 6 (19830)*
Mon Nov 12 14:18:53 [3760] checking start
Mon Nov 12 14:18:53 [3760] DolbyDigital5.1 audio detected. logo/border/aspect detection disabled
Mon Nov 12 14:18:53 [3760] aspectratio of 16:9 detected
Mon Nov 12 14:18:53 [3760] using mark on position 19830 as start mark
Mon Nov 12 14:19:00 [3760] processing file 00002
Mon Nov 12 14:19:14 [3760] audio channel change from 6 to 2 (79410)
Mon Nov 12 14:19:16 [3760] audio channel change from 2 to 6 (82614)*
Mon Nov 12 14:19:21 [3760] checking stop
Mon Nov 12 14:19:21 [3760] assuming stop (85122)
Mon Nov 12 14:19:21 [3760] index doesn't match marks, sorry you're lost
Mon Nov 12 14:19:21 [3760] 2nd pass
Mon Nov 12 14:19:21 [3760] processing file 00001 (before mark 79410)
Mon Nov 12 14:19:26 [3760] processing file 00001 (after mark 82614)
Mon Nov 12 14:19:37 [3760] processed time 147.25s, 91643/5556 frames, 660.1 fps, 26.4 pps

Es betrifft aber nicht jede Aufnahme. Kann ein Zufall sein...

Actions
Copy link
 #8

Updated by MegaV0lt over 11 years ago

Was komisch ist, dass immer nach 27 Sekunden versucht wird die zweite Datei zu öffnen. Kannst Du da noch mehr Debug-Ausgaben einbauen? Vieleicht reicht es ja schon einfach ein wenig zu warten, wenn markad denkt die Aufnahme wird gesplittet?

Wed Nov 14 23:10:00 [4057] starting v0.1.5pre (32bit)
Wed Nov 14 23:10:00 [4057] on /mnt/data/video/Suburgatory/Der_Mutter-Blues/2012-11-14.23.10.56-0.rec
Wed Nov 14 23:10:10 [4057] getting broadcast start from directory atime
Wed Nov 14 23:10:10 [4057] pre-timer 5m
Wed Nov 14 23:10:10 [4057] broadcast length 28m
Wed Nov 14 23:10:10 [4057] found H264-video (0x01ff)
Wed Nov 14 23:10:10 [4057] found AC3 (0x0203)
Wed Nov 14 23:10:10 [4057] using libavcodec.so.52.122.0 with 2 threads
Wed Nov 14 23:10:10 [4057] using codec H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10
Wed Nov 14 23:10:10 [4057] channel ProSieben_HD
Wed Nov 14 23:10:10 [4057] processing file 00001
Wed Nov 14 23:10:11 [4057] HDTV 1920x1080i25
Wed Nov 14 23:10:11 [4057] detected logo start (84)*
Wed Nov 14 23:10:27 [4057] failed to open 00002.ts
Wed Nov 14 23:10:27 [4057] stop of recording (540)
Wed Nov 14 23:10:27 [4057] ALERT: stopping before end of broadcast
Wed Nov 14 23:10:27 [4057] processed time 2.03s, 592/0 frames, 292.2 fps, 11.7 pps
Actions
Copy link
 #9

Updated by MegaV0lt over 11 years ago

Any idea?

Wed Nov 14 23:10:00 [4057] starting v0.1.5pre (32bit)
Wed Nov 14 23:10:00 [4057] on /mnt/data/video/Suburgatory/Der_Mutter-Blues/2012-11-14.23.10.56-0.rec
Wed Nov 14 23:10:10 [4057] getting broadcast start from directory atime
Wed Nov 14 23:10:10 [4057] pre-timer 5m
Wed Nov 14 23:10:10 [4057] broadcast length 28m
Wed Nov 14 23:10:10 [4057] found H264-video (0x01ff)
Wed Nov 14 23:10:10 [4057] found AC3 (0x0203)
Wed Nov 14 23:10:10 [4057] using libavcodec.so.52.122.0 with 2 threads
Wed Nov 14 23:10:10 [4057] using codec H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10
Wed Nov 14 23:10:10 [4057] channel ProSieben_HD
Wed Nov 14 23:10:10 [4057] processing file 00001
Wed Nov 14 23:10:11 [4057] HDTV 1920x1080i25
Wed Nov 14 23:10:11 [4057] detected logo start (84)*
Wed Nov 14 23:10:27 [4057] failed to open 00002.ts
Wed Nov 14 23:10:27 [4057] stop of recording (540)
Wed Nov 14 23:10:27 [4057] ALERT: stopping before end of broadcast
Wed Nov 14 23:10:27 [4057] processed time 2.03s, 592/0 frames, 292.2 fps, 11.7 pps

Actions
Copy link
 #10

Updated by MegaV0lt over 11 years ago 

Mon Nov 19 10:55:01 [4442] starting v0.1.5pre (32bit)
Mon Nov 19 10:55:01 [4442] on /mnt/data/video/Lass_es,_Larry!/The_Safe_House/2012-11-19.10.55.5-0.rec
Mon Nov 19 10:55:11 [4442] broadcast aspectratio 16:9 (from info)
Mon Nov 19 10:55:11 [4442] getting broadcast start from directory atime
Mon Nov 19 10:55:11 [4442] no logo found, logo detection disabled
Mon Nov 19 10:55:11 [4442] marks can/will be weak!
Mon Nov 19 10:55:11 [4442] pre-timer 4m
Mon Nov 19 10:55:11 [4442] broadcast length 30m
Mon Nov 19 10:55:11 [4442] found H264-video (0x04ff)
Mon Nov 19 10:55:11 [4442] found AC3 (0x0504)
Mon Nov 19 10:55:11 [4442] using libavcodec.so.52.122.0 with 2 threads
Mon Nov 19 10:55:11 [4442] using codec H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10
Mon Nov 19 10:55:11 [4442] channel Sky_Atlantic_HD
Mon Nov 19 10:55:11 [4442] processing file 00001
Mon Nov 19 10:55:11 [4442] HDTV 1920x1080i25
Mon Nov 19 10:55:27 [4442] failed to open 00002.ts
Mon Nov 19 10:55:27 [4442] stop of recording (472)
Mon Nov 19 10:55:27 [4442] ALERT: stopping before end of broadcast
Mon Nov 19 10:55:27 [4442] processed time 1.69s, 535/0 frames, 317.4 fps, 12.7 pps

the last one, It seems to affect all channels with h.264 signal. What can be the reason? File locked? I have vdr 1.7.31 running
Actions
Copy link
 #11

Updated by Joe_D over 11 years ago

  • File vdr-markad-0.1.5pre.tgz added
  • % Done changed from 20 to 30

please try attached version...

Actions
Copy link
 #12

Updated by MegaV0lt over 11 years ago

OK, i try and will report! Thanks!

Actions
Copy link
 #13

Updated by MegaV0lt over 11 years ago

Have a recording running for a few minutes. Interesting new log:

Tue Nov 20 10:55:01 [8879] starting v0.1.5pre (32bit)
Tue Nov 20 10:55:01 [8879] on /mnt/data/video/Lass_es,_Larry!/Palestinian_Chicken/2012-11-20.10.55.5-0.rec
Tue Nov 20 10:55:11 [8879] broadcast aspectratio 16:9 (from info)
Tue Nov 20 10:55:11 [8879] getting broadcast start from directory atime
Tue Nov 20 10:55:11 [8879] no logo found, logo detection disabled
Tue Nov 20 10:55:11 [8879] marks can/will be weak!
Tue Nov 20 10:55:11 [8879] pre-timer 4m
Tue Nov 20 10:55:11 [8879] broadcast length 30m
Tue Nov 20 10:55:11 [8879] found H264-video (0x04ff)
Tue Nov 20 10:55:11 [8879] found AC3 (0x0504)
Tue Nov 20 10:55:11 [8879] using libavcodec.so.52.122.0 with 2 threads
Tue Nov 20 10:55:11 [8879] using codec H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10
Tue Nov 20 10:55:11 [8879] channel Sky_Atlantic_HD
Tue Nov 20 10:55:26 [8879] got errno 0 while waiting for new data
Tue Nov 20 10:55:26 [8879] processing file 00001
Tue Nov 20 10:55:26 [8879] HDTV 1920x1080i25
Tue Nov 20 10:55:42 [8879] got errno 0 while waiting for new data
Tue Nov 20 10:55:58 [8879] got errno 0 while waiting for new data
Tue Nov 20 10:56:14 [8879] got errno 0 while waiting for new data
Tue Nov 20 10:56:30 [8879] got errno 0 while waiting for new data
Tue Nov 20 10:56:47 [8879] got errno 0 while waiting for new data
Tue Nov 20 10:57:04 [8879] got errno 0 while waiting for new data
Tue Nov 20 10:57:21 [8879] got errno 0 while waiting for new data
Tue Nov 20 10:57:37 [8879] got errno 0 while waiting for new data
Tue Nov 20 10:57:53 [8879] got errno 0 while waiting for new data
Tue Nov 20 10:58:09 [8879] got errno 0 while waiting for new data
Tue Nov 20 10:58:26 [8879] got errno 0 while waiting for new data
Tue Nov 20 10:58:42 [8879] got errno 0 while waiting for new data
Tue Nov 20 10:58:58 [8879] got errno 0 while waiting for new data
Tue Nov 20 10:59:15 [8879] got errno 0 while waiting for new data
Tue Nov 20 10:59:31 [8879] got errno 0 while waiting for new data
Tue Nov 20 10:59:47 [8879] got errno 0 while waiting for new data
Tue Nov 20 11:00:03 [8879] got errno 0 while waiting for new data
Is still recording:!http://i.imgur.com/YYpCE.png!

Actions
Copy link
 #14

Updated by Joe_D over 11 years ago

  • File vdr-markad-0.1.5pre.tgz added

Ups, errno=0 should'nt be logged. Please try the fixed version attached...

Actions
Copy link
 #15

Updated by Joe_D over 11 years ago

  • File deleted (vdr-markad-0.1.5pre.tgz)
Actions
Copy link
 #16

Updated by MegaV0lt over 11 years ago

Ok, i try the new Version. All recordings yesterday have got marks. Some have goterrno 2 and some goterrno25, but marks ok. i report what happens with the new verion.

Actions
Copy link
 #17

Updated by MegaV0lt over 11 years ago

Again. Nothing new to sse in the logs:

Wed Nov 21 20:08:01 [15570] starting v0.1.5pre (32bit)
Wed Nov 21 20:08:01 [15570] on /mnt/data/video/Once_Upon_A_Time_-_Es_war_einmal..#2E/Das_Biest_und_die_Schöne/2012-11-21.20.08.72-0.rec
Wed Nov 21 20:08:11 [15570] getting broadcast start from directory atime
Wed Nov 21 20:08:11 [15570] pre-timer 6m
Wed Nov 21 20:08:11 [15570] broadcast length 55m
Wed Nov 21 20:08:11 [15570] found H264-video (0x012c)
Wed Nov 21 20:08:11 [15570] found AC3 (0x0136)
Wed Nov 21 20:08:11 [15570] using libavcodec.so.52.122.0 with 2 threads
Wed Nov 21 20:08:11 [15570] using codec H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10
Wed Nov 21 20:08:11 [15570] channel SUPER_RTL_HD
Wed Nov 21 20:08:26 [15570] processing file 00001
Wed Nov 21 20:08:26 [15570] HDTV 1920x1080i25
Wed Nov 21 20:08:26 [15570] H264 video stream with filler nalu (0x012c)
Wed Nov 21 20:08:29 [15570] failed to open 00002.ts
Wed Nov 21 20:08:29 [15570] skipped 621236 bytes
Wed Nov 21 20:08:29 [15570] processed time 2.62s, 311/0 frames, 118.8 fps, 4.8 pps

Only one out of ten recordings have this effect.

Actions
Copy link
 #18

Updated by MegaV0lt over 11 years ago

Recordin still running. got decoding error, but doeas not semm to affect markad.

Thu Nov 22 10:35:01 [4948] starting v0.1.5pre (32bit)
Thu Nov 22 10:35:01 [4948] on /mnt/data/video/Breakout_Kings/2012.11.22-10#3A40-Do/2012-11-22.10.35.18-0.rec
Thu Nov 22 10:35:11 [4948] broadcast aspectratio 4:3 (from info)
Thu Nov 22 10:35:11 [4948] getting broadcast start from directory atime
Thu Nov 22 10:35:11 [4948] no logo found, logo detection disabled
Thu Nov 22 10:35:11 [4948] marks can/will be weak!
Thu Nov 22 10:35:11 [4948] pre-timer 4m
Thu Nov 22 10:35:11 [4948] broadcast length 50m
Thu Nov 22 10:35:11 [4948] found H262-video (0x06ff)
Thu Nov 22 10:35:11 [4948] using libavcodec.so.52.122.0 with 2 threads
Thu Nov 22 10:35:11 [4948] using codec MPEG-2 video
Thu Nov 22 10:35:11 [4948] channel RTL_Crime
Thu Nov 22 10:35:11 [4948] processing file 00001
Thu Nov 22 10:35:11 [4948] SDTV 720x576i25
*Thu Nov 22 10:35:11 [4948] error decoding video*
Thu Nov 22 10:42:18 [4948] checking start
Thu Nov 22 10:42:18 [4948] video aspect description in info (4:3) wrong
Thu Nov 22 10:42:18 [4948] aspectratio of 16:9 detected
Thu Nov 22 10:42:18 [4948] assuming start (7476)

Actions
Copy link
 #19

Updated by MegaV0lt over 11 years ago

Until now all recordings have marks. Some have errno2 and one like this:

Wed Nov 21 00:33:00 [25843] starting v0.1.5pre (32bit)
Wed Nov 21 00:33:00 [25843] on /mnt/data/video/Southland/Voller_Einsatz/2012-11-21.00.33.57-0.rec
Wed Nov 21 00:33:10 [25843] getting broadcast start from directory atime
Wed Nov 21 00:33:10 [25843] pre-timer 5m
Wed Nov 21 00:33:10 [25843] broadcast length 52m
Wed Nov 21 00:33:10 [25843] found H264-video (0x02ff)
Wed Nov 21 00:33:10 [25843] found AC3 (0x0303)
Wed Nov 21 00:33:10 [25843] using libavcodec.so.52.122.0 with 2 threads
Wed Nov 21 00:33:10 [25843] using codec H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10
Wed Nov 21 00:33:10 [25843] channel kabel_eins_HD
Wed Nov 21 00:33:25 [25843] got errno 0 while waiting for new data
Wed Nov 21 00:33:25 [25843] processing file 00001
Wed Nov 21 00:33:25 [25843] HDTV 1920x1080i25
Wed Nov 21 00:33:26 [25843] detected logo start (28)*
Wed Nov 21 00:33:42 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:33:58 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:34:15 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:34:32 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:34:49 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:35:05 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:35:22 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:35:39 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:35:55 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:36:12 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:36:29 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:36:45 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:37:02 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:37:19 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:37:35 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:37:52 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:38:09 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:38:26 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:38:43 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:39:00 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:39:17 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:39:33 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:39:50 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:40:07 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:40:23 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:40:24 [25843] checking start
Wed Nov 21 00:40:24 [25843] DolbyDigital5.1 audio detected. logo/border/aspect detection disabled
Wed Nov 21 00:40:24 [25843] aspectratio of 16:9 detected
Wed Nov 21 00:40:24 [25843] assuming start (7504)
Wed Nov 21 00:40:39 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:40:54 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:41:10 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:41:25 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:41:41 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:41:56 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:42:12 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:42:27 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:42:43 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:42:59 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:43:14 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:43:30 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:43:45 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:44:01 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:44:17 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:44:32 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:44:48 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:45:03 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:45:19 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:45:34 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:45:49 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:46:05 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:46:20 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:46:36 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:46:51 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:47:07 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:47:22 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:47:37 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:47:53 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:48:08 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:48:24 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:48:39 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:48:55 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:49:10 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:49:26 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:49:42 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:49:57 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:50:13 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:50:28 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:50:44 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:50:59 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:51:14 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:51:30 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:51:46 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:52:01 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:52:17 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:52:33 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:52:48 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:53:04 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:53:19 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:53:34 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:53:50 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:54:05 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:54:21 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:54:36 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:54:51 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:55:07 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:55:22 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:55:38 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:55:53 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:56:08 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:56:24 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:56:39 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:56:55 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:57:10 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:57:25 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:57:41 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:57:56 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:58:12 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:58:27 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:58:27 [25843] audio channel change from 6 to 2 (37644)
Wed Nov 21 00:58:43 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:58:58 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:59:14 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:59:29 [25843] got errno 2 while waiting for new data
Wed Nov 21 00:59:44 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:00:00 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:00:15 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:00:31 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:00:46 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:01:02 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:01:17 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:01:32 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:01:48 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:02:03 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:02:03 [25843] processing file 00002
Wed Nov 21 01:02:18 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:02:34 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:02:49 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:03:04 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:03:20 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:03:35 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:03:51 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:04:06 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:04:22 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:04:37 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:04:52 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:05:08 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:05:23 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:05:39 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:05:54 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:06:10 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:06:26 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:06:42 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:06:57 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:07:13 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:07:14 [25843] audio channel change from 2 to 6 (51028)*
Wed Nov 21 01:07:29 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:07:44 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:07:59 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:08:15 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:08:30 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:08:46 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:09:01 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:09:16 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:09:32 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:09:48 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:10:04 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:10:19 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:10:35 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:10:51 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:11:06 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:11:21 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:11:37 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:11:52 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:12:07 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:12:23 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:12:38 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:12:54 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:13:09 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:13:24 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:13:40 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:13:55 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:14:10 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:14:26 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:14:41 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:14:57 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:15:12 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:15:28 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:15:43 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:15:59 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:16:14 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:16:30 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:16:45 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:17:00 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:17:16 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:17:31 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:17:47 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:18:02 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:18:18 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:18:33 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:18:49 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:19:04 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:19:04 [25843] audio channel change from 6 to 2 (68416)
Wed Nov 21 01:19:19 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:19:35 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:19:50 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:20:06 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:20:21 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:20:37 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:20:52 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:21:08 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:21:23 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:21:39 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:21:54 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:22:10 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:22:10 [25843] audio channel change from 2 to 6 (73304)*
Wed Nov 21 01:22:25 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:22:41 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:22:56 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:23:12 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:23:27 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:23:43 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:23:58 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:24:13 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:24:29 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:24:44 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:24:59 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:25:15 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:25:30 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:25:46 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:26:01 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:26:16 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:26:32 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:26:47 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:27:02 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:27:18 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:27:33 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:27:48 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:28:04 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:28:19 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:28:35 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:28:50 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:29:05 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:29:21 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:29:36 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:29:51 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:30:07 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:30:23 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:30:23 [25843] audio channel change from 6 to 2 (85476)
Wed Nov 21 01:30:23 [25843] audio channel change from 2 to 6 (85668)*
Wed Nov 21 01:30:38 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:30:38 [25843] processing file 00003
Wed Nov 21 01:30:54 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:31:09 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:31:25 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:31:40 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:31:55 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:32:11 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:32:27 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:32:42 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:32:58 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:33:13 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:33:29 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:33:44 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:34:00 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:34:15 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:34:30 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:34:46 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:35:01 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:35:17 [25843] got errno 2 while waiting for new data
Wed Nov 21 01:35:17 [25843] assuming old recording (1)
Wed Nov 21 01:35:17 [25843] assuming old recording (1)
Wed Nov 21 01:35:17 [25843] assuming old recording (1)
Wed Nov 21 01:35:17 [25843] assuming old recording (1)
Wed Nov 21 01:35:17 [25843] assuming old recording (1)
Wed Nov 21 01:35:17 [25843] assuming old recording (1)
Wed Nov 21 01:35:17 [25843] assuming old recording (1)
Wed Nov 21 01:35:17 [25843] assuming old recording (1)
Wed Nov 21 01:35:17 [25843] assuming old recording (1)
Wed Nov 21 01:35:17 [25843] assuming old recording (1)
Wed Nov 21 01:35:17 [25843] assuming old recording (1)
Wed Nov 21 01:35:17 [25843] assuming old recording (1)
Wed Nov 21 01:35:17 [25843] assuming old recording (1)
Wed Nov 21 01:35:17 [25843] assuming old recording (1)
Wed Nov 21 01:35:17 [25843] assuming old recording (1)
Wed Nov 21 01:35:17 [25843] assuming old recording (1)
Wed Nov 21 01:35:17 [25843] assuming old recording (1)
Wed Nov 21 01:35:17 [25843] assuming old recording (1)
Wed Nov 21 01:35:17 [25843] assuming old recording (1)
Wed Nov 21 01:35:17 [25843] assuming old recording (1)
Wed Nov 21 01:35:17 [25843] assuming old recording (1)
Wed Nov 21 01:35:17 [25843] assuming old recording (1)
Wed Nov 21 01:35:17 [25843] assuming old recording (1)
Wed Nov 21 01:35:17 [25843] assuming old recording (1)
Wed Nov 21 01:35:17 [25843] assuming old recording (1)
Wed Nov 21 01:35:17 [25843] assuming old recording (1)
Wed Nov 21 01:35:17 [25843] failed to open 00004.ts
Wed Nov 21 01:35:17 [25843] checking stop
Wed Nov 21 01:35:17 [25843] using mark on position 85476 as stop mark
Wed Nov 21 01:35:17 [25843] writing info file
Wed Nov 21 01:35:17 [25843] 2nd pass
Wed Nov 21 01:35:17 [25843] processing file 00001 (before mark 37644)
Wed Nov 21 01:35:31 [25843] processing file 00002 (after mark 51028)
Wed Nov 21 01:36:10 [25843] processing file 00002 (before mark 68416)
Wed Nov 21 01:36:24 [25843] processing file 00002 (after mark 73304)
Wed Nov 21 01:36:59 [25843] processed time 3828.80s, 92941/22111 frames, 30.0 fps, 1.2 pps

Actions
Copy link
 #20

Updated by MegaV0lt over 11 years ago

Until now all recordings have got marks. in the log sometime is "index doesn't match" but this is a other problem.

Actions
Copy link
 #21

Updated by MegaV0lt over 11 years ago

Well, yesterday it happemned again:

Wed Nov 28 20:08:00 [20226] starting v0.1.5pre (32bit)
Wed Nov 28 20:08:00 [20226] on /mnt/data/video/Once_Upon_A_Time_-_Es_war_einmal..#2E/Fluch_und_Versöhnung/2012-11-28.20.08.72-0.rec
Wed Nov 28 20:08:10 [20226] getting broadcast start from directory atime
Wed Nov 28 20:08:10 [20226] pre-timer 7m
Wed Nov 28 20:08:10 [20226] broadcast length 55m
Wed Nov 28 20:08:10 [20226] found H264-video (0x012c)
Wed Nov 28 20:08:10 [20226] found AC3 (0x0136)
Wed Nov 28 20:08:10 [20226] using libavcodec.so.52.122.0 with 2 threads
Wed Nov 28 20:08:10 [20226] using codec H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10
Wed Nov 28 20:08:10 [20226] channel SUPER_RTL_HD
Wed Nov 28 20:08:25 [20226] processing file 00001
Wed Nov 28 20:08:26 [20226] HDTV 1920x1080i25
Wed Nov 28 20:08:26 [20226] detected logo start (28)*
Wed Nov 28 20:08:26 [20226] H264 video stream with filler nalu (0x012c)
Wed Nov 28 20:08:29 [20226] failed to open 00002.ts
Wed Nov 28 20:08:29 [20226] stop of recording (313)
Wed Nov 28 20:08:29 [20226] ALERT: stopping before end of broadcast
Wed Nov 28 20:08:29 [20226] skipped 142941 bytes
Wed Nov 28 20:08:29 [20226] processed time 3.79s, 331/0 frames, 87.4 fps, 3.5 pps

Actions
Copy link
 #22

Updated by MegaV0lt over 11 years ago

Again. Strange, that ther is no extra messages in the log:

Wed Dec  5 20:08:02 [18690] starting v0.1.5pre (32bit)
Wed Dec  5 20:08:02 [18690] on /mnt/data/video/Once_Upon_A_Time_-_Es_war_einmal..#2E/Jenseits_der_Träume/2012-12-05.20.08.72-0.rec
Wed Dec  5 20:08:12 [18690] getting broadcast start from directory atime
Wed Dec  5 20:08:12 [18690] pre-timer 6m
Wed Dec  5 20:08:12 [18690] broadcast length 55m
Wed Dec  5 20:08:12 [18690] found H264-video (0x012c)
Wed Dec  5 20:08:12 [18690] found AC3 (0x0136)
Wed Dec  5 20:08:12 [18690] using libavcodec.so.52.122.0 with 2 threads
Wed Dec  5 20:08:12 [18690] using codec H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10
Wed Dec  5 20:08:12 [18690] channel SUPER_RTL_HD
Wed Dec  5 20:08:12 [18690] processing file 00001
Wed Dec  5 20:08:12 [18690] HDTV 1920x1080i25
Wed Dec  5 20:08:28 [18690] H264 video stream with filler nalu (0x012c)
Wed Dec  5 20:08:30 [18690] failed to open 00002.ts
Wed Dec  5 20:08:30 [18690] skipped 1548592 bytes
Wed Dec  5 20:08:30 [18690] processed time 3.42s, 346/0 frames, 101.0 fps, 4.0 pps

Actions
Copy link
 #23

Updated by Joe_D over 11 years ago

Bitte die neue Testdatei ausprobieren...

Actions
Copy link
 #24

Updated by Joe_D over 11 years ago

  • File deleted (vdr-markad-0.1.5pre.tgz)
Actions
Copy link
 #25

Updated by MegaV0lt over 11 years ago

Vielen Dank für die neue Version. Test läuft...

Actions
Copy link
 #26

Updated by MegaV0lt over 11 years ago

Schon wieder. Neue Version (inkl. Plugin läuft):

Wed Dec 12 20:08:02 [15572] starting v0.1.5pre (32bit)
Wed Dec 12 20:08:02 [15572] on /mnt/data/video/Once_Upon_A_Time_-_Es_war_einmal..#2E/Wolfswinter/2012-12-12.20.08.72-0.rec
Wed Dec 12 20:08:12 [15572] getting broadcast start from directory atime
Wed Dec 12 20:08:12 [15572] pre-timer 6m
Wed Dec 12 20:08:12 [15572] broadcast length 55m
Wed Dec 12 20:08:12 [15572] found H264-video (0x012c)
Wed Dec 12 20:08:12 [15572] found AC3 (0x0136)
Wed Dec 12 20:08:12 [15572] using libavcodec.so.52.122.0 with 2 threads
Wed Dec 12 20:08:12 [15572] using codec H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10
Wed Dec 12 20:08:12 [15572] channel SUPER_RTL_HD
Wed Dec 12 20:08:27 [15572] processing file 00001
Wed Dec 12 20:08:27 [15572] HDTV 1920x1080i25
Wed Dec 12 20:08:27 [15572] H264 video stream with filler nalu (0x012c)
Wed Dec 12 20:08:29 [15572] failed to open 00002.ts
Wed Dec 12 20:08:29 [15572] skipped 665584 bytes
Wed Dec 12 20:08:29 [15572] processed time 2.72s, 320/0 frames, 117.5 fps, 4.7 pps
Seltsam, dass keine extra Logzeilen erscheinen. Bereits nach 2 Sekunden wird versucht das 000002.ts zu öffnen, das es natürlich noch nicht gibt.

Actions
Copy link
 #27

Updated by MegaV0lt over 11 years ago

Hier die gleiche Aufnahme mit manuellem Aufruf:

hdvdr01 ~ # markad -b -vvv -R - /video/Once_Upon_A_Time_-_Es_war_einmal..#2E/Wolfswinter/2012-12-12.20.08.72-0.rec/


Thu Dec 13 11:59:31 [15261] starting v0.1.5pre (32bit)
Thu Dec 13 11:59:31 [15261] on /mnt/data/video/Once_Upon_A_Time_-_Es_war_einmal..#2E/Wolfswinter/2012-12-12.20.08.72-0.rec
Thu Dec 13 11:59:31 [15261] getting broadcast start from directory atime
Thu Dec 13 11:59:31 [15261] pre-timer 6m
Thu Dec 13 11:59:31 [15261] broadcast length 55m
Thu Dec 13 11:59:31 [15261] found H264-video (0x012c)
Thu Dec 13 11:59:31 [15261] found AC3 (0x0136)
Thu Dec 13 11:59:31 [15261] using libavcodec.so.52.122.0 with 2 threads
Thu Dec 13 11:59:31 [15261] libavcodec config: --prefix=/usr --libdir=/usr/lib --shlibdir=/usr/lib --mandir=/usr/share/man --enable-shared --cc=i686-pc-linux-gnu-gcc --disable-static --enable-gpl --enable-version3 --enable-postproc --enable-avfilter --disable-stripping --disable-debug --disable-doc --disable-optimizations --enable-runtime-cpudetect --enable-libmp3lame --enable-libvo-aacenc --enable-libvo-amrwbenc --enable-libtheora --enable-libvorbis --enable-libx264 --enable-libxvid --enable-libfaac --enable-nonfree --enable-libdc1394 --enable-x11grab --enable-libfreetype --enable-pthreads --enable-libopencore-amrwb --enable-libopencore-amrnb --enable-libschroedinger --enable-libspeex --disable-ssse3 --disable-altivec --disable-avx --disable-mmx2 --disable-amd3dnow --disable-amd3dnowext --cpu=pentium3 --enable-hardcoded-tables
Thu Dec 13 11:59:31 [15261] using codec H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10
Thu Dec 13 11:59:31 [15261] channel SUPER_RTL_HD
Thu Dec 13 11:59:31 [15261] processing file 00001
Thu Dec 13 11:59:31 [15261] HDTV 1920x1080i25
Thu Dec 13 11:59:31 [15261] H264 video stream with filler nalu (0x012c)
Thu Dec 13 11:59:37 [15261] buffer TS2H264 usage:  91%
Thu Dec 13 11:59:37 [15261] buffer TS2H264 usage:  92%
Thu Dec 13 11:59:37 [15261] buffer TS2H264 usage:  93%
Thu Dec 13 12:00:06 [15261] detected logo start (3844)*
Thu Dec 13 12:00:17 [15261] audio channel change from 2 to 6 (5208)*
Thu Dec 13 12:01:19 [15261] checking start
Thu Dec 13 12:01:19 [15261] DolbyDigital5.1 audio detected. logo/border/aspect detection disabled
Thu Dec 13 12:01:19 [15261] aspectratio of 16:9 detected
Thu Dec 13 12:01:19 [15261] using mark on position 5208 as start mark
Thu Dec 13 12:01:40 [15261] processing file 00002
Thu Dec 13 12:01:47 [15261] audio channel change from 6 to 2 (25942)
Thu Dec 13 12:01:56 [15261] buffer TS2H264 usage:  91%
Thu Dec 13 12:01:56 [15261] buffer TS2H264 usage:  92%
Thu Dec 13 12:02:00 [15261] buffer TS2H264 usage:  91%
Thu Dec 13 12:02:00 [15261] buffer TS2H264 usage:  92%
Thu Dec 13 12:02:00 [15261] buffer TS2H264 usage:  93%
Thu Dec 13 12:02:00 [15261] buffer TS2H264 usage:  94%
Thu Dec 13 12:02:00 [15261] buffer TS2H264 usage:  95%
Thu Dec 13 12:02:00 [15261] buffer TS2H264 usage:  96%
Thu Dec 13 12:02:00 [15261] audio channel change from 2 to 6 (32065)*
Thu Dec 13 12:02:20 [15261] audio channel change from 6 to 2 (40863)
Thu Dec 13 12:02:32 [15261] processing file 00003
Thu Dec 13 12:02:34 [15261] buffer TS2H264 usage:  91%
Thu Dec 13 12:02:34 [15261] buffer TS2H264 usage:  92%
Thu Dec 13 12:02:34 [15261] buffer TS2H264 usage:  93%
Thu Dec 13 12:02:34 [15261] buffer TS2H264 usage:  94%
Thu Dec 13 12:02:34 [15261] buffer TS2H264 usage:  95%
Thu Dec 13 12:02:34 [15261] buffer TS2H264 usage:  96%
Thu Dec 13 12:02:34 [15261] audio channel change from 2 to 6 (46703)*
Thu Dec 13 12:02:36 [15261] audio channel change from 6 to 2 (48010)
Thu Dec 13 12:02:37 [15261] audio channel change from 2 to 6 (48127)*
Thu Dec 13 12:02:46 [15261] buffer TS2H264 usage:  91%
Thu Dec 13 12:02:46 [15261] buffer TS2H264 usage:  92%
Thu Dec 13 12:02:46 [15261] buffer TS2H264 usage:  93%
Thu Dec 13 12:02:46 [15261] buffer TS2H264 usage:  94%
Thu Dec 13 12:02:46 [15261] buffer TS2H264 usage:  95%
Thu Dec 13 12:02:46 [15261] buffer TS2H264 usage:  96%
Thu Dec 13 12:02:46 [15261] buffer TS2H264 usage:  97%
Thu Dec 13 12:02:46 [15261] buffer TS2H264 usage:  98%
Thu Dec 13 12:02:46 [15261] buffer TS2H264 usage:  99%
Thu Dec 13 12:02:46 [15261] buffer TS2H264 full
Thu Dec 13 12:02:51 [15261] failed to open 00004.ts
Thu Dec 13 12:02:51 [15261] stop of recording (54912)
Thu Dec 13 12:02:51 [15261] index doesn't match marks, sorry you're lost
Thu Dec 13 12:02:51 [15261] 2nd pass
Thu Dec 13 12:02:51 [15261] processing file 00001 (before mark 25942)
Thu Dec 13 12:02:53 [15261] H264 video stream with filler nalu (0x012c)
Thu Dec 13 12:03:04 [15261] processing file 00001 (after mark 32065)
Thu Dec 13 12:03:06 [15261] H264 video stream with filler nalu (0x012c)
Thu Dec 13 12:03:43 [15261] processing file 00001 (before mark 40863)
Thu Dec 13 12:03:48 [15261] H264 video stream with filler nalu (0x012c)
Thu Dec 13 12:03:58 [15261] processing file 00002 (after mark 46703)
Thu Dec 13 12:04:11 [15261] H264 video stream with filler nalu (0x012c)
Thu Dec 13 12:04:36 [15261] processing file 00001 (before mark 48010)
Thu Dec 13 12:04:36 [15261] processing file 00002 (before mark 48010)
Thu Dec 13 12:04:50 [15261] processing file 00002 (after mark 48127)
Thu Dec 13 12:04:57 [15261] H264 video stream with filler nalu (0x012c)
Thu Dec 13 12:05:29 [15261] skipped 42865774 bytes
Thu Dec 13 12:05:29 [15261] processed time 358.37s, 54931/16842 frames, 200.3 fps, 8.0 pps
Thu Dec 13 12:05:29 [15261] buffer usage  : DEMUX             3%
Thu Dec 13 12:05:29 [15261] buffer skipped: TS2H264         5840026 bytes
Thu Dec 13 12:05:29 [15261] buffer usage  : TS2H264         100%
Thu Dec 13 12:05:29 [15261] buffer skipped: TS2PES AC3      368 bytes
Thu Dec 13 12:05:29 [15261] buffer usage  : TS2PES AC3       19%
Thu Dec 13 12:05:29 [15261] buffer skipped: PES2AC3         3072 bytes
Thu Dec 13 12:05:29 [15261] buffer usage  : PES2AC3          23%
Vielleicht hilft es ja was.

Actions
Copy link
 #28

Updated by MegaV0lt over 11 years ago

Beim Anschauen ist mir dann aufgefallen, dass die Marken von oben zwar gesetz wurden, aber leider an der "halben" Position.

Actions
Copy link
 #29

Updated by Joe_D over 11 years ago

  • Priority changed from High to Normal

Welche VDR-Version verwendest Du? Bei HD ist es am Besten VDR >= 1.7.32 zu verwenden! Da wurden viele Fixes gemacht hinsichtlich Frameerkennung, desweiteren ist der "Bug" markad-HD-Marke nicht auf I-Frame dort auch behoben.

Actions
Copy link
 #30

Updated by MegaV0lt over 11 years ago

Ich verwende 1.7.32 mit extp. Dist ist Gen2VDR V3.
Wenn die 1.7.33 mit extp für Gen2VDR zur Verfügung steht, werde ich updaten.

Momentan sieht es (noch) so aus, als ob nur Super RTL HD betroffen wäre...

Mit der 1.7.32 bekomme ich im Syslog oft "mark ... aligned by x frames" angezeigt

Actions
Copy link
 #31

Updated by Joe_D over 11 years ago

Thu Dec 13 12:02:46 [15261] buffer TS2H264 full
Thu Dec 13 12:02:51 [15261] failed to open 00004.ts

Erhöhe bitte mal den Wert 524288 in Zeile 1355 von demux.cpp auf 655360 und lass es nochmals über die Aufnahme 'Wolfswinter' laufen.

Actions
Copy link
 #32

Updated by MegaV0lt over 11 years ago

Die Aufnahme habe in inzwischen nicht mehr. Die Änderung habe ich eingebaut. Buffer full kam ja nur bei manuellem Aufruf. Beim Check während der Aufnahme hat der Abbruch ja schon vorher stattgefunden.

Actions
Copy link
 #33

Updated by MegaV0lt over 11 years ago

Mit der Änderung in der demux.cpp:

Wed Dec 19 20:08:02 [16863] starting v0.1.5pre (32bit)
Wed Dec 19 20:08:02 [16863] on /mnt/data/video/Once_Upon_A_Time_-_Es_war_einmal..#2E/Finsternis_im_Herzen/2012-12-19.20.08.72-0.rec
Wed Dec 19 20:08:12 [16863] getting broadcast start from directory atime
Wed Dec 19 20:08:12 [16863] pre-timer 6m
Wed Dec 19 20:08:12 [16863] broadcast length 55m
Wed Dec 19 20:08:12 [16863] found H264-video (0x012c)
Wed Dec 19 20:08:12 [16863] found AC3 (0x0136)
Wed Dec 19 20:08:12 [16863] using libavcodec.so.52.122.0 with 2 threads
Wed Dec 19 20:08:12 [16863] using codec H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10
Wed Dec 19 20:08:12 [16863] channel SUPER_RTL_HD
Wed Dec 19 20:08:27 [16863] processing file 00001
Wed Dec 19 20:08:27 [16863] HDTV 1920x1080i25
Wed Dec 19 20:08:29 [16863] H264 video stream with filler nalu (0x012c)
Wed Dec 19 20:08:30 [16863] failed to open 00002.ts
Wed Dec 19 20:08:30 [16863] skipped 539409 bytes
Wed Dec 19 20:08:30 [16863] processed time 3.19s, 331/0 frames, 103.9 fps, 4.2 pps
Keine Veränderung ;(

Warum will markad die 00002.ts drei Sekunden nach der 00001.ts öffnen? Das ist mir unverständlich!

Actions
Copy link
 #34

Updated by MegaV0lt over 11 years ago

War 2 Wochen Im Urlaub.

Keine Änderung:

Wed Jan  2 20:08:01 [5236] starting v0.1.5pre (32bit)
Wed Jan  2 20:08:01 [5236] on /mnt/data/video/Once_Upon_A_Time_-_Es_war_einmal..#2E/Der_Hutmacher/2013-01-02.20.08.72-0.rec
Wed Jan  2 20:08:11 [5236] getting broadcast start from directory atime
Wed Jan  2 20:08:11 [5236] pre-timer 7m
Wed Jan  2 20:08:11 [5236] broadcast length 55m
Wed Jan  2 20:08:11 [5236] found H264-video (0x012c)
Wed Jan  2 20:08:11 [5236] found AC3 (0x0136)
Wed Jan  2 20:08:11 [5236] using libavcodec.so.52.122.0 with 2 threads
Wed Jan  2 20:08:11 [5236] using codec H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10
Wed Jan  2 20:08:11 [5236] channel SUPER_RTL_HD
Wed Jan  2 20:08:11 [5236] processing file 00001
Wed Jan  2 20:08:11 [5236] HDTV 1920x1080i25
Wed Jan  2 20:08:11 [5236] H264 video stream with filler nalu (0x012c)
Wed Jan  2 20:08:11 [5236] detected logo start (15)*
Wed Jan  2 20:08:28 [5236] failed to open 00002.ts
Wed Jan  2 20:08:28 [5236] stop of recording (313)
Wed Jan  2 20:08:28 [5236] ALERT: stopping before end of broadcast
Wed Jan  2 20:08:28 [5236] skipped 389470 bytes
Wed Jan  2 20:08:28 [5236] processed time 2.44s, 333/0 frames, 136.2 fps, 5.4 pps

Ich mache jetzt mal die Git-Version drauf, da die inzwischen aktueller ist.

Actions
Copy link
 #35

Updated by MegaV0lt over 11 years ago

Mit der aktuellen GIT-Versiojn auch Abbruch. So wie es aussieht aber momentan immer nur bei SuperRTL HD

Wed Jan  9 20:08:00 [9786] starting v0.1.5pre (32bit)
Wed Jan  9 20:08:00 [9786] on /mnt/data/video/Once_Upon_A_Time_-_Es_war_einmal..#2E/Schmetterlingseffekt/2013-01-09.20.08.72-0.rec
Wed Jan  9 20:08:10 [9786] getting broadcast start from directory atime
Wed Jan  9 20:08:10 [9786] pre-timer 7m
Wed Jan  9 20:08:10 [9786] broadcast length 55m
Wed Jan  9 20:08:10 [9786] found H264-video (0x012c)
Wed Jan  9 20:08:10 [9786] found AC3 (0x0136)
Wed Jan  9 20:08:10 [9786] using libavcodec.so.52.122.0 with 2 threads
Wed Jan  9 20:08:10 [9786] using codec H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10
Wed Jan  9 20:08:10 [9786] channel SUPER_RTL_HD
Wed Jan  9 20:08:10 [9786] processing file 00001
Wed Jan  9 20:08:11 [9786] HDTV 1920x1080i25
Wed Jan  9 20:08:26 [9786] detected logo start (14)*
Wed Jan  9 20:08:27 [9786] H264 video stream with filler nalu (0x012c)
Wed Jan  9 20:08:28 [9786] failed to open 00002.ts
Wed Jan  9 20:08:28 [9786] stop of recording (311)
Wed Jan  9 20:08:28 [9786] ALERT: stopping before end of broadcast
Wed Jan  9 20:08:28 [9786] skipped 363150 bytes
Wed Jan  9 20:08:28 [9786] processed time 2.42s, 334/0 frames, 138.0 fps, 5.5 pps

Actions
Copy link
 #36

Updated by MegaV0lt over 11 years ago 

Wed Jan 16 20:08:00 [18537] starting v0.1.5pre (32bit)
Wed Jan 16 20:08:00 [18537] on /mnt/data/video/Once_Upon_A_Time_-_Es_war_einmal..#2E/Die_Rückkehr_und_die_Fragen/2013-01-16.20.08.71-0.rec
Wed Jan 16 20:08:10 [18537] getting broadcast start from directory atime
Wed Jan 16 20:08:10 [18537] pre-timer 7m
Wed Jan 16 20:08:10 [18537] broadcast length 55m
Wed Jan 16 20:08:10 [18537] found H264-video (0x012c)
Wed Jan 16 20:08:10 [18537] found AC3 (0x0136)
Wed Jan 16 20:08:10 [18537] using libavcodec.so.52.122.0 with 2 threads
Wed Jan 16 20:08:10 [18537] using codec H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10
Wed Jan 16 20:08:10 [18537] channel SUPER_RTL_HD
Wed Jan 16 20:08:25 [18537] processing file 00001
Wed Jan 16 20:08:25 [18537] HDTV 1920x1080i25
Wed Jan 16 20:08:26 [18537] detected logo start (72)*
Wed Jan 16 20:08:27 [18537] H264 video stream with filler nalu (0x012c)
Wed Jan 16 20:08:28 [18537] failed to open 00002.ts
Wed Jan 16 20:08:28 [18537] stop of recording (308)
Wed Jan 16 20:08:28 [18537] ALERT: stopping before end of broadcast
Wed Jan 16 20:08:28 [18537] skipped 95295 bytes
Wed Jan 16 20:08:28 [18537] processed time 2.51s, 325/0 frames, 129.6 fps, 5.2 pps
Immer das gleiche. Kannst Du mal versuchen ein paar Logmeldungen einzubauen? Es kann doch nicht sein, dass schon nach 20 Sekunden die 2. Datei gesucht wird, obwohl noch in die erste aufgenommen wird... Eventuell hilft es ja in solch einem Fall einfach länger zu warten...
Actions
Copy link
 #37

Updated by satellit over 11 years ago

Bei mir sehen die Abbrüche so aus.
Jan 18 23:00:50 ReelBox noadcall.sh: using markad for HD recording.
Jan 18 23:00:50 ReelBox markad: [1116] starting v0.1.5pre (32bit)
Jan 18 23:00:50 ReelBox markad: [1116] on /media/hd0/recordings/Irgendwann_in_Mexico/2012-11-26.22.13.8-0.rec
Jan 18 23:00:50 ReelBox markad: [1116] getting broadcast start from info mtime
Jan 18 23:00:50 ReelBox markad: [1116] broadcast start truncated by 11m, length will be corrected
Jan 18 23:00:50 ReelBox markad: [1116] broadcast length 104m
Jan 18 23:00:50 ReelBox vdr: [2527] info: Markiere Werbung in 'Irgendwann in Mexico'
Jan 18 23:00:50 ReelBox vdr: [2527] connect from 127.0.0.1, port 33321 - accepted
Jan 18 23:00:50 ReelBox vdr: [2527] closing SVDRP connection
Jan 18 23:00:51 ReelBox markad: [1116] found H264-video (0x02ff)
Jan 18 23:00:51 ReelBox markad: [1116] found AC3 (0x0303)
Jan 18 23:00:51 ReelBox markad: [1116] using libavcodec.so.52.20.1 with 2 threads
Jan 18 23:00:51 ReelBox markad: [1116] using codec H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10
Jan 18 23:00:51 ReelBox markad: [1116] channel kabel_eins_HD
Jan 18 23:00:51 ReelBox markad: [1116] processing file 00001
Jan 18 23:00:51 ReelBox markad: [1116] HDTV 1920x1080i25
Jan 18 23:00:51 ReelBox markad: [1116] detected logo start (28)*
Jan 18 23:00:51 ReelBox vdr: [2527] connect from 127.0.0.1, port 33322 - accepted
Jan 18 23:00:51 ReelBox vdr: [2527] SVDRP message: 'Starte markad für 'Irgendwann in Mexico''
Jan 18 23:00:52 ReelBox vdr: [2527] closing SVDRP connection
Jan 18 23:00:54 ReelBox vdr: [2527] info: Starte markad für 'Irgendwann in Mexico'
Jan 18 23:00:56 ReelBox markad: [1116] sequence error 14->3 (0x02ff)
Jan 18 23:00:56 ReelBox markad: [1116] sequence error 12->1 (0x0303)
Jan 18 23:00:56 ReelBox markad: [1116] broken TS in queue, skipping
Jan 18 23:00:56 ReelBox markad: [1116] error demuxing

Actions
Copy link
 #38

Updated by MegaV0lt over 11 years ago

Wenn ich markad nach beendigung der Aufnahme manuell starte, dann werden marken gesetz. Allerdings haben die dann alle die "halbe Zeit" Siehe http://projects.vdr-developer.org/issues/1108#note-28

Actions
Copy link
 #39

Updated by satellit over 11 years ago

Das ist bei mir anders. Wenn ich markad per Hand starte, wird markad ebenfalls abgebrochen.

Actions
Copy link
 #40

Updated by MegaV0lt over 11 years ago

Immer wieder der gleiche Fehler:

Wed Jan 23 20:08:01 [612] starting v0.1.5pre (32bit)
Wed Jan 23 20:08:01 [612] on /mnt/data/video/Once_Upon_A_Time_-_Es_war_einmal..#2E/Emmas_Bürde/2013-01-23.20.08.71-0.rec
Wed Jan 23 20:08:11 [612] getting broadcast start from directory atime
Wed Jan 23 20:08:11 [612] pre-timer 7m
Wed Jan 23 20:08:11 [612] broadcast length 55m
Wed Jan 23 20:08:11 [612] found H264-video (0x012c)
Wed Jan 23 20:08:11 [612] found AC3 (0x0136)
Wed Jan 23 20:08:11 [612] using libavcodec.so.52.122.0 with 2 threads
Wed Jan 23 20:08:11 [612] using codec H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10
Wed Jan 23 20:08:11 [612] channel SUPER_RTL_HD
Wed Jan 23 20:08:26 [612] processing file 00001
Wed Jan 23 20:08:26 [612] HDTV 1920x1080i25
Wed Jan 23 20:08:26 [612] H264 video stream with filler nalu (0x012c)
Wed Jan 23 20:08:28 [612] failed to open 00002.ts
Wed Jan 23 20:08:28 [612] skipped 254224 bytes
Wed Jan 23 20:08:28 [612] processed time 2.68s, 326/0 frames, 121.4 fps, 4.9 pps
Manuelles setzen der Marken bringt auch nichts, weil die dann an der halben Zeit liegen. Hängt wohl alles zusammen. Ich nehmen jetzt ein 15 Minuten Teststück auf und lade es gleich hoch. Vielleicht kannst Du den Stream ja auf Fehler analysieren? Es betrifft wohl auch nur SuperRTL HD...

Actions
Copy link
 #41

Updated by MegaV0lt over 11 years ago

Ich habe nun die Archive hoch geladen. Es ist eine 15 Minütige Aufnahme von SuperRTL_HD (Bob der Baumeister). Das markad-Log ist ähnlich wie oben. Ich habe den ganzen Aufnahme-Ordner gepackt (Zwei Teile). Hier die Links:

https://dl.dropbox.com/u/1490505/VDR/Bob_der_Baumeister_-_Achtung_Baustelle%21.z01 (700 MB)
https://dl.dropbox.com/u/1490505/VDR/Bob_der_Baumeister_-_Achtung_Baustelle%21.zip (407 MB)

Vielleicht kannst Du damit was anfangen. Ich vermute, dass markad den Stream falsch erkennt (darum die Marken an der halben Zeit) und darum versucht die 2. Datei zu öffnen, obwohl die ja noch gar nicht existiert.

Actions
Copy link
 #42

Updated by Joe_D over 10 years ago

Ist das immer noch so??

Actions
Copy link
 #43

Updated by MegaV0lt over 10 years ago

Am Schluss waren es nur noch Aufnahmen von SuperRTL HD. Im Oktober geht es bei "Once upon a time" weiter. Inzwischen habe ich Gen2VDR V4 und VDR 2.0.2 drauf. Auch das Ausgabedevice ist jetzt anders (TT S2-6400 -> GT610).

Konntest Du mir dem Beispiel Bob... was anfangen?

Ich werde gleich mal eine Testaufnahme starten und berichten...

Actions
Copy link
 #44

Updated by MegaV0lt over 10 years ago

Sieht schlecht aus:

Wed Aug  7 17:50:21 [10138] starting v0.1.5pre (64bit)
Wed Aug  7 17:50:21 [10138] on /mnt/data/video/Go_Wild!_-_Mission_Wildnis/Pollenflug!/2013-08-07.17.40.72-0.rec
Wed Aug  7 17:50:31 [10138] getting broadcast start from directory atime
Wed Aug  7 17:50:31 [10138] broadcast start truncated by 5m, length will be corrected
Wed Aug  7 17:50:31 [10138] broadcast length 24m
Wed Aug  7 17:50:31 [10138] found H264-video (0x012c)
Wed Aug  7 17:50:31 [10138] found AC3 (0x0136)
Wed Aug  7 17:50:31 [10138] using libavcodec.so.54.92.100 with 2 threads
Wed Aug  7 17:50:31 [10138] using codec H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10
Wed Aug  7 17:50:31 [10138] channel SUPER_RTL_HD
Wed Aug  7 17:50:46 [10138] processing file 00001
Wed Aug  7 17:50:46 [10138] HDTV 1920x1080i25
Wed Aug  7 17:50:46 [10138] H264 video stream with filler nalu (0x012c)
Wed Aug  7 17:50:46 [10138] detected logo start (48)*
Wed Aug  7 17:50:49 [10138] failed to open 00002.ts
Wed Aug  7 17:50:49 [10138] stop of recording (277)
Wed Aug  7 17:50:49 [10138] ALERT: stopping before end of broadcast
Wed Aug  7 17:50:49 [10138] skipped 420165 bytes
Wed Aug  7 17:50:49 [10138] processed time 3.67s, 292/0 frames, 79.6 fps, 3.2 pps
Wieder wird nach 00002.ts gesucht, obwohl die ja noch gar nicht existieren kann... http://i.imgur.com/U1sPskc.png
Actions
Copy link
 #45

Updated by MegaV0lt over 10 years ago

Inzwischen VDR 2.1.1 :

Wed Oct  9 20:08:00 [27207] starting v0.1.5pre (64bit)
Wed Oct  9 20:08:00 [27207] on /mnt/data/video/Once_Upon_A_Time_-_Es_war_einmal..#2E/Der_neue_Fluch_der_Freiheit/2013-10-09.20.08.73-0.rec
Wed Oct  9 20:08:10 [27207] getting broadcast start from directory atime
Wed Oct  9 20:08:10 [27207] pre-timer 7m
Wed Oct  9 20:08:10 [27207] broadcast length 55m
Wed Oct  9 20:08:10 [27207] found H264-video (0x012c)
Wed Oct  9 20:08:10 [27207] found AC3 (0x0136)
Wed Oct  9 20:08:10 [27207] using libavcodec.so.54.59.100 with 2 threads
Wed Oct  9 20:08:10 [27207] using codec H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10
Wed Oct  9 20:08:10 [27207] channel SUPER_RTL_HD
Wed Oct  9 20:08:25 [27207] processing file 00001
Wed Oct  9 20:08:25 [27207] H264 video stream with filler nalu (0x012c)
Wed Oct  9 20:08:25 [27207] HDTV 1920x1080i25
Wed Oct  9 20:08:25 [27207] duplicate packet, skipping (0x012c)
Wed Oct  9 20:08:26 [27207] detected logo start (17)*
Wed Oct  9 20:08:31 [27207] failed to open 00002.ts
Wed Oct  9 20:08:31 [27207] stop of recording (340)
Wed Oct  9 20:08:31 [27207] ALERT: stopping before end of broadcast
Wed Oct  9 20:08:31 [27207] skipped 4025152 bytes
Wed Oct  9 20:08:31 [27207] processed time 6.47s, 363/0 frames, 56.1 fps, 2.2 pps

Actions
Copy link
 #46

Updated by Joe_D over 10 years ago

  • % Done changed from 60 to 80

Bitte mal aktuelle GIT-Version probieren...

Actions
Copy link
 #47

Updated by MegaV0lt over 10 years ago

Ich habe eine kurze Testaufnahme gemacht:

Sun Oct 13 20:34:32 [25023] starting v0.1.5pre (5b1ab19) (64bit)
Sun Oct 13 20:34:32 [25023] on /mnt/data/video/Rüdiger_Hoffmann_live!_Sex_oder_Liebe/2013-10-13.20.10.73-0.rec
Sun Oct 13 20:34:42 [25023] getting broadcast start from directory atime
Sun Oct 13 20:34:42 [25023] broadcast start truncated by 19m, length will be corrected
Sun Oct 13 20:34:42 [25023] broadcast length 100m
Sun Oct 13 20:34:42 [25023] found H264-video (0x012c)
Sun Oct 13 20:34:42 [25023] found AC3 (0x0136)
Sun Oct 13 20:34:42 [25023] using libavcodec.so.54.59.100 with 2 threads
Sun Oct 13 20:34:42 [25023] using codec H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10
Sun Oct 13 20:34:42 [25023] channel SUPER_RTL_HD
Sun Oct 13 20:34:57 [25023] processing file 00001
Sun Oct 13 20:34:57 [25023] HDTV 1920x1080i25
Sun Oct 13 20:34:57 [25023] H264 video stream with filler nalu (0x012c)
Sun Oct 13 20:34:57 [25023] detected logo start (32)*
Sun Oct 13 20:34:57 [25023] duplicate packet, skipping (0x012c)
Sun Oct 13 20:36:48 [25023] checking start
Sun Oct 13 20:36:48 [25023] broadcast with 2 audio channels, disabling AC3 decoding
Sun Oct 13 20:36:48 [25023] aspectratio of 16:9 detected
Sun Oct 13 20:36:48 [25023] assuming start (32)
Sun Oct 13 20:38:35 [25023] detected logo stop (5507)
Sun Oct 13 20:44:22 [25023] detected logo start (14242)*
Sun Oct 13 20:44:55 [25023] sequence error 5->7 (0x012c)
Sun Oct 13 20:44:55 [25023] duplicate packet, skipping (0x012c)
Sun Oct 13 20:44:58 [25023] stream error bit set (0x012c)
Sun Oct 13 20:45:14 [25023] duplicate packet, skipping (0x012c)
Sun Oct 13 20:46:28 [25023] detected logo stop (17370)
Sun Oct 13 20:46:28 [25023] mark distance too short (125.1s), deleting 14242,17370
Sun Oct 13 20:46:44 [25023] detected logo start (17543)*
Sun Oct 13 20:59:56 [25023] detected logo stop (37435)
Sun Oct 13 21:05:37 [25023] processing file 00002
Sun Oct 13 21:05:54 [25023] detected logo start (46352)*
Sun Oct 13 21:34:51 [25023] detected logo stop (90046)
Sun Oct 13 21:36:55 [25023] processing file 00003
Sun Oct 13 21:40:33 [25023] detected logo start (98502)*
Sun Oct 13 21:50:16 [25023] recording interrupted, waiting for continuation...
Sun Oct 13 22:15:01 [25023] assuming old recording, now>startTime+length
Sun Oct 13 22:15:01 [25023] assuming old recording, now>startTime+length
Sun Oct 13 22:15:01 [25023] assuming old recording, now>startTime+length
Sun Oct 13 22:15:01 [25023] assuming old recording, now>startTime+length
Sun Oct 13 22:15:01 [25023] assuming old recording, now>startTime+length
Sun Oct 13 22:15:01 [25023] assuming old recording, now>startTime+length
Sun Oct 13 22:15:01 [25023] assuming old recording, now>startTime+length
Sun Oct 13 22:15:01 [25023] assuming old recording, now>startTime+length
Sun Oct 13 22:15:01 [25023] assuming old recording, now>startTime+length
Sun Oct 13 22:15:01 [25023] assuming old recording, now>startTime+length
Sun Oct 13 22:15:01 [25023] assuming old recording, now>startTime+length
Sun Oct 13 22:15:01 [25023] assuming old recording, now>startTime+length
Sun Oct 13 22:15:01 [25023] assuming old recording, now>startTime+length
Sun Oct 13 22:15:01 [25023] assuming old recording, now>startTime+length
Sun Oct 13 22:15:01 [25023] assuming old recording, now>startTime+length
Sun Oct 13 22:15:01 [25023] assuming old recording, now>startTime+length
Sun Oct 13 22:15:01 [25023] assuming old recording, now>startTime+length
Sun Oct 13 22:15:01 [25023] assuming old recording, now>startTime+length
Sun Oct 13 22:15:01 [25023] assuming old recording, now>startTime+length
Sun Oct 13 22:15:01 [25023] assuming old recording, now>startTime+length
Sun Oct 13 22:15:01 [25023] assuming old recording, now>startTime+length
Sun Oct 13 22:15:01 [25023] assuming old recording, now>startTime+length
Sun Oct 13 22:15:01 [25023] assuming old recording, now>startTime+length
Sun Oct 13 22:15:01 [25023] assuming old recording, now>startTime+length
Sun Oct 13 22:15:01 [25023] assuming old recording, now>startTime+length
Sun Oct 13 22:15:01 [25023] assuming old recording, now>startTime+length
Sun Oct 13 22:15:01 [25023] assuming old recording, now>startTime+length
Sun Oct 13 22:15:01 [25023] assuming old recording, now>startTime+length
Sun Oct 13 22:15:01 [25023] failed to open 00004.ts
Sun Oct 13 22:15:01 [25023] stop of recording (113078)
Sun Oct 13 22:15:01 [25023] writing info file
Sun Oct 13 22:15:01 [25023] 2nd pass
Sun Oct 13 22:15:01 [25023] processing file 00001 (before mark 5507)
Sun Oct 13 22:15:02 [25023] H264 video stream with filler nalu (0x012c)
Sun Oct 13 22:15:02 [25023] duplicate packet, skipping (0x012c)
Sun Oct 13 22:15:25 [25023] processing file 00001 (after mark 17543)
Sun Oct 13 22:15:25 [25023] duplicate packet, skipping (0x012c)
Sun Oct 13 22:15:25 [25023] H264 video stream with filler nalu (0x012c)
Sun Oct 13 22:16:33 [25023] processing file 00001 (before mark 37435)
Sun Oct 13 22:16:33 [25023] duplicate packet, skipping (0x012c)
Sun Oct 13 22:16:33 [25023] H264 video stream with filler nalu (0x012c)
Sun Oct 13 22:16:52 [25023] processing file 00002 (after mark 46352)
Sun Oct 13 22:16:52 [25023] H264 video stream with filler nalu (0x012c)
Sun Oct 13 22:16:57 [25023] duplicate packet, skipping (0x012c)
Sun Oct 13 22:17:58 [25023] processing file 00002 (before mark 90046)
Sun Oct 13 22:17:58 [25023] H264 video stream with filler nalu (0x012c)
Sun Oct 13 22:17:59 [25023] duplicate packet, skipping (0x012c)
Sun Oct 13 22:18:18 [25023] processing file 00003 (after mark 98502)
Sun Oct 13 22:18:18 [25023] H264 video stream with filler nalu (0x012c)
Sun Oct 13 22:18:22 [25023] duplicate packet, skipping (0x012c)
Sun Oct 13 22:19:13 [25023] skipped 497761992 bytes
Sun Oct 13 22:19:13 [25023] processed time 976.14s, 113132/33850 frames, 150.6 fps, 6.0 pps


Sieht gut aus. Ich werde das noch eine Weile beobachten.
Actions
Copy link
 #48

Updated by MegaV0lt over 10 years ago

Ich glaube nun geht es! Vielen Dank. Log vom Problemsender:

Wed Oct 16 20:08:01 [5669] starting v0.1.5pre (5b1ab19) (64bit)
Wed Oct 16 20:08:01 [5669] on /mnt/data/video/Once_Upon_A_Time_-_Es_war_einmal..#2E/Muttergefühle/2013-10-16.20.08.73-0.rec
Wed Oct 16 20:08:11 [5669] getting broadcast start from directory atime
Wed Oct 16 20:08:11 [5669] pre-timer 7m
Wed Oct 16 20:08:11 [5669] broadcast length 55m
Wed Oct 16 20:08:11 [5669] found H264-video (0x012c)
Wed Oct 16 20:08:11 [5669] found AC3 (0x0136)
Wed Oct 16 20:08:11 [5669] using libavcodec.so.54.59.100 with 2 threads
Wed Oct 16 20:08:11 [5669] using codec H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10
Wed Oct 16 20:08:11 [5669] channel SUPER_RTL_HD
Wed Oct 16 20:08:26 [5669] processing file 00001
Wed Oct 16 20:08:26 [5669] HDTV 1920x1080i25
Wed Oct 16 20:08:26 [5669] H264 video stream with filler nalu (0x012c)
Wed Oct 16 20:08:26 [5669] duplicate packet, skipping (0x012c)
Wed Oct 16 20:14:53 [5669] audio channel change from 2 to 6 (9980)*
Wed Oct 16 20:17:27 [5669] checking start
Wed Oct 16 20:17:27 [5669] DolbyDigital5.1 audio detected. logo/border/aspect detection disabled
Wed Oct 16 20:17:27 [5669] aspectratio of 16:9 detected
Wed Oct 16 20:17:27 [5669] using mark on position 9980 as start mark
Wed Oct 16 20:41:13 [5669] audio channel change from 6 to 2 (49108)
Wed Oct 16 20:45:47 [5669] processing file 00002
Wed Oct 16 20:47:33 [5669] audio channel change from 2 to 6 (58778)*
Wed Oct 16 20:59:27 [5669] audio channel change from 6 to 2 (76614)
Wed Oct 16 21:07:33 [5669] audio channel change from 2 to 6 (88666)*
Wed Oct 16 21:10:05 [5669] audio channel change from 6 to 2 (92466)
Wed Oct 16 21:15:53 [5669] checking stop
Wed Oct 16 21:15:53 [5669] using mark on position 92466 as stop mark
Wed Oct 16 21:15:53 [5669] 2nd pass
Wed Oct 16 21:15:53 [5669] processing file 00001 (before mark 49108)
Wed Oct 16 21:15:54 [5669] H264 video stream with filler nalu (0x012c)
Wed Oct 16 21:15:56 [5669] duplicate packet, skipping (0x012c)
Wed Oct 16 21:16:06 [5669] processing file 00002 (after mark 58778)
Wed Oct 16 21:16:06 [5669] duplicate packet, skipping (0x012c)
Wed Oct 16 21:16:06 [5669] H264 video stream with filler nalu (0x012c)
Wed Oct 16 21:16:56 [5669] processing file 00002 (before mark 76614)
Wed Oct 16 21:16:56 [5669] H264 video stream with filler nalu (0x012c)
Wed Oct 16 21:16:56 [5669] duplicate packet, skipping (0x012c)
Wed Oct 16 21:17:07 [5669] processing file 00002 (after mark 88666)
Wed Oct 16 21:17:07 [5669] H264 video stream with filler nalu (0x012c)
Wed Oct 16 21:17:08 [5669] duplicate packet, skipping (0x012c)
Wed Oct 16 21:17:56 [5669] skipped 417248352 bytes
Wed Oct 16 21:17:56 [5669] processed time 255.62s, 101519/22427 frames, 484.9 fps, 19.4 pps
Ist das mit den skipped bytes in Ordnung?

Actions
Copy link
 #49

Updated by Joe_D over 10 years ago

  • Status changed from Feedback to Closed
  • % Done changed from 80 to 100

Ist das mit den skipped bytes in Ordnung?

Ja, bei Sendern die Füllbytes verwenden (filler nalu). Die gleiche Sendung hätte auch mit ca. 400MB weniger Daten übertragen werden können.... Dafür gibt es glaube ich den "nalustripper"

Actions
Copy link

Also available in: Atom PDF