2012-10-10, 10:27 AM
I have upgraded to NPVR 2.5.9 (this issue also existed in 2.5.5, but did not exist in previous versions as often). Almost every morning, the following recording produces a zero length file. Most other recordings during the day do record properly, however, not all. The HD Homerun logs indicate that the tuning is successful. I am and have also been running WMC on this same computer and using a different set of tuner cards for WMC. I have prevented WMC from using the HD Homerun. I restarted the NPVR recording service and it then began recording this manually scheduled event. The HD Homerun has the latest Firmware installed.
2012-10-10 03:58:00.004 [DEBUG][7] allocating recording target filename: V:\MSNBCHD 0358-0802_20121010_03580802.ts
2012-10-10 03:58:00.004 [DEBUG][7] About to start recording (142266 on 27): V:\MSNBCHD 0358-0802_20121010_03580802.ts...
2012-10-10 03:58:00.024 [DEBUG][7] Free space 986554183680 (V:\)
2012-10-10 03:58:00.074 [DEBUG][7] HDHomeRunRecorder@1
2012-10-10 03:58:00.074 [DEBUG][7] HDHomeRunRecorder@2.0
2012-10-10 03:58:00.074 [DEBUG][7] HDHomeRunRecorder@2.1
2012-10-10 03:58:00.074 [DEBUG][7] HDHomeRunRecorder@2.2 nextPort=36312
2012-10-10 03:58:00.074 [DEBUG][7] HDHomeRunRecorder@2.2.0
2012-10-10 03:58:00.074 [DEBUG][7] HDHomeRunRecorder@2.2.0@allocated
2012-10-10 03:58:00.074 [DEBUG][7] HDHomeRunRecorder@2.3
2012-10-10 03:58:00.074 [DEBUG][7] Allocated port: 36312
2012-10-10 03:58:00.074 [DEBUG][7] HDHomeRunRecorder@3
2012-10-10 03:58:00.074 [DEBUG][7] About to start HDHR device. Checking status for information sake... (could tell if it's already in use elsewhere)
2012-10-10 03:58:00.074 [DEBUG][7] Executing: C:\Program Files\Silicondust\HDHomeRun\hdhomerun_config.exe 1312389D get /tuner1/status
2012-10-10 03:58:00.114 [DEBUG][7] Status: ch=none lock=none ss=0 snq=0 seq=0 bps=0 pps=0
2012-10-10 03:58:07.185 [DEBUG][7] SetTarget@2
2012-10-10 03:58:07.186 [DEBUG][7] Executing: C:\Program Files\Silicondust\HDHomeRun\hdhomerun_config.exe 1312389D set /tuner1/vchannel 317
2012-10-10 03:58:07.279 [DEBUG][7] NIC: Realtek PCIe GBE Family Controller
2012-10-10 03:58:07.280 [DEBUG][7] Executing: C:\Program Files\Silicondust\HDHomeRun\hdhomerun_config.exe 1312389D set /tuner1/target rtp://10.1.1.230:36312
2012-10-10 03:58:07.281 [DEBUG][7] SetTarget@2
2012-10-10 03:58:07.283 [DEBUG][7] Temp at 10/10/2012 3:58:17 AM
2012-10-10 03:58:07.283 [DEBUG][7] Started recording (142266:1:V:\MSNBCHD 0358-0802_20121010_03580802.ts)
2012-10-10 03:58:07.319 [DEBUG][7] No C:\Users\Public\NPVR\Scripts\ParallelProcessing.bat
Here's the HD Homerun log entry for this recording:
20121010-08:58:10 CableCARD: Tuner1: vchannel 317 (207MHz-98) access = subscribed
Tuner 1 Status
Virtual Channel 317 MSNBC HD
Frequency 207.000 MHz
Program Number 98
Authorization subscribed
CCI Protection unrestricted
CGMS Protection n/a
Modulation Lock qam256
PCR Lock locked
Signal Strength 100% (4.6 dBmV)
Signal Quality 100% (38.3 dB)
Symbol Quality 100%
Streaming Rate 8.591 Mbps
Resource Lock none
2012-10-10 03:58:00.004 [DEBUG][7] allocating recording target filename: V:\MSNBCHD 0358-0802_20121010_03580802.ts
2012-10-10 03:58:00.004 [DEBUG][7] About to start recording (142266 on 27): V:\MSNBCHD 0358-0802_20121010_03580802.ts...
2012-10-10 03:58:00.024 [DEBUG][7] Free space 986554183680 (V:\)
2012-10-10 03:58:00.074 [DEBUG][7] HDHomeRunRecorder@1
2012-10-10 03:58:00.074 [DEBUG][7] HDHomeRunRecorder@2.0
2012-10-10 03:58:00.074 [DEBUG][7] HDHomeRunRecorder@2.1
2012-10-10 03:58:00.074 [DEBUG][7] HDHomeRunRecorder@2.2 nextPort=36312
2012-10-10 03:58:00.074 [DEBUG][7] HDHomeRunRecorder@2.2.0
2012-10-10 03:58:00.074 [DEBUG][7] HDHomeRunRecorder@2.2.0@allocated
2012-10-10 03:58:00.074 [DEBUG][7] HDHomeRunRecorder@2.3
2012-10-10 03:58:00.074 [DEBUG][7] Allocated port: 36312
2012-10-10 03:58:00.074 [DEBUG][7] HDHomeRunRecorder@3
2012-10-10 03:58:00.074 [DEBUG][7] About to start HDHR device. Checking status for information sake... (could tell if it's already in use elsewhere)
2012-10-10 03:58:00.074 [DEBUG][7] Executing: C:\Program Files\Silicondust\HDHomeRun\hdhomerun_config.exe 1312389D get /tuner1/status
2012-10-10 03:58:00.114 [DEBUG][7] Status: ch=none lock=none ss=0 snq=0 seq=0 bps=0 pps=0
2012-10-10 03:58:07.185 [DEBUG][7] SetTarget@2
2012-10-10 03:58:07.186 [DEBUG][7] Executing: C:\Program Files\Silicondust\HDHomeRun\hdhomerun_config.exe 1312389D set /tuner1/vchannel 317
2012-10-10 03:58:07.279 [DEBUG][7] NIC: Realtek PCIe GBE Family Controller
2012-10-10 03:58:07.280 [DEBUG][7] Executing: C:\Program Files\Silicondust\HDHomeRun\hdhomerun_config.exe 1312389D set /tuner1/target rtp://10.1.1.230:36312
2012-10-10 03:58:07.281 [DEBUG][7] SetTarget@2
2012-10-10 03:58:07.283 [DEBUG][7] Temp at 10/10/2012 3:58:17 AM
2012-10-10 03:58:07.283 [DEBUG][7] Started recording (142266:1:V:\MSNBCHD 0358-0802_20121010_03580802.ts)
2012-10-10 03:58:07.319 [DEBUG][7] No C:\Users\Public\NPVR\Scripts\ParallelProcessing.bat
Here's the HD Homerun log entry for this recording:
20121010-08:58:10 CableCARD: Tuner1: vchannel 317 (207MHz-98) access = subscribed
Tuner 1 Status
Virtual Channel 317 MSNBC HD
Frequency 207.000 MHz
Program Number 98
Authorization subscribed
CCI Protection unrestricted
CGMS Protection n/a
Modulation Lock qam256
PCR Lock locked
Signal Strength 100% (4.6 dBmV)
Signal Quality 100% (38.3 dB)
Symbol Quality 100%
Streaming Rate 8.591 Mbps
Resource Lock none