HDPVR stream count and recordings that don't terminate

wtg · 2011-01-18, 08:06 PM

I'm not exactly sure what a stream count is that I keep seeing in the logs - used for tracking multiple recordings coming from 1 tuner perhaps? - but it's causing some trouble for my HD-PVR.

While testing my channel change/box reset issue I mentioned earlier, I've found that when a recording is canceled or finishes my HDPVR is being left in a recording state afterwards - HDPVR's little red recording light is on and the file continues to be written to even after the recording finishes. Here's an example of the problem from the logs:

Code:
2011-01-18 13:32:27.319    [DEBUG][7]    About to start recording (1066): F:\video\recordings\Signs\Signs_20110118_12301420-0.ts

2011-01-18 13:32:27.320    [INFO][7]    HDPVRRecorder.StartStream(F:\video\recordings\Signs\Signs_20110118_12301420-0.ts)

[B][COLOR=red]2011-01-18 13:32:27.320    [INFO][7]    HDPVR stream count now 1[/COLOR][/B]

2011-01-18 13:32:27.320    [INFO][7]    Running blaster: C:\vid\STB\channel.bat 951

2011-01-18 13:32:31.830    [INFO][7]    Creating graph

2011-01-18 13:32:31.866    [DEBUG][7]    FindFilterByName failed to locate filter: Hauppauge HD PVR Crossbar

2011-01-18 13:32:31.877    [DEBUG][7]    Temp at 1/18/2011 1:32:41 PM

[COLOR=red]2011-01-18 13:32:31.877    [DEBUG][7]    Failed to start recording (1066:F:\video\recordings\Signs\Signs_20110118_12301420-0.ts): 'Unable to locate crossbar filter (Hauppauge HD PVR Crossbar: #1)'

[/COLOR]

<snip - some time passes while I fix my channel.bat file>

[COLOR=red]2011-01-18 13:33:43.879    [DEBUG][7]    About to start recording (1067): F:\video\recordings\Signs\Signs_20110118_12301420-0.ts

[/COLOR]2011-01-18 13:33:43.879    [INFO][7]    HDPVRRecorder.StartStream(F:\video\recordings\Signs\Signs_20110118_12301420-0.ts)

[B][COLOR=red]2011-01-18 13:33:43.879    [INFO][7]    HDPVR stream count now 2[/COLOR][/B]

2011-01-18 13:33:43.879    [INFO][7]    Running blaster: C:\vid\STB\channel.bat 951

2011-01-18 13:33:44.598    [INFO][7]    Creating graph

2011-01-18 13:33:44.810    [DEBUG][7]    Graph filter list:

2011-01-18 13:33:44.810    [DEBUG][7]     - NPVR Writer2

2011-01-18 13:33:44.810    [DEBUG][7]     - NPVR Writer

2011-01-18 13:33:44.810    [DEBUG][7]     - Infinite Pin Tee Filter

2011-01-18 13:33:44.810    [DEBUG][7]     - Hauppauge HD PVR Encoder

2011-01-18 13:33:44.810    [DEBUG][7]     - Hauppauge HD PVR Capture Device

2011-01-18 13:33:44.810    [DEBUG][7]     - Hauppauge HD PVR Crossbar

2011-01-18 13:33:44.810    [INFO][7]    About to start graph

2011-01-18 13:33:44.816    [DEBUG][7]    Device reports resolution: 1920x1080 (fps:30)

2011-01-18 13:33:44.816    [DEBUG][7]    device minimum bitrate: 200000

2011-01-18 13:33:44.816    [DEBUG][7]    device maximum bitrate: 13500000

2011-01-18 13:33:44.816    [DEBUG][7]    device bitrate step size: 100000

2011-01-18 13:33:44.819    [DEBUG][7]    device reports current bitrate as: 13500000

2011-01-18 13:33:44.823    [DEBUG][7]    device reports current peak bitrate as: 20200000

2011-01-18 13:33:44.823    [DEBUG][7]    About to set BITRATE MODE

2011-01-18 13:33:44.827    [DEBUG][7]    requesting variable encoding

2011-01-18 13:33:44.834    [DEBUG][7]    trying to request bitrate: 13500000

2011-01-18 13:33:44.851    [DEBUG][7]    device confirms bitrate as: 13500000

2011-01-18 13:33:44.851    [DEBUG][7]    About to set PEAK BITRATE 

2011-01-18 13:33:44.851    [DEBUG][7]    device minimum peak bitrate: 200000

2011-01-18 13:33:44.851    [DEBUG][7]    device maximum peak bitrate: 20200000

2011-01-18 13:33:44.851    [DEBUG][7]    device peak bitrate step size: 100000

2011-01-18 13:33:44.851    [DEBUG][7]    trying to request peak bitrate: 20200000

2011-01-18 13:33:44.863    [DEBUG][7]    device confirms bitrate as: 20200000

2011-01-18 13:33:48.837    [DEBUG][7]    About to switch HDPVR to target: 

F:\video\recordings\Signs\Signs_20110118_12301420-0.ts

2011-01-18 13:33:48.851    [DEBUG][7]    Temp at 1/18/2011 1:33:58 PM

2011-01-18 13:33:48.851    [DEBUG][7]    Started recording (1067:F:\video\recordings\Signs\Signs_20110118_12301420-0.ts)

2011-01-18 13:33:48.945    [DEBUG][7]    Starting: C:\Users\Public\NPVR\Scripts\ParallelProcessing.bat "F:\video\recordings\Signs\Signs_20110118_12301420-0.ts" 951 1067

[COLOR=red]2011-01-18 14:22:00.197    [DEBUG][7]    Stopping recording (1067). Past end time of recording.

[B]2011-01-18 14:22:00.197    [INFO][7]    HDPVR stream count now 1[/B][/COLOR]

2011-01-18 14:22:00.490    [DEBUG][7]    No C:\Users\Public\NPVR\Scripts\PostProcessing.bat

After this last recording ended the file just keeps growing and I'm guessing it's due to the stream count issue.

***sub*** · 2011-01-18, 08:24 PM

Remove your rebooting the HD-PVR logic from your batch file, apply this patch (which adds some logging), then reproduce the problem and repost the logs. I'll see if anything stands out.

wtg · 2011-01-18, 09:24 PM

That didn't go well. I applied the patch and while the recordings worked, the logging shows nothing related to them and some new errors:

Code:
[...startup]

2011-01-18 16:08:41.003    [DEBUG][4]    OnStart()

2011-01-18 16:08:41.046    [INFO][4]    Using local in-process recording service

2011-01-18 16:08:41.732    [DEBUG][4]    RecordingServiceProxy@exit

2011-01-18 16:08:41.942    [INFO][4]    RecordingService.Startup()

2011-01-18 16:08:41.942    [INFO][4]    Starting remoting service

2011-01-18 16:08:42.002    [ERROR][4]    Error listing for recording service interface: System.Net.Sockets.SocketException: Only one usage of each socket address (protocol/network address/port) is normally permitted

   at System.Net.Sockets.Socket.DoBind(EndPoint endPointSnapshot, SocketAddress socketAddress)

   at System.Net.Sockets.Socket.Bind(EndPoint localEP)

   at System.Net.Sockets.TcpListener.Start(Int32 backlog)

   at System.Net.Sockets.TcpListener.Start()

   at System.Runtime.Remoting.Channels.ExclusiveTcpListener.Start(Boolean exclusiveAddressUse)

   at System.Runtime.Remoting.Channels.Tcp.TcpServerChannel.StartListening(Object data)

   at System.Runtime.Remoting.Channels.Tcp.TcpServerChannel.SetupChannel()

   at System.Runtime.Remoting.Channels.Tcp.TcpServerChannel..ctor(Int32 port)

   at NShared.RecordingService.Startup()

2011-01-18 16:08:42.041    [DEBUG][7]    Requesting wake up for 'EPGWAKEUP' at 1/19/2011 2:00 AM

2011-01-18 16:08:42.077    [INFO][4]    Starting web server on: 8866

2011-01-18 16:08:42.077    [INFO][4]    Setting working directory to: C:\Program Files\NPVR\

2011-01-18 16:08:42.077    [INFO][4]    Web root: C:\Users\Public\NPVR\web

2011-01-18 16:08:42.171    [INFO][6]    RecordingService starting...

2011-01-18 16:08:42.171    [DEBUG][6]    Loading recording schedule

2011-01-18 16:08:42.186    [DEBUG][6]    Requesting wake up for 'RecordingOID1007' at 1/18/2011 7:57 PM

2011-01-18 16:08:42.186    [DEBUG][6]    Requesting wake up for 'RecordingOID1009' at 1/18/2011 7:57 PM

2011-01-18 16:08:42.186    [DEBUG][6]    Requesting wake up for 'RecordingOID1026' at 1/18/2011 11:57 PM

2011-01-18 16:08:42.187    [DEBUG][6]    Requesting wake up for 'RecordingOID1027' at 1/19/2011 12:57 AM

2011-01-18 16:08:42.187    [DEBUG][6]    Requesting wake up for 'RecordingOID1011' at 1/19/2011 7:57 PM

2011-01-18 16:08:42.187    [DEBUG][6]    Requesting wake up for 'RecordingOID1015' at 1/19/2011 8:57 PM

2011-01-18 16:08:42.187    [DEBUG][6]    Requesting wake up for 'RecordingOID1028' at 1/19/2011 11:57 PM

2011-01-18 16:08:42.187    [DEBUG][6]    Requesting wake up for 'RecordingOID1029' at 1/20/2011 12:57 AM

2011-01-18 16:08:42.187    [DEBUG][6]    Requesting wake up for 'RecordingOID1012' at 1/20/2011 7:57 PM

2011-01-18 16:08:42.187    [DEBUG][6]    Requesting wake up for 'RecordingOID1019' at 1/20/2011 7:57 PM

2011-01-18 16:08:42.187    [DEBUG][6]    Requesting wake up for 'RecordingOID1017' at 1/20/2011 8:57 PM

2011-01-18 16:08:42.187    [DEBUG][6]    Requesting wake up for 'RecordingOID1022' at 1/20/2011 10:27 PM

2011-01-18 16:08:42.187    [DEBUG][6]    Requesting wake up for 'RecordingOID1030' at 1/22/2011 12:57 PM

2011-01-18 16:08:42.187    [DEBUG][6]    Requesting wake up for 'RecordingOID1031' at 1/22/2011 1:57 PM

2011-01-18 16:08:42.188    [DEBUG][6]    Requesting wake up for 'RecordingOID1032' at 1/22/2011 2:57 PM

2011-01-18 16:08:42.188    [DEBUG][6]    Requesting wake up for 'RecordingOID1033' at 1/22/2011 3:57 PM

2011-01-18 16:08:42.188    [DEBUG][6]    Requesting wake up for 'RecordingOID1034' at 1/22/2011 4:57 PM

2011-01-18 16:08:42.188    [DEBUG][6]    Requesting wake up for 'RecordingOID1035' at 1/22/2011 5:57 PM

2011-01-18 16:08:42.188    [DEBUG][6]    Requesting wake up for 'RecordingOID1053' at 1/22/2011 6:57 PM

2011-01-18 16:08:42.188    [DEBUG][6]    Requesting wake up for 'RecordingOID1020' at 1/22/2011 7:57 PM

2011-01-18 16:08:42.188    [DEBUG][6]    Requesting wake up for 'RecordingOID1036' at 1/22/2011 7:57 PM

2011-01-18 16:08:42.188    [DEBUG][6]    Requesting wake up for 'RecordingOID896' at 1/22/2011 8:57 PM

2011-01-18 16:08:42.188    [DEBUG][6]    Requesting wake up for 'RecordingOID1037' at 1/24/2011 2:57 PM

2011-01-18 16:08:42.188    [DEBUG][6]    Requesting wake up for 'RecordingOID1038' at 1/24/2011 3:57 PM

2011-01-18 16:08:42.188    [DEBUG][6]    Requesting wake up for 'RecordingOID1039' at 1/24/2011 4:57 PM

2011-01-18 16:08:42.188    [DEBUG][6]    Requesting wake up for 'RecordingOID1040' at 1/24/2011 5:57 PM

2011-01-18 16:08:42.188    [DEBUG][6]    Requesting wake up for 'RecordingOID1041' at 1/24/2011 6:57 PM

2011-01-18 16:08:42.188    [DEBUG][6]    Requesting wake up for 'RecordingOID1005' at 1/24/2011 8:57 PM

2011-01-18 16:08:42.188    [DEBUG][6]    Requesting wake up for 'RecordingOID1054' at 1/24/2011 8:57 PM

2011-01-18 16:08:42.188    [DEBUG][6]    Requesting wake up for 'RecordingOID1042' at 1/25/2011 12:57 AM

2011-01-18 16:08:42.188    [DEBUG][6]    Requesting wake up for 'RecordingOID1008' at 1/25/2011 7:57 PM

2011-01-18 16:08:42.188    [DEBUG][6]    Requesting wake up for 'RecordingOID1010' at 1/25/2011 7:57 PM

2011-01-18 16:08:42.188    [DEBUG][6]    Requesting wake up for 'RecordingOID1043' at 1/25/2011 11:57 PM

2011-01-18 16:08:42.188    [DEBUG][6]    Requesting wake up for 'RecordingOID1044' at 1/26/2011 12:57 AM

2011-01-18 16:08:42.188    [DEBUG][6]    Requesting wake up for 'RecordingOID1045' at 1/26/2011 6:57 PM

2011-01-18 16:08:42.188    [DEBUG][6]    Requesting wake up for 'RecordingOID1013' at 1/26/2011 7:57 PM

2011-01-18 16:08:42.189    [DEBUG][6]    Requesting wake up for 'RecordingOID1046' at 1/26/2011 7:57 PM

2011-01-18 16:08:42.189    [DEBUG][6]    Requesting wake up for 'RecordingOID1016' at 1/26/2011 8:57 PM

2011-01-18 16:08:42.189    [DEBUG][6]    Requesting wake up for 'RecordingOID1047' at 1/26/2011 11:57 PM

2011-01-18 16:08:42.189    [DEBUG][6]    Requesting wake up for 'RecordingOID1048' at 1/27/2011 12:57 AM

2011-01-18 16:08:42.189    [DEBUG][6]    Requesting wake up for 'RecordingOID1014' at 1/27/2011 7:57 PM

2011-01-18 16:08:42.189    [DEBUG][6]    Requesting wake up for 'RecordingOID1021' at 1/27/2011 7:57 PM

2011-01-18 16:08:42.189    [DEBUG][6]    Requesting wake up for 'RecordingOID1018' at 1/27/2011 8:57 PM

2011-01-18 16:08:42.189    [DEBUG][6]    Requesting wake up for 'RecordingOID1023' at 1/27/2011 10:27 PM

2011-01-18 16:08:42.189    [DEBUG][6]    Requesting wake up for 'RecordingOID1049' at 1/31/2011 2:57 PM

2011-01-18 16:08:42.189    [DEBUG][6]    Requesting wake up for 'RecordingOID1050' at 1/31/2011 3:57 PM

2011-01-18 16:08:42.189    [DEBUG][6]    Requesting wake up for 'RecordingOID1051' at 1/31/2011 4:57 PM

2011-01-18 16:08:42.189    [DEBUG][6]    Requesting wake up for 'RecordingOID1052' at 1/31/2011 5:57 PM

2011-01-18 16:08:42.189    [DEBUG][6]    Requesting wake up for 'RecordingOID1024' at 1/31/2011 6:57 PM

2011-01-18 16:08:42.189    [DEBUG][6]    Requesting wake up for 'RecordingOID1006' at 1/31/2011 8:57 PM

2011-01-18 16:08:42.189    [DEBUG][6]    Requesting wake up for 'RecordingOID1055' at 1/31/2011 8:57 PM

2011-01-18 16:08:42.189    [DEBUG][6]    Requesting wake up for 'RecordingOID1025' at 1/31/2011 11:57 PM

2011-01-18 16:08:47.047    [DEBUG][8]    Client Listener starting on port 7969

2011-01-18 16:08:47.048    [ERROR][8]    Unexpected error in Client Listener: System.Net.Sockets.SocketException: Only one usage of each socket address (protocol/network address/port) is normally permitted

   at System.Net.Sockets.Socket.DoBind(EndPoint endPointSnapshot, SocketAddress socketAddress)

   at System.Net.Sockets.Socket.Bind(EndPoint localEP)

   at NShared.ClientStreaming.WorkerThread()

2011-01-18 16:08:49.752    [DEBUG][4]    OnStart() complete...

***sub*** · 2011-01-18, 10:37 PM

Try rebooting

wtg · 2011-01-19, 12:07 AM

Here's the log file.

The first few recording attempts and cancellations worked fine. At the 17:55 mark I put the restart logic back in and had a failure, and at that point the stream count got off like before....

wtg · 2011-01-20, 08:12 PM

Any thing of interest in the log sub?

By the way, with the patch installed I had a strange problem last night. After midnight when BladeRunner should have been recording I noticed that the red recording light of the HD-PVR wasn't on. Looking at logs I could see the recording seemed to start without error and when I looked in the recordings directory, I could see it was writing to the file so I let it go. When I checked on it this morning it seemed to finish fine but the file doesn't contain playable video data. It looks like it hit an error at startup but didn't detect it. (I did not have my reset logic in there) Another HDPVR recording later in the evening worked fine however.

Any chance npvr didn't detect the error due to the extra debugging logic?

Code:
2011-01-20 00:14:00.033    [DEBUG][7]    About to start recording (1132): F:\video\recordings\Blade Runner\Blade Runner_20110120_00150215.ts

2011-01-20 00:14:00.036    [INFO][7]    HDPVRRecorder.StartStream(F:\video\recordings\Blade Runner\Blade Runner_20110120_00150215.ts)

2011-01-20 00:14:00.036    [INFO][7]    HDPVR stream count now 1

2011-01-20 00:14:00.036    [INFO][7]    Running blaster: C:\vid\STB\channel.bat 949

2011-01-20 00:14:00.974    [INFO][7]    Creating graph

2011-01-20 00:14:01.283    [DEBUG][7]    Graph filter list:

2011-01-20 00:14:01.283    [DEBUG][7]     - NPVR Writer2

2011-01-20 00:14:01.283    [DEBUG][7]     - NPVR Writer

2011-01-20 00:14:01.283    [DEBUG][7]     - Infinite Pin Tee Filter

2011-01-20 00:14:01.283    [DEBUG][7]     - Hauppauge HD PVR Encoder

2011-01-20 00:14:01.283    [DEBUG][7]     - Hauppauge HD PVR Capture Device

2011-01-20 00:14:01.284    [DEBUG][7]     - Hauppauge HD PVR Crossbar

2011-01-20 00:14:01.284    [INFO][7]    About to start graph

2011-01-20 00:14:01.289    [DEBUG][7]    Device reports resolution: 1920x1080 (fps:30)

2011-01-20 00:14:01.289    [DEBUG][7]    device minimum bitrate: 200000

2011-01-20 00:14:01.289    [DEBUG][7]    device maximum bitrate: 13500000

2011-01-20 00:14:01.289    [DEBUG][7]    device bitrate step size: 100000

2011-01-20 00:14:01.291    [DEBUG][7]    device reports current bitrate as: 13500000

2011-01-20 00:14:01.295    [DEBUG][7]    device reports current peak bitrate as: 20200000

2011-01-20 00:14:01.295    [DEBUG][7]    About to set BITRATE MODE

2011-01-20 00:14:01.299    [DEBUG][7]    requesting variable encoding

2011-01-20 00:14:01.308    [DEBUG][7]    trying to request bitrate: 13500000

2011-01-20 00:14:01.324    [DEBUG][7]    device confirms bitrate as: 13500000

2011-01-20 00:14:01.324    [DEBUG][7]    About to set PEAK BITRATE 

2011-01-20 00:14:01.324    [DEBUG][7]    device minimum peak bitrate: 200000

2011-01-20 00:14:01.324    [DEBUG][7]    device maximum peak bitrate: 20200000

2011-01-20 00:14:01.324    [DEBUG][7]    device peak bitrate step size: 100000

2011-01-20 00:14:01.324    [DEBUG][7]    trying to request peak bitrate: 20200000

2011-01-20 00:14:01.335    [DEBUG][7]    device confirms bitrate as: 20200000

2011-01-20 00:14:02.134    [DEBUG][7]    About to switch HDPVR to target: 

F:\video\recordings\Blade Runner\Blade Runner_20110120_00150215.ts

2011-01-20 00:14:02.169    [DEBUG][7]    Temp at 1/20/2011 12:14:12 AM

2011-01-20 00:14:02.169    [DEBUG][7]    Started recording (1132:F:\video\recordings\Blade Runner\Blade Runner_20110120_00150215.ts)

2011-01-20 00:14:02.254    [DEBUG][7]    Starting: C:\Users\Public\NPVR\Scripts\ParallelProcessing.bat "F:\video\recordings\Blade Runner\Blade Runner_20110120_00150215.ts" 949 1132

2011-01-20 00:59:00.264    [DEBUG][7]    About to start recording (1107): F:\video\recordings\UFC Unleashed\UFC Unleashed_20110120_01000200.ts

2011-01-20 00:59:00.264    [INFO][7]    DigitalRecorder.StartStream(F:\video\recordings\UFC Unleashed\UFC Unleashed_20110120_01000200.ts)

2011-01-20 00:59:00.286    [INFO][7]    DigitalRecorder.StartStream() allocated handle: 0x3

2011-01-20 00:59:00.289    [DEBUG][7]    Temp at 1/20/2011 12:59:10 AM

2011-01-20 00:59:00.290    [DEBUG][7]    Started recording (1107:F:\video\recordings\UFC Unleashed\UFC Unleashed_20110120_01000200.ts)

2011-01-20 00:59:00.446    [DEBUG][7]    Starting: C:\Users\Public\NPVR\Scripts\ParallelProcessing.bat "F:\video\recordings\UFC Unleashed\UFC Unleashed_20110120_01000200.ts" 141 1107

2011-01-20 01:02:00.106    [DEBUG][7]    Stopping recording (1106). Past end time of recording.

2011-01-20 01:02:00.106    [INFO][7]    DigitalRecorder.StopStream() handle: 1

2011-01-20 01:02:00.332    [DEBUG][7]    No C:\Users\Public\NPVR\Scripts\PostProcessing.bat

2011-01-20 02:01:13.940    [DEBUG][8]    About to update EPG

2011-01-20 02:01:13.975    [DEBUG][8]    Updating EPG...

2011-01-20 02:02:00.279    [DEBUG][7]    Stopping recording (1107). Past end time of recording.

2011-01-20 02:02:00.279    [INFO][7]    DigitalRecorder.StopStream() handle: 3

2011-01-20 02:02:00.314    [INFO][7]    No more streams active. Stopping device.

2011-01-20 02:02:00.314    [DEBUG][7]    About to request async graph stop

2011-01-20 02:02:00.315    [DEBUG][14]    Graph stopping... (async)

2011-01-20 02:02:00.332    [DEBUG][14]    Graph reports state 'Stopped'

2011-01-20 02:02:00.332    [DEBUG][14]    Graph stopped (async)

2011-01-20 02:02:00.332    [DEBUG][7]    Async stop completed successfully

2011-01-20 02:02:00.392    [DEBUG][7]    No C:\Users\Public\NPVR\Scripts\PostProcessing.bat

2011-01-20 02:09:51.125    [DEBUG][8]    Checking for any XMLTV listings

2011-01-20 02:09:51.223    [DEBUG][8]    Will process xmltv file: C:\XMLTV\digital_listing.xml

2011-01-20 02:09:51.230    [DEBUG][8]    Loading XMLTV from: C:\XMLTV\digital_listing.xml

<snip>

2011-01-20 02:17:00.177    [DEBUG][7]    Stopping recording (1132). Past end time of recording.

2011-01-20 02:17:00.178    [INFO][7]    HDPVRRecorder.StopStream(2)

2011-01-20 02:17:00.178    [INFO][7]    HDPVR stream count now 0

2011-01-20 02:17:00.179    [DEBUG][7]    Graph stopping...

2011-01-20 02:17:03.421    [DEBUG][7]    Graph stopped

2011-01-20 02:17:03.424    [DEBUG][7]    Removing filter  NPVR Writer2

2011-01-20 02:17:03.424    [DEBUG][7]    Removing filter  NPVR Writer

2011-01-20 02:17:03.424    [DEBUG][7]    Removing filter  Infinite Pin Tee Filter

2011-01-20 02:17:03.426    [DEBUG][7]    Removing filter  Hauppauge HD PVR Encoder

2011-01-20 02:17:03.427    [DEBUG][7]    Removing filter  Hauppauge HD PVR Capture Device

2011-01-20 02:17:03.428    [DEBUG][7]    Removing filter  Hauppauge HD PVR Crossbar

2011-01-20 02:17:03.505    [DEBUG][7]    No C:\Users\Public\NPVR\Scripts\PostProcessing.bat

wtg · 2011-01-20, 08:14 PM

When I said "the file doesn't contain playable video data", I mean it wouldn't play. But npvr did apparently keep writing to the file the entire time... it was an expected 8GB file size.

***sub*** · 2011-01-20, 08:32 PM

wtg Wrote:The first few recording attempts and cancellations worked fine. At the 17:55 mark I put the restart logic back in and had a failure, and at that point the stream count got off like before....

Yeah, I suspect you're breaking the graph by effectively disconnecting/reconnecting the device, and some how this is leading to the problem. I dont really have any suggestions for you on this though. Sorry.

***sub*** · 2011-01-20, 08:33 PM

wtg Wrote:When I said "the file doesn't contain playable video data", I mean it wouldn't play. But npvr did apparently keep writing to the file the entire time... it was an expected 8GB file size.

Thats odd. NPVR doesnt even look at the data though - it comes out of the HDPVR and is sent straight to disk. If it has garbage data in it, I'm pretty sure the HDPVR generated this garbage.

Does it play in VLC?

wtg · 2011-01-20, 11:06 PM

No, won't play in anything. Strangely, MediaInfo reports it as valid MPEG container, reports the resolutions and bitrate, etc.. but like you suggest, I'm guessing that it's just garbage data. But like I said, I didn't have any logic in the channel.bat file to reset the device when this ran, so I wondered if maybe the debug logic that was added somehow affected npvr's ability to recognize the HDPVR failed to start.

In any event, the next recording worked and with your patch I'll test the reset logic with npvr. I really didn't expect you to make a change to begin with but was just hoping someone had some other ideas about how to reset the device periodically.

Thanks again!

Possibly Related Threads…
Thread		Author	Replies	Views	Last Post
	Failed recordings won't delete	Spid4567	3	2,350	2023-07-14, 10:13 PM Last Post: ZeDoZ
	All my recordings start 90 sec early	ncsercs	2	1,290	2022-03-19, 03:28 AM Last Post: sub
	Wake - Sleep Interaction -> Failed Recordings	mikeh49	48	14,060	2021-03-21, 11:21 PM Last Post: careads
	DVB-T and selecting audio stream	three6zerocool	17	4,832	2021-02-06, 04:22 PM Last Post: artmetz
	Most recordings are zero bytes	virtualpaul	4	1,945	2021-01-29, 12:55 PM Last Post: virtualpaul
	Recordings with Next PVR 4.2.5 (CL0116) have background music but no voice in record	DavidF	4	1,986	2021-01-07, 08:47 AM Last Post: sub
	Recordings not playing in browser	FamilyGuyFan	1	1,375	2020-10-22, 10:18 PM Last Post: mvallevand
	Recordings 1 minute off	BobbyDing	7	2,675	2020-10-11, 08:07 PM Last Post: mvallevand
	easy tools to remove adverts in recordings?	V_J	6	3,870	2020-10-06, 02:37 AM Last Post: Ehrlichia
	Black screen, no audio, & zero bit recordings	mattman1968	1	1,507	2020-09-15, 12:19 AM Last Post: mattman1968