Bug #4012
Feature Request #3993 add Chapter to MKV for EIT p/f not working
Start date:
2016-10-05
Due date:
% Done:
0%
Estimated time:
Found in version:
v4.1-2249-g747ed01
Affected Versions:
Description
My feature request #3993 to add a chapter mark when using Accurate Recording to an MKV has been marked as fixed and implemented, but unfortunately it does not work.
No chapter mark is added to the MKV, however, Mediainfo shows a lone "Menu" item in the MKV - maybe the wrong thing is getting added to the MKV? See attached output from Mediainfo of the recorded MKV
Apologies for opening a new Issue but I have not received a response on the original request, presumably because it is marked as fixed.
Files
History
Updated by
Updated by Laurie Davis about 8 years ago
Updated by - File ffprobe-mkv.txt ffprobe-mkv.txt added
I've deleted this MKV but have recorded another and this one shows no sign of the "menu" item. Attached is the output of ffprobe (windows version as Libreelec doesn't seem to have it). No sign of any chapters in this file.
Updated by Jaroslav Kysela about 8 years ago
-show_chapters argument is missing like:
$ ffprobe -v error -show_format -show_streams -show_chapters /mnt/dvb/perex/Amerika.mkv [STREAM] index=0 codec_name=h264 codec_long_name=H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 profile=High codec_type=video codec_time_base=1/50 codec_tag_string=[0][0][0][0] codec_tag=0x0000 width=1920 height=1080 coded_width=1920 coded_height=1088 has_b_frames=2 sample_aspect_ratio=1:1 display_aspect_ratio=16:9 pix_fmt=yuv420p level=40 color_range=tv color_space=bt709 color_transfer=bt709 color_primaries=bt709 chroma_location=left timecode=N/A refs=4 is_avc=1 nal_length_size=4 id=N/A r_frame_rate=25/1 avg_frame_rate=25/1 time_base=1/1000 start_pts=16 start_time=0.016000 duration_ts=5850477 duration=5850.477000 bit_rate=N/A max_bit_rate=N/A bits_per_raw_sample=8 nb_frames=N/A nb_read_frames=N/A nb_read_packets=N/A DISPOSITION:default=1 DISPOSITION:dub=0 DISPOSITION:original=0 DISPOSITION:comment=0 DISPOSITION:lyrics=0 DISPOSITION:karaoke=0 DISPOSITION:forced=0 DISPOSITION:hearing_impaired=0 DISPOSITION:visual_impaired=0 DISPOSITION:clean_effects=0 DISPOSITION:attached_pic=0 TAG:language=eng [/STREAM] [STREAM] index=1 codec_name=ac3 codec_long_name=ATSC A/52A (AC-3) profile=unknown codec_type=audio codec_time_base=1/48000 codec_tag_string=[0][0][0][0] codec_tag=0x0000 sample_fmt=fltp sample_rate=48000 channels=2 channel_layout=stereo bits_per_sample=0 dmix_mode=-1 ltrt_cmixlev=-1.000000 ltrt_surmixlev=-1.000000 loro_cmixlev=-1.000000 loro_surmixlev=-1.000000 id=N/A r_frame_rate=0/0 avg_frame_rate=0/0 time_base=1/1000 start_pts=16 start_time=0.016000 duration_ts=N/A duration=N/A bit_rate=384000 max_bit_rate=N/A bits_per_raw_sample=N/A nb_frames=N/A nb_read_frames=N/A nb_read_packets=N/A DISPOSITION:default=1 DISPOSITION:dub=0 DISPOSITION:original=0 DISPOSITION:comment=0 DISPOSITION:lyrics=0 DISPOSITION:karaoke=0 DISPOSITION:forced=0 DISPOSITION:hearing_impaired=0 DISPOSITION:visual_impaired=0 DISPOSITION:clean_effects=0 DISPOSITION:attached_pic=0 TAG:language=cze [/STREAM] [STREAM] index=2 codec_name=ac3 codec_long_name=ATSC A/52A (AC-3) profile=unknown codec_type=audio codec_time_base=1/48000 codec_tag_string=[0][0][0][0] codec_tag=0x0000 sample_fmt=fltp sample_rate=48000 channels=2 channel_layout=stereo bits_per_sample=0 dmix_mode=-1 ltrt_cmixlev=-1.000000 ltrt_surmixlev=-1.000000 loro_cmixlev=-1.000000 loro_surmixlev=-1.000000 id=N/A r_frame_rate=0/0 avg_frame_rate=0/0 time_base=1/1000 start_pts=26 start_time=0.026000 duration_ts=N/A duration=N/A bit_rate=384000 max_bit_rate=N/A bits_per_raw_sample=N/A nb_frames=N/A nb_read_frames=N/A nb_read_packets=N/A DISPOSITION:default=1 DISPOSITION:dub=0 DISPOSITION:original=0 DISPOSITION:comment=0 DISPOSITION:lyrics=0 DISPOSITION:karaoke=0 DISPOSITION:forced=0 DISPOSITION:hearing_impaired=0 DISPOSITION:visual_impaired=0 DISPOSITION:clean_effects=0 DISPOSITION:attached_pic=0 TAG:language=qaa [/STREAM] [STREAM] index=3 codec_name=dvbsub codec_long_name=DVB subtitles profile=unknown codec_type=subtitle codec_time_base=1/1000 codec_tag_string=[0][0][0][0] codec_tag=0x0000 width=N/A height=N/A id=N/A r_frame_rate=0/0 avg_frame_rate=0/0 time_base=1/1000 start_pts=16 start_time=0.016000 duration_ts=5850477 duration=5850.477000 bit_rate=N/A max_bit_rate=N/A bits_per_raw_sample=N/A nb_frames=N/A nb_read_frames=N/A nb_read_packets=N/A DISPOSITION:default=1 DISPOSITION:dub=0 DISPOSITION:original=0 DISPOSITION:comment=0 DISPOSITION:lyrics=0 DISPOSITION:karaoke=0 DISPOSITION:forced=0 DISPOSITION:hearing_impaired=0 DISPOSITION:visual_impaired=0 DISPOSITION:clean_effects=0 DISPOSITION:attached_pic=0 TAG:language=cze [/STREAM] [CHAPTER] id=1 time_base=1/1000000000 start=57057000000 start_time=57.057000 end=4091457000000 end_time=4091.457000 [/CHAPTER] [CHAPTER] id=2 time_base=1/1000000000 start=4091457000000 start_time=4091.457000 end=4553677000000 end_time=4553.677000 [/CHAPTER] [CHAPTER] id=3 time_base=1/1000000000 start=4553677000000 start_time=4553.677000 end=5850493000000 end_time=5850.493000 [/CHAPTER] [FORMAT] filename=/mnt/dvb/perex/Amerika.mkv nb_streams=4 nb_programs=0 format_name=matroska,webm format_long_name=Matroska / WebM start_time=0.016000 duration=5850.477000 size=5272931547 bit_rate=7210258 probe_score=100 TAG:title=Amerika TAG:encoder=Tvheadend Matroska muxer TAG:DATE_BROADCASTED=2015-11-19 21:35:00 TAG:ORIGINAL_MEDIA_TYPE=TV TAG:CONTENT_TYPE=News / Current affairs TAG:TVCHANNEL=HBO HD TAG:SUMMARY=Čechokanaďanka Bára a muzikant Honza se vydávají na společnou toulku českou krajinou. Na své cestě, která vede stinnými lesy, přes prosluněné louky i pod jasnou noční oblohou, se pozvolna proplétají tuzemskou trampskou komunitou. Bich míst trampů, starých bezmála sto let. Film sleduje jejich cestu do země svobody, kde kulisou je jen les, oheň a širé nebe. Sami na sobě zakoušejí únik do imaginární Ameriky, s každým dalším setkáním či zážitkem se jejich cesta proměňuje v univerzální příběh přátelství, hudby a snů o svobodě. Režie: Jan Foukal (2015) TAG:SUMMARY-cze=Čechokanaďanka Bára a muzikant Honza se vydávají na společnou toulku českou krajinou. Na své cestě, která vede stinnými lesy, přes prosluněné louky i pod jasnou noční oblohou, se pozvolna proplétají tuzemskou trampskou komunitou. Bich míst trampů, starých bezmála sto let. Film sleduje jejich cestu do země svobody, kde kulisou je jen les, oheň a širé nebe. Sami na sobě zakoušejí únik do imaginární Ameriky, s každým dalším setkáním či zážitkem se jejich cesta proměňuje v univerzální příběh přátelství, hudby a snů o svobodě. Režie: Jan Foukal (2015) [/FORMAT]
Updated by Laurie Davis about 8 years ago
Still not showing any chapters
C:\Video\ffmpeg-20161011-8063978-win64-static\bin>ffprobe -v error -show_format -show_streams -show_chapters "\\192.168.1.114\sda1-usb-WD_Elements_10A8\Recordings\US Presidential Debate Highlights\US Presidential Debate Highlights (BBC TWOHD) 2016-10-10 11-00 .mkv" [h264 @ 000000000035c160] mmco: unref short failure [STREAM] message repeated 1 times index=0 codec_name=h264 codec_long_name=H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 profile=High codec_type=video codec_time_base=1/50 codec_tag_string=[0][0][0][0] codec_tag=0x0000 width=1920 height=1080 coded_width=1920 coded_height=1080 has_b_frames=3 sample_aspect_ratio=1:1 display_aspect_ratio=16:9 pix_fmt=yuv420p level=40 color_range=tv color_space=bt709 color_transfer=bt709 color_primaries=bt709 chroma_location=left timecode=N/A refs=1 is_avc=true nal_length_size=4 id=N/A r_frame_rate=25/1 avg_frame_rate=25/1 time_base=1/1000 start_pts=1313 start_time=1.313000 duration_ts=N/A duration=N/A bit_rate=N/A max_bit_rate=N/A bits_per_raw_sample=8 nb_frames=N/A nb_read_frames=N/A nb_read_packets=N/A DISPOSITION:default=1 DISPOSITION:dub=0 DISPOSITION:original=0 DISPOSITION:comment=0 DISPOSITION:lyrics=0 DISPOSITION:karaoke=0 DISPOSITION:forced=0 DISPOSITION:hearing_impaired=0 DISPOSITION:visual_impaired=0 DISPOSITION:clean_effects=0 DISPOSITION:attached_pic=0 TAG:language=eng [/STREAM] [STREAM] index=1 codec_name=aac codec_long_name=AAC (Advanced Audio Coding) profile=LC codec_type=audio codec_time_base=1/48000 codec_tag_string=[0][0][0][0] codec_tag=0x0000 sample_fmt=fltp sample_rate=48000 channels=2 channel_layout=stereo bits_per_sample=0 id=N/A r_frame_rate=0/0 avg_frame_rate=0/0 time_base=1/1000 start_pts=0 start_time=0.000000 duration_ts=N/A duration=N/A bit_rate=N/A max_bit_rate=N/A bits_per_raw_sample=N/A nb_frames=N/A nb_read_frames=N/A nb_read_packets=N/A DISPOSITION:default=1 DISPOSITION:dub=0 DISPOSITION:original=0 DISPOSITION:comment=0 DISPOSITION:lyrics=0 DISPOSITION:karaoke=0 DISPOSITION:forced=0 DISPOSITION:hearing_impaired=0 DISPOSITION:visual_impaired=0 DISPOSITION:clean_effects=0 DISPOSITION:attached_pic=0 TAG:language=eng [/STREAM] [STREAM] index=2 codec_name=dvb_subtitle codec_long_name=DVB subtitles profile=unknown codec_type=subtitle codec_time_base=0/1 codec_tag_string=[0][0][0][0] codec_tag=0x0000 width=N/A height=N/A id=N/A r_frame_rate=0/0 avg_frame_rate=0/0 time_base=1/1000 start_pts=2816 start_time=2.816000 duration_ts=N/A duration=N/A bit_rate=N/A max_bit_rate=N/A bits_per_raw_sample=N/A nb_frames=N/A nb_read_frames=N/A nb_read_packets=N/A DISPOSITION:default=1 DISPOSITION:dub=0 DISPOSITION:original=0 DISPOSITION:comment=0 DISPOSITION:lyrics=0 DISPOSITION:karaoke=0 DISPOSITION:forced=0 DISPOSITION:hearing_impaired=0 DISPOSITION:visual_impaired=0 DISPOSITION:clean_effects=0 DISPOSITION:attached_pic=0 TAG:language=eng [/STREAM] [FORMAT] filename=\\192.168.1.114\sda1-usb-WD_Elements_10A8\Recordings\US Presidential Debate Highlights\US Presidential Debate H ighlights (BBC TWO HD) 2016-10-10 11-00 .mkv nb_streams=3 nb_programs=0 format_name=matroska,webm format_long_name=Matroska / WebM start_time=0.000000 duration=4380.553000 size=1982885249 bit_rate=3621251 probe_score=100 TAG:title=US Presidential Debate Highlights TAG:encoder=Tvheadend Matroska muxer TAG:DATE_BROADCASTED=2016-10-10 11:00:00 TAG:ORIGINAL_MEDIA_TYPE=TV TAG:CONTENT_TYPE=News / Current affairs TAG:TVCHANNEL=BBC TWO HD TAG:SUMMARY=Highlights from the presidential debate between Hillary Clinton and Donald Trump. [HD] [S] TAG:SUMMARY-eng=Highlights from the presidential debate between Hillary Clinton and Donald Trump. [HD] [S] [/FORMAT]
Updated by Jaroslav Kysela about 8 years ago
It works here. Upgrade to v4.1-2275-gea1f43f and provide log from tvh for the problematic recordings. There should be dvr: EPG lines.
$ ffprobe -show_chapters ~/git/tvheadend/dvr/2016-10-12/Scott\ i\ Bailey\ 1\ \(odc.\ 5\).mkv [CHAPTER] id=1 time_base=1/1000000000 start=2023600000000 start_time=2023.600000 end=2083280000000 end_time=2083.280000 [/CHAPTER] [CHAPTER] id=2 time_base=1/1000000000 start=2083280000000 start_time=2083.280000 end=2139760000000 end_time=2139.760000 [/CHAPTER] [CHAPTER] id=3 time_base=1/1000000000 start=2139760000000 start_time=2139.760000 end=2148253000000 end_time=2148.253000 [/CHAPTER]
Updated by Laurie Davis about 8 years ago
- File TVHlog-131016.zip TVHlog-131016.zip added
I've upgraded to 2275 but still not working.
Attached is a log with a DVR trace (if that helps) and ffprobe of the mkv file. There are no "DVR: EPG" entries in the log. Also attached is a screenshot of the recording profile - is there anything that needs to be set to make this work that I'm missing? I have pre-record padding at 3 mins, post padding at 10 mins and "Use EPG Running State" unticked. So recording should start 3 mins before the EIT change. It seems odd that it works for you but not for me.
Let me know if you need any more logs.
Thanks
Updated by Jaroslav Kysela about 8 years ago
I don't see 'BBC ONE HD' in the list of channels providing EITp/f. Try another channel.
2016-10-13 11:41:31.664 [ TRACE]:dvr: dvr event running check for 5 News At Lunchtime on Channel 5 HD running 0 2016-10-13 11:41:31.730 [ TRACE]:dvr: dvr event running check for The Dog Ate My Homework on CBBC HD running 0 2016-10-13 11:41:32.086 [ TRACE]:dvr: dvr event running check for Anzio on Film4+1 running 0 2016-10-13 11:41:32.676 [ TRACE]:dvr: dvr event running check for The Wright Stuff on Channel 5 HD running 0 2016-10-13 11:41:32.676 [ TRACE]:dvr: dvr event running check for New: House Doctor on Channel 5 HD running 2 2016-10-13 11:41:32.733 [ TRACE]:dvr: dvr event running check for Naomi's Nightmares of Nature on CBBC HD running 0 2016-10-13 11:41:32.733 [ TRACE]:dvr: dvr event running check for Junior Bake Off on CBBC HD running 2 2016-10-13 11:41:33.097 [ TRACE]:dvr: dvr event running check for Teleshopping on Film4+1 running 2
Updated by Laurie Davis about 8 years ago
So I tried a recording on CBBC HD - and it worked! Two chapters, one at the start and one at the end point. However, this is now really weird. There are three channels on that same mux that are not appearing in the TVH debug log with the "dvr event running check" - BBC ONE HD, BBC TWO HD and ITV HD. These channels definitely, definitely use Accurate Recording as I use it all the time on my PVR. SO I'm not sure why TVH isn't checking them. Any ideas or any suggestions on what further traces I can do to check this?
Updated by Laurie Davis about 8 years ago
So I think this is now fixed 
I removed all channels from that mux, then all services and then the mux itself. I then added it back and re-scanned the channels, and now the trace shows it checking the EPG running status of those missing channels. A few test recordings and the chapter mark is being added exactly as the broadcaster sends the start signal - excellent stuff!
One question - when does the chapter mark get added to the file? Is it when the EPG change occurs or does TVH save them till the end of recording and then add them? I ask because I tried playing one of the test recordings back while it was still in progress and there were no chapter marks. They only appeared when the recording finished.
Thanks again for all your help
Updated by Jaroslav Kysela about 8 years ago
The chapter blocks are created immediately, but the index table is written as last (on close) to the file (for matroska).
The question remains why tvh didn't detect EITp/f for your three channels before new scan. Do you have a config backup for the old mux to analyze this? The backups should be created automatically in the <tvh_config_dir>/backup directory.
Updated by Laurie Davis about 8 years ago
I can't find a backup directory for TVH - this is running on Libreelec, and I've looked under the addons folder and the userdata one as well. Doing a Find from root for anything called 'backup' doesn't find anything either.
The only thing odd about those channels was that those were the ones I initially mapped when I was setting up TVH for the first time on the RPI3. The others were mapped later. I think I was using 2267 when I mapped them, but today I redid them using 2275.
Updated by Mark Clarkstone about 8 years ago
Updated by Jaroslav Kysela wrote:
The chapter blocks are created immediately, but the index table is written as last (on close) to the file (for matroska).
The question remains why tvh didn't detect EITp/f for your three channels before new scan. Do you have a config backup for the old mux to analyze this? The backups should be created automatically in the <tvh_config_dir>/backup directory.
Just thought I'd pop in and post what I'd experienced with these changes.
A recording on BBC One HD and BBC One E Mids (at the same time but diff mux) had no bookmarks according to Kodi. These were both added at 21:51, 21:53 and started at 22:00, maybe I added them too late?
I also recorded two back to back episodes of an old game show on Challenge, both recorded almost as expected and had bookmarks, but and I'm not sure this was intended, both had a bookmark for the ending of the previous programme.
Basically it went..
- Tvheadend starts recording (near end of current programme).
- Current programme ends, bookmark created (on end production info/ident).
- Programme (that we want to record) starts, bookmark created.
- Adbreak starts (half way into the programme), bookmark created.
- Adbreak ends, programme resumes, bookmark created.
- Programme is near end, adbreak starts, bookmark created.
- Adbreak ends, programme resumes, bookmark created.
- Programme finishes (credits roll), bookmark created (on end production info/ident).
This to me looks as intended, (I'm a little surprised that Challenge (for a Sky owned channel) actually sent flags on adbreaks) :o, Tvheadends EITp/f is certainly a better than it was (not that it was bad to begin with it was just a bit buggy on some channels).
I'm wondering whether or not the reason the flags on BBC One weren't detected was because of an epg conflict (I have three ota grabbers enabled), but then again if that was the case Challenge would have the same problem? shrug.
If I was able I would upload 2 hours worth of a mux (for two muxes) but I can't as I have no fixed line broadband at the moment and having to use a mobile dongle.
Anyway, (and I know I keep saying this) I really appreciate everything you put into Tvheadend Jaroslav (and yes I'm still working on the docs while being 'offline' :))
------------------
@Laurie: I'm pretty sure that libreelec (just like openelec) uses the -B argument to prevent backups.
Updated by Jaroslav Kysela about 8 years ago
Could you try upgrade to v4.1-2278-g398cf2c and do "--trace tbl-eit,dvr" ? Look for the channel which does not work (there should be lines with ch='<name>' and running= strings).
Updated by Mark Clarkstone about 8 years ago
Jaroslav Kysela wrote:
Could you try upgrade to v4.1-2278-g398cf2c and do "--trace tbl-eit,dvr" ? Look for the channel which does not work (there should be lines with ch='<name>' and running= strings).
BBC One E Mid (channel that doesn't create bookmarks) : http://pastebin.com/raw/7ZXN9NmS
CBS Reality (It should work) : http://pastebin.com/raw/kvEuQ99i
Challenge (It does work on this one): http://pastebin.com/raw/wQBpFkSV
Hope these are what you are after.
Actually, scrap that, I think you may want to see the dvr lines too, not just the eit table (should have realised this as you asked for dvr trace too, damn lack of sleep!), will record and post another ASAP.
Updated by Laurie Davis about 8 years ago
Now that I have this working on my setup, I've turned my attention to how I want to play these files back, and have hit another small problem. My aim is to watch the recorded programmes in Kodi using the TVH PVR client. I want to be able to start playback, press the "skip forward" button which should skip to the next chapter, so that I am immediately at the chapter marker for the start of the program. However, this doesn't quite work. What happens is that Kodi just jumps forward 20 secs at each press of the skip forward - until it is past the first chapter marker. The next press then takes me to the next chapter (ie, the end of the programme, or the first commercial break, depending on how the broadcaster has flagged it).
I believe the problem is that there is no initial chapter right at the start of the recording. It seems that before it has reached any chapters, Kodi is unaware of them and so only does a 20 second skip.
So Jaroslav, would it be possible for TVH to add a chapter right at the start of the recording (ie 00:00:00)? I think this will then fix it.
Thanks
Updated by Mark Clarkstone about 8 years ago
I did a little investigating and this is the result (took me a while to sift through the 800mb log file):
Programme: James Martin: Home Comforts
Start/End: 11:30am/12:00pm
Padding Pre/Post: 10mins/10mins
Duration: 50m (inc padding + 30s warmup)
Eid: 65455 (based om the start/stop unix stamps which are UTC, but tvheadend correctly adds an hour to the value)
Status (and this is just a guess):
- 0 = Not running?
- 1 = Next?
- 4 = Running?
Adding the entry and Recording starting..
2016-10-15 10:09:14.674 [ TRACE]:dvr: entry 1ef387f9e54dbd7e3a05af993d73b6e6 - assign broadcast 2525 2016-10-15 10:09:14.674 [ TRACE]:dvr: entry 1ef387f9e54dbd7e3a05af993d73b6e6 start 2016-10-15;11:19:30(+0100) stop 2016-10-15;12:10:00(+0100) - set timer 2016-10-15 10:09:14.674 [ TRACE]:dvr: entry 1ef387f9e54dbd7e3a05af993d73b6e6 start 2016-10-15;11:19:30(+0100) - set timer - schedule 2016-10-15 10:09:14.674 [ INFO]:dvr: entry 1ef387f9e54dbd7e3a05af993d73b6e6 "James Martin: Home Comforts" on "BBC One E Mid" starting at 2016-10-15 11:19:30, scheduled for recording by "192.168.1.104" 2016-10-15 11:20:00.037 [ TRACE]:dvr: entry 1ef387f9e54dbd7e3a05af993d73b6e6 - set state - state RECORDING rec_state RUNNING error 'OK' 2016-10-15 11:20:00.038 [ TRACE]:dvr: entry 1ef387f9e54dbd7e3a05af993d73b6e6 - set state - state RECORDING rec_state WAIT error 'OK' 2016-10-15 11:20:00.038 [ DEBUG]:dvr: File "/md0/tvheadend/dvr/BBC One E Mid/James Martin_ Home Comforts2016-10-1511-30.mkv" -- No such file or directory -- Using for recording 2016-10-15 11:20:00.068 [ INFO]:dvr: /md0/tvheadend/dvr/BBC One E Mid/James Martin_ Home Comforts2016-10-1511-30.mkv from adapter: "Sony CXD2820R : DVB-T #0", network: "DVB-T - Waltham", mux: "698MHz", provider: "<N/A>", service: "BBC ONE E Mid" 2016-10-15 11:20:00.068 [ INFO]:dvr: # type lang resolution aspect ratio sample rate channels 2016-10-15 11:20:00.068 [ INFO]:dvr: 1 MPEG2VIDEO 704x576 16:9 2016-10-15 11:20:00.068 [ INFO]:dvr: 2 MPEG2AUDIO eng 48000 2 2016-10-15 11:20:00.068 [ INFO]:dvr: 3 MPEG2AUDIO eng ? ? <disabled, no valid input> 2016-10-15 11:20:00.068 [ TRACE]:dvr: entry 1ef387f9e54dbd7e3a05af993d73b6e6 - set state - state RECORDING rec_state RUNNING error 'OK'
Recording end log - first thing I noticed was the rstart/stop values, is that correct?
2016-10-15 12:10:00.001 [ TRACE]:dvr: entry 1ef387f9e54dbd7e3a05af993d73b6e6 rstart 1970-01-01;01:00:00(+0100) rstop 1970-01-01;01:00:00(+0100) - stop recording timer called 2016-10-15 12:10:00.086 [ INFO]:subscription: 0073: "DVR: James Martin: Home Comforts" unsubscribing from "BBC One E Mid" 2016-10-15 12:10:00.154 [ TRACE]:dvr: entry 1ef387f9e54dbd7e3a05af993d73b6e6 - set state - state COMPLETED rec_state FINISHED error 'OK' 2016-10-15 12:10:00.154 [ TRACE]:dvr: entry 1ef387f9e54dbd7e3a05af993d73b6e6 - retention timer - disarm 2016-10-15 12:10:00.154 [ INFO]:dvr: "James Martin: Home Comforts" on "BBC One E Mid": End of program: Completed OK 2016-10-15 12:10:00.154 [ TRACE]:dvr: entry 1ef387f9e54dbd7e3a05af993d73b6e6 - retention timer - disarm
tbl-eit log lines (using shitty regex to filter):
2016-10-15 10:11:27.234 [ TRACE]:tbl-eit: svc='BBC One E Mid', ch='BBC One E Mid', eid=65455, tbl=60, running=0, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:19:32.004 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:19:34.028 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:19:36.019 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:19:36.164 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=50, running=0, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:19:37.995 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:19:40.036 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:19:41.558 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4f, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:19:42.032 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:19:44.056 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:19:46.032 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:19:48.001 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:19:50.024 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:19:52.024 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:19:54.039 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:19:56.016 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:19:58.007 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:20:00.069 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:20:02.038 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:20:04.000 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:20:06.053 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:20:07.998 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:20:10.008 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:20:12.013 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:20:14.029 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:20:16.052 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:20:18.004 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:20:20.060 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:20:22.028 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:20:24.012 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:20:26.013 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:20:28.011 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:20:30.026 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:20:32.026 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:20:34.044 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:20:36.029 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:20:38.033 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:20:40.025 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:20:41.993 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:20:44.008 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:20:46.024 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:20:48.008 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:20:50.027 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:20:52.008 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:20:54.015 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:20:55.999 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:20:58.030 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:21:00.054 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:21:02.014 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:21:04.007 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:21:06.013 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:21:07.998 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:21:10.045 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:21:12.006 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:21:14.020 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:21:16.044 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:21:18.020 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:21:20.027 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:21:22.020 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:21:24.035 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:21:26.003 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:21:28.026 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:21:30.066 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:21:32.034 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:21:34.018 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:21:36.011 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:21:38.041 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:21:40.034 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:21:42.025 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:21:44.040 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:21:46.000 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:21:48.008 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:21:50.031 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:21:52.031 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:21:54.001 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:21:56.015 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:21:58.008 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:22:00.022 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:22:02.015 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:22:04.015 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:22:06.030 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:22:08.021 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:22:10.037 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:22:12.005 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:22:14.052 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:22:16.028 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:22:18.022 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:22:20.028 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:22:22.019 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:22:24.043 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:22:26.028 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:22:28.050 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:22:30.050 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:22:32.034 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:22:34.014 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:22:36.081 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:22:38.041 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:22:40.014 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:22:42.057 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:22:44.064 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:22:46.675 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:22:48.009 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:22:50.033 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:22:52.023 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:22:54.023 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:22:56.132 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:22:58.038 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:23:00.031 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:23:02.046 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:23:04.018 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:23:06.037 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:23:08.029 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:23:10.037 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:23:12.053 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:23:14.068 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:23:16.044 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:23:18.036 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:23:20.059 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:23:22.020 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:23:24.043 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:23:26.005 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:23:28.287 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:23:30.013 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:23:32.050 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:23:34.015 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:23:36.012 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:23:36.596 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4f, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:23:38.026 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:23:40.032 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:23:42.009 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:23:44.016 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:23:46.025 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:23:48.039 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:23:50.024 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:23:52.026 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:23:54.093 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:23:56.015 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:23:58.047 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:24:00.015 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:24:02.024 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:24:04.078 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:24:06.014 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:24:08.053 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:24:10.053 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:24:12.021 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:24:14.044 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:24:16.014 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:24:18.013 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:24:20.042 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:24:22.028 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:24:24.022 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:24:26.043 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:24:28.029 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:24:30.059 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:25:54.047 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:28:26.038 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:28:36.050 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:28:38.026 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:28:48.025 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:28:48.267 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=60, running=0, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:28:50.064 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:29:50.051 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:30:44.072 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:30:46.033 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:32:56.040 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:32:58.070 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:33:24.052 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:33:26.075 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:33:28.059 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:33:30.059 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:33:40.065 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=1, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:33:41.042 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=4, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:33:43.058 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=4, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:33:45.049 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=4, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:33:45.622 [ TRACE]:tbl-eit: svc='BBC One E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=4, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:33:56.614 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4f, running=4, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:34:47.041 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=4, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:35:05.070 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=4, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:35:23.075 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=4, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:35:25.084 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=4, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:35:39.074 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=4, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:36:16.625 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4f, running=4, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:38:51.530 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=60, running=0, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:41:01.079 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=4, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:41:25.123 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=4, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:43:25.076 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=4, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:43:33.107 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=4, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:47:57.103 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=4, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:48:27.155 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=4, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:49:57.112 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=4, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:49:59.095 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=4, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:50:11.661 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4f, running=4, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:52:51.096 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=4, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:52:57.112 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=4, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:53:25.116 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=4, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:54:48.439 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=60, running=0, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:55:31.123 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=4, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:55:33.147 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=4, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:55:35.135 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=4, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:55:37.138 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=4, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:57:49.113 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=4, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:58:27.116 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=4, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:58:47.154 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=4, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 11:59:41.130 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=4, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 12:01:49.137 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=4, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 12:02:37.115 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=4, start=1476527400, stop=1476529200,ebc=(nil) 2016-10-15 12:02:57.136 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=65455, tbl=4e, running=4, start=1476527400, stop=1476529200,ebc=(nil) Found 207 matches for ".*BBC ONE E Mid.*eid=65455.*".
The next flag is this:
2016-10-15 12:02:58.136 [ TRACE]:tbl-eit: svc='BBC ONE E Mid', ch='BBC One E Mid', eid=59691, tbl=4e, running=1, start=1476529200, stop=1476532800, ebc=(nil)
Hope this helps
Updated by Jaroslav Kysela about 8 years ago
Mark, do you have multiple EPG sources for this channel ? If ebc = (nil) then something blocks to create the EIT event in the database (probably other EPG grabber has greater priority). In this case EITp/f does not work (I don't see a simple way to correlate the event from two and more different sources).
Updated by Mark Clarkstone about 8 years ago
Jaroslav Kysela wrote:
Mark, do you have multiple EPG sources for this channel ? If ebc = (nil) then something blocks to create the EIT event in the database (probably other EPG grabber has greater priority). In this case EITp/f does not work (I don't see a simple way to correlate the event from two and more different sources).
Bold 1:
Yes. I have the following grabbers enabled across all channels (services from dvb-t and dvb-s are combined - dvb-t services have higher priority).
Grabber | Priority | Will change to ----------------------|-------------|-------- OpenTV (Sky UK) | 10 | 1 UK: Freeview | 5 | 8 UK: Freesat | 1 | 6 EIT: DVB Grabber | 1 | 10
I'll rejig the priority as in the table, delete the epgdb and attempt another recording then see it that makes any difference. See below..
Bold 2:
Yep, I see where you're coming from, the event info tvh has needs to match whatever is supplied in the stream during the recording, if the event info is from a different network then it won't match.
It is a bit of a pickle.
You could allow the user to pick the epg data/grabber that will be used for the recording. You could do this by adding a grabber drop down (with an "all" choice as default) to the EPG grid, then when the user chooses an entry to record (and only when a single grabber is selected) add a warning to the event info dialog, something along the lines of "Note that this event information is from a single EPG grabber/source. Only networks that supplied the data (or linked) to the selected grabber will be used for recording.".
It's not exactly a great solution and it wouldn't be much good for htsp clients but it's something I suppose. :p
Heh, it's taken me that long to write this I'd forgotten that I'd set a recording after changing the grabber priority!
Chapters are now being created and appear to be correct (or at least as far as I can tell)! The programme "Asian Provocateur: Mum's American Dream" is 30 mins long, the scheduled duration is shown as 50 mins (+ padding) and the actual length of the recording is (according to VLC) 31:28.
The recording starts exactly on the BBC One ident (00:00) which means Tvheadend has detected the flag correctly, this is also where the first chapter is, the second chapter is at 00:22 right after the ident ends and exactly where the programme starts.
The BBC don't appear to indicate that the programme has ended where you'd expect (right at the end credits) so all the bumpers for other programmes are included, the recording however ends exactly on the start of the ident for the next programme!
So it does work! =D
Updated by Mark Clarkstone about 8 years ago
Heh, I've only just noticed that changing the grabber priority (to the above) caused loss of EPG on some channels, mostly those on satellite.
Updated by Laurie Davis about 8 years ago
Laurie Davis wrote:
Now that I have this working on my setup, I've turned my attention to how I want to play these files back, and have hit another small problem. My aim is to watch the recorded programmes in Kodi using the TVH PVR client. I want to be able to start playback, press the "skip forward" button which should skip to the next chapter, so that I am immediately at the chapter marker for the start of the program. However, this doesn't quite work. What happens is that Kodi just jumps forward 20 secs at each press of the skip forward - until it is past the first chapter marker. The next press then takes me to the next chapter (ie, the end of the programme, or the first commercial break, depending on how the broadcaster has flagged it).
I believe the problem is that there is no initial chapter right at the start of the recording. It seems that before it has reached any chapters, Kodi is unaware of them and so only does a 20 second skip.
So Jaroslav, would it be possible for TVH to add a chapter right at the start of the recording (ie 00:00:00)? I think this will then fix it.
Thanks
Hi Jaroslav, did you have a chance to consider implementing this please?
Thanks
Updated by Laurie Davis over 7 years ago
I'd forgotten all about this Thanks for trying to implement it, but it doesn't seem to be working for me. I've done a few test recordings to MKV and there is no chapter mark right at the start - the first still seems to be at the first EIT change.
I've attached a log with a DVR trace, and ffprobe on the file shows this:
[STREAM] index=0 codec_name=mpeg2video codec_long_name=MPEG-2 video profile=Main codec_type=video codec_time_base=1/25 codec_tag_string=[0][0][0][0] codec_tag=0x0000 width=720 height=576 coded_width=0 coded_height=0 has_b_frames=1 sample_aspect_ratio=64:45 display_aspect_ratio=16:9 pix_fmt=yuv420p level=8 color_range=tv color_space=unknown color_transfer=unknown color_primaries=unknown chroma_location=left field_order=tt timecode=N/A refs=1 id=N/A r_frame_rate=25/1 avg_frame_rate=25/1 time_base=1/1000 start_pts=120 start_time=0.120000 duration_ts=N/A duration=N/A bit_rate=N/A max_bit_rate=N/A bits_per_raw_sample=N/A nb_frames=N/A nb_read_frames=N/A nb_read_packets=N/A DISPOSITION:default=1 DISPOSITION:dub=0 DISPOSITION:original=0 DISPOSITION:comment=0 DISPOSITION:lyrics=0 DISPOSITION:karaoke=0 DISPOSITION:forced=0 DISPOSITION:hearing_impaired=0 DISPOSITION:visual_impaired=0 DISPOSITION:clean_effects=0 DISPOSITION:attached_pic=0 DISPOSITION:timed_thumbnails=0 TAG:language=eng [/STREAM] [STREAM] index=1 codec_name=mp2 codec_long_name=MP2 (MPEG audio layer 2) profile=unknown codec_type=audio codec_time_base=1/48000 codec_tag_string=[0][0][0][0] codec_tag=0x0000 sample_fmt=s16p sample_rate=48000 channels=2 channel_layout=stereo bits_per_sample=0 id=N/A r_frame_rate=0/0 avg_frame_rate=0/0 time_base=1/1000 start_pts=20 start_time=0.020000 duration_ts=N/A duration=N/A bit_rate=192000 max_bit_rate=N/A bits_per_raw_sample=N/A nb_frames=N/A nb_read_frames=N/A nb_read_packets=N/A DISPOSITION:default=1 DISPOSITION:dub=0 DISPOSITION:original=0 DISPOSITION:comment=0 DISPOSITION:lyrics=0 DISPOSITION:karaoke=0 DISPOSITION:forced=0 DISPOSITION:hearing_impaired=0 DISPOSITION:visual_impaired=0 DISPOSITION:clean_effects=0 DISPOSITION:attached_pic=0 DISPOSITION:timed_thumbnails=0 TAG:language=eng [/STREAM] [STREAM] index=2 codec_name=mp2 codec_long_name=MP2 (MPEG audio layer 2) profile=unknown codec_type=audio codec_time_base=1/48000 codec_tag_string=[0][0][0][0] codec_tag=0x0000 sample_fmt=s16p sample_rate=48000 channels=1 channel_layout=mono bits_per_sample=0 id=N/A r_frame_rate=0/0 avg_frame_rate=0/0 time_base=1/1000 start_pts=20 start_time=0.020000 duration_ts=N/A duration=N/A bit_rate=64000 max_bit_rate=N/A bits_per_raw_sample=N/A nb_frames=N/A nb_read_frames=N/A nb_read_packets=N/A DISPOSITION:default=1 DISPOSITION:dub=0 DISPOSITION:original=0 DISPOSITION:comment=0 DISPOSITION:lyrics=0 DISPOSITION:karaoke=0 DISPOSITION:forced=0 DISPOSITION:hearing_impaired=0 DISPOSITION:visual_impaired=0 DISPOSITION:clean_effects=0 DISPOSITION:attached_pic=0 DISPOSITION:timed_thumbnails=0 TAG:language=eng [/STREAM] [STREAM] index=3 codec_name=dvb_subtitle codec_long_name=DVB subtitles profile=unknown codec_type=subtitle codec_time_base=0/1 codec_tag_string=[0][0][0][0] codec_tag=0x0000 width=N/A height=N/A id=N/A r_frame_rate=0/0 avg_frame_rate=0/0 time_base=1/1000 start_pts=20 start_time=0.020000 duration_ts=2580440 duration=2580.440000 bit_rate=N/A max_bit_rate=N/A bits_per_raw_sample=N/A nb_frames=N/A nb_read_frames=N/A nb_read_packets=N/A DISPOSITION:default=1 DISPOSITION:dub=0 DISPOSITION:original=0 DISPOSITION:comment=0 DISPOSITION:lyrics=0 DISPOSITION:karaoke=0 DISPOSITION:forced=0 DISPOSITION:hearing_impaired=0 DISPOSITION:visual_impaired=0 DISPOSITION:clean_effects=0 DISPOSITION:attached_pic=0 DISPOSITION:timed_thumbnails=0 TAG:language=eng [/STREAM] [CHAPTER] id=1 time_base=1/1000000000 start=293400000000 start_time=293.400000 end=1917560000000 end_time=1917.560000 [/CHAPTER] [CHAPTER] id=3 time_base=1/1000000000 start=1917560000000 start_time=1917.560000 end=2580460000000 end_time=2580.460000 [/CHAPTER] [FORMAT] filename=D:\Recordings-TVH\How I Met Your Mother\How I Met Your Mother (E4) 2017-05-18 15-30 .mkv nb_streams=4 nb_programs=0 format_name=matroska,webm format_long_name=Matroska / WebM start_time=0.020000 duration=2580.440000 size=683834100 bit_rate=2120054 probe_score=100 TAG:title=How I Met Your Mother TAG:encoder=Tvheadend Matroska muxer TAG:DATE_BROADCASTED=2017-05-18 15:30:00 TAG:ORIGINAL_MEDIA_TYPE=TV TAG:CONTENT_TYPE=Show / Game show TAG:TVCHANNEL=E4 TAG:SUMMARY=Twin Beds: After Don asks Robin to move in with him, she decides it's time for Ted and Barney to meet him. They both react badly when they realise Robin has moved on. [AD,S] TAG:SUMMARY-eng=Twin Beds: After Don asks Robin to move in with him, she decides it's time for Ted and Barney to meet him. They both react badly when they realise Robin has moved on. [AD,S] [/FORMAT]