Potential EPG / Tuning Issue

[noyodeling]

I've been experiencing a sudden change in channel while I've been watching either via the web UI or via Kodi. While on a channel, it would suddenly switch to a different channel without indicating via the UI. It would keep doing it until I reset the service. I couldn't find a pattern until recently.

I was watching a channel and it changed to a different one around the same time it was scheduled to do an EPG update. 

Please see the relevant device logs below. I have a Hauppauge Dual HD USB Tuner. The first <tuning /> block is the channel I was watching when it happened. Any help is appreciated.

Code:

2021-09-25 16:58:51.467    [INFO][6]    Got POST request: /stream/start?slipseconds=1200&target=LIVE%26D%3A%5CNPVR%5CTimeShift%5Clive-WDTN%20HD-821908-5.ts
2021-09-25 16:58:51.467    [DEBUG][6]    Starting Stream: LIVE&D:\NPVR\TimeShift\live-WDTN HD-821908-5.ts
2021-09-25 16:58:51.467    [DEBUG][6]    SlipSeconds: 1200
2021-09-25 16:58:51.467    [DEBUG][6]    Tuning:
<tuning>
  <type>ATSC</type>
  <locator>
    <physical_channel>31</physical_channel>
  </locator>
  <service_id>4</service_id>
  <tsid>2273</tsid>
  <service_type>1</service_type>
  <provider>ATSC</provider>
</tuning>

2021-09-25 16:58:51.467    [DEBUG][6]    StartStream(): LIVE&D:\NPVR\TimeShift\live-WDTN HD-821908-5.ts
2021-09-25 16:58:51.471    [DEBUG][6]    Using tuner: Hauppauge WinTV-dualHD ATSC Tuner (1)
2021-09-25 16:58:51.471    [DEBUG][6]    About to connect...
2021-09-25 16:58:51.471    [DEBUG][6]    has network provider
2021-09-25 16:58:51.471    [DEBUG][6]    has tuner
2021-09-25 16:58:51.479    [INFO][6]                [9b403334-5642-44b9-8e1b59a0c32b3fe4]-00000000-00000000
2021-09-25 16:58:51.480    [DEBUG][6]    About to auto detect capture filter...
2021-09-25 16:58:51.480    [INFO][6]    Need match: [9b403334-5642-44b9-8e1b59a0c32b3fe4]-00000000-00000000
2021-09-25 16:58:51.481    [DEBUG][6]    dw1=00000000 vs 00000000
2021-09-25 16:58:51.481    [DEBUG][6]    Got capture filter: 'Hauppauge WinTV-dualHD TS Capture'
2021-09-25 16:58:51.481    [INFO][6]    medium:     [9b403334-5642-44b9-8e1b59a0c32b3fe4]-00000000-00000000
2021-09-25 16:58:51.481    [DEBUG][6]    Added capture filter
2021-09-25 16:58:51.482    [DEBUG][6]    Connected Tuner to Capture
2021-09-25 16:58:51.487    [DEBUG][6]    Graph filter list:
2021-09-25 16:58:51.487    [DEBUG][6]     - MPEG-2 Sections and Tables
2021-09-25 16:58:51.487    [DEBUG][6]     - BDA MPEG2 Transport Information Filter
2021-09-25 16:58:51.487    [DEBUG][6]     - MPEG-2 Demultiplexer
2021-09-25 16:58:51.487    [DEBUG][6]     - NPVR TS Mon
2021-09-25 16:58:51.487    [DEBUG][6]     - Capture
2021-09-25 16:58:51.487    [DEBUG][6]     - Tuner
2021-09-25 16:58:51.487    [DEBUG][6]     - Network Provider
2021-09-25 16:58:51.487    [DEBUG][6]    Graph Connections
2021-09-25 16:58:51.487    [DEBUG][6]       Filter [4fb2e84]  'MPEG-2 Sections and Tables'
2021-09-25 16:58:51.487    [DEBUG][6]           Pin [5053c94]  'In' [I]  Connected to [11b3f6c]
2021-09-25 16:58:51.487    [DEBUG][6]       Filter [4fb819c]  'BDA MPEG2 Transport Information Filter'
2021-09-25 16:58:51.488    [DEBUG][6]           Pin [501deec]  'IB Input' [I]  Connected to [11b3ad4]
2021-09-25 16:58:51.488    [DEBUG][6]           Pin [4fd465c]  'OOB Input' [I]
2021-09-25 16:58:51.488    [DEBUG][6]           Pin [11b2ff4]  'iTV Out' [O]
2021-09-25 16:58:51.488    [DEBUG][6]           Pin [4fc16cc]  'SBE OUT' [O]
2021-09-25 16:58:51.488    [DEBUG][6]       Filter [11b66cc]  'MPEG-2 Demultiplexer'
2021-09-25 16:58:51.488    [DEBUG][6]           Pin [4fb2a84]  'MPEG-2 Stream' [I]  Connected to [12c1dec]
2021-09-25 16:58:51.488    [DEBUG][6]           Pin [11b3ad4]  '001' [O]  Connected to [501deec]
2021-09-25 16:58:51.488    [DEBUG][6]           Pin [11b3f6c]  '002' [O]  Connected to [5053c94]
2021-09-25 16:58:51.488    [DEBUG][6]           Pin [11b332c]  '003' [O]
2021-09-25 16:58:51.488    [DEBUG][6]           Pin [11b3c5c]  '004' [O]
2021-09-25 16:58:51.488    [DEBUG][6]           Pin [11b40f4]  '005' [O]
2021-09-25 16:58:51.488    [DEBUG][6]           Pin [4ff7a04]  '006' [O]
2021-09-25 16:58:51.488    [DEBUG][6]           Pin [4ff6184]  '007' [O]
2021-09-25 16:58:51.488    [DEBUG][6]           Pin [4ff5ffc]  '008' [O]
2021-09-25 16:58:51.488    [DEBUG][6]       Filter [4bf502c]  'NPVR TS Mon'
2021-09-25 16:58:51.488    [DEBUG][6]           Pin [12d72e4]  'Input' [I]  Connected to [4fed84c]
2021-09-25 16:58:51.488    [DEBUG][6]           Pin [12c1dec]  'Output' [O]  Connected to [4fb2a84]
2021-09-25 16:58:51.488    [DEBUG][6]       Filter [11b3de4]  'Capture'
2021-09-25 16:58:51.488    [DEBUG][6]           Pin [11b7594]  'MPEG2 Transport' [I]  Connected to [4fc85f4]
2021-09-25 16:58:51.488    [DEBUG][6]           Pin [4fed84c]  'MPEG2 Transport' [O]  Connected to [12d72e4]
2021-09-25 16:58:51.488    [DEBUG][6]       Filter [11b37c4]  'Tuner'
2021-09-25 16:58:51.488    [DEBUG][6]           Pin [11b5adc]  'Input0' [I]  Connected to [500c9f4]
2021-09-25 16:58:51.489    [DEBUG][6]           Pin [4fc85f4]  'MPEG2 Transport' [O]  Connected to [11b7594]
2021-09-25 16:58:51.489    [DEBUG][6]       Filter [4fbfa04]  'Network Provider'
2021-09-25 16:58:51.489    [DEBUG][6]           Pin [500c9f4]  'Antenna Out' [O]  Connected to [11b5adc]
2021-09-25 16:58:51.489    [DEBUG][6]    Starting graph...
2021-09-25 16:58:52.477    [DEBUG][6]    Calling LockChannel()
2021-09-25 16:58:52.500    [DEBUG][6]    locked=0, present=0, strength=100, quality=0   (took 16ms to check)
2021-09-25 16:58:52.500    [INFO][6]    Setting locator to BDA_MOD_8VSB

2021-09-25 16:58:52.749    [DEBUG][6]    Calling LockChannel()
2021-09-25 16:58:52.769    [DEBUG][6]    locked=0, present=0, strength=31, quality=0   (took 15ms to check)
2021-09-25 16:58:52.769    [DEBUG][6]    StartStream()@exit handle=15
2021-09-25 16:58:52.769    [DEBUG][6]    StartStream succeded. Handle: 15
2021-09-25 17:01:47.681    [INFO][6]    Got POST request: /stream/start?slipseconds=1200&target=c%3A%5Cdevxxxxxx%5Cnull.ts
2021-09-25 17:01:47.681    [DEBUG][6]    Starting Stream: c:\devxxxxxx\null.ts
2021-09-25 17:01:47.681    [DEBUG][6]    SlipSeconds: 1200
2021-09-25 17:01:47.681    [DEBUG][6]    Tuning:
<tuning>
  <type>ATSC</type>
  <locator>
    <physical_channel>31</physical_channel>
  </locator>
  <service_id>100000</service_id>
  <tsid>2273</tsid>
  <service_type>1</service_type>
  <provider>ATSC</provider>
</tuning>

2021-09-25 17:01:47.681    [DEBUG][6]    StartStream(): c:\devxxxxxx\null.ts
2021-09-25 17:01:47.682    [DEBUG][6]    Calling LockChannel()
2021-09-25 17:01:47.702    [DEBUG][6]    locked=1, present=1, strength=36, quality=93   (took 16ms to check)
2021-09-25 17:01:47.702    [DEBUG][6]    StartStream()@exit handle=16
2021-09-25 17:01:47.703    [DEBUG][6]    StartStream succeded. Handle: 16
2021-09-25 17:01:47.703    [INFO][8]    Got GET request: /stream/epg
2021-09-25 17:01:47.704    [DEBUG][8]    EIT collection started
2021-09-25 17:02:48.531    [INFO][6]    Got GET request: /stream/epg
2021-09-25 17:02:48.588    [INFO][8]    Got GET request: /stream/stop?handle=16
2021-09-25 17:02:48.593    [INFO][6]    Got POST request: /stream/start?slipseconds=1200&target=c%3A%5Cdevxxxxxx%5Cnull.ts
2021-09-25 17:02:48.593    [DEBUG][6]    Starting Stream: c:\devxxxxxx\null.ts
2021-09-25 17:02:48.593    [DEBUG][6]    SlipSeconds: 1200
2021-09-25 17:02:48.593    [DEBUG][6]    Tuning:
<tuning>
  <type>ATSC</type>
  <locator>
    <physical_channel>33</physical_channel>
  </locator>
  <service_id>100000</service_id>
  <tsid>2275</tsid>
  <service_type>1</service_type>
  <provider>ATSC</provider>
</tuning>

[mvallevand]

Using NextPVR during an EPG update is not recommended. If you are using OTA ATSC and doing frequent scans this can be a problem. Please post your entire zipped logs if you want us to look into it.

Martin

[sub]

I was watching a channel and it changed to a different one around the same time it was scheduled to do an EPG update. 

Yeah, don't do that.

[noyodeling]

Ha. Thanks guys. Noted. 

I added multiple EPG updates since it was only giving me data for a few hours. I don't remember what it was giving me for sure since it was so long ago. I'm going to set it back to once and day and see how that goes. 

Thanks again. Cheers.

[mvallevand]

Short guide data is a know issue with OTA ATSC you probably won't be happy with once a day. That is why Schedules Direct for a cup of coffee a month is a bargain.

Martin

[noyodeling]

I'll look into it. Thanks!

[noyodeling]

All setup on SD now. Working great. Thanks guys.