Unexpected error in WriteSafeReadAllLines when playing back via webclient

[gEd]

Sub, Martin

I'm seeing all these errors when playing back native (and skipping) UK H264 content via the web client. I can see this error being reported on the forum quite some time ago (related to VOD playback) but nothing recent.
BTW: A few weeks back I stopped using postprocessing.bat to remux to mp4 as I found that I was getting regular lipsync issues with mp4 playback on the TV with AndroidUI and was delighted to find that the latest version of the UI playback native UK content perfectly (hurrah).

I tried both on and off for "Avoid transcoding where possible (for better performance)" but that made no difference, the error still happens.
Playback seems fine so I'm not experiencing problems but the frequency of these errors doesn't seem to be a good thing.

Attached the the ffmpeg log from web/temp (which doesn't get removed btw in case that's not by design)

Code:

2022-11-16 22:45:07.065 [ERROR][65] Unexpected error in WriteSafeReadAllLines: System.IO.FileNotFoundException: Could not find file 'C:\Users\Public\NPVR-Data\web\temp\Later  with Jools Holland-4baeecf74b714d6f8798f29a802c99be.m3u8'.
File name: 'C:\Users\Public\NPVR-Data\web\temp\Later  with Jools Holland-4baeecf74b714d6f8798f29a802c99be.m3u8'
  at Microsoft.Win32.SafeHandles.SafeFileHandle.CreateFile(String fullPath, FileMode mode, FileAccess access, FileShare share, FileOptions options)
  at Microsoft.Win32.SafeHandles.SafeFileHandle.Open(String fullPath, FileMode mode, FileAccess access, FileShare share, FileOptions options, Int64 preallocationSize)
  at System.IO.Strategies.OSFileStreamStrategy..ctor(String path, FileMode mode, FileAccess access, FileShare share, FileOptions options, Int64 preallocationSize)
  at NShared.Extend.RequestHandlers.TranscoderHLS.WriteSafeReadAllLines(String path)
2022-11-16 22:45:07.077 [ERROR][65] Unexpected error in WriteSafeReadAllLines: System.IO.FileNotFoundException: Could not find file 'C:\Users\Public\NPVR-Data\web\temp\Later  with Jools Holland-4baeecf74b714d6f8798f29a802c99be.m3u8'.
File name: 'C:\Users\Public\NPVR-Data\web\temp\Later  with Jools Holland-4baeecf74b714d6f8798f29a802c99be.m3u8'
  at Microsoft.Win32.SafeHandles.SafeFileHandle.CreateFile(String fullPath, FileMode mode, FileAccess access, FileShare share, FileOptions options)
  at Microsoft.Win32.SafeHandles.SafeFileHandle.Open(String fullPath, FileMode mode, FileAccess access, FileShare share, FileOptions options, Int64 preallocationSize)
  at System.IO.Strategies.OSFileStreamStrategy..ctor(String path, FileMode mode, FileAccess access, FileShare share, FileOptions options, Int64 preallocationSize)
  at NShared.Extend.RequestHandlers.TranscoderHLS.WriteSafeReadAllLines(String path)
2022-11-16 22:45:07.087 [ERROR][65] Unexpected error in WriteSafeReadAllLines: System.IO.FileNotFoundException: Could not find file 'C:\Users\Public\NPVR-Data\web\temp\Later  with Jools Holland-4baeecf74b714d6f8798f29a802c99be.m3u8'.
File name: 'C:\Users\Public\NPVR-Data\web\temp\Later  with Jools Holland-4baeecf74b714d6f8798f29a802c99be.m3u8'
  at Microsoft.Win32.SafeHandles.SafeFileHandle.CreateFile(String fullPath, FileMode mode, FileAccess access, FileShare share, FileOptions options)
  at Microsoft.Win32.SafeHandles.SafeFileHandle.Open(String fullPath, FileMode mode, FileAccess access, FileShare share, FileOptions options, Int64 preallocationSize)
  at System.IO.Strategies.OSFileStreamStrategy..ctor(String path, FileMode mode, FileAccess access, FileShare share, FileOptions options, Int64 preallocationSize)
  at NShared.Extend.RequestHandlers.TranscoderHLS.WriteSafeReadAllLines(String path)
2022-11-16 22:45:07.098 [ERROR][65] Unexpected error in WriteSafeReadAllLines: System.IO.FileNotFoundException: Could not find file 'C:\Users\Public\NPVR-Data\web\temp\Later  with Jools Holland-4baeecf74b714d6f8798f29a802c99be.m3u8'.
File name: 'C:\Users\Public\NPVR-Data\web\temp\Later  with Jools Holland-4baeecf74b714d6f8798f29a802c99be.m3u8'
  at Microsoft.Win32.SafeHandles.SafeFileHandle.CreateFile(String fullPath, FileMode mode, FileAccess access, FileShare share, FileOptions options)
  at Microsoft.Win32.SafeHandles.SafeFileHandle.Open(String fullPath, FileMode mode, FileAccess access, FileShare share, FileOptions options, Int64 preallocationSize)
  at System.IO.Strategies.OSFileStreamStrategy..ctor(String path, FileMode mode, FileAccess access, FileShare share, FileOptions options, Int64 preallocationSize)
  at NShared.Extend.RequestHandlers.TranscoderHLS.WriteSafeReadAllLines(String path)

[mvallevand]

You really would need to use sub's postprocessing options to skip files that need to be transcoded. We'd probably need to full log and the ffmpeg log. Attachments must be zipped and under 2MB

Martin

[gEd]

I can skip my ts recordings fine. about 80% as good as when I converted them to mp4 and without the lipsync issue in AndoidUI on my TV.
I can reproduce the problem and upload a full set of logs if you think there is a potential problem worthy of investigating.

[mvallevand]

The web client doesn't skip on the recorded file, the skipping is done on demand generated new chunks.

I always like to see the logs to see if there is any root cause error.

Martin

[gEd]

Attached a (very) clean set of logs. (I shutdown recording service, deleted all logs, restarted, watched a recording via browser and skipped a few times)
cheers.

[mvallevand]

That doens't look like the logs you get with the zip file. There is 50 minutes and files missing.

Martin

[sub]

Are you set to only log errors? It looks like that nrecord.log is missing most of the useful stuff. (either that, or maybe your restarted the server while the playback page was already trying to play the stream)

[gEd]

"Like a fool", I thought this meant I had debug logging instead of error

[...startup]
2022-11-17 00:07:51.671 [DEBUG][1] No C:\Users\Public\NPVR-Data\scripts\PreStartup.bat
2022-11-17 00:07:51.683 [DEBUG][1] Checking if upgrade required

new set of DEBUG logs

[mvallevand]

Code:

"C:\Program Files\NextPVR\Other\ffmpeg.exe" -y   -ss 311  -i file:"R:\Recordings\Later  with Jools Holland\Later  with Jools Holland_20221112_21002235.ts" -map_metadata -1 -threads 0 -ignore_unknown  -map 0:v:0?  -map 0:a:0 -map -0:s -codec:v:0 libx264 -pix_fmt yuv420p -preset superfast -crf 23 -vf yadif=0:-1:0 -b:v 8000000 -maxrate 8000000 -bufsize 16000000 -vsync vfr -profile:v high -level 41 -force_key_frames "expr:gte(t,n_forced*3)" -s 1920x1080  -c:s dvbsub -flags -global_header -sc_threshold 0 -codec:a:0 aac -strict experimental -ac 2 -ab 192000 -hls_time 5 -start_number 0 -hls_list_size 0 -y "C:\Users\Public\NPVR-Data\web\temp\Later  with Jools Holland-2eb8b0da23d34660a2cd7b270a72464e.m3u8"

Could you test the command and see if it create the file?

Martin

[gEd]

it created lots of files