Project

General

Profile

Actions

Bug #3904

open

dvr recording unexpectedly stops short with accurate recording enabled

Added by dj bloc almost 9 years ago. Updated over 8 years ago.

Status:
New
Priority:
Normal
Assignee:
Category:
PVR / DVR
Target version:
-
Start date:
2016-07-20
Due date:
% Done:

0%

Estimated time:
Found in version:
HTS Tvheadend 4.1-2141~g01c26fc~trusty
Affected Versions:

Description

Using TVH connected to DVB-T2 USB adapter tuned into UK Freeview and OTA EPG grabbers.

Recorded two consecutive programmes on BBC One HD - BBC News at Ten and This Is BBC One HD.

Under DVR recording profiles I have 'Extra warming up time' set to 60 seconds and 'Use EPG running state' enabled. There is no pre/post-padding set.

BBC News at Ten was scheduled to start at 10.00pm with a duration of 30 mins. This is BBC One HD was scheduled to start at 10.30pm with a duration of 15 mins.

I would expect the first recording to end and the second to start immediately. Watching both files, what happens is both started at the correct EPG AR time but the recording of the first programme on disk was cut short to c. 30 mins even though the programme lasted over 32 mins.

tvheadend extract from syslog below

Jul 19 21:59:00 haribo tvheadend[1281]: dvr: "BBC News at Ten" on "BBC ONE HD" recorder starting
Jul 19 21:59:00 haribo tvheadend[1281]: service: 2: BBC ONE HD si 0x7f6ac4009650 Silicon Labs Si2168 : DVB-T #0 weight 0 prio 10 error 0
Jul 19 21:59:00 haribo tvheadend[1281]: mpegts: 618.167MHz in Hannington - tuning on Silicon Labs Si2168 : DVB-T #0
Jul 19 21:59:00 haribo tvheadend[1281]: linuxdvb: Silicon Labs Si2168 : DVB-T #0 - starting 618.167MHz in Hannington
Jul 19 21:59:00 haribo tvheadend[1281]: mpegts: 618.167MHz in Hannington - started
...
Jul 19 21:59:55 haribo tvheadend[1281]: dvr: dvr entry e5fec9969b15b80b52b48b2c14dcf676 event BBC News at Ten on BBC ONE HD - EPG marking start
Jul 19 21:59:55 haribo tvheadend[1281]: dvr: File "/home/shared/openshare/kodi_test_files/.inprogress/BBC-ONE-HD/2016-07-19/2016-07-19-22-00-BBC-News-at-Ten-.mkv" -- No such file or directory -- Using for recording
Jul 19 21:59:55 haribo tvheadend[1281]: dvr: /home/shared/openshare/kodi_test_files/.inprogress/BBC-ONE-HD/2016-07-19/2016-07-19-22-00-BBC-News-at-Ten-.mkv from adapter: "Silicon Labs Si2168 : DVB-T #0", network: "Hannington", mux: "618.167MHz", provider: "<N/A>", service: "BBC ONE HD" 
Jul 19 21:59:55 haribo tvheadend[1281]: dvr:  #  type              lang  resolution  aspect ratio  sample rate  channels
Jul 19 21:59:55 haribo tvheadend[1281]: dvr:  1  H264                    1920x1080   16:9                                 
Jul 19 21:59:55 haribo tvheadend[1281]: dvr:  2  AAC               eng                             48000        2         
Jul 19 21:59:55 haribo tvheadend[1281]: dvr:  3  AAC               eng                             ?            ?         <disabled, no valid input>
Jul 19 21:59:55 haribo tvheadend[1281]: dvr:  4  DVBSUB            eng                                                    
...
Jul 19 22:29:00 haribo tvheadend[1281]: dvr: "This Is BBC One HD" on "BBC ONE HD" recorder starting
Jul 19 22:29:00 haribo tvheadend[1281]: service: 2: BBC ONE HD si 0x7f6ac400a960 Silicon Labs Si2168 : DVB-T #0 weight -1 prio 9 error 0
Jul 19 22:29:00 haribo tvheadend[1281]: subscription: 005E: "DVR: This Is BBC One HD" subscribing on channel "BBC ONE HD", weight: 300, adapter: "Silicon Labs Si2168 : DVB-T #0", network: "Hannington", mux: "618.167MHz", service: "BBC ONE HD", profile="matroska" 
Jul 19 22:30:00 haribo tvheadend[1281]: subscription: 005D: "DVR: BBC News at Ten" unsubscribing from "BBC ONE HD" 
Jul 19 22:30:00 haribo tvheadend[1281]: dvr: "BBC News at Ten" on "BBC ONE HD": End of program: Completed OK
...
Jul 19 22:32:37 haribo tvheadend[1281]: dvr: dvr entry 35bce60baab3c83ac38a991b792b19bd event This Is BBC One HD on BBC ONE HD - EPG marking start
Jul 19 22:32:37 haribo tvheadend[1281]: dvr: File "/home/shared/openshare/kodi_test_files/.inprogress/BBC-ONE-HD/2016-07-19/2016-07-19-22-30-This-Is-BBC-One-HD-.mkv" -- No such file or directory -- Using for recording
Jul 19 22:32:37 haribo tvheadend[1281]: dvr: /home/shared/openshare/kodi_test_files/.inprogress/BBC-ONE-HD/2016-07-19/2016-07-19-22-30-This-Is-BBC-One-HD-.mkv from adapter: "Silicon Labs Si2168 : DVB-T #0", network: "Hannington", mux: "618.167MHz", provider: "<N/A>", service: "BBC ONE HD" 
Jul 19 22:32:37 haribo tvheadend[1281]: dvr:  #  type              lang  resolution  aspect ratio  sample rate  channels
Jul 19 22:32:37 haribo tvheadend[1281]: dvr:  1  H264                    1920x1080   16:9                                 
Jul 19 22:32:37 haribo tvheadend[1281]: dvr:  2  AAC               eng                             48000        2         
Jul 19 22:32:37 haribo tvheadend[1281]: dvr:  3  AAC               eng                             ?            ?         <disabled, no valid input>
Jul 19 22:32:37 haribo tvheadend[1281]: dvr:  4  DVBSUB            eng                                                    
Jul 19 22:32:38 haribo tvheadend[1281]: epg: expire event 321853 (BBC News at Ten) from BBC ONE HD

Notice the epg expire event comes at 22:32:38 but the recording stopped at 22:30:00.

Using ffmpeg confirmed file duration of BBC News at Ten is only 00:30:05.80.


Files

dvr_trace_bug_3904.log.gz (276 KB) dvr_trace_bug_3904.log.gz dvr trace file dj bloc, 2016-08-18 00:06
Actions

Also available in: Atom PDF