error on starting livetv in 1.5.28

[johnsonx42]

When I try to start live tv from the TV Guide, it hangs for awhile, then I hear sound but get a .net exception on the screen. After closing the .net exception, the sound continues for a few more moments, then ends.

NPVR/NRECORD logs attached, and here is the text of the .net exception:

Code:

See the end of this message for details on invoking just-in-time (JIT) debugging instead of this dialog box. ************** Exception Text ************** System.Collections.Generic.KeyNotFoundException: The given key was not present in the dictionary. at System.ThrowHelper.ThrowKeyNotFoundException() at System.Collections.Generic.Dictionary`2.get_Item(TKey key) at NextPVR.Players.LiveTvPlayer.StartLiveTV(Channel channel, String& reason) at NextPVR.ControllerForm.PlayLiveTV(Channel channel) at NextPVR.TV.ShowDetailsPopup.HandleCommand(String command) at NextPVR.TV.ShowDetailsPopup.HandleButtonCommand(String buttonName) at NUtility.Controls.UiButtonList.OnKeyDown(KeyEventArgs e) at NextPVR.TV.ShowDetailsPopup.OnKeyDown(KeyEventArgs e) at NextPVR.ControllerForm.OnKeyDown(Object sender, KeyEventArgs e) at System.Windows.Forms.Control.OnKeyDown(KeyEventArgs e) at System.Windows.Forms.Control.ProcessKeyEventArgs(Message& m) at System.Windows.Forms.Control.ProcessKeyMessage(Message& m) at System.Windows.Forms.Control.WmKeyChar(Message& m) at System.Windows.Forms.Control.WndProc(Message& m) at System.Windows.Forms.ScrollableControl.WndProc(Message& m) at System.Windows.Forms.ContainerControl.WndProc(Message& m) at System.Windows.Forms.Form.WndProc(Message& m) at NextPVR.ControllerForm.WndProc(Message& m) at System.Windows.Forms.Control.ControlNativeWindow.OnMessage(Message& m) at System.Windows.Forms.Control.ControlNativeWindow.WndProc(Message& m) at System.Windows.Forms.NativeWindow.Callback(IntPtr hWnd, Int32 msg, IntPtr wparam, IntPtr lparam) ************** Loaded Assemblies ************** mscorlib Assembly Version: 2.0.0.0 Win32 Version: 2.0.50727.4927 (NetFXspW7.050727-4900) CodeBase: file:///C:/Windows/Microsoft.NET/Framework/v2.0.50727/mscorlib.dll ---------------------------------------- NextPVR Assembly Version: 1.0.0.0 Win32 Version: 1.0.0.0 CodeBase: file:///C:/Program%20Files/NPVR/NextPVR.exe ---------------------------------------- NShared Assembly Version: 1.0.0.0 Win32 Version: 1.0.0.0 CodeBase: file:///C:/Program%20Files/NPVR/NShared.DLL ---------------------------------------- NUtility Assembly Version: 1.0.0.0 Win32 Version: 1.0.0.0 CodeBase: file:///C:/Program%20Files/NPVR/NUtility.DLL ---------------------------------------- System.Data Assembly Version: 2.0.0.0 Win32 Version: 2.0.50727.4927 (NetFXspW7.050727-4900) CodeBase: file:///C:/Windows/assembly/GAC_32/System.Data/2.0.0.0__b77a5c561934e089/System.Data.dll ---------------------------------------- System Assembly Version: 2.0.0.0 Win32 Version: 2.0.50727.4927 (NetFXspW7.050727-4900) CodeBase: file:///C:/Windows/assembly/GAC_MSIL/System/2.0.0.0__b77a5c561934e089/System.dll ---------------------------------------- System.Windows.Forms Assembly Version: 2.0.0.0 Win32 Version: 2.0.50727.4927 (NetFXspW7.050727-4900) CodeBase: file:///C:/Windows/assembly/GAC_MSIL/System.Windows.Forms/2.0.0.0__b77a5c561934e089/System.Windows.Forms.dll ---------------------------------------- System.Drawing Assembly Version: 2.0.0.0 Win32 Version: 2.0.50727.4927 (NetFXspW7.050727-4900) CodeBase: file:///C:/Windows/assembly/GAC_MSIL/System.Drawing/2.0.0.0__b03f5f7f11d50a3a/System.Drawing.dll ---------------------------------------- System.Data.SQLite Assembly Version: 1.0.65.0 Win32 Version: 1.0.65.0 CodeBase: file:///C:/Program%20Files/NPVR/System.Data.SQLite.DLL ---------------------------------------- System.Xml Assembly Version: 2.0.0.0 Win32 Version: 2.0.50727.4927 (NetFXspW7.050727-4900) CodeBase: file:///C:/Windows/assembly/GAC_MSIL/System.Xml/2.0.0.0__b77a5c561934e089/System.Xml.dll ---------------------------------------- System.Data.Entity Assembly Version: 3.5.0.0 Win32 Version: 3.5.30729.4926 built by: NetFXw7 CodeBase: file:///C:/Windows/assembly/GAC_MSIL/System.Data.Entity/3.5.0.0__b77a5c561934e089/System.Data.Entity.dll ---------------------------------------- System.Core Assembly Version: 3.5.0.0 Win32 Version: 3.5.30729.4926 built by: NetFXw7 CodeBase: file:///C:/Windows/assembly/GAC_MSIL/System.Core/3.5.0.0__b77a5c561934e089/System.Core.dll ---------------------------------------- System.Runtime.Remoting Assembly Version: 2.0.0.0 Win32 Version: 2.0.50727.4927 (NetFXspW7.050727-4900) CodeBase: file:///C:/Windows/assembly/GAC_MSIL/System.Runtime.Remoting/2.0.0.0__b77a5c561934e089/System.Runtime.Remoting.dll ---------------------------------------- Test1 Assembly Version: 1.0.0.0 Win32 Version: 1.0.0.0 CodeBase: file:///C:/Program%20Files/NPVR/NUtility.dll ---------------------------------------- Test2 Assembly Version: 1.0.0.0 Win32 Version: 1.0.0.0 CodeBase: file:///C:/Program%20Files/NPVR/NUtility.dll ---------------------------------------- Test3 Assembly Version: 1.0.0.0 Win32 Version: 1.0.0.0 CodeBase: file:///C:/Program%20Files/NPVR/NUtility.dll ---------------------------------------- StreamIt.Netflix Assembly Version: 1.0.0.0 Win32 Version: 1.0.0.0 CodeBase: file:///C:/Program%20Files/NPVR/NUtility.dll ---------------------------------------- System.Data.Services.Client Assembly Version: 3.5.0.0 Win32 Version: 3.5.30729.5004 built by: Win7RTMLDR CodeBase: file:///C:/Windows/assembly/GAC_MSIL/System.Data.Services.Client/3.5.0.0__b77a5c561934e089/System.Data.Services.Client.dll ---------------------------------------- WebRadio Assembly Version: 1.0.0.0 Win32 Version: 1.0.0.0 CodeBase: file:///C:/Program%20Files/NPVR/NUtility.dll ---------------------------------------- SlimDX Assembly Version: 2.0.8.42 Win32 Version: CodeBase: file:///C:/Program%20Files/NPVR/SlimDX.DLL ---------------------------------------- msvcm90 Assembly Version: 9.0.30729.4926 Win32 Version: 9.00.30729.4926 CodeBase: file:///C:/Windows/WinSxS/x86_microsoft.vc90.crt_1fc8b3b9a1e18e3b_9.0.30729.4926_none_508ed732bcbc0e5a/msvcm90.dll ---------------------------------------- taglib-sharp Assembly Version: 2.0.3.0 Win32 Version: 2.0.3.0 CodeBase: file:///C:/Program%20Files/NPVR/taglib-sharp.DLL ---------------------------------------- System.Transactions Assembly Version: 2.0.0.0 Win32 Version: 2.0.50727.4927 (NetFXspW7.050727-4900) CodeBase: file:///C:/Windows/assembly/GAC_32/System.Transactions/2.0.0.0__b77a5c561934e089/System.Transactions.dll ---------------------------------------- System.Configuration Assembly Version: 2.0.0.0 Win32 Version: 2.0.50727.4927 (NetFXspW7.050727-4900) CodeBase: file:///C:/Windows/assembly/GAC_MSIL/System.Configuration/2.0.0.0__b03f5f7f11d50a3a/System.Configuration.dll ---------------------------------------- System.EnterpriseServices Assembly Version: 2.0.0.0 Win32 Version: 2.0.50727.4927 (NetFXspW7.050727-4900) CodeBase: file:///C:/Windows/assembly/GAC_32/System.EnterpriseServices/2.0.0.0__b03f5f7f11d50a3a/System.EnterpriseServices.dll ---------------------------------------- Unmanaged Assembly Version: 1.0.3870.12587 Win32 Version: CodeBase: file:///C:/Program%20Files/NPVR/Unmanaged.DLL ---------------------------------------- ************** JIT Debugging ************** To enable just-in-time (JIT) debugging, the .config file for this application or computer (machine.config) must have the jitDebugging value set in the system.windows.forms section. The application must also be compiled with debugging enabled. For example: <configuration> <system.windows.forms jitDebugging="true" /> </configuration> When JIT debugging is enabled, any unhandled exception will be sent to the JIT debugger registered on the computer rather than be handled by this dialog box.

[johnsonx42]

bump... nobody has anything on this? I can no longer watch Live TV. My wife is going to kill me if I don't get this resolved. So much is improved with 1.5.28 I can't even consider going back to 1.5.24.

[sub]

I cant see any obvious reason in your logs, but try it with this patch, then repost the npvr.log. It adds more messages around the area of code that is having the problem.

[johnsonx42]

thanks sub, I'll put in the patch and test as soon as my wife gives up the TV for the evening.

[johnsonx42]

ok, weird, livetv works fine with the new patch. I have to admit though I didn't actually try livetv tonight before posting, I just asked my wife if she had tried again while I was away, she said yes, she got the same exception so I left it at that

here's the double weird thing, livetv now works fine on my test client too (the desktop win7 pc I'm typing this from), except I didn't change anything on the client. both the client and the server got the same exception error when trying to watch livetv, and now it's gone. both machines have been rebooted since livetv was discovered not to work, with no change until now.

this doesn't make a hell of a lot of sense. I also had the phantom epg problem where all my pending recordings disappeared, and that went away by itself too.

gremlins?

[sub]

Odd. Come back to me if it stops working.

[johnsonx42]

This is back. I figured out the mystery - I get this exception if I try to start LiveTV while a recording is in progress. As far as I can tell, both tuners are working fine. In a few minutes I have recordings starting on both tuners; I will report whether those proceed normally.

In the meantime, here are the logs of tonight's problem. Same symptoms as reported before - hangs a moment, then I get sound, the exception pops up, then sound continues for a bit and ends.

My wife came and got me because she couldn't watch Entertainment tonight. I first restarted NextPVR.exe, and then tried it myself.

Look at the logs at 19:21:21 - I tried to start live tv, and got the exception. Then I noticed a recording (#4056) was in progress so on a hunch I cancelled that, at 19:22:13. Then I was able to start Live TV at 19:22:41.

Then at 19:30:00 it tried to end the recording 4056 again at the normal time even though I already cancelled it 9 minutes earlier. LiveTV came to an abrupt end with the message "The tuner being used for LiveTV is no longer available". It appears that when it thought it was killing 4056 it was actually killing the graph being used by LiveTV, and the renew lease failed a few seconds later.

I was able to restart LiveTV again a few seconds later. My wife declared that this all sucks, all she wants to do is watch stupid tv.

[johnsonx42]

Yes, both recordings are running and playable, so the tuners are fine. Here is a log excerpt from when the recordings started (we left LiveTV running up until it was forcibly ended):

Code:

2010-08-10 19:59:59.779 [DEBUG][5] GetQuality() 2010-08-10 19:59:59.785 [DEBUG][5] GetQuality()@exit 2010-08-10 20:00:00.148 [DEBUG][6] Scheduled recording is supposed to start on tuner currently being used for live tv. Need to look for alternative tuner. 2010-08-10 20:00:00.157 [DEBUG][6] Checking if multi-record possible... 2010-08-10 20:00:00.161 [DEBUG][6] Unable to find alternative tuner. Live TV will be stopped. 2010-08-10 20:00:00.161 [DEBUG][6] About to start recording (4048): F:\Recordings\Wipeout\Wipeout_20100810_20002101.ts 2010-08-10 20:00:00.161 [INFO][6] DigitalRecorder.StartStream(F:\Recordings\Wipeout\Wipeout_20100810_20002101.ts) 2010-08-10 20:00:00.172 [DEBUG][6] Switching BDA graph to tune: <tuning> <type>ATSC</type> <locator> <physical_channel>7</physical_channel> </locator> <service_id>1</service_id> <tsid>295</tsid> <service_type>1</service_type> </tuning> 2010-08-10 20:00:00.686 [DEBUG][6] locked=1, present=1, strength=-10000, quality=100 (took 15ms to check) 2010-08-10 20:00:00.687 [INFO][6] DigitalRecorder.StartStream() allocated handle: 0x2 2010-08-10 20:00:00.687 [DEBUG][6] Temp at 8/10/2010 8:00:10 PM 2010-08-10 20:00:00.687 [DEBUG][6] Started recording (4048:F:\Recordings\Wipeout\Wipeout_20100810_20002101.ts) 2010-08-10 20:00:00.752 [DEBUG][6] No C:\Users\Public\NPVR\Scripts\ParallelProcessing.bat 2010-08-10 20:00:00.759 [DEBUG][6] About to start recording (4070): F:\Recordings\Minute to Win It\Minute to Win It_20100810_20002100.ts 2010-08-10 20:00:00.759 [INFO][6] DigitalRecorder.StartStream(F:\Recordings\Minute to Win It\Minute to Win It_20100810_20002100.ts) 2010-08-10 20:00:00.759 [INFO][6] Creating BDA graph 2010-08-10 20:00:00.766 [DEBUG][6] Using tuner WinTV HVR-950 BDA Tuner (1) 2010-08-10 20:00:00.781 [DEBUG][6] About to auto detect capture filter 2010-08-10 20:00:00.784 [DEBUG][6] Got capture filter. 2010-08-10 20:00:00.784 [DEBUG][6] Added capture filter 2010-08-10 20:00:00.786 [DEBUG][6] Connected Tuner to Capture 2010-08-10 20:00:00.801 [DEBUG][6] Graph filter list: 2010-08-10 20:00:00.802 [DEBUG][6] - BDA MPEG2 Transport Information Filter 2010-08-10 20:00:00.802 [DEBUG][6] - MPEG-2 Demultiplexer 2010-08-10 20:00:00.802 [DEBUG][6] - NPVR TS Mon 2010-08-10 20:00:00.802 [DEBUG][6] - Capture 2010-08-10 20:00:00.802 [DEBUG][6] - Tuner 2010-08-10 20:00:00.802 [DEBUG][6] - Network Provider 2010-08-10 20:00:00.803 [INFO][6] About to start BDA graph 2010-08-10 20:00:00.803 [DEBUG][6] Starting graph... 2010-08-10 20:00:04.625 [DEBUG][6] About to tune BDA graph: <tuning> <type>ATSC</type> <locator> <physical_channel>36</physical_channel> </locator> <service_id>3</service_id> <tsid>291</tsid> <service_type>1</service_type> </tuning> 2010-08-10 20:00:04.944 [DEBUG][6] locked=1, present=1, strength=-28, quality=73 (took 78ms to check) 2010-08-10 20:00:04.945 [INFO][6] DigitalRecorder.StartStream() allocated handle: 0x1 2010-08-10 20:00:04.946 [DEBUG][6] Temp at 8/10/2010 8:00:14 PM 2010-08-10 20:00:04.946 [DEBUG][6] Started recording (4070:F:\Recordings\Minute to Win It\Minute to Win It_20100810_20002100.ts) 2010-08-10 20:00:05.021 [DEBUG][6] No C:\Users\Public\NPVR\Scripts\ParallelProcessing.bat 2010-08-10 20:00:05.027 [DEBUG][5] Renew lease failed (0x5F20001) 2010-08-10 20:00:05.027 [DEBUG][5] liveHandleRenewalTime contains 1 handles: 2010-08-10 20:00:05.027 [DEBUG][5] - 0x5F20001 2010-08-10 20:00:05.027 [DEBUG][15] GetQuality() 2010-08-10 20:00:05.034 [DEBUG][15] GetQuality()@exit 2010-08-10 20:00:05.034 [DEBUG][15] GetQuality() 2010-08-10 20:00:05.056 [DEBUG][15] GetQuality()@exit 2010-08-10 20:00:05.134 [DEBUG][14] GetQuality() 2010-08-10 20:00:05.139 [DEBUG][14] GetQuality()@exit 2010-08-10 20:00:05.139 [DEBUG][14] GetQuality() 2010-08-10 20:00:05.161 [DEBUG][14] GetQuality()@exit 2010-08-10 20:00:05.227 [DEBUG][13] GetQuality() 2010-08-10 20:00:05.232 [DEBUG][13] GetQuality()@exit 2010-08-10 20:00:05.232 [DEBUG][13] GetQuality() 2010-08-10 20:00:05.254 [DEBUG][13] GetQuality()@exit 2010-08-10 20:00:05.320 [INFO][5] DigitalRecorder.StopStream() handle: 1 2010-08-10 20:00:05.324 [DEBUG][15] GetQuality() 2010-08-10 20:00:05.330 [DEBUG][15] GetQuality()@exit 2010-08-10 20:00:05.330 [DEBUG][15] GetQuality() 2010-08-10 20:00:05.359 [DEBUG][15] GetQuality()@exit

[sub]

I was able to restart LiveTV again a few seconds later. My wife declared that this all sucks, all she wants to do is watch stupid tv.

Hey - I did say it was a beta

[johnsonx42]

yeah, wives are less understanding of the whole beta thing than us nerds are