recording service stopped

[snagglewest]

Had another lock up tonight about 21:04 while watching live TV.  A check of the cli found everything like the last times, web UI is accessible but the tuners in live TV are not.  2 recordings started at 19:58 and both ended at 21:02 (2 min pre & post padding) which I'm suspecting has something to do with it.  The best I can figure is every time we have this issue is when a recording is starting or ending.  

Here are logs.  I added "export NEXTPVR_VERBOSE=true" to nextpvr-server.conf" as Martin suggested  on Feb 27 so hopefully the logs are correct and give you something to go on.

[attachment=834]

[mvallevand]

Has the problem changed? Earlier posts where about streams not stopping but this seems more about an RPi client not streaming.

I don't see any verbose logging but with the logging from so many clients that might not be a bad thing.

Martin

[snagglewest]

As far as I can tell it's a combination of both, but not necessarily at the exact same time though I think it's all related.  Generally I find there's a problem when streaming stops or isn't functioning.  If we're watching live TV and it happens it's easy to identify there's a problem, if not then the first indication is usually when we try to start live TV and it won't work.  The one common denominator is the problem always happens when a recording is ending and from what I can tell, when at least 2 end at the same time.  In the case were the files never stopped recording there was 2 recordings which stopped at the same time while the 2 others were still recording.

You mentioned the enhanced logging doesn't appear to be working.  This is the contents of nextpvr-server.conf, does it look right?

Code:

NEXTPVR_DATADIR_USERDATA=/var/opt/nextpvr/
export NEXTPVR_VERBOSE=true

[snagglewest]

Ok, so I might be making some progress at least with recreating the problem at will.  writting the last post kinda got me thinking so I ran the link Sub provided in the browser to activate the enhanced logging.  I then scheduled 2 simultaneous recordings, Xploration Outer Space.S05E01 & This Old House.S41E09, both ending at 9:02am ( 2 min post padding).  These both started about 8:33ish.  

Live TV was playing on the TV (WVEC-HD)  the entire time and about 9:03ish the stream locked up again.  Same symptoms as usual, web ui responsive,  recordings can't be played thru the web ui,  live TV not available and the web ui showing no tuners in use.

Anyhow, I restarted the service from the cli and grabbed the attached logs.  Hopefully they are more useful.

[attachment=837]

[mvallevand]

There is some link in your log to the described issue since just after the recording stops we see the last reference to that live tv item.

2020-03-07 09:02:03.709 [DEBUG][8] Closing TSWriter: /mnt/recordings/Xploration Outer Space/Xploration Outer Space.S05E01.Mars InSight.ts
2020-03-07 09:02:03.900 [DEBUG][44] Renewed lease... (1A0007)

is the last reference to that lease on the thread and it didn't report back the ok.

Looking at the previous logs that seems to be consistent no ok was logged.

Also my instructions were wrong you don't need the export to set the variable in the conf file.

Martin

[snagglewest]

Ok, in nextpvr-server.conf I removed "export" so the line is just "NEXTPVR_VERBOSE=true" now.

I'm guessing Sub will need to look into the lease issue?

[sub]

writting the last post kinda got me thinking so I ran the link Sub provided in the browser to activate the enhanced logging. 

Unfortunately we're yet to see any of the verbose log messages appear in your logs. I'm not really sure why, probably the variable needing that export removed.

[mvallevand]

That last set has verbose messages mainly on recording status playback position

Martin

[sub]

I'm guessing Sub will need to look into the lease issue?

At this stage there is still no clear indication of where the problem is, so nothing obvious for me to fix. The lack of a 'Renew lease ok' message may mean it's blocked waiting for something to complete on the main recorder thread, but I'm not not really sure.

[snagglewest]

I'm not sure why we're not getting the verbose logging you want.  I just checked and the NShared.dll is definitely the correct version and the url you asked me to run seems to be giving the proper return.  Is there something else i need to do on my end?

[attachment=840]