2011-09-08, 03:17 AM
At least twice now, I've found that NRecord.exe was still "recording" a program long after it was supposed to be finished. When I look in the NRecord.log file, I see:
NRecord is effectively "hung" and no further recording get started until the Recording service is restarted. After the service is restarted that log file end with:
As I investigated further, I found that the .ts file only contained data for about 15 minutes of the 60 minute show. And, the DCR-2650 network adapter device was no longer listed in Windows. So, I couldn't access the DCR management pages to check on it. Previously, I had unplugged and replugged the DCR power cable--but, of course, that lost any log data in it. So this time, I just unplugged and replugged the USB cable. The network device then reappeared in Windows. And I could access the management pages and look at the log file. Here's what I found:
So far, I haven't found the cause of the "CableCARD: out of memory error", but I did find a couple of reports of the same error with HDHR Primes on the SiliconDust site. No report of fix or anything there, just reports of the problem.
Code:
2011-09-07 13:59:00.112 [DEBUG][7] allocating recording target filename: D:\NPVR Recordings\The Closer\The Closer_20110907_14001500.ts
2011-09-07 13:59:00.112 [DEBUG][7] About to start recording (23786): D:\NPVR Recordings\The Closer\The Closer_20110907_14001500.ts
2011-09-07 13:59:00.174 [DEBUG][7] About to start HDHR device. Checking status for information sake... (could tell if it's already in use elsewhere)
2011-09-07 13:59:00.174 [DEBUG][7] Executing: C:\Program Files\Silicondust\HDHomeRun\hdhomerun_config.exe 20100465 get /tuner0/status
2011-09-07 13:59:01.297 [DEBUG][7] Status: ch=none lock=none ss=0 snq=0 seq=0 bps=0 pps=0
2011-09-07 13:59:02.859 [DEBUG][7] SetTarget@2
2011-09-07 13:59:02.878 [DEBUG][7] Executing: C:\Program Files\Silicondust\HDHomeRun\hdhomerun_config.exe 20100465 set /tuner0/vchannel 879
2011-09-07 13:59:03.225 [DEBUG][7] NIC: Realtek PCIe GBE Family Controller
2011-09-07 13:59:03.226 [DEBUG][7] NIC: Hauppauge OpenCable Receiver (MOCUR-SD)
2011-09-07 13:59:03.227 [DEBUG][7] Executing: C:\Program Files\Silicondust\HDHomeRun\hdhomerun_config.exe 20100465 set /tuner0/target rtp://192.168.140.210:5000
2011-09-07 13:59:03.343 [DEBUG][7] SetTarget@2
2011-09-07 13:59:03.373 [DEBUG][7] Temp at 9/7/2011 1:59:13 PM
2011-09-07 13:59:03.373 [DEBUG][7] Started recording (23786:D:\NPVR Recordings\The Closer\The Closer_20110907_14001500.ts)
2011-09-07 13:59:03.632 [DEBUG][7] No C:\Users\Public\NPVR\Scripts\ParallelProcessing.bat
2011-09-07 15:02:00.058 [DEBUG][7] Stopping recording (23786). Past end time of recording.
2011-09-07 15:02:00.060 [DEBUG][7] Graph stopping...NRecord is effectively "hung" and no further recording get started until the Recording service is restarted. After the service is restarted that log file end with:
Code:
011-09-07 15:02:00.058 [DEBUG][7] Stopping recording (23786). Past end time of recording.
2011-09-07 15:02:00.060 [DEBUG][7] Graph stopping...
2011-09-07 21:41:25.870 [DEBUG][28] OnStop()
2011-09-07 21:41:25.870 [DEBUG][28] About to stop webserver
2011-09-07 21:41:26.072 [DEBUG][28] webserver stopped
2011-09-07 21:41:26.072 [DEBUG][28] About to stop MVP servers
2011-09-07 21:41:26.073 [DEBUG][28] MVPManager shutdown initiated
2011-09-07 21:41:26.073 [DEBUG][28] MVPManager shutdown complete
2011-09-07 21:41:26.073 [DEBUG][28] MVP servers stopped
2011-09-07 21:41:26.073 [DEBUG][28] About to stop recording service
2011-09-07 21:41:26.074 [INFO][28] RecordingService.Shutdown()
2011-09-07 21:41:28.074 [INFO][28] Recording Service hadnt stopped after 2000ms, continuing anyway
2011-09-07 21:41:28.274 [DEBUG][28] recording service stopped
2011-09-07 21:41:28.274 [DEBUG][28] OnStop() complete...As I investigated further, I found that the .ts file only contained data for about 15 minutes of the 60 minute show. And, the DCR-2650 network adapter device was no longer listed in Windows. So, I couldn't access the DCR management pages to check on it. Previously, I had unplugged and replugged the DCR power cable--but, of course, that lost any log data in it. So this time, I just unplugged and replugged the USB cable. The network device then reappeared in Windows. And I could access the management pages and look at the log file. Here's what I found:
Code:
20110907-18:59:01 CableCARD: vchannel 879 (537MHz-2) access = subscribed
20110907-19:15:02 CableCARD: out of memory error (cchost_system_time:46)
20110907-19:16:02 CableCARD: out of memory error (cchost_system_time:46)
20110907-19:17:02 CableCARD: out of memory error (cchost_system_time:46)
20110907-19:18:02 CableCARD: out of memory error (cchost_system_time:46)
20110907-19:19:02 CableCARD: out of memory error (cchost_system_time:46)
20110907-19:19:27 CableCARD: out of memory error (cchost_session:160)
20110908-02:38:41 System: network link down
20110908-02:38:41 System: ip address expired
20110908-02:38:41 System: ip address expired
20110908-02:38:49 System: network link usb
20110908-02:38:49 System: ip address obtained: 192.168.140.209 / 255.255.255.248
20110908-02:39:11 System: ip address obtained: 169.254.247.16 / 255.255.0.0So far, I haven't found the cause of the "CableCARD: out of memory error", but I did find a couple of reports of the same error with HDHR Primes on the SiliconDust site. No report of fix or anything there, just reports of the problem.
