nPVR 2.3.6 stops recording from 2:00 AM to 4:00 AM on one channel (R2a didn't fix)

[DHL]

Since installing 2.3.6, two programs are not recording 2 days of the week (from 7 PM to 8 PM) that used to record with version 2.2.6. Also, almost every night (on a different computer) from 2:00 AM to approximately 4:00 AM, one of my scheduled recordings stops recording. It is programmed to record from 12:58 AM to 4:02 AM, daily.

I've attached the most recent logs. The program that stops each night is WLS 0058-0402. This did not occur with version 2.2.6.

[DHL]

ndigitalhost-22.log shows the recording in question stopping due to "Frequency has changed."

[mvallevand]

I am not sure if your usage qualifies as "personal use only" it's hard to imagine anyone watching that much TV. There's a few things I notice (hard to say without the ndigitalhost rolling files) but you a lot of things inside the time of that recording, including stopping and starting the service, updating the EPG twice

It seems to start ok,

2012-03-09 00:58:00.224 [DEBUG][7] allocating recording target filename: U:\WLS 0058-0402_20120309_00580402.ts
2012-03-09 00:58:00.224 [DEBUG][7] About to start recording (443605 on 22): U:\WLS 0058-0402_20120309_00580402.ts...
2012-03-09 00:58:00.224 [DEBUG][7] Asking NDigitalHost to start: U:\WLS 0058-0402_20120309_00580402.ts
2012-03-09 00:58:00.244 [DEBUG][7] Temp at 3/9/2012 12:58:10 AM
2012-03-09 00:58:00.244 [DEBUG][7] Started recording (443605:274:U:\WLS 0058-0402_20120309_00580402.ts)

Start an EPG update

2012-03-09 02:00:18.461 [DEBUG][8] About to update EPG
2012-03-09 02:00:18.461 [DEBUG][8] Updating EPG...

But then it tries to do on EPG scan on a different channel on that tuner

2012-03-09 02:01:23.521 [DEBUG][8] Asking NDigitalHost to start: c:\devxxxxxx\null.ts
2012-03-09 02:01:23.941 [DEBUG][8] Scanning Freq:12 SID:1

The recording service is stopped during the scan

2012-03-09 02:20:32.999 [INFO][13] RecordingService.Shutdown()
2012-03-09 02:20:33.474 [INFO][7] DigitalRecorder.StopAllStreams()

And then the service restarts again but still wants to do an EPG update

2012-03-09 02:21:24.556 [DEBUG][8] About to update EPG
2012-03-09 02:21:24.570 [DEBUG][8] Updating EPG...

and it also restarts the recording (without a -0 filename though)

2012-03-09 02:21:27.619 [DEBUG][7] Marking recording (443605) as 'Recording service restarted during recording'
2012-03-09 02:21:27.805 [DEBUG][7] allocating recording target filename: U:\WLS 0058-0402_20120309_00580402.ts
2012-03-09 02:21:27.805 [DEBUG][7] About to start recording (443605 on 22): U:\WLS 0058-0402_20120309_00580402.ts...

and during the scan it stops the recording yet again

2012-03-09 02:22:29.033 [DEBUG][8] StopStream
2012-03-09 02:22:29.538 [DEBUG][8] Asking NDigitalHost to start: c:\devxxxxxx\null.ts
2012-03-09 02:22:49.939 [DEBUG][8] Scanning Freq:12 SID:1

Your logs don't go far enough but I expect during that same time slot for that recording it would do this

2012-03-08 02:44:49.378 [INFO][8] UpdateAllRecurringRecordings()
2012-03-08 02:44:49.378 [INFO][8] Deleting existing pending season recordings

and then it will find a recording that start in the past, and start recording it again. I don't know what would happen here if the EPG update scan hadn't stopped the tuner.

2012-03-08 02:45:29.028 [INFO][8] UpdateRecurringRecording(932, 'WLS 0058-0402'):

2012-03-08 02:46:19.128 [DEBUG][7] allocating recording target filename: U:\WLS 0058-0402_20120308_00580402.ts
2012-03-08 02:46:19.128 [DEBUG][7] About to start recording (443604 on 22): U:\WLS 0058-0402_20120308_00580402.ts...
2012-03-08 02:46:19.128 [DEBUG][7] Asking NDigitalHost to start: U:\WLS 0058-0402_20120308_00580402.ts
2012-03-08 02:46:19.548 [DEBUG][7] Temp at 3/8/2012 2:46:29 AM
2012-03-08 02:46:19.548 [DEBUG][7] Started recording (443604:261:U:\WLS 0058-0402_20120308_00580402.ts)
..
2012-03-08 04:02:00.735 [DEBUG][7] Stopping recording (443604 on 22). Past end time of recording. 261

Martin