NextPVR Forums
  • Home
  • New Posts
  • Wiki
  • Members
  • Help
  • Search
  • Register
  • Login
  • Home
  • Wiki
  • Members
  • Help
  • Search
NextPVR Forums Public NextPVR v5 Support Windows v
« Previous 1 2 3 4 5 … 35 Next »
Scheduled resume happens a few minutes late

 
  • 0 Vote(s) - 0 Average
Scheduled resume happens a few minutes late
DomesticSimian
Offline

Junior Member

United States
Posts: 14
Threads: 4
Joined: Jan 2021
#1
2021-01-06, 01:59 AM
I had a failed recording last night, and while looking at the logs I noticed that the OnResume happened a few minutes after the scheduled time. Full logs are attached, but here are some relevant snippets:


Quote:2021-01-04 12:37:00.398 [DEBUG][9] Loading recording schedule
2021-01-04 12:37:00.402 [DEBUG][9] [The Late Show With Stephen Colbert] at 1/4/2021 11:35 PM
2021-01-04 12:37:00.402 [DEBUG][9] Requesting wake up for 'RecordingOID889' [The Late Show With Stephen Colbert] at 1/4/2021 11:31 PM


<snip>
2021-01-04 17:31:03.458 [DEBUG][95] stopping device process
2021-01-04 23:34:27.882 [DEBUG][9] DefaultDirectoryChoice: first
2021-01-04 23:34:27.884 [DEBUG][9] Preferred filename is 'The.Late.Show.With.Stephen.Colbert.S06E59.Stacey.Abrams;.RuPaul.Charles;.Maren.Morris'
2021-01-04 23:34:28.345 [DEBUG][84] [Resume]
2021-01-04 23:34:28.345 [DEBUG][84] OnResume...

Any idea why that might be happening? Is there a way for me to increase the wake up time buffer so my PC will wake up earlier?

The actual failure happened shortly after that:

Quote:2021-01-04 23:34:46.003 [DEBUG][9] Unexpected error in GetTargetName: System.IO.DirectoryNotFoundException: Could not find a part of the path 'D:\Recorded TV\The Late Show With Stephen Colbert\Season 06\'.

  at System.IO.FileSystem.CreateDirectory(String fullPath, Byte[] securityDescriptor)
  at System.IO.Directory.CreateDirectory(String path)
  at NShared.RecordingService.GetTargetName(ScheduledRecording scheduledRecording)
  at NShared.RecordingService.WorkerThread()


I am (temporarily) using a USB attached drive for my recordings, and I suspect there was some timing issue here where the drive had not fully resumed from standby when NextPVR attempted to create the directory, which resulted in the above failure.

Any suggestion on how to prevent that from happening again? Thanks!
sub
Offline

Administrator

NextPVR HQ, New Zealand
Posts: 96,690
Threads: 674
Joined: Nov 2003
#2
2021-01-06, 02:25 AM
It looks like Stephen Colbert was due to start at 11:35pm. The recording was due to start at 11:34pm, because it had one minute of pre-padding. It woke the machine a couple of minutes early (11:31pm), to make sure the machine had plenty of time to wake properly before the recording started at 11:34pm.

Yes, looked like your D:\ drive wasn't available by 11:34pm. Not clear exactly why.
mvallevand
Online

Posting Freak

Ontario Canada
Posts: 36,362
Threads: 723
Joined: May 2006
#3
2021-01-06, 02:31 AM
The resume is already well before padding time I think a full minute before padding.

Martin
DomesticSimian
Offline

Junior Member

United States
Posts: 14
Threads: 4
Joined: Jan 2021
#4
2021-01-06, 01:27 PM
Quote:2021-01-04 12:37:00.402 [DEBUG][9] Requesting wake up for 'RecordingOID889' [The Late Show With Stephen Colbert] at 1/4/2021 11:31 PM


Ok, so this log line implies that the PC should wake up at 11:31, right?


Quote:2021-01-04 23:34:28.345 [DEBUG][84] [Resume]
2021-01-04 23:34:28.345 [DEBUG][84] OnResume...


These lines seem to indicate to me that the PC actually woke up at 11:34. Am I misinterpreting what those lines mean? Also, my pre-padding is set to 2 minutes, so I would have expected the recording to start at 11:33.
Graham
Offline

Posting Freak

UK
Posts: 3,934
Threads: 102
Joined: Dec 2005
#5
2021-01-06, 01:55 PM
(2021-01-06, 01:27 PM)DomesticSimian Wrote:
Quote:2021-01-04 12:37:00.402 [DEBUG][9] Requesting wake up for 'RecordingOID889' [The Late Show With Stephen Colbert] at 1/4/2021 11:31 PM


Ok, so this log line implies that the PC should wake up at 11:31, right?


Quote:2021-01-04 23:34:28.345 [DEBUG][84] [Resume]
2021-01-04 23:34:28.345 [DEBUG][84] OnResume...


These lines seem to indicate to me that the PC actually woke up at 11:34. Am I misinterpreting what those lines mean? Also, my pre-padding is set to 2 minutes, so I would have expected the recording to start at 11:33.

I suspect that the first log message does not include the time that NextPVR sends to Windows asking for a wake up ... only the time that the recording is due to start.

The second message indicates the time that NextPVR Server resumed after Windows had finished its part of the wakeup process.

What does the Windows Event Viewer have to say about the wake up?

At the risk of stating the bleedin' obvious ... You can set the pre-padding to five minutes (or whatever) and that should make the problem go away.
mvallevand
Online

Posting Freak

Ontario Canada
Posts: 36,362
Threads: 723
Joined: May 2006
#6
2021-01-06, 02:02 PM
Extra pre-padding won't make the problem go away, the wake up will still be 1 minute before prep-adding so if the device isn't waking in one minute the recording will still fail. There is no second attempt at start time.

Realistically use a drive that doesn't take as long to wake or turn off sleep until the replacement drive is ready.

Martin
Graham
Offline

Posting Freak

UK
Posts: 3,934
Threads: 102
Joined: Dec 2005
#7
2021-01-06, 02:10 PM
(2021-01-06, 02:02 PM)mvallevand Wrote: Extra pre-padding won't make the problem go away, the wake up will still be 1 minute before prep-adding so if the device isn't waking in one minute the recording will still fail.  There is no second attempt at start time.

Obviously! .... I seem to be exceptionally empty headed today ...
DomesticSimian
Offline

Junior Member

United States
Posts: 14
Threads: 4
Joined: Jan 2021
#8
2021-01-06, 04:50 PM
So I take it there is currently no way to increase the "wake up time" buffer?
mvallevand
Online

Posting Freak

Ontario Canada
Posts: 36,362
Threads: 723
Joined: May 2006
#9
2021-01-06, 07:17 PM
There is this setting in config.xml

<WakeupPreRecordingSeconds>90</WakeupPreRecordingSeconds>

You can play around with it.

Martin
DomesticSimian
Offline

Junior Member

United States
Posts: 14
Threads: 4
Joined: Jan 2021
#10
2021-01-06, 09:45 PM
Awesome thanks!
« Next Oldest | Next Newest »

Users browsing this thread: 1 Guest(s)

Pages (2): 1 2 Next »


Possibly Related Threads…
Thread Author Replies Views Last Post
  Recording stopped less than 2 minutes in Ricknextpvr 30 1,578 2020-08-01, 11:52 AM
Last Post: Ricknextpvr
  NextPVR fails to record some scheduled programs MovieBuff 15 1,123 2020-04-19, 05:50 PM
Last Post: MovieBuff
  Shows scheduled to record aren't colored in guide unless genre colors disabled 4zm4r3d02 4 556 2020-04-16, 11:35 PM
Last Post: mvallevand
  LiveTV stopping after several minutes shspvr 85 6,468 2020-03-25, 05:01 PM
Last Post: sub
  Although 60 mins pre and post padding specified recording is done with 30 minutes aderlopas 3 425 2020-02-16, 10:02 PM
Last Post: sub
  See what is scheduled in search Oempa 2 226 2020-02-10, 07:59 PM
Last Post: Oempa
  Should v5 try to reconnect a scheduled recording? markn62 39 2,392 2019-11-26, 12:21 AM
Last Post: markn62
  LiveTV stopping after several (7) minutes RoadBlock2k 2 677 2019-08-25, 07:54 PM
Last Post: RoadBlock2k

  • View a Printable Version
  • Subscribe to this thread
Forum Jump:

© Designed by D&D, modified by NextPVR - Powered by MyBB

Linear Mode
Threaded Mode