Live TV stops streaming at 7 minutes

[sub]

Can you add LogDemuxFileOps=1(DWORD) registry setting in HKEY_LOCAL_MACHINE\Software\Wow6432Node\NPVR, reproduce the problem, then post those logs again, along with the extra c:\temp\file.txt

[sub]

actually - that was only if you were using nextpvr.exe, so not streaming to kodi.

[sub]

On the Settings->General page, press the ctrl key, then click the verbose logging button that appears, then reproduce the problem in kodi, then immediately post the logs.

[Sepulchre]

Sorry that took a while longer than expected but logs now attached

Hope this helps.

[mvallevand]

I can duplicate this, but I need many attempts. So here is what I found with verbose logging.

When it works

Code:

2021-07-07 19:00:16.038    [DEBUG][91]    RollingFile.Open(C:\temp\live-CBOT-DT-10472-22.ts) ..
2021-07-07 19:00:16.081    [VERBOSE][91]    Got map helper Global\NPVR-mutex-242598cba805384091e7cb514ae842e6
2021-07-07 19:00:16.084    [DEBUG][91]    File is in live mode
2021-07-07 19:00:16.084    [VERBOSE][91]    <map><stream_length>7630168</stream_length><stream_duration>250</stream_duration><complete>false</complete><live>true</live><files><file><filename>C:\temp\live-CBOT-DT-10472-22.ts</filename><offset>0</offset><start_ms>0</start_ms><end_ms>0</end_ms></file></files></map>
2021-07-07 19:00:16.084    [VERBOSE][91]    About to RenewStream()

When it fails, no "live mode" and I don't get that first verbose map and I do get maps on renew which I don't see on sessions that don't fail.

Code:

2021-07-07 19:02:51.184    [DEBUG][91]    StreamNative@10 (with close monitoring...)
2021-07-07 19:02:51.184    [DEBUG][91]    RollingFile.Open(C:\temp\live-CTS-HD-10472-23.ts) ..
2021-07-07 19:02:51.187    [VERBOSE][91]    Got map helper Global\NPVR-mutex-2a4825178ceda151607e55c89a83f151
2021-07-07 19:02:51.194    [VERBOSE][91]    About to RenewStream()
...
2021-07-07 19:03:52.920    [DEBUG][91]    
<map><stream_length>143631624</stream_length><stream_duration>62859</stream_duration><complete>false</complete><live>true</live><files><file><filename>C:\temp\live-CTS-HD-10472-23-2.ts</filename><offset>139187680</offset><start_ms>61015</start_ms><end_ms>61015</end_ms></file><file><filename>C:\temp\live-CTS-HD-10472-23.ts</filename><offset>0</offset><start_ms>0</start_ms><end_ms>0</end_ms></file></files></map>
2021-07-07 19:03:53.355    [DEBUG][91]    Renewed lease... (7E0017)

If you look at @Sepulchre's log you will see the same thing live mode streams work.

Martin

[sub]

I think it's to do with how slow the source is to start delivering data. I think this can happen if the source takes more than 2 seconds to start delivering some data.

[Sepulchre]

Does that explain why it works fine if I restart the same stream again directly afterwards as that’s the behaviour I’ve seen each time.

[sub]

Can do, particularly if 'keep digital tuners primed' is ticked, since it's quicker to start after the first time (and wont even need to retune if the last attempt was the same channel).

[Sepulchre]

Can do, particularly if 'keep digital tuners primed' is ticked, since it's quicker to start after the first time (and wont even need to retune if the last attempt was the same channel).

Interesting thanks!

[mvallevand]

Now that I know to look for the missing "live mode" it makes testing easier and it doesn't seem related to 2 seconds.

2021-07-07 19:57:58.196 [DEBUG][37] Got request [::1]: /live
2021-07-07 19:57:58.197 [DEBUG][37] live tv is possible
2021-07-07 19:57:58.197 [DEBUG][37] http://localhost:54839/stream/start?slip...0472-29.ts
2021-07-07 19:57:58.944 [DEBUG][37] StreamNative@10 (with close monitoring...)
2021-07-07 19:57:58.944 [DEBUG][37] RollingFile.Open(C:\temp\live-CTS-HD-10472-29.ts) ..
2021-07-07 19:57:58.947 [VERBOSE][37] Got map helper Global\NPVR-mutex-e4392c30451d46bce93523b16c514693
2021-07-07 19:57:58.952 [VERBOSE][37] About to RenewStream()

It only took 125ms to tune.

2021-07-07 19:57:58.729 [DEBUG][35] locked=1, present=1, strength=-1500, quality=83 (took 125ms to check)

Martin