back2back recordings, 2nd stops early

[tgp]

I'm still on 1.1.5, and have noticed this for a bit, particularly when SCIFI channel has a marathon...

Stargate was on the schedule for 1800-1900 and then 1900-2000 yesterday.

this is what finally recorded

Code:

03/26/2008  07:02 PM     1,866,540,992 Stargate SG-1_20080326_18001900.mpg
03/27/2008  07:02 PM     1,861,984,192 Stargate SG-1_20080327_18001900.mpg
03/28/2008  07:02 PM        84,015,040 Stargate SG-1_20080328_18001900-2.mpg
03/28/2008  06:59 PM     1,805,883,328 Stargate SG-1_20080328_18001900.mpg
03/28/2008  06:59 PM           974,784 Stargate SG-1_20080328_19002000.mpg

I think the recording service is getting confused, it restarts on the recording already in progress and then starts up the new one . Exactly when this happens or why is not entirely clear to me.

then a few minutes later (the 2 minute post recording period) the recording service stops both of them...

Code:

008-03-28 18:25:25.837    VERBOSE    [11]    Hour is currently 18. Conversions will happen between 1:00 and 6:00
2008-03-28 18:56:25.837    VERBOSE    [11]    Hour is currently 18. Conversions will happen between 1:00 and 6:00
2008-03-28 18:59:00.118    VERBOSE    [5]    Schedule recording is allocated to a tuner that is currently in use.... Moving recording to another available capture source.
2008-03-28 18:59:00.118    VERBOSE    [5]    RecordingFactory.save()
2008-03-28 18:59:00.149    VERBOSE    [5]    Save(): Updated existing scheduled recording
2008-03-28 18:59:00.149    INFO    [5]    Found new programme requiring recording: Stargate SG-1
2008-03-28 18:59:00.149    INFO    [5]    Stopping existing recording on this capture source. (removing from currentlyRecording)
2008-03-28 18:59:00.149    VERBOSE    [5]    Stopping recording oid:1
2008-03-28 18:59:00.368    VERBOSE    [5]    RecordingFactory.save()
2008-03-28 18:59:00.415    VERBOSE    [5]    Save(): Updated existing scheduled recording
2008-03-28 18:59:00.415    VERBOSE    [5]    Adding F:\Recordings\Scheduled\Stargate SG-1\Stargate SG-1_20080328_18001900.mpg to commercial detection queue
2008-03-28 18:59:00.415    VERBOSE    [5]    Adding F:\Recordings\Scheduled\Stargate SG-1\Stargate SG-1_20080328_18001900.mpg to conversion detection queue
2008-03-28 18:59:00.493    VERBOSE    [5]    Changing to channel (GBPVR.Backend.Common.NullTunerController): 79
2008-03-28 18:59:00.493    VERBOSE    [5]    Requesting IRecordingSource to start recording: F:\Recordings\Scheduled\Stargate SG-1\Stargate SG-1_20080328_19002000.mpg
2008-03-28 18:59:00.508    VERBOSE    [5]    DirectRecordingSource about to start recording  oid:1 channel:79
2008-03-28 18:59:01.868    VERBOSE    [5]    recording started
2008-03-28 18:59:01.868    VERBOSE    [5]    Programme is now recording
2008-03-28 18:59:01.868    VERBOSE    [5]    RecordingFactory.save()
2008-03-28 18:59:03.774    VERBOSE    [5]    Save(): Updated existing scheduled recording
2008-03-28 18:59:03.774    VERBOSE    [5]    Adding F:\Recordings\Scheduled\Stargate SG-1\Stargate SG-1_20080328_19002000.mpg to parallel processing queue
2008-03-28 18:59:03.774    VERBOSE    [5]    RecordingFactory.getExtrasForGroup(2)
2008-03-28 18:59:03.993    INFO    [5]    Found new programme requiring recording: Stargate SG-1
2008-03-28 18:59:03.993    INFO    [5]    Stopping existing recording on this capture source. (removing from currentlyRecording)
2008-03-28 18:59:03.993    VERBOSE    [5]    Stopping recording oid:1
2008-03-28 18:59:05.102    VERBOSE    [5]    RecordingFactory.save()
2008-03-28 18:59:05.149    VERBOSE    [5]    Save(): Updated existing scheduled recording
2008-03-28 18:59:05.165    VERBOSE    [5]    Adding F:\Recordings\Scheduled\Stargate SG-1\Stargate SG-1_20080328_19002000.mpg to commercial detection queue
2008-03-28 18:59:05.165    VERBOSE    [5]    Adding F:\Recordings\Scheduled\Stargate SG-1\Stargate SG-1_20080328_19002000.mpg to conversion detection queue
2008-03-28 18:59:05.446    VERBOSE    [5]    Changing to channel (GBPVR.Backend.Common.NullTunerController): 79
2008-03-28 18:59:05.446    VERBOSE    [5]    Requesting IRecordingSource to start recording: F:\Recordings\Scheduled\Stargate SG-1\Stargate SG-1_20080328_18001900-2.mpg
2008-03-28 18:59:05.446    VERBOSE    [5]    DirectRecordingSource about to start recording  oid:1 channel:79
2008-03-28 18:59:12.977    VERBOSE    [5]    recording started
2008-03-28 18:59:12.977    VERBOSE    [5]    Programme is now recording
2008-03-28 18:59:12.977    VERBOSE    [5]    RecordingFactory.save()
2008-03-28 18:59:13.321    VERBOSE    [5]    Save(): Updated existing scheduled recording
2008-03-28 18:59:13.321    VERBOSE    [5]    Adding F:\Recordings\Scheduled\Stargate SG-1\Stargate SG-1_20080328_18001900-2.mpg to parallel processing queue
2008-03-28 18:59:13.321    VERBOSE    [5]    RecordingFactory.getExtrasForGroup(2)
2008-03-28 19:02:00.040    VERBOSE    [5]    Recording has passed endtime+padding. Stopping.
2008-03-28 19:02:00.040    VERBOSE    [5]    Stopping recording oid:1
2008-03-28 19:02:00.227    VERBOSE    [5]    Adding F:\Recordings\Scheduled\Stargate SG-1\Stargate SG-1_20080328_18001900-2.mpg to commercial detection queue
2008-03-28 19:02:00.227    VERBOSE    [5]    Adding F:\Recordings\Scheduled\Stargate SG-1\Stargate SG-1_20080328_18001900-2.mpg to conversion detection queue
2008-03-28 19:02:00.290    VERBOSE    [5]    RecordingStatus is now RecordingStatus.RECORDING_COMPETED
2008-03-28 19:02:00.290    VERBOSE    [5]    RecordingFactory.save()
2008-03-28 19:02:00.352    VERBOSE    [5]    Save(): Updated existing scheduled recording
2008-03-28 19:02:00.352    VERBOSE    [5]    RecordingFactory.loadSchedule()

logs are attached

a great program, I certainly appreciate any and all help. Thanks in advance SUB .