2017-05-17, 09:38 AM
I've been seeing an occasional issue occur since the Win 10 creators update - recordings seem to miss the first 10 mins.
Here's an example from the log
2017-05-17 17:59:00.121 [INFO][58] DigitalRecorder.StartStream(F:\Recorded TV\Newshub Live At 6pm\Newshub Live At 6pm_20170517_18001900.ts)
2017-05-17 17:59:00.121 [INFO][58] Creating BDA graph
2017-05-17 17:59:00.121 [DEBUG][58] Using tuner: Silicondust HDHomeRun Tuner 1110C493-0 (1)
2017-05-17 17:59:00.121 [INFO][58] [14fbe79c-b17c-06de-4c000000bca7b201]-14fbe7d8-00000000
2017-05-17 17:59:00.121 [DEBUG][58] About to connect...
2017-05-17 17:59:00.121 [DEBUG][58] has network provider
2017-05-17 17:59:00.121 [DEBUG][58] has tuner
2017-05-17 17:59:00.137 [DEBUG][58] About to auto detect capture filter...
2017-05-17 17:59:00.137 [DEBUG][58] Skipping capture filter detection
2017-05-17 17:59:00.137 [DEBUG][58] No BDA capture filter for this device
2017-05-17 17:59:00.137 [DEBUG][58] Activating time machine
2017-05-17 17:59:00.137 [DEBUG][58] Time machine activated...
2017-05-17 17:59:00.152 [DEBUG][58] EIT collection started
2017-05-17 17:59:00.152 [DEBUG][58] Graph filter list:
2017-05-17 17:59:00.152 [DEBUG][58] - MPEG-2 Sections and Tables
2017-05-17 17:59:00.152 [DEBUG][58] - BDA MPEG2 Transport Information Filter
2017-05-17 17:59:00.152 [DEBUG][58] - MPEG-2 Demultiplexer
2017-05-17 17:59:00.152 [DEBUG][58] - NPVR TS Mon
2017-05-17 17:59:00.152 [DEBUG][58] - Tuner
2017-05-17 17:59:00.152 [DEBUG][58] - Network Provider
2017-05-17 17:59:00.152 [INFO][58] About to start BDA graph
2017-05-17 17:59:00.152 [DEBUG][58] Starting graph...
2017-05-17 17:59:00.155 [DEBUG][58] Calling LockChannel()
2017-05-17 17:59:00.155 [DEBUG][58] locked=0, present=0, strength=0, quality=0 (took 0ms to check)
2017-05-17 17:59:00.155 [DEBUG][58] About to tune BDA graph:
<tuning>
<type>DVB-T</type>
<locator>
<frequency>562000</frequency>
<bandwidth>8</bandwidth>
</locator>
<service_id>1300</service_id>
<tsid>31</tsid>
<onid>8746</onid>
<service_type>25</service_type>
<provider>Mediaworks</provider>
</tuning>
2017-05-17 17:59:00.155 [DEBUG][58] DigitalRecorderDVBT::Tune@1
2017-05-17 17:59:00.155 [DEBUG][58] DigitalRecorderDVBT::Tune@2
2017-05-17 17:59:00.155 [DEBUG][58] DigitalRecorderDVBT::Tune@3
2017-05-17 17:59:00.155 [DEBUG][58] DigitalRecorderDVBT::Tune@4
2017-05-17 17:59:00.165 [DEBUG][58] DigitalRecorderDVBT::Tune@5
2017-05-17 18:09:00.325 [DEBUG][58] DigitalRecorderDVBT::Tune@post
2017-05-17 18:09:00.325 [DEBUG][58] whoosh whoosh
2017-05-17 18:09:07.279 [DEBUG][58] Calling LockChannel()
2017-05-17 18:09:07.279 [DEBUG][58] locked=0, present=0, strength=0, quality=0 (took 0ms to check)
2017-05-17 18:09:07.279 [DEBUG][58] File size is 0
2017-05-17 18:09:07.279 [INFO][58] DigitalRecorder.StartStream() allocated handle: 0x12
2017-05-17 18:09:07.279 [DEBUG][58] Temp at 17/05/2017 18:09:17
2017-05-17 19:02:00.190 [INFO][180] DigitalRecorder.StopStream() handle: 12
2017-05-17 19:02:00.320 [INFO][180] No more streams active. Stopping device.
2017-05-17 19:02:00.320 [DEBUG][180] About to request async graph stop
2017-05-17 19:02:00.320 [DEBUG][179] Graph stopping... (async)
2017-05-17 19:02:00.345 [DEBUG][179] Graph reports state 'Stopped'
2017-05-17 19:02:00.345 [DEBUG][179] Graph stopped (async)
2017-05-17 19:02:00.345 [DEBUG][180] Async stop completed successfully
2017-05-17 19:02:00.351 [DEBUG][180] Removing filter MPEG-2 Sections and Tables
2017-05-17 19:02:00.351 [DEBUG][180] Removing filter BDA MPEG2 Transport Information Filter
2017-05-17 19:02:00.351 [DEBUG][180] Removing filter MPEG-2 Demultiplexer
2017-05-17 19:02:00.351 [DEBUG][180] Removing filter NPVR TS Mon
2017-05-17 19:02:00.351 [DEBUG][180] Removing filter Tuner
2017-05-17 19:02:00.351 [DEBUG][180] Removing filter Network Provider
On the main recordings screen it shows the 6pm - 7pm time but the recording actually starts at 6:09pm so I miss the first 10 mins.
This issue will not occur for a couple of days after a system reboot but then seems to happen continually until a reboot and it then comes right again.
Any ideas sub?
Here's an example from the log
2017-05-17 17:59:00.121 [INFO][58] DigitalRecorder.StartStream(F:\Recorded TV\Newshub Live At 6pm\Newshub Live At 6pm_20170517_18001900.ts)
2017-05-17 17:59:00.121 [INFO][58] Creating BDA graph
2017-05-17 17:59:00.121 [DEBUG][58] Using tuner: Silicondust HDHomeRun Tuner 1110C493-0 (1)
2017-05-17 17:59:00.121 [INFO][58] [14fbe79c-b17c-06de-4c000000bca7b201]-14fbe7d8-00000000
2017-05-17 17:59:00.121 [DEBUG][58] About to connect...
2017-05-17 17:59:00.121 [DEBUG][58] has network provider
2017-05-17 17:59:00.121 [DEBUG][58] has tuner
2017-05-17 17:59:00.137 [DEBUG][58] About to auto detect capture filter...
2017-05-17 17:59:00.137 [DEBUG][58] Skipping capture filter detection
2017-05-17 17:59:00.137 [DEBUG][58] No BDA capture filter for this device
2017-05-17 17:59:00.137 [DEBUG][58] Activating time machine
2017-05-17 17:59:00.137 [DEBUG][58] Time machine activated...
2017-05-17 17:59:00.152 [DEBUG][58] EIT collection started
2017-05-17 17:59:00.152 [DEBUG][58] Graph filter list:
2017-05-17 17:59:00.152 [DEBUG][58] - MPEG-2 Sections and Tables
2017-05-17 17:59:00.152 [DEBUG][58] - BDA MPEG2 Transport Information Filter
2017-05-17 17:59:00.152 [DEBUG][58] - MPEG-2 Demultiplexer
2017-05-17 17:59:00.152 [DEBUG][58] - NPVR TS Mon
2017-05-17 17:59:00.152 [DEBUG][58] - Tuner
2017-05-17 17:59:00.152 [DEBUG][58] - Network Provider
2017-05-17 17:59:00.152 [INFO][58] About to start BDA graph
2017-05-17 17:59:00.152 [DEBUG][58] Starting graph...
2017-05-17 17:59:00.155 [DEBUG][58] Calling LockChannel()
2017-05-17 17:59:00.155 [DEBUG][58] locked=0, present=0, strength=0, quality=0 (took 0ms to check)
2017-05-17 17:59:00.155 [DEBUG][58] About to tune BDA graph:
<tuning>
<type>DVB-T</type>
<locator>
<frequency>562000</frequency>
<bandwidth>8</bandwidth>
</locator>
<service_id>1300</service_id>
<tsid>31</tsid>
<onid>8746</onid>
<service_type>25</service_type>
<provider>Mediaworks</provider>
</tuning>
2017-05-17 17:59:00.155 [DEBUG][58] DigitalRecorderDVBT::Tune@1
2017-05-17 17:59:00.155 [DEBUG][58] DigitalRecorderDVBT::Tune@2
2017-05-17 17:59:00.155 [DEBUG][58] DigitalRecorderDVBT::Tune@3
2017-05-17 17:59:00.155 [DEBUG][58] DigitalRecorderDVBT::Tune@4
2017-05-17 17:59:00.165 [DEBUG][58] DigitalRecorderDVBT::Tune@5
2017-05-17 18:09:00.325 [DEBUG][58] DigitalRecorderDVBT::Tune@post
2017-05-17 18:09:00.325 [DEBUG][58] whoosh whoosh
2017-05-17 18:09:07.279 [DEBUG][58] Calling LockChannel()
2017-05-17 18:09:07.279 [DEBUG][58] locked=0, present=0, strength=0, quality=0 (took 0ms to check)
2017-05-17 18:09:07.279 [DEBUG][58] File size is 0
2017-05-17 18:09:07.279 [INFO][58] DigitalRecorder.StartStream() allocated handle: 0x12
2017-05-17 18:09:07.279 [DEBUG][58] Temp at 17/05/2017 18:09:17
2017-05-17 19:02:00.190 [INFO][180] DigitalRecorder.StopStream() handle: 12
2017-05-17 19:02:00.320 [INFO][180] No more streams active. Stopping device.
2017-05-17 19:02:00.320 [DEBUG][180] About to request async graph stop
2017-05-17 19:02:00.320 [DEBUG][179] Graph stopping... (async)
2017-05-17 19:02:00.345 [DEBUG][179] Graph reports state 'Stopped'
2017-05-17 19:02:00.345 [DEBUG][179] Graph stopped (async)
2017-05-17 19:02:00.345 [DEBUG][180] Async stop completed successfully
2017-05-17 19:02:00.351 [DEBUG][180] Removing filter MPEG-2 Sections and Tables
2017-05-17 19:02:00.351 [DEBUG][180] Removing filter BDA MPEG2 Transport Information Filter
2017-05-17 19:02:00.351 [DEBUG][180] Removing filter MPEG-2 Demultiplexer
2017-05-17 19:02:00.351 [DEBUG][180] Removing filter NPVR TS Mon
2017-05-17 19:02:00.351 [DEBUG][180] Removing filter Tuner
2017-05-17 19:02:00.351 [DEBUG][180] Removing filter Network Provider
On the main recordings screen it shows the 6pm - 7pm time but the recording actually starts at 6:09pm so I miss the first 10 mins.
This issue will not occur for a couple of days after a system reboot but then seems to happen continually until a reboot and it then comes right again.
Any ideas sub?