8.1 WMCs are kicking each other off of ETH6 tuners

[smassey22180]

I have been battling an ETH6 for a few weeks now. I have narrowed down the issue to adding tuners to a 2nd WMC. One WMC works fine but as soon as we add tuners to the 2nd the first WMC starts showing no tv signal or re-install tuners messages. The web status shows plenty of signal. Each WMC can be using as little as one tuner at the time of failure.

So far I have swapped out the ETH6, updated the firmware, re-paired the cable card, cleared/discovered/re-setup WMC tuners multiple tuners multiple times. What am I missing here? I know it is something simple. HTPCs are 8.1 WMC with only WMC on them. One is a brand new Intel i5 NUC. The 2nd is an older one that I have used successfully for years with a HD Homerun and OTA antenna. Network is 1G. Should I lock 3 tuners to one WMC and 3 to the other?

Log below. Where can I fix the date stamp? Thanks

Jan 1 04:33:08 ocur[21]: ocur: STT time Mon Aug 18 23:03:11 2014 UTC
Jan 1 04:41:14 ocur[21]: ocur: WARNING: [5] failed to get pat
Jan 1 04:47:50 ocur[21]: upnp: [192.168.242.13] Calling Action(cas[3]) SetChannel
Jan 1 04:47:50 ocur[21]: ocur: [3] Attempting to SetChannel (Channel=753 SourceId=0 Mode=0)
Jan 1 04:47:50 ocur[21]: upnp: [192.168.242.13] Action(cas[3]) SetChannel success
Jan 1 04:47:50 ocur[21]: ocur: Disabled table monitor for instance 3
Jan 1 04:47:50 ocur[21]: ocur: [3] Program number set to 0, was 11
Jan 1 04:47:50 ocur[21]: ocur: [3] Tune to 753 (mod=q256, freq=357000, program=5135, std=9)
Jan 1 04:47:50 ocur[21]: ocur: [3] Program number set to 5135, was 0
Jan 1 04:47:50 ocur[21]: ocur: Disabled table monitor for instance 3
Jan 1 04:47:50 ocur[21]: ocur: [3] Adding pid 0x0000
Jan 1 04:47:50 ocur[21]: ocur: [3] Locked: 1 Acc E: 11
Jan 1 04:47:50 ocur[21]: ocur: [3] Adding pid 0x1ffb
Jan 1 04:47:50 ocur[21]: upnp: [192.168.242.13] Calling Action(ua[3]) UserActivityDetected
Jan 1 04:47:50 ocur[21]: upnp: [192.168.242.13] Action(ua[3]) UserActivityDetected success
Jan 1 04:47:51 ocur[21]: ocur: [3] Tune finished to freq 357000
Jan 1 04:47:51 ocur[21]: ocur: [3] Getting pmt for program 5135
Jan 1 04:47:51 ocur[21]: ocur: [3] Got pmt for program# 5135
Jan 1 04:47:51 ocur[21]: ocur: [3] Adding pid 0x0030
Jan 1 04:47:51 ocur[21]: ocur: [3] Adding pid 0x0031
Jan 1 04:47:51 ocur[21]: ocur: [3] Adding pid 0x0032
Jan 1 04:47:51 ocur[21]: ocur: [3] Adding pid 0x0033
Jan 1 04:47:51 ocur[21]: upnp: Event(tuner[3]): PCRLock, "1"
Jan 1 04:47:51 ocur[21]: ocur: [3] Adding pid 0x07c0
Jan 1 04:47:51 ocur[21]: ocur: [3] Adding pid 0x0430
Jan 1 04:47:51 ocur[21]: ocur: [3] Adding pid 0x07c1
Jan 1 04:47:51 ocur[21]: ocur: [3] Adding pid 0x07c2
Jan 1 04:47:51 ocur[21]: ocur: [3] Adding pid 0x07c3
Jan 1 04:47:51 ocur[21]: ocur: [3] Adding pid 0x07c4
Jan 1 04:47:51 ocur[21]: ocur: [3] Adding pid 0x07c5
Jan 1 04:47:51 ocur[21]: ocur: Disabled table monitor for instance 3
Jan 1 04:47:51 ocur[21]: ocur: Enabled table monitor for instance 3
Jan 1 04:47:51 ocur[21]: ocur: [3] Channel is scrambled, expecting CCI
Jan 1 04:47:51 ocur[21]: upnp: [192.168.242.13] Get(tuner[3]): Frequency "357000"
Jan 1 04:47:51 ocur[21]: ocur: [3] Sending ca_pmt to CableCARD for program number 5135 index 0
Jan 1 04:47:51 ocur[21]: upnp: [192.168.242.13] Get(mux[3]): ProgramNumber "5135"
Jan 1 04:47:52 ocur[21]: ocur: [3] CCI 00 arrived for program# 5135
Jan 1 04:48:12 ocur[21]: upnp: [192.168.242.13] Calling Action(fdc[3]) RequestTables
Jan 1 04:48:12 ocur[21]: upnp: [192.168.242.13] Action(fdc[3]) RequestTables success
Jan 1 04:48:13 ocur[21]: upnp: [192.168.242.13] Calling Action(fdc[3]) RequestTables
Jan 1 04:48:13 ocur[21]: upnp: [192.168.242.13] Action(fdc[3]) RequestTables success
Jan 1 04:48:14 ocur[21]: upnp: [192.168.242.13] Calling Action(av[3]) Stop
Jan 1 04:48:14 ocur[21]: ocur: WARNING: [3] Disabling video
Jan 1 04:48:14 ocur[21]: ocur: [3] Program number set to 0, was 5135
Jan 1 04:48:14 ocur[21]: upnp: [192.168.242.13] Action(av[3]) Stop success
Jan 1 04:48:14 ocur[21]: upnp: [192.168.242.13] Calling Action(cm[3]) ConnectionComplete
Jan 1 04:48:14 ocur[21]: ocur: [3] rtp teardown for client 192.168.242.22:5001
Jan 1 04:48:15 ocur[21]: upnp: deallocate[3<-3] c0a8f216
Jan 1 04:48:15 ocur[21]: upnp: map[0] = { alloc: 0, instance: -1, udn: (null), client: 0.0.0.0 }
Jan 1 04:48:15 ocur[21]: upnp: map[1] = { alloc: 0, instance: -1, udn: (null), client: 0.0.0.0 }
Jan 1 04:48:15 ocur[21]: upnp: map[2] = { alloc: 0, instance: -1, udn: (null), client: 0.0.0.0 }
Jan 1 04:48:15 ocur[21]: upnp: map[3] = { alloc: 0, instance: -1, udn: (null), client: 192.168.242.22 }
Jan 1 04:48:15 ocur[21]: upnp: map[4] = { alloc: 0, instance: -1, udn: (null), client: 0.0.0.0 }
Jan 1 04:48:15 ocur[21]: upnp: map[5] = { alloc: 0, instance: -1, udn: (null), client: 0.0.0.0 }
Jan 1 04:48:15 ocur[21]: upnp: Event(cm[3]): CurrentConnectionIDs, ""
Jan 1 04:48:15 ocur[21]: ocur: Disabled table monitor for instance 3
Jan 1 04:48:15 ocur[21]: upnp: [192.168.242.13] Action(cm[3]) ConnectionComplete success
Jan 1 04:48:59 ocur[21]: upnp: [192.168.242.22] Calling Action(ua[3]) UserActivityDetected
Jan 1 04:48:59 ocur[21]: upnp: [192.168.242.22] Action(ua[3]) UserActivityDetected success
Jan 1 04:49:00 ocur[21]: upnp: [192.168.242.22] Calling Action(fdc[3]) RequestTables
Jan 1 04:49:00 ocur[21]: upnp: [192.168.242.22] Action(fdc[3]) RequestTables success
Jan 1 04:49:01 ocur[21]: upnp: [192.168.242.22] Calling Action(fdc[3]) RequestTables
Jan 1 04:49:01 ocur[21]: upnp: [192.168.242.22] Action(fdc[3]) RequestTables success
Jan 1 04:49:01 ocur[21]: upnp: [192.168.242.22] Calling Action(av[3]) Stop
Jan 1 04:49:01 ocur[21]: ocur: WARNING: Stop issued in stop state
Jan 1 04:49:01 ocur[21]: upnp: [192.168.242.22] Action(av[3]) Stop success
Jan 1 04:49:01 ocur[21]: upnp: [192.168.242.22] Calling Action(cm[3]) ConnectionComplete
Jan 1 04:49:01 ocur[21]: upnp: map[0] = { alloc: 0, instance: -1, udn: (null), client: 0.0.0.0 }
Jan 1 04:49:01 ocur[21]: upnp: map[1] = { alloc: 0, instance: -1, udn: (null), client: 0.0.0.0 }
Jan 1 04:49:01 ocur[21]: upnp: map[2] = { alloc: 0, instance: -1, udn: (null), client: 0.0.0.0 }
Jan 1 04:49:01 ocur[21]: upnp: map[3] = { alloc: 0, instance: -1, udn: (null), client: 192.168.242.22 }
Jan 1 04:49:01 ocur[21]: upnp: map[4] = { alloc: 0, instance: -1, udn: (null), client: 0.0.0.0 }
Jan 1 04:49:01 ocur[21]: upnp: map[5] = { alloc: 0, instance: -1, udn: (null), client: 0.0.0.0 }
Jan 1 04:49:01 ocur[21]: upnp: Event(cm[3]): CurrentConnectionIDs, ""
Jan 1 04:49:01 ocur[21]: ocur: Disabled table monitor for instance 3
Jan 1 04:49:01 ocur[21]: upnp: [192.168.242.22] Action(cm[3]) ConnectionComplete success
Jan 1 04:49:13 ocur[21]: upnp: [192.168.242.22] Calling Action(ua[3]) GetUserActivityInterval
Jan 1 04:49:13 ocur[21]: upnp: [192.168.242.22] Action(ua[3]) GetUserActivityInterval success
Jan 1 04:49:13 ocur[21]: upnp: [192.168.242.22] Calling Action(ua[3]) UserActivityDetected
Jan 1 04:49:13 ocur[21]: upnp: [192.168.242.22] Action(ua[3]) UserActivityDetected success
Jan 1 04:49:13 ocur[21]: upnp: allocate[3] uuid:89333102-EBE5-11D8-AC9A-000008099214 c0a8f216
Jan 1 04:49:13 ocur[21]: upnp: map[3]
Jan 1 04:49:13 ocur[21]: upnp: map[0] = { alloc: 0, instance: -1, udn: (null), client: 0.0.0.0 }
Jan 1 04:49:13 ocur[21]: upnp: map[1] = { alloc: 0, instance: -1, udn: (null), client: 0.0.0.0 }
Jan 1 04:49:13 ocur[21]: upnp: map[2] = { alloc: 0, instance: -1, udn: (null), client: 0.0.0.0 }
Jan 1 04:49:13 ocur[21]: upnp: map[3] = { alloc: 1, instance: 3, udn: uuid:89333102-EBE5-11D8-AC9A-000008099214, client: 192.168.242.22 }
Jan 1 04:49:13 ocur[21]: upnp: map[4] = { alloc: 0, instance: -1, udn: (null), client: 0.0.0.0 }
Jan 1 04:49:13 ocur[21]: upnp: map[5] = { alloc: 0, instance: -1, udn: (null), client: 0.0.0.0 }
Jan 1 04:49:13 ocur[21]: upnp: [192.168.242.22] Calling Action(cm[3]) PrepareForConnection
Jan 1 04:49:13 ocur[21]: upnp: Event(cm[3]): CurrentConnectionIDs, "0"
Jan 1 04:49:13 ocur[21]: upnp: [192.168.242.22] Action(cm[3]) PrepareForConnection success
Jan 1 04:49:13 ocur[21]: libctn91xx: Setting mpeg_eth headers for instance 3
Jan 1 04:49:13 ocur[21]: libctn91xx: rip C0A8F216 lip C0A8F21E rp 5001 lp 43012
Jan 1 04:49:13 ocur[21]: ocur: [3] rtp setup for client 192.168.242.22:5001
Jan 1 04:49:14 ocur[21]: upnp: [192.168.242.22] Calling Action(av[3]) Play
Jan 1 04:49:14 ocur[21]: upnp: [192.168.242.22] Action(av[3]) Play success
Jan 1 04:49:14 ocur[21]: upnp: [192.168.242.22] Calling Action(fdc[3]) RequestTables
Jan 1 04:49:14 ocur[21]: upnp: [192.168.242.22] Action(fdc[3]) RequestTables success
Jan 1 04:49:14 ocur[21]: upnp: [192.168.242.22] Calling Action(cas[3]) SetChannel
Jan 1 04:49:14 ocur[21]: ocur: [3] Attempting to SetChannel (Channel=751 SourceId=0 Mode=0)
Jan 1 04:49:14 ocur[21]: upnp: [192.168.242.22] Action(cas[3]) SetChannel success
Jan 1 04:49:14 ocur[21]: ocur: Disabled table monitor for instance 3
Jan 1 04:49:14 ocur[21]: ocur: [3] Program number set to 0, was 0
Jan 1 04:49:14 ocur[21]: ocur: [3] Tune to 751 (mod=q256, freq=69000, program=11, std=9)
Jan 1 04:49:14 ocur[21]: ocur: [3] Program number set to 11, was 0
Jan 1 04:49:14 ocur[21]: ocur: Disabled table monitor for instance 3
Jan 1 04:49:14 ocur[21]: ocur: [3] Adding pid 0x0000
Jan 1 04:49:15 ocur[21]: ocur: [3] Locked: 1 Acc E: 0
Jan 1 04:49:15 ocur[21]: ocur: [3] Adding pid 0x1ffb
Jan 1 04:49:15 ocur[21]: upnp: [192.168.242.22] Calling Action(fdc[3]) RequestTables
Jan 1 04:49:15 ocur[21]: upnp: [192.168.242.22] Action(fdc[3]) RequestTables success
Jan 1 04:49:15 ocur[21]: upnp: [192.168.242.22] Calling Action(ua[3]) SetCurrentTunerUseReason
Jan 1 04:49:15 ocur[21]: ocur: [3] UA: use_reason 2 TA: use_status 0
Jan 1 04:49:15 ocur[21]: upnp: [192.168.242.22] Action(ua[3]) SetCurrentTunerUseReason success
Jan 1 04:49:15 ocur[21]: ocur: [3] Tune finished to freq 69000
Jan 1 04:49:15 ocur[21]: ocur: [3] Getting pmt for program 11
Jan 1 04:49:15 ocur[21]: ocur: [3] Got pmt for program# 11
Jan 1 04:49:15 ocur[21]: ocur: [3] Adding pid 0x0031
Jan 1 04:49:15 ocur[21]: ocur: [3] Adding pid 0x0034
Jan 1 04:49:15 ocur[21]: ocur: [3] Adding pid 0x0035
Jan 1 04:49:15 ocur[21]: ocur: [3] Adding pid 0x0036
Jan 1 04:49:15 ocur[21]: upnp: Event(tuner[3]): PCRLock, "1"
Jan 1 04:49:15 ocur[21]: ocur: [3] Adding pid 0x0e0f
Jan 1 04:49:15 ocur[21]: ocur: [3] Adding pid 0x0104
Jan 1 04:49:15 ocur[21]: ocur: [3] Adding pid 0x0e10
Jan 1 04:49:15 ocur[21]: ocur: [3] Adding pid 0x0e11
Jan 1 04:49:15 ocur[21]: ocur: [3] Adding pid 0x0e1d
Jan 1 04:49:15 ocur[21]: ocur: [3] Adding pid 0x0e1e
Jan 1 04:49:15 ocur[21]: ocur: [3] Adding pid 0x0e12
Jan 1 04:49:15 ocur[21]: ocur: [3] Adding pid 0x0e13
Jan 1 04:49:15 ocur[21]: ocur: Disabled table monitor for instance 3
Jan 1 04:49:15 ocur[21]: ocur: Enabled table monitor for instance 3
Jan 1 04:49:15 ocur[21]: ocur: [3] Channel is scrambled, expecting CCI
Jan 1 04:49:15 ocur[21]: ocur: [3] Sending ca_pmt to CableCARD for program number 11 index 0
Jan 1 04:49:16 ocur[21]: ocur: [3] CCI 00 arrived for program# 11
Jan 1 04:49:16 ocur[21]: upnp: [192.168.242.22] Get(tuner[3]): Frequency "69000"
Jan 1 04:49:16 ocur[21]: upnp: [192.168.242.22] Get(mux[3]): ProgramNumber "11"
Jan 1 04:49:16 ocur[21]: upnp: [192.168.242.22] Calling Action(ua[3]) UserActivityDetected
Jan 1 04:49:16 ocur[21]: upnp: [192.168.242.22] Action(ua[3]) UserActivityDetected success
Jan 1 04:52:11 ocur[21]: upnp: [192.168.242.22] Calling Action(ua[3]) UserActivityDetected
Jan 1 04:52:11 ocur[21]: upnp: [192.168.242.22] Action(ua[3]) UserActivityDetected success

[JohnW248]

Did you set this up so each computer has full access to all six tuners or did you install only certain tuners to each machine?

The "no signal" squabble sounds like a tuner sharing issue (which I have also experienced with SD Prime tuners when multiple computers have access to the same device).

For a quick test you might try using edit sources on each machine and on one channel only allow tuner 1 to one machine and on the other machine do not allow tuner 1 but 2-6. Since this only applies to a single channel, then tune that same channel on both machines and see if it works.

BTW the date stamp always starts there with a tuner reboot. You can use the cableCARD time as an offset to go to the London time zone and then apply your local correction.

[smassey22180]

I have switched tuners 1-3 to WMC1 and 4-6 to WMC2. No issues since the switch. I don't need tuner pooling. 2+ per wmc is fine for me.