Project

General

Profile

Forums » General »

[EPG] OTA EPG Grabber only grabs one satellite while multiple are configured

Added by ZZD M almost 8 years ago

Setup:
- TVHeadend 4.1-2309~g0736ebc~xenial
- Single DVB-S tuner
- DiSEqC rotor configured for 4 satellites (Astra 19.2E, Astra 23.5E, Astra 28.2E and Hotbird 13.0E)

Issue description:
I'd like to fetch the EPG data with the OTA EPG grabber so I manually click the button to trigger the OTA grabber. But I notice that TVHeadend only runs through the muxes of the Astra 28.2E satellite. It never completes the ones for the other 3 satellites. I can see from the logs that it tries to start for Astra 19.2E, but then it stops shortly after the first mux (at least that's what I think is happening, correct me if I'm wrong).

Log snippet:

Nov 15 11:55:59 ubuntuServer tvheadend[1363]: epggrab: ota - kick callback
Nov 15 11:55:59 ubuntuServer tvheadend[1363]: mpegts: 10714.25H in Astra 28.2E - tuning on Conexant CX24116/CX24118 : DVB-S #0
Nov 15 11:55:59 ubuntuServer tvheadend[1363]: diseqc: initial tone off
Nov 15 11:55:59 ubuntuServer tvheadend[1363]: diseqc: rotor already positioned to 28.2E
Nov 15 11:55:59 ubuntuServer tvheadend[1363]: subscription: 0007: "epggrab" subscribing to mux "10714.25H", weight: 4, adapter: "Conexant CX24116/CX24118 : DVB-S #0", network: "Astra 28.2E", service: "Raw PID Subscription" 
Nov 15 11:55:59 ubuntuServer tvheadend[1363]: epggrab: mux 10714.25H in Astra 28.2E (0x55806d63dcd0), started
Nov 15 11:55:59 ubuntuServer tvheadend[1363]: epggrab: no OTA modules active for 10743.75H in Astra 28.2E, check again next time
Nov 15 11:55:59 ubuntuServer tvheadend[1363]: epggrab: no OTA modules active for 10744H in Astra 28.2E, check again next time
Nov 15 11:55:59 ubuntuServer tvheadend[1363]: epggrab: subscription failed for 10773H in Astra 28.2E (result 200)
Nov 15 11:55:59 ubuntuServer tvheadend[1363]: epggrab: no OTA modules active for 10714H in Astra 19.2E, check again next time
Nov 15 11:55:59 ubuntuServer tvheadend[1363]: epggrab: no OTA modules active for 10714H in Astra 19.2E, check again next time
Nov 15 11:55:59 ubuntuServer tvheadend[1363]: epggrab: subscription failed for 10743.75H in Astra 19.2E (result 200)
Nov 15 11:55:59 ubuntuServer tvheadend[1363]: epggrab: subscription failed for 10802H in Astra 23.5E (result 200)
Nov 15 11:55:59 ubuntuServer tvheadend[1363]: epggrab: subscription failed for 10723H in Hotbird 13.0E (result 200)
Nov 15 11:55:59 ubuntuServer tvheadend[1363]: epggrab: mux stats - all 465 pending 460
Nov 15 11:56:39 ubuntuServer tvheadend[1363]: epggrab: data timeout check succeed
Nov 15 11:56:39 ubuntuServer tvheadend[1363]: epggrab: grab done for 10714.25H in Astra 28.2E (timeout)
Nov 15 11:56:39 ubuntuServer tvheadend[1363]: epggrab: UK: Freesat - data completion timeout for 10714.25H in Astra 28.2E
Nov 15 11:56:39 ubuntuServer tvheadend[1363]: epggrab: EIT: DVB Grabber - data completion timeout for 10714.25H in Astra 28.2E
Nov 15 11:56:39 ubuntuServer tvheadend[1363]: subscription: 0007: "epggrab" unsubscribing
Nov 15 11:56:39 ubuntuServer tvheadend[1363]: epggrab: mux 10714.25H in Astra 28.2E (0x55806d63dcd0) stop
Nov 15 11:56:40 ubuntuServer tvheadend[1363]: epggrab: ota - kick callback
Nov 15 11:56:40 ubuntuServer tvheadend[1363]: mpegts: 10773H in Astra 28.2E - tuning on Conexant CX24116/CX24118 : DVB-S #0
Nov 15 11:56:40 ubuntuServer tvheadend[1363]: diseqc: initial tone off
Nov 15 11:56:40 ubuntuServer tvheadend[1363]: diseqc: rotor already positioned to 28.2E
Nov 15 11:56:40 ubuntuServer tvheadend[1363]: subscription: 000C: "epggrab" subscribing to mux "10773H", weight: 4, adapter: "Conexant CX24116/CX24118 : DVB-S #0", network: "Astra 28.2E", service: "Raw PID Subscription" 
Nov 15 11:56:40 ubuntuServer tvheadend[1363]: epggrab: mux 10773H in Astra 28.2E (0x55806d676ec0), started
Nov 15 11:56:40 ubuntuServer tvheadend[1363]: epggrab: subscription failed for 10803H in Astra 28.2E (result 200)
Nov 15 11:56:40 ubuntuServer tvheadend[1363]: epggrab: subscription failed for 10743.75H in Astra 19.2E (result 200)
Nov 15 11:56:40 ubuntuServer tvheadend[1363]: epggrab: subscription failed for 10802H in Astra 23.5E (result 200)
Nov 15 11:56:40 ubuntuServer tvheadend[1363]: epggrab: subscription failed for 10723H in Hotbird 13.0E (result 200)
Nov 15 11:56:40 ubuntuServer tvheadend[1363]: epggrab: mux stats - all 465 pending 459

From this I understand that 465 muxes are scheduled and it counts down whenever one is completed. Just as a side note here, I've got the EPG scan timeout set to 30 seconds, because else it takes forever to complete one mux, not sure if that's OK as well?...

So far so good, but then when the next satellite is up (Astra 19.2E) I get this:

Nov 15 12:49:30 ubuntuServer tvheadend[1363]: epggrab: mux 12363V in Astra 28.2E (0x55806d3fda20), started
Nov 15 12:49:30 ubuntuServer tvheadend[1363]: epggrab: no OTA modules active for 12441V in Astra 28.2E, check again next time
Nov 15 12:49:30 ubuntuServer tvheadend[1363]: epggrab: no OTA modules active for 12480V in Astra 28.2E, check again next time
Nov 15 12:49:30 ubuntuServer tvheadend[1363]: epggrab: subscription failed for 10743.75H in Astra 19.2E (result 200)
Nov 15 12:49:30 ubuntuServer tvheadend[1363]: epggrab: subscription failed for 10802H in Astra 23.5E (result 200)
Nov 15 12:49:30 ubuntuServer tvheadend[1363]: epggrab: subscription failed for 10723H in Hotbird 13.0E (result 200)
Nov 15 12:49:30 ubuntuServer tvheadend[1363]: epggrab: mux stats - all 465 pending 367
Nov 15 12:50:10 ubuntuServer tvheadend[1363]: epggrab: data timeout check succeed
Nov 15 12:50:10 ubuntuServer tvheadend[1363]: epggrab: grab done for 12363V in Astra 28.2E (timeout)
Nov 15 12:50:10 ubuntuServer tvheadend[1363]: epggrab: EIT: DVB Grabber - data completion timeout for 12363V in Astra 28.2E
Nov 15 12:50:10 ubuntuServer tvheadend[1363]: epggrab: UK: Freesat - data completion timeout for 12363V in Astra 28.2E
Nov 15 12:50:10 ubuntuServer tvheadend[1363]: subscription: 018D: "epggrab" unsubscribing
Nov 15 12:50:10 ubuntuServer tvheadend[1363]: epggrab: mux 12363V in Astra 28.2E (0x55806d3fda20) stop
Nov 15 12:50:11 ubuntuServer tvheadend[1363]: epggrab: ota - kick callback
Nov 15 12:50:11 ubuntuServer tvheadend[1363]: mpegts: 10743.75H in Astra 19.2E - tuning on Conexant CX24116/CX24118 : DVB-S #0
Nov 15 12:50:11 ubuntuServer tvheadend[1363]: diseqc: set voltage 18V
Nov 15 12:50:11 ubuntuServer tvheadend[1363]: diseqc: initial tone off
Nov 15 12:50:11 ubuntuServer tvheadend[1363]: diseqc: initial sleep 100ms
Nov 15 12:50:11 ubuntuServer tvheadend[1363]: diseqc: sending diseqc (len 4) E0 31 6B 01
Nov 15 12:50:11 ubuntuServer tvheadend[1363]: diseqc: rotor GOTOX pos 1 sent
Nov 15 12:50:11 ubuntuServer tvheadend[1363]: diseqc: waiting 5 seconds to finish setup for GOTOX
Nov 15 12:50:11 ubuntuServer tvheadend[1363]: subscription: 0191: "epggrab" subscribing to mux "10743.75H", weight: 4, adapter: "Conexant CX24116/CX24118 : DVB-S #0", network: "Astra 19.2E", service: "Raw PID Subscription" 
Nov 15 12:50:11 ubuntuServer tvheadend[1363]: epggrab: mux 10743.75H in Astra 19.2E (0x55806e68e2a0), started
Nov 15 12:50:11 ubuntuServer tvheadend[1363]: epggrab: no free adapter for 10773.25H in Astra 19.2E (subscribe)
Nov 15 12:50:11 ubuntuServer tvheadend[1363]: epggrab: no free adapter for 10802H in Astra 23.5E (subscribe)
Nov 15 12:50:11 ubuntuServer tvheadend[1363]: epggrab: no free adapter for 10723H in Hotbird 13.0E (subscribe)
Nov 15 12:50:11 ubuntuServer tvheadend[1363]: epggrab: mux stats - all 465 pending 0
Nov 15 12:50:16 ubuntuServer tvheadend[1363]: diseqc: initial tone off
Nov 15 12:50:46 ubuntuServer tvheadend[1363]: epggrab: eit complete 1 first 0
Nov 15 12:50:46 ubuntuServer tvheadend[1363]: epggrab: uk_freesat complete 0 first 1
Nov 15 12:50:46 ubuntuServer tvheadend[1363]: epggrab: uk_freeview complete 1 first 1
Nov 15 12:50:46 ubuntuServer tvheadend[1363]: epggrab: viasat_baltic complete 1 first 1
Nov 15 12:50:46 ubuntuServer tvheadend[1363]: epggrab: Bulsatcom_39E complete 1 first 1
Nov 15 12:50:46 ubuntuServer tvheadend[1363]: epggrab: psip complete 1 first 1
Nov 15 12:50:46 ubuntuServer tvheadend[1363]: epggrab: opentv-skynz complete 1 first 1
Nov 15 12:50:46 ubuntuServer tvheadend[1363]: epggrab: opentv-ausat complete 1 first 1
Nov 15 12:50:46 ubuntuServer tvheadend[1363]: epggrab: opentv-skyit complete 1 first 1
Nov 15 12:50:46 ubuntuServer tvheadend[1363]: epggrab: opentv-skyuk complete 1 first 1
Nov 15 12:50:46 ubuntuServer tvheadend[1363]: epggrab: grab done for 10743.75H in Astra 19.2E (complete)
Nov 15 12:50:46 ubuntuServer tvheadend[1363]: subscription: 0191: "epggrab" unsubscribing
Nov 15 12:50:46 ubuntuServer tvheadend[1363]: epggrab: mux 10743.75H in Astra 19.2E (0x55806e68e2a0) stop
Nov 15 13:26:28 ubuntuServer tvheadend[1363]: epgdb: snapshot start
Nov 15 13:26:28 ubuntuServer tvheadend[1363]: epgdb: queued to save (size 79888930)
Nov 15 13:26:28 ubuntuServer tvheadend[1363]: epgdb:   brands     0
Nov 15 13:26:28 ubuntuServer tvheadend[1363]: epgdb:   seasons    9139
Nov 15 13:26:28 ubuntuServer tvheadend[1363]: epgdb:   episodes   130395
Nov 15 13:26:28 ubuntuServer tvheadend[1363]: epgdb:   broadcasts 160162
Nov 15 13:26:28 ubuntuServer tvheadend[1363]: epgdb: save start
Nov 15 13:26:29 ubuntuServer tvheadend[1363]: epgdb: stored (size 9956110)
Nov 15 14:04:00 ubuntuServer tvheadend[1363]: epggrab: ota start callback
Nov 15 14:04:00 ubuntuServer tvheadend[1363]: epggrab: next ota start event in 72360 seconds
Nov 15 14:04:00 ubuntuServer tvheadend[1363]: epggrab: ota - kick callback
Nov 15 14:04:00 ubuntuServer tvheadend[1363]: mpegts: 10714.25H in Astra 28.2E - tuning on Conexant CX24116/CX24118 : DVB-S #0
Nov 15 14:04:00 ubuntuServer tvheadend[1363]: diseqc: initial tone off
Nov 15 14:04:01 ubuntuServer tvheadend[1363]: diseqc: initial sleep 100ms
Nov 15 14:04:01 ubuntuServer tvheadend[1363]: diseqc: sending diseqc (len 4) E0 31 6B 04
Nov 15 14:04:02 ubuntuServer tvheadend[1363]: diseqc: rotor GOTOX pos 4 sent
Nov 15 14:04:02 ubuntuServer tvheadend[1363]: diseqc: waiting 5 seconds to finish setup for GOTOX
Nov 15 14:04:02 ubuntuServer tvheadend[1363]: subscription: 0195: "epggrab" subscribing to mux "10714.25H", weight: 4, adapter: "Conexant CX24116/CX24118 : DVB-S #0", network: "Astra 28.2E", service: "Raw PID Subscription" 
Nov 15 14:04:02 ubuntuServer tvheadend[1363]: epggrab: mux 10714.25H in Astra 28.2E (0x55806d63dcd0), started
Nov 15 14:04:02 ubuntuServer tvheadend[1363]: epggrab: no OTA modules active for 10743.75H in Astra 28.2E, check again next time
Nov 15 14:04:02 ubuntuServer tvheadend[1363]: epggrab: no OTA modules active for 10744H in Astra 28.2E, check again next time
Nov 15 14:04:02 ubuntuServer tvheadend[1363]: epggrab: no free adapter for 10773H in Astra 28.2E (subscribe)
Nov 15 14:04:02 ubuntuServer tvheadend[1363]: epggrab: no OTA modules active for 10714H in Astra 19.2E, check again next time
Nov 15 14:04:02 ubuntuServer tvheadend[1363]: epggrab: no OTA modules active for 10714H in Astra 19.2E, check again next time
Nov 15 14:04:02 ubuntuServer tvheadend[1363]: epggrab: no free adapter for 10743.75H in Astra 19.2E (subscribe)
Nov 15 14:04:02 ubuntuServer tvheadend[1363]: epggrab: no free adapter for 10802H in Astra 23.5E (subscribe)
Nov 15 14:04:02 ubuntuServer tvheadend[1363]: epggrab: no free adapter for 10723H in Hotbird 13.0E (subscribe)
Nov 15 14:04:02 ubuntuServer tvheadend[1363]: epggrab: mux stats - all 465 pending 0

The number of pending muxes drops to 0 and besides the single mux of 10743.75H on Astra 19.2E, nothing else is being scanned on that satellite. Furthermore, the other 2 remaining satellites aren't even started.

This makes me wonder, could this be a bug or is it possible I'm missing something in my setup/configuration which prevents OTA EPG working properly for multiple satellites?

tvh_log_ota_epg.txt (168 KB) tvh_log_ota_epg.txt Full log

Replies (3)

RE: [EPG] OTA EPG Grabber only grabs one satellite while multiple are configured - Added by Mark Clarkstone almost 8 years ago

ZZD M wrote:

Setup:
- TVHeadend 4.1-2309~g0736ebc~xenial
- Single DVB-S tuner
- DiSEqC rotor configured for 4 satellites (Astra 19.2E, Astra 23.5E, Astra 28.2E and Hotbird 13.0E)

Issue description:
I'd like to fetch the EPG data with the OTA EPG grabber so I manually click the button to trigger the OTA grabber. But I notice that TVHeadend only runs through the muxes of the Astra 28.2E satellite. It never completes the ones for the other 3 satellites. I can see from the logs that it tries to start for Astra 19.2E, but then it stops shortly after the first mux (at least that's what I think is happening, correct me if I'm wrong).

Log snippet:
[...]

From this I understand that 465 muxes are scheduled and it counts down whenever one is completed. Just as a side note here, I've got the EPG scan timeout set to 30 seconds, because else it takes forever to complete one mux, not sure if that's OK as well?...

So far so good, but then when the next satellite is up (Astra 19.2E) I get this:
[...]

The number of pending muxes drops to 0 and besides the single mux of 10743.75H on Astra 19.2E, nothing else is being scanned on that satellite. Furthermore, the other 2 remaining satellites aren't even started.

This makes me wonder, could this be a bug or is it possible I'm missing something in my setup/configuration which prevents OTA EPG working properly for multiple satellites?

If you've set the orbital position for the network remove it & see if that solves the problem, if not you'll have to create a network for each satellite & set the position.

RE: [EPG] OTA EPG Grabber only grabs one satellite while multiple are configured - Added by ZZD M almost 8 years ago

An orbital position was set for every network, removing it didn't fix the issue. Now I'm trying again with newly defined networks.

RE: [EPG] OTA EPG Grabber only grabs one satellite while multiple are configured - Added by ZZD M almost 8 years ago

Just finished re-adding the networks, re-scanning and also with the orbital position set correctly (although it was already before). But the same issue is still seen. Only now it goes over the Astra 19.2E muxes, probably because that network was added first. After those are finished, the other satellites aren't touched for EPG grabbing.

As can be seen below, the number of muxes pending changes to 0 after the Astra 19.2E satellite is finished.

Nov 15 20:27:28 ubuntuServer tvheadend[6157]: subscription: 0237: "epggrab" subscribing to mux "12728.5V", weight: 4, adapter: "Conexant CX24116/CX24118 : DVB-S #0", network: "Astra 19.2E", service: "Raw PID Subscription" 
Nov 15 20:27:28 ubuntuServer tvheadend[6157]: epggrab: mux 12728.5V in Astra 19.2E (0x55f5effe78a0), started
Nov 15 20:27:28 ubuntuServer tvheadend[6157]: epggrab: subscription failed for 10714.25H in Astra 28.2E (result 200)
Nov 15 20:27:28 ubuntuServer tvheadend[6157]: epggrab: subscription failed for 10802H in Astra 23.5E (result 200)
Nov 15 20:27:28 ubuntuServer tvheadend[6157]: epggrab: subscription failed for 10723H in Hotbird 13.0E (result 200)
Nov 15 20:27:28 ubuntuServer tvheadend[6157]: epggrab: mux stats - all 475 pending 362
Nov 15 20:28:07 ubuntuServer tvheadend[6157]: epggrab: data timeout check succeed
Nov 15 20:28:08 ubuntuServer tvheadend[6157]: epggrab: grab done for 12728.5V in Astra 19.2E (timeout)
Nov 15 20:28:08 ubuntuServer tvheadend[6157]: epggrab: UK: Freesat - data completion timeout for 12728.5V in Astra 19.2E
Nov 15 20:28:08 ubuntuServer tvheadend[6157]: epggrab: EIT: DVB Grabber - data completion timeout for 12728.5V in Astra 19.2E
Nov 15 20:28:08 ubuntuServer tvheadend[6157]: subscription: 0237: "epggrab" unsubscribing
Nov 15 20:28:08 ubuntuServer tvheadend[6157]: epggrab: mux 12728.5V in Astra 19.2E (0x55f5effe78a0) stop
Nov 15 20:28:09 ubuntuServer tvheadend[6157]: epggrab: ota - kick callback
Nov 15 20:28:09 ubuntuServer tvheadend[6157]: mpegts: 10714.25H in Astra 28.2E - tuning on Conexant CX24116/CX24118 : DVB-S #0
Nov 15 20:28:09 ubuntuServer tvheadend[6157]: diseqc: set voltage 18V
Nov 15 20:28:10 ubuntuServer tvheadend[6157]: diseqc: initial tone off
Nov 15 20:28:10 ubuntuServer tvheadend[6157]: diseqc: initial sleep 100ms
Nov 15 20:28:10 ubuntuServer tvheadend[6157]: diseqc: sending diseqc (len 4) E0 31 6B 04
Nov 15 20:28:10 ubuntuServer tvheadend[6157]: diseqc: rotor GOTOX pos 4 sent
Nov 15 20:28:10 ubuntuServer tvheadend[6157]: diseqc: waiting 5 seconds to finish setup for GOTOX
Nov 15 20:28:10 ubuntuServer tvheadend[6157]: subscription: 023B: "epggrab" subscribing to mux "10714.25H", weight: 4, adapter: "Conexant CX24116/CX24118 : DVB-S #0", network: "Astra 28.2E", service: "Raw PID Subscription" 
Nov 15 20:28:10 ubuntuServer tvheadend[6157]: epggrab: mux 10714.25H in Astra 28.2E (0x55f5f00ae670), started
Nov 15 20:28:10 ubuntuServer tvheadend[6157]: epggrab: no free adapter for 10744H in Astra 28.2E (subscribe)
Nov 15 20:28:10 ubuntuServer tvheadend[6157]: epggrab: no free adapter for 10802H in Astra 23.5E (subscribe)
Nov 15 20:28:10 ubuntuServer tvheadend[6157]: epggrab: no free adapter for 10723H in Hotbird 13.0E (subscribe)
Nov 15 20:28:10 ubuntuServer tvheadend[6157]: epggrab: mux stats - all 475 pending 0
Nov 15 20:28:15 ubuntuServer tvheadend[6157]: diseqc: initial tone off

    (1-3/3)