Npvr server crash

[baj1]

Around 20:47 my wife was skipping ahead watching playback in knewc on the server PC of the Sunday Night NFL game which was still recording, and the server crashed.

Kodi and NextPVR logs attached.

This has actually happened a few times over the past several days, but the first time I caught the logs right away.

Thanks,
-Brad

[mvallevand]

You might want to look at linux logs like dmesg and journaltctl

Also was there a kodi stacktrace dump with the logs? From kodi all I can see is you trying to play that bad NFL game from earlier.


Martin

[baj1]

Also was there a kodi stacktrace dump with the logs?  From kodi all I can see is you trying to play that bad NFL game from earlier.

Those were the only two .log files in ~/.kodi/temp - is there another spot to look for kodi logs?

[baj1]

You might want to look at linux logs like dmesg and journaltctl

dmesg shows dotnet GPF about 7.5 hours after finishing reboot after earlier server crash this afternoon, which I think was around 13:15 so that would appear to coincide (or at least close) with 20:47 issue:

Code:

[   20.697905] saa7164 driver loaded
[   31.375304] tda18271: performing RF tracking filter calibration
[   33.921523] tda18271: RF tracking filter calibration complete
[  294.743236] logitech-hidpp-device 0003:046D:404D.0006: HID++ 4.1 device connected.
[26847.771888] show_signal: 11 callbacks suppressed
[26847.771890] traps: dotnet[14660] general protection fault ip:7f03cc2bd823 sp:7f0346ffad30 error:0 in libgdiplus.so.0.0.0[7f03cc297000+66000]

Some nasty looking stuff in journalctl @ 20:47 also.  I sent the journal entries from the current boot (~13:15 today) to the attached log file (too big to post).

[baj1]

Or perhaps it didn't get attach.

[mvallevand]

Unfortunately not much help there, the crash is in the graphics interface and UI client uses that heavily but it doesn't explain if it is a NextPVR bug or a driver bug causing the issue. Whatever it is, it is not knewc.

Martin

[mvallevand]

I was playing with knewc today and I had this crash too

Code:

Dec 03 12:09:15 lenovo kernel: dotnet[32252]: segfault at b0 ip 00007fb15a0578d5 sp 00007fb11d569de8 error 4 in libgdiplus.so.0.0.0[7fb15a044000+64000]
Dec 03 12:09:15 lenovo kernel: Code: 02 00 00 00 c3 48 8b 06 ff 60 08 66 2e 0f 1f 84 00 00 00 00 00 48 85 f6 0f 94 c1 48 85
Dec 03 12:09:15 lenovo systemd[1]: nextpvr-server.service: Main process exited, code=killed, status=11/SEGV
Dec 03 12:09:15 lenovo systemd[1]: nextpvr-server.service: Failed with result 'signal'.

Something it seems that something sub is doing in UI client mode is not valid. It seems to be related to a /control?media= command which never returns but that is the most I can see.

Martin

[baj1]

Thanks Martin, glad I'm not the only one having issues with this. The server has crashed on us a couple times in the last week. Most of the time I can restart the service from the terminal, occasionally I need to reboot the PC. We'll see if Sub can find anything. Let me know if there is anything I can test or otherwise do to assist.

I don't know if it's related or not, but knewc running locally on the server crashes (or drops out to Kodi?) almost every day, and lately, sometimes Kodi crashes with it.

[baj1]

More info on the server crashes.  This is still happening with the new DLLs from sub on 12-31-2020.



Server logs attached.  This happened ~18:45 on 1/16/2020 when my wife tried to delete an NFL football game recording from within the Video Library on the local Kodi-knewc client




dmesg | tail

Code:

[95126.461917] Code: Bad RIP value.
[103959.602149] traps: dotnet[17376] general protection fault ip:7fbe9c5b7823 sp:7fbe64e75c20 error:0 in libgdiplus.so.0.0.0[7fbe9c591000+66000]
[104091.170859] traps: dotnet[17793] general protection fault ip:7f1a505b7823 sp:7f1a77ffcc20 error:0 in libgdiplus.so.0.0.0[7f1a50591000+66000]
[114258.378554] LanguageInvoker[18027]: segfault at 0 ip 0000000000000000 sp 00007f69b4ff7b18 error 14 in kodi-x11[55e4e4320000+2575000]
[114258.378561] Code: Bad RIP value.
[193411.078329] EXT4-fs (nvme0n1p6): mounted filesystem with ordered data mode. Opts: (null)
[197686.081311] LanguageInvoker[22929]: segfault at 0 ip 0000000000000000 sp 00007f5988fa1b18 error 14 in kodi-x11[5614d894d000+2575000]
[197686.081317] Code: Bad RIP value.
[226871.413706] LanguageInvoker[25928]: segfault at 0 ip 0000000000000000 sp 00007f2e517f8b18 error 14 in kodi-x11[563f93401000+2575000]
[226871.413714] Code: Bad RIP value.
[238994.457455] perf: interrupt took too long (2560 > 2500), lowering kernel.perf_event_max_sample_rate to 78000
[507509.069577] CIFS VFS: Server 10.99.99.102 has not responded in 180 seconds. Reconnecting...
[601411.117277] LanguageInvoker[11766]: segfault at 0 ip 0000000000000000 sp 00007feabf7fcb18 error 14 in kodi-x11[55c2227f5000+2575000]
[601411.117285] Code: Bad RIP value.
[635817.752033] LanguageInvoker[8301]: segfault at 0 ip 0000000000000000 sp 00007f5be8e01b18 error 14 in kodi-x11[557fc8886000+2575000]
[635817.752039] Code: Bad RIP value.
[640874.341713] traps: dotnet[27165] general protection fault ip:7f6ef65bb823 sp:7f733515dc20 error:0 in libgdiplus.so.0.0.0[7f6ef6595000+66000]
[642651.195792] traps: dotnet[28282] general protection fault ip:7ff654289823 sp:7ff63bffcc20 error:0 in libgdiplus.so.0.0.0[7ff654263000+66000]
[642743.106268] traps: dotnet[28978] general protection fault ip:7f4378af4823 sp:7f437a535b90 error:0 in libgdiplus.so.0.0.0[7f4378ace000+66000]
[786945.392668] LanguageInvoker[30277]: segfault at 0 ip 0000000000000000 sp 00007fe5d77fcb18 error 14
[786945.392671] Code: Bad RIP value.
[1044679.336732] LanguageInvoker[16790]: segfault at 0 ip 0000000000000000 sp 00007f9fd480eb18 error 14 in kodi-x11[55de49398000+2575000]
[1044679.336739] Code: Bad RIP value.
[1174594.960444] LanguageInvoker[26347]: segfault at 0 ip 0000000000000000 sp 00007f8b8effbb18 error 14 in kodi-x11[56312d20d000+2575000]
[1174594.960451] Code: Bad RIP value.
[1229575.526238] traps: dotnet[9746] general protection fault ip:7f4c05147823 sp:7f47557f7c20 error:0 in libgdiplus.so.0.0.0[7f4c05121000+66000]
[1234366.004684] traps: dotnet[12526] general protection fault ip:7fb8602bd823 sp:7fb862d36c20 error:0 in libgdiplus.so.0.0.0[7fb860297000+66000]
[1301451.026370] CIFS VFS: Server 10.99.99.102 has not responded in 180 seconds. Reconnecting...

Doing a quick call from "uptime", the last dotnet GPFs message coincides with the server crash (1234366.004684 = ~18:45pm on 1/16/2020)




journalctl | grep "Jan 16":

Code:

Jan 16 18:36:55 BiVo-MS-7A38 server.sh[9882]: libpng warning: iCCP: known incorrect sRGB profile
Jan 16 18:36:55 BiVo-MS-7A38 server.sh[9882]: libpng warning: iCCP: known incorrect sRGB profile
Jan 16 18:42:01 BiVo-MS-7A38 dotnet[9884]: PNG images with 64bpp aren't supported by libgdiplus.
Jan 16 18:45:31 BiVo-MS-7A38 kernel: traps: dotnet[12526] general protection fault ip:7fb8602bd823 sp:7fb862d36c20 error:0 in libgdiplus.so.0.0.0[7fb860297000+66000]
Jan 16 18:45:31 BiVo-MS-7A38 systemd[1]: Started Process Core Dump (PID 12687/UID 0).
Jan 16 18:45:32 BiVo-MS-7A38 systemd[1]: nextpvr-server.service: Main process exited, code=killed, status=11/SEGV
Jan 16 18:45:32 BiVo-MS-7A38 systemd[1]: nextpvr-server.service: Failed with result 'signal'.
Jan 16 18:45:33 BiVo-MS-7A38 systemd-coredump[12688]: Process 9884 (dotnet) of user 999 dumped core.
Jan 16 18:46:01 BiVo-MS-7A38 sudo[12726]: bmserver : TTY=pts/1 ; PWD=/home/bmserver ; USER=root ; COMMAND=/usr/sbin/service nextpvr-server start
Jan 16 18:46:01 BiVo-MS-7A38 sudo[12726]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jan 16 18:46:02 BiVo-MS-7A38 systemd[1]: Starting NextPVRServer...
Jan 16 18:46:04 BiVo-MS-7A38 server.sh[12756]: Starting server..Done. PID=12758
Jan 16 18:46:04 BiVo-MS-7A38 systemd[1]: Started NextPVRServer.
Jan 16 18:46:04 BiVo-MS-7A38 sudo[12726]: pam_unix(sudo:session): session closed for user root
Jan 16 18:46:19 BiVo-MS-7A38 dbus-daemon[980]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.421' (uid=1000 pid=2183 comm="/usr/lib/firefox/firefox " label="unconfined")
Jan 16 18:46:19 BiVo-MS-7A38 systemd[1]: Starting Hostname Service...
Jan 16 18:46:19 BiVo-MS-7A38 dbus-daemon[980]: [system] Successfully activated service 'org.freedesktop.hostname1'
Jan 16 18:46:19 BiVo-MS-7A38 systemd[1]: Started Hostname Service.
Jan 16 18:46:44 BiVo-MS-7A38 server.sh[12756]: libpng warning: iCCP: known incorrect sRGB profile
Jan 16 18:46:45 BiVo-MS-7A38 server.sh[12756]: libpng warning: iCCP: known incorrect sRGB profile
Jan 16 18:46:45 BiVo-MS-7A38 server.sh[12756]: libpng warning: iCCP: known incorrect sRGB profile
Jan 16 18:46:45 BiVo-MS-7A38 server.sh[12756]: libpng warning: iCCP: known incorrect sRGB profile
Jan 16 18:46:45 BiVo-MS-7A38 server.sh[12756]: libpng warning: iCCP: known incorrect sRGB profile
Jan 16 18:46:45 BiVo-MS-7A38 server.sh[12756]: libpng warning: iCCP: known incorrect sRGB profile
Jan 16 18:46:45 BiVo-MS-7A38 server.sh[12756]: libpng warning: iCCP: known incorrect sRGB profile
Jan 16 18:46:45 BiVo-MS-7A38 server.sh[12756]: libpng warning: iCCP: known incorrect sRGB profile
Jan 16 18:46:53 BiVo-MS-7A38 server.sh[12756]: libpng warning: iCCP: known incorrect sRGB profile
Jan 16 18:46:53 BiVo-MS-7A38 server.sh[12756]: libpng warning: iCCP: known incorrect sRGB profile
Jan 16 18:46:53 BiVo-MS-7A38 server.sh[12756]: libpng warning: iCCP: known incorrect sRGB profile
Jan 16 18:47:04 BiVo-MS-7A38 server.sh[12756]: libpng warning: iCCP: known incorrect sRGB profile
Jan 16 18:47:35 BiVo-MS-7A38 server.sh[12756]: libpng warning: iCCP: known incorrect sRGB profile
Jan 16 19:00:01 BiVo-MS-7A38 CRON[13411]: pam_unix(cron:session): session opened for user root by (uid=0)
Jan 16 19:00:01 BiVo-MS-7A38 CRON[13412]: (root) CMD (timeshift --check --scripted)
Jan 16 19:00:01 BiVo-MS-7A38 CRON[13411]: pam_unix(cron:session): session closed for user root
Jan 16 19:05:21 BiVo-MS-7A38 mateweather-app[1864]: Failed to get IWIN forecast data: 404 Not Found
Jan 16 19:05:21 BiVo-MS-7A38 mateweather-app[1864]: Source ID 62473 was not found when attempting to remove it
Jan 16 19:05:21 BiVo-MS-7A38 mateweather-app[1864]: Failed to get IWIN forecast data: 404 Not Found
Jan 16 19:05:21 BiVo-MS-7A38 mateweather-app[1864]: Source ID 62476 was not found when attempting to remove it

She had it crash earlier too, but I did not note what she was doing that caused the crash.

[mvallevand]

The comment (with partial logs) that is crashing in a delete plus this message should be helpful to sub

Jan 16 18:42:01 BiVo-MS-7A38 dotnet[9884]: PNG images with 64bpp aren't supported by libgdiplus.

Martin