recording service stopped

[snagglewest]

Sub, over the last 2 nights the recording service has stopped running and  I've only found it in the morning when live TV wouldn't work.  Interesting enough, the web UI still works fine and I can even play a existing recording but the tuners aren't available.  This morning I SSH'd and ran "service nextpvr-server status" to see what was going on.  It appeared everything was normal, but I didn't capture a screen shot.  A restart get everything back running normally.  This also happened several weeks ago, but I really didn't think much of it until today.

last night I had 4 recordings going starting at 8:58, 2 recorded to completion, 2 stopped mid recording.

Deputy.S01E06 - 8:58:00 PM - 10:02:00 PM - recorded full length
Tommy.S01E01 - 9:58:00 PM - 11:02:00 PM  - recorded full length
A Million Little Things.S02E12 - 9:59:00 PM - 11:00:00 PM - stopped recording after 7min 49sec
Alone The Beast.S01E02 - 10:01:00 PM - 11:05:00 PM  - stopped recording after 7min 49sec

Interesting enough, the 2 recordings that didn't complete only get released at 5:49am when I restarted the service.  Apparently Npvr still held them both open the whole time until the restart.  Both recordings are playable in both the web UI and VLC and appear to be normal other than being short.

I looked at the attached logs and nothing stands out but I really don't know what I'm looking at for the most part.  Your thoughts?

[mvallevand]

Do you have the default 20 minute buffer for live tv 7:49 sound like one minute of prepadding on a rolling file segment. I do see the Kodi spam over night showing the recording status all night

Martin

[snagglewest]

The live TV buffer is set to 30 min which has been that way for quite some time.

[mvallevand]

That throws my theory out the window.

Martin

[sub]

Martin - if he's installed via the .deb, how can he manually run it in a terminal window, so we can see the output after it crashes?

[mvallevand]

What is crashing?  The app keeps running and it is not using DeviceHostLinux.

Martin

[sub]

True. I hadn't re-read this fully today. I'd stopped at "Sub, over the last 2 nights the recording service has stopped running"

[snagglewest]

Came home from work tonight about 18:30 to find the same issue, the web UI was accessible but the tuners were not.  There was a recording from 14:45 to 17:45 which completed without issue.  Here's the logs and the CLI output when I checked it and the result after a restart of the service.


  logs-20200209-1836.zip (Size: 812.32 KB / Downloads: 2)

Code:

npvr@npvr:~$ service nextpvr-server status
● nextpvr-server.service - NextPVRServer
  Loaded: loaded (/usr/lib/systemd/system/nextpvr-server.service; enabled; vendor preset: enabled)
  Active: active (running) since Sat 2020-02-08 17:26:13 EST; 1 day 1h ago
  Process: 1021 ExecStart=/opt/nextpvr/shell/server.sh start (code=exited, status=0/SUCCESS)
Main PID: 1181 (dotnet)
    Tasks: 29 (limit: 4623)
  CGroup: /system.slice/nextpvr-server.service
          └─1181 /opt/dotnet/dotnet /opt/nextpvr/system/NextPVRServer.dll

Feb 08 17:26:11 npvr systemd[1]: Starting NextPVRServer...
Feb 08 17:26:13 npvr systemd[1]: Started NextPVRServer.
npvr@npvr:~$
npvr@npvr:~$
npvr@npvr:~$ sudo service nextpvr-server restart
[sudo] password for npvr:
npvr@npvr:~$
npvr@npvr:~$
npvr@npvr:~$ service nextpvr-server status
● nextpvr-server.service - NextPVRServer
  Loaded: loaded (/usr/lib/systemd/system/nextpvr-server.service; enabled; vendor preset: enabled)
  Active: active (running) since Sun 2020-02-09 18:36:05 EST; 17s ago
  Process: 4978 ExecStart=/opt/nextpvr/shell/server.sh start (code=exited, status=0/SUCCESS)
Main PID: 4991 (dotnet)
    Tasks: 23 (limit: 4623)
  CGroup: /system.slice/nextpvr-server.service
          └─4991 /opt/dotnet/dotnet /opt/nextpvr/system/NextPVRServer.dll

Feb 09 18:36:03 npvr systemd[1]: Starting NextPVRServer...
Feb 09 18:36:05 npvr server.sh[4978]: Starting server..Done. PID=4991
Feb 09 18:36:05 npvr systemd[1]: Started NextPVRServer.
npvr@npvr:~$

[sub]

I can't see any obvious error in the logs. If you click 'Device Status' (Settings->About) when it's like this, does it claim the server is doing anything already?

[snagglewest]

No, both times I checked, this time and the last, it just said "No devices are currently active" before I did the service restart from the CLI.