Ocam - TVheadend

Süheyl Karakas

Hallo allemaal!

Ik hoop dat iemand mij kan helpen met het configureren van mijn omgeving.

Hierbij mijn specs:

AMD Phenom II X6 1045T
ASRock 890GX Extreme3
8GB RAM
EVGA GeForce GT 610 2GB

Digital Devices Cine C/T V6

Ik draai de laatste versie van XBMCbuntu. Ik gebruik oscam in combinatie met Tvheadend. De verbinding met de server lijkt ok (in eerste instantie).

De niet gecodeerde zender worden middels Tveadend moeiteloos doorgegeven aan XBMC. Ook werkt mijn EPG.

Wanneer ik een gecodeerde zender wil bekijken heb ik de eerste 15-30 seconden alleen beeld, geen geluid. Daarna stopt het.

Waar kan dit aan liggen?

Alex .

Hi,

This forum is usually in English, I hope that is no problem for you.

Does the debug-log at the bottom of tvheadend show any messages that might give a clue ? ( check by opening this log and enabling debug-mode and then start watching a channel). It will tell you the status of decrypting, and might give some clues.

You say 'it stops' , you mean the entire video stops ? Again, what does the debug-log show when this happens?

Alex.

Süheyl Karakas wrote:
> Hallo allemaal!
>
> Ik hoop dat iemand mij kan helpen met het configureren van mijn omgeving.
>
> Hierbij mijn specs:
>
> AMD Phenom II X6 1045T
> ASRock 890GX Extreme3
> 8GB RAM
> EVGA GeForce GT 610 2GB
> Digital Devices Cine C/T V6
>
>
> Ik draai de laatste versie van XBMCbuntu. Ik gebruik oscam in combinatie met Tvheadend. De verbinding met de server lijkt ok (in eerste instantie).
> De niet gecodeerde zender worden middels Tveadend moeiteloos doorgegeven aan XBMC. Ook werkt mijn EPG.
>
> Wanneer ik een gecodeerde zender wil bekijken heb ik de eerste 15-30 seconden alleen beeld, geen geluid. Daarna stopt het.
>

> Waar kan dit aan liggen?

Süheyl Karakas

Hi Alex,<

I´m sorry, didn´t know it was English. But that´s fine with me.

There are some channels which are not scrambled. They work fine. When I tune to a scrambled channel it works fine for some seconds, but after that the screen freezes.

Sometimes I only get video and no sound.

Here's some logging:

Hope you can help me.

System log
Loglevel debug: enabled
Aug 29 18:25:34.253 subscription: "192.168.1.26 [ xbmc | XBMC Media Center ]" unsubscribing from "Nederland 1"
Aug 29 18:25:34.261 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Adding adapter "_dev_dvb_adapter0_STV0367_DVB_C_DVB_T554000000" for service "DDbridge_01/554,000 kHz/FOX Sports Informatie"
Aug 29 18:25:34.261 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Probing adapter "_dev_dvb_adapter0_STV0367_DVB_C_DVB_T554000000" without stealing for service "DDbridge_01/554,000 kHz/FOX Sports Informatie"
Aug 29 18:25:34.261 dvb: /dev/dvb/adapter0 stopping thread
Aug 29 18:25:34.262 dvb: /dev/dvb/adapter0 stopped thread
Aug 29 18:25:34.262 dvb: "/dev/dvb/adapter0" tuning to "554,000 kHz" (Transport start)
Aug 29 18:25:34.262 subscription: "192.168.1.26 [ xbmc | XBMC Media Center ]" subscribing on "FOX Sports Informatie", weight: 150, adapter: "DDbridge_01", network: "", mux: "554,000 kHz", provider: "Ziggo", service: "FOX Sports Informatie", quality: 100
Aug 29 18:25:34.576 dvb: /dev/dvb/adapter0 started dvr thread
Aug 29 18:25:34.576 viasat_baltic: install table handlers
Aug 29 18:25:34.576 uk_freesat: install table handlers
Aug 29 18:25:34.576 eit: install table handlers
Aug 29 18:25:34.597 Service: DDbridge_01/554,000 kHz/FOX Sports Informatie: Status changed to [Hardware input]
Aug 29 18:25:34.597 Service: DDbridge_01/554,000 kHz/FOX Sports Informatie: Status changed to [Hardware input] [Input on service]
Aug 29 18:25:34.597 Service: DDbridge_01/554,000 kHz/FOX Sports Informatie: Status changed to [Hardware input] [Input on service] [Demuxed packets]
Aug 29 18:25:34.598 eit: begin processing
Aug 29 18:25:34.777 Service: DDbridge_01/554,000 kHz/FOX Sports Informatie: Status changed to [Hardware input] [Input on service] [Demuxed packets] [Reassembled packets]
Aug 29 18:25:37.619 subscription: "192.168.1.26 [ xbmc | XBMC Media Center ]" unsubscribing from "FOX Sports Informatie"
Aug 29 18:25:37.625 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Adding adapter "_dev_dvb_adapter0_STV0367_DVB_C_DVB_T794000000" for service "DDbridge_01/794,000 kHz/Nederland 1 HD"
Aug 29 18:25:37.625 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Probing adapter "_dev_dvb_adapter0_STV0367_DVB_C_DVB_T794000000" without stealing for service "DDbridge_01/794,000 kHz/Nederland 1 HD"
Aug 29 18:25:37.625 dvb: /dev/dvb/adapter0 stopping thread
Aug 29 18:25:37.626 dvb: /dev/dvb/adapter0 stopped thread
Aug 29 18:25:37.626 eit: processing cancelled
Aug 29 18:25:37.626 dvb: "/dev/dvb/adapter0" tuning to "794,000 kHz" (Transport start)
Aug 29 18:25:37.626 subscription: "192.168.1.26 [ xbmc | XBMC Media Center ]" subscribing on "Nederland 1 HD", weight: 150, adapter: "DDbridge_01", network: "", mux: "794,000 kHz", provider: "Ziggo", service: "Nederland 1 HD", quality: 100
Aug 29 18:25:37.940 dvb: /dev/dvb/adapter0 started dvr thread
Aug 29 18:25:37.940 viasat_baltic: install table handlers
Aug 29 18:25:37.940 uk_freesat: install table handlers
Aug 29 18:25:37.940 eit: install table handlers
Aug 29 18:25:37.968 Service: DDbridge_01/794,000 kHz/Nederland 1 HD: Status changed to [Hardware input]
Aug 29 18:25:37.968 Service: DDbridge_01/794,000 kHz/Nederland 1 HD: Status changed to [Hardware input] [Input on service]
Aug 29 18:25:37.968 Service: DDbridge_01/794,000 kHz/Nederland 1 HD: Status changed to [Hardware input] [Input on service] [Demuxed packets]
Aug 29 18:25:37.969 Service: DDbridge_01/794,000 kHz/Nederland 1 HD: Status changed to [Hardware input] [Input on service] [Demuxed packets] [Reassembled packets]
Aug 29 18:25:37.970 eit: begin processing
Aug 29 18:25:58.002 epg: expire event 125454 from HBO 2
Aug 29 18:25:58.002 epg: now/next 126578/127704 set on HBO 2
Aug 29 18:25:58.002 epg: arm channel timer

 1377801096 for HBO 2
Aug 29 18:25:58.002 epg: inform HTSP of now event change on HBO 2
Aug 29 18:25:58.002 epg: expire event 126222 from HBO 2 HD
Aug 29 18:25:58.002 epg: now/next 127120/128312 set on HBO 2 HD
Aug 29 18:25:58.002 epg: arm channel timer

1377801096 for HBO 2 HD
Aug 29 18:25:58.002 epg: inform HTSP of now event change on HBO 2 HD
Aug 29 18:26:00.002 epg: expire event 127550 from Baby TV
Aug 29 18:26:00.002 epg: now/next 127552/127554 set on Baby TV
Aug 29 18:26:00.002 epg: arm channel timer

 1377795600 for Baby TV
Aug 29 18:26:00.002 epg: inform HTSP of now event change on Baby TV
Aug 29 18:26:22.957 eit: processing complete
Aug 29 18:26:25.595 subscription: "192.168.1.26 [ xbmc | XBMC Media Center ]" unsubscribing from "Nederland 1 HD"
Aug 29 18:26:25.605 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Skipping "DDbridge_01/730,000 kHz/Omroep Flevoland" -- not enabled
Aug 29 18:26:25.605 subscription: No transponder available for subscription "192.168.1.26 [ xbmc | XBMC Media Center ]" to channel "Omroep Flevoland"
Aug 29 18:26:27.002 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Skipping "DDbridge_01/730,000 kHz/Omroep Flevoland" -- not enabled
Aug 29 18:26:29.002 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Skipping "DDbridge_01/730,000 kHz/Omroep Flevoland" -- not enabled
Aug 29 18:26:31.002 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Skipping "DDbridge_01/730,000 kHz/Omroep Flevoland" -- not enabled
Aug 29 18:26:33.002 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Skipping "DDbridge_01/730,000 kHz/Omroep Flevoland" -- not enabled
Aug 29 18:26:35.002 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Skipping "DDbridge_01/730,000 kHz/Omroep Flevoland" -- not enabled
Aug 29 18:26:36.130 subscription: "192.168.1.26 [ xbmc | XBMC Media Center ]" unsubscribing from "Omroep Flevoland"
Aug 29 18:26:36.141 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Skipping "DDbridge_01/730,000 kHz/TV Gelderland" -- not enabled
Aug 29 18:26:36.141 subscription: No transponder available for subscription "192.168.1.26 [ xbmc | XBMC Media Center ]" to channel "TV Gelderland"
Aug 29 18:26:36.975 subscription: "192.168.1.26 [ xbmc | XBMC Media Center ]" unsubscribing from "TV Gelderland"
Aug 29 18:26:36.985 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Adding adapter "_dev_dvb_adapter0_STV0367_DVB_C_DVB_T730000000" for service "DDbridge_01/730,000 kHz/TV Oost"
Aug 29 18:26:36.985 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Probing adapter "_dev_dvb_adapter0_STV0367_DVB_C_DVB_T730000000" without stealing for service "DDbridge_01/730,000 kHz/TV Oost"
Aug 29 18:26:36.985 dvb: /dev/dvb/adapter0 stopping thread
Aug 29 18:26:36.986 dvb: /dev/dvb/adapter0 stopped thread
Aug 29 18:26:36.986 dvb: "/dev/dvb/adapter0" tuning to "730,000 kHz" (Transport start)
Aug 29 18:26:36.986 subscription: "192.168.1.26 [ xbmc | XBMC Media Center ]" subscribing on "TV Oost", weight: 150, adapter: "DDbridge_01", network: "", mux: "730,000 kHz", provider: "Ziggo", service: "TV Oost", quality: 100
Aug 29 18:26:37.300 dvb: /dev/dvb/adapter0 started dvr thread
Aug 29 18:26:37.300 viasat_baltic: install table handlers
Aug 29 18:26:37.300 uk_freesat: install table handlers
Aug 29 18:26:37.300 eit: install table handlers
Aug 29 18:26:37.328 Service: DDbridge_01/730,000 kHz/TV Oost: Status changed to [Hardware input] 
Aug 29 18:26:37.328 Service: DDbridge_01/730,000 kHz/TV Oost: Status changed to [Hardware input] [Input on service] 
Aug 29 18:26:37.328 Service: DDbridge_01/730,000 kHz/TV Oost: Status changed to [Hardware input] [Input on service] [Demuxed packets] 
Aug 29 18:26:37.328 Service: DDbridge_01/730,000 kHz/TV Oost: Status changed to [Hardware input] [Input on service] [Demuxed packets] [Reassembled packets] 
Aug 29 18:26:37.329 eit: begin processing
Aug 29 18:26:37.674 subscription: "192.168.1.26 [ xbmc | XBMC Media Center ]" unsubscribing from "TV Oost"
Aug 29 18:26:37.685 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Skipping "DDbridge_01/730,000 kHz/TV Drenthe" -- not enabled
Aug 29 18:26:37.685 subscription: No transponder available for subscription "192.168.1.26 [ xbmc | XBMC Media Center ]" to channel "TV Drenthe"
Aug 29 18:26:39.002 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Skipping "DDbridge_01/730,000 kHz/TV Drenthe" -- not enabled
Aug 29 18:26:41.002 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Skipping "DDbridge_01/730,000 kHz/TV Drenthe" -- not enabled
Aug 29 18:26:42.002 eit: processing complete
Aug 29 18:26:42.002 dvb: /dev/dvb/adapter0 stopping thread
Aug 29 18:26:42.003 dvb: /dev/dvb/adapter0 stopped thread
Aug 29 18:26:42.003 eit: processing cancelled
Aug 29 18:26:42.003 dvb: "/dev/dvb/adapter0" tuning to "356,000 kHz" (Autoscan)
Aug 29 18:26:43.000 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Skipping "DDbridge_01/730,000 kHz/TV Drenthe" -- not enabled
Aug 29 18:26:45.000 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Skipping "DDbridge_01/730,000 kHz/TV Drenthe" -- not enabled
Aug 29 18:26:46.253 subscription: "192.168.1.26 [ xbmc | XBMC Media Center ]" unsubscribing from "TV Drenthe"
Aug 29 18:26:46.326 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Adding adapter "_dev_dvb_adapter0_STV0367_DVB_C_DVB_T610000000" for service "DDbridge_01/610,000 kHz/Veronica/Disney XD"
Aug 29 18:26:46.326 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Probing adapter "_dev_dvb_adapter0_STV0367_DVB_C_DVB_T610000000" without stealing for service "DDbridge_01/610,000 kHz/Veronica/Disney XD"
Aug 29 18:26:46.326 dvb: "/dev/dvb/adapter0" tuning to "610,000 kHz" (Transport start)
Aug 29 18:26:46.326 cwc: DDbridge_01/610,000 kHz/Veronica/Disney XD using CWC 192.168.1.26:15050
Aug 29 18:26:46.327 subscription: "192.168.1.26 [ xbmc | XBMC Media Center ]" subscribing on "Veronica/Disney XD", weight: 150, adapter: "DDbridge_01", network: "", mux: "610,000 kHz", provider: "Ziggo", service: "Veronica/Disney XD", quality: 100
Aug 29 18:26:46.644 dvb: /dev/dvb/adapter0 started dvr thread
Aug 29 18:26:46.644 viasat_baltic: install table handlers
Aug 29 18:26:46.644 uk_freesat: install table handlers
Aug 29 18:26:46.644 eit: install table handlers
Aug 29 18:26:46.672 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input] 
Aug 29 18:26:46.672 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input] [Input on service] 
Aug 29 18:26:46.672 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input] [Input on service] [Demuxed packets] 
Aug 29 18:26:46.673 eit: begin processing
Aug 29 18:26:46.911 cwc: Insert new ECM (PID 5001) for service "Veronica/Disney XD"
Aug 29 18:26:46.911 cwc: Sending ECM (PID 5001) section=0/1, for service "Veronica/Disney XD" (seqno: 20176)
Aug 29 18:26:46.911 cwc: Sending ECM (PID 5001) section=1/1, for service "Veronica/Disney XD" (seqno: 20177)
Aug 29 18:26:47.239 cwc: Saving prefered PID 5001
Aug 29 18:26:47.239 cwc: Received ECM reply (PID 5001) for service "Veronica/Disney XD" even: dc.27.b8.bb.d4.be.22.b4 odd: 2f.ce.25.22.1d.89.01.a7 (seqno: 20176 Req delay: 328 ms)
Aug 29 18:26:47.239 cwc: Obtained key for service "Veronica/Disney XD" in 328 ms, from 192.168.1.26:15050
Aug 29 18:26:47.310 cwc: Sending ECM (PID 5001) section=0/1, for service "Veronica/Disney XD" (seqno: 20178)
Aug 29 18:26:47.310 cwc: Sending ECM (PID 5001) section=1/1, for service "Veronica/Disney XD" (seqno: 20179)
Aug 29 18:26:47.604 TS: DDbridge_01/610,000 kHz/Veronica/Disney XD: TELETEXT

#314: Continuity counter error
Aug 29 18:26:47.604 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input] [Input on service] [Demuxed packets] [Reassembled packets]
Aug 29 18:26:47.834 cwc: Received ECM reply (PID 5001) for service "Veronica/Disney XD" even: 62.4e.83.33.ba.1d.11.e8 odd: 2f.ce.25.22.1d.89.01.a7 (seqno: 20178 Req delay: 524 ms)
Aug 29 18:26:48.067 cwc: Received NOK for service "Veronica/Disney XD" (PID 5001) (seqno: 20179 Req delay: 756 ms)
Aug 29 18:26:48.067 cwc: Got unexpected ECM reply (seqno: 20177)
Aug 29 18:26:48.067 cwc: After got unexpected (ct->cs_okchannel: 5001)
Aug 29 18:27:00.002 epg: expire event 127612 from Canvas HD
Aug 29 18:27:00.002 epg: now/next 127614/127616 set on Canvas HD
Aug 29 18:27:00.002 epg: arm channel timer

 1377793800 for Canvas HD
Aug 29 18:27:00.002 epg: inform HTSP of now event change on Canvas HD
Aug 29 18:27:00.002 epg: expire event 128324 from Canvas
Aug 29 18:27:00.002 epg: now/next 128326/128328 set on Canvas
Aug 29 18:27:00.002 epg: arm channel timer

1377793800 for Canvas
Aug 29 18:27:00.002 epg: inform HTSP of now event change on Canvas
Aug 29 18:27:00.002 epg: expire event 128590 from Dusk! Deluxe
Aug 29 18:27:00.002 epg: now/next 128592/128594 set on Dusk! Deluxe
Aug 29 18:27:00.002 epg: arm channel timer

 1377795060 for Dusk! Deluxe
Aug 29 18:27:00.002 epg: inform HTSP of now event change on Dusk! Deluxe
Aug 29 18:27:12.304 cwc: Sending ECM (PID 5001) section=0/1, for service "Veronica/Disney XD" (seqno: 20180)
Aug 29 18:27:12.304 cwc: Sending ECM (PID 5001) section=1/1, for service "Veronica/Disney XD" (seqno: 20181)
Aug 29 18:27:12.306 cwc: Received NOK for service "Veronica/Disney XD" (PID 5001) (seqno: 20180 Req delay: 0 ms)
Aug 29 18:27:12.308 cwc: Received NOK for service "Veronica/Disney XD" (PID 5001) (seqno: 20181 Req delay: 4 ms)
Aug 29 18:27:12.308 cwc: Can not descramble service "Veronica/Disney XD", access denied (seqno: 20181 Req delay: 4 ms)
Aug 29 18:27:12.330 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input] [Input on service] [Demuxed packets] [Reassembled packets] [No access] 
Aug 29 18:27:18.327 subscription: "192.168.1.26 [ xbmc | XBMC Media Center ]" unsubscribing from "Veronica/Disney XD"
Aug 29 18:27:18.332 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Adding adapter "_dev_dvb_adapter0_STV0367_DVB_C_DVB_T474000000" for service "DDbridge_01/474,000 kHz/13TH STREET"
Aug 29 18:27:18.332 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Probing adapter "_dev_dvb_adapter0_STV0367_DVB_C_DVB_T474000000" without stealing for service "DDbridge_01/474,000 kHz/13TH STREET"
Aug 29 18:27:18.332 dvb: /dev/dvb/adapter0 stopping thread
Aug 29 18:27:18.332 dvb: /dev/dvb/adapter0 stopped thread
Aug 29 18:27:18.332 eit: processing cancelled
Aug 29 18:27:18.332 dvb: "/dev/dvb/adapter0" tuning to "474,000 kHz" (Transport start)
Aug 29 18:27:18.333 cwc: DDbridge_01/474,000 kHz/13TH STREET using CWC 192.168.1.26:15050
Aug 29 18:27:18.333 subscription: "192.168.1.26 [ xbmc | XBMC Media Center ]" subscribing on "13TH STREET", weight: 150, adapter: "DDbridge_01", network: "", mux: "474,000 kHz", provider: "Ziggo", service: "13TH STREET", quality: 100
Aug 29 18:27:18.644 dvb: /dev/dvb/adapter0 started dvr thread
Aug 29 18:27:18.644 viasat_baltic: install table handlers
Aug 29 18:27:18.644 uk_freesat: install table handlers
Aug 29 18:27:18.644 eit: install table handlers
Aug 29 18:27:18.665 Service: DDbridge_01/474,000 kHz/13TH STREET: Status changed to [Hardware input] 
Aug 29 18:27:18.665 Service: DDbridge_01/474,000 kHz/13TH STREET: Status changed to [Hardware input] [Input on service] 
Aug 29 18:27:18.665 eit: begin processing
Aug 29 18:27:18.805 Service: DDbridge_01/474,000 kHz/13TH STREET: Status changed to [Hardware input] [Input on service] [Demuxed packets] 
Aug 29 18:27:18.805 cwc: Insert new ECM (PID 5008) for service "13TH STREET"
Aug 29 18:27:18.805 cwc: Sending ECM (PID 5008) section=0/1, for service "13TH STREET" (seqno: 20182)
Aug 29 18:27:18.805 cwc: Sending ECM (PID 5008) section=1/1, for service "13TH STREET" (seqno: 20183)
Aug 29 18:27:19.132 cwc: Saving prefered PID 5008
Aug 29 18:27:19.132 cwc: Received ECM reply (PID 5008) for service "13TH STREET" even: 9a.ae.3b.83.23.ff.1a.3c odd: a0.ef.42.d1.63.92.4b.40 (seqno: 20182 Req delay: 328 ms)
Aug 29 18:27:19.132 cwc: Obtained key for service "13TH STREET" in 328 ms, from 192.168.1.26:15050
Aug 29 18:27:19.185 Service: DDbridge_01/474,000 kHz/13TH STREET: Status changed to [Hardware input] [Input on service] [Demuxed packets] [Reassembled packets] 
Aug 29 18:27:19.351 cwc: Received NOK for service "13TH STREET" (PID 5008) (seqno: 20183 Req delay: 548 ms)
Aug 29 18:27:21.018 cwc: Sending ECM (PID 5008) section=0/1, for service "13TH STREET" (seqno: 20184)
Aug 29 18:27:21.018 cwc: Sending ECM (PID 5008) section=1/1, for service "13TH STREET" (seqno: 20185)
Aug 29 18:27:21.022 cwc: Received NOK for service "13TH STREET" (PID 5008) (seqno: 20184 Req delay: 4 ms)
Aug 29 18:27:21.023 cwc: Received NOK for service "13TH STREET" (PID 5008) (seqno: 20185 Req delay: 4 ms)
Aug 29 18:27:21.023 cwc: Can not descramble service "13TH STREET", access denied (seqno: 20185 Req delay: 4 ms)
Aug 29 18:27:21.038 Service: DDbridge_01/474,000 kHz/13TH STREET: Status changed to [Hardware input] [Input on service] [Demuxed packets] [Reassembled packets] [No access] 
Aug 29 18:27:46.025 cwc: Sending ECM (PID 5008) section=0/1, for service "13TH STREET" (seqno: 20186)
Aug 29 18:27:46.025 cwc: Sending ECM (PID 5008) section=1/1, for service "13TH STREET" (seqno: 20187)
Aug 29 18:28:03.773 eit: processing complete
Aug 29 18:28:11.012 cwc: Sending ECM (PID 5008) section=0/1, for service "13TH STREET" (seqno: 20188)
Aug 29 18:28:24.133 epg: now/next 146776/127308 set on Star Gold
Aug 29 18:28:24.133 epg: arm channel timer

1377793800 for Star Gold
Aug 29 18:28:24.133 epg: inform HTSP of now event change on Star Gold
Aug 29 18:30:00.002 epg: expire event 146776 from Star Gold
Aug 29 18:30:00.002 epg: now/next 127308/128674 set on Star Gold
Aug 29 18:30:00.002 epg: arm channel timer

 1377802800 for Star Gold
Aug 29 18:30:00.002 epg: inform HTSP of now event change on Star Gold
Aug 29 18:30:00.002 epg: expire event 128326 from Canvas
Aug 29 18:30:00.002 epg: now/next 128328/128330 set on Canvas
Aug 29 18:30:00.002 epg: arm channel timer

1377795600 for Canvas
Aug 29 18:30:00.002 epg: inform HTSP of now event change on Canvas
Aug 29 18:30:00.002 epg: expire event 127614 from Canvas HD
Aug 29 18:30:00.002 epg: now/next 127616/127618 set on Canvas HD
Aug 29 18:30:00.002 epg: arm channel timer

 1377795600 for Canvas HD
Aug 29 18:30:00.002 epg: inform HTSP of now event change on Canvas HD
Aug 29 18:30:00.002 epg: expire event 127212 from JimJam
Aug 29 18:30:00.002 epg: now/next 127214/127216 set on JimJam
Aug 29 18:30:00.002 epg: arm channel timer

1377794100 for JimJam
Aug 29 18:30:00.002 epg: inform HTSP of now event change on JimJam
Aug 29 18:30:00.002 epg: expire event 128270 from Eén HD
Aug 29 18:30:00.002 epg: now/next 128272/128274 set on Eén HD
Aug 29 18:30:00.002 epg: arm channel timer

 1377795600 for Eén HD
Aug 29 18:30:00.002 epg: inform HTSP of now event change on Eén HD
Aug 29 18:30:00.002 epg: expire event 128300 from Eén
Aug 29 18:30:00.002 epg: now/next 128302/128304 set on Eén
Aug 29 18:30:00.002 epg: arm channel timer

1377795600 for Eén
Aug 29 18:30:00.002 epg: inform HTSP of now event change on Eén
Aug 29 18:30:00.003 epg: expire event 127906 from FOX Sports 1 Eredivisie
Aug 29 18:30:00.003 epg: now/next 127908/127910 set on FOX Sports 1 Eredivisie
Aug 29 18:30:00.003 epg: arm channel timer

 1377795600 for FOX Sports 1 Eredivisie
Aug 29 18:30:00.003 epg: inform HTSP of now event change on FOX Sports 1 Eredivisie
Aug 29 18:30:00.003 epg: expire event 127746 from FOX Sports 1 Eredivisie HD
Aug 29 18:30:00.003 epg: now/next 127748/127750 set on FOX Sports 1 Eredivisie HD
Aug 29 18:30:00.003 epg: arm channel timer

1377795600 for FOX Sports 1 Eredivisie HD
Aug 29 18:30:00.003 epg: inform HTSP of now event change on FOX Sports 1 Eredivisie HD
Aug 29 18:30:00.003 epg: expire event 146420 from Zappelin / Zapp 24
Aug 29 18:30:00.003 epg: now/next 146422/146424 set on Zappelin / Zapp 24
Aug 29 18:30:00.003 epg: arm channel timer

 1377795300 for Zappelin / Zapp 24
Aug 29 18:30:00.003 epg: inform HTSP of now event change on Zappelin / Zapp 24
Aug 29 18:30:00.003 epg: expire event 128170 from Disney Channel
Aug 29 18:30:00.003 epg: now/next 128172/128174 set on Disney Channel
Aug 29 18:30:00.003 epg: arm channel timer

1377795300 for Disney Channel
Aug 29 18:30:00.003 epg: inform HTSP of now event change on Disney Channel
Aug 29 18:30:00.003 epg: expire event 128196 from FOXlife HD
Aug 29 18:30:00.003 epg: now/next 128198/128200 set on FOXlife HD
Aug 29 18:30:00.003 epg: arm channel timer

 1377796500 for FOXlife HD
Aug 29 18:30:00.003 epg: inform HTSP of now event change on FOXlife HD
Aug 29 18:30:00.003 epg: expire event 128476 from FOXlife
Aug 29 18:30:00.003 epg: now/next 128478/128480 set on FOXlife
Aug 29 18:30:00.003 epg: arm channel timer

1377796500 for FOXlife
Aug 29 18:30:00.003 epg: inform HTSP of now event change on FOXlife
Aug 29 18:30:00.003 epg: expire event 127640 from Boomerang
Aug 29 18:30:00.003 epg: now/next 127642/127644 set on Boomerang
Aug 29 18:30:00.003 epg: arm channel timer

 1377795300 for Boomerang
Aug 29 18:30:00.003 epg: inform HTSP of now event change on Boomerang
Aug 29 18:30:00.003 epg: expire event 128222 from RTL 7 HD
Aug 29 18:30:00.003 epg: now/next 128224/128226 set on RTL 7 HD
Aug 29 18:30:00.003 epg: arm channel timer

1377797400 for RTL 7 HD
Aug 29 18:30:00.003 epg: inform HTSP of now event change on RTL 7 HD
Aug 29 18:30:00.003 epg: expire event 127374 from RTL 7
Aug 29 18:30:00.003 epg: now/next 127376/127378 set on RTL 7
Aug 29 18:30:00.003 epg: arm channel timer

 1377797400 for RTL 7
Aug 29 18:30:00.003 epg: inform HTSP of now event change on RTL 7
Aug 29 18:30:00.003 epg: expire event 127288 from Aljazeera English
Aug 29 18:30:00.003 epg: now/next 127290/127292 set on Aljazeera English
Aug 29 18:30:00.003 epg: arm channel timer

1377795600 for Aljazeera English
Aug 29 18:30:00.003 epg: inform HTSP of now event change on Aljazeera English
Aug 29 18:30:00.003 epg: expire event 127966 from NostalgieNet
Aug 29 18:30:00.003 epg: now/next 127968/127970 set on NostalgieNet
Aug 29 18:30:00.003 epg: arm channel timer

 1377795600 for NostalgieNet
Aug 29 18:30:00.003 epg: inform HTSP of now event change on NostalgieNet
Aug 29 18:30:00.003 epg: expire event 127440 from RTL Lounge
Aug 29 18:30:00.003 epg: now/next 127442/127444 set on RTL Lounge
Aug 29 18:30:00.003 epg: arm channel timer

1377797400 for RTL Lounge
Aug 29 18:30:00.003 epg: inform HTSP of now event change on RTL Lounge
Aug 29 18:30:00.003 epg: expire event 127512 from National Geographic Channel HD
Aug 29 18:30:00.003 epg: now/next 127514/127516 set on National Geographic Channel HD
Aug 29 18:30:00.003 epg: arm channel timer

 1377795600 for National Geographic Channel HD
Aug 29 18:30:00.003 epg: inform HTSP of now event change on National Geographic Channel HD
Aug 29 18:30:00.003 epg: expire event 128434 from National Geographic Channel
Aug 29 18:30:00.003 epg: now/next 128436/128438 set on National Geographic Channel
Aug 29 18:30:00.004 epg: arm channel timer

1377795600 for National Geographic Channel
Aug 29 18:30:00.004 epg: inform HTSP of now event change on National Geographic Channel
Aug 29 18:30:00.004 epg: expire event 128136 from TLC
Aug 29 18:30:00.004 epg: now/next 128138/128140 set on TLC
Aug 29 18:30:00.004 epg: arm channel timer

 1377795600 for TLC
Aug 29 18:30:00.004 epg: inform HTSP of now event change on TLC
Aug 29 18:30:00.004 epg: expire event 130712 from FOX
Aug 29 18:30:00.004 epg: now/next 130714/130716 set on FOX
Aug 29 18:30:00.004 epg: arm channel timer

1377795300 for FOX
Aug 29 18:30:00.004 epg: inform HTSP of now event change on FOX
Aug 29 18:30:00.004 epg: expire event 131802 from FOX HD
Aug 29 18:30:00.004 epg: now/next 131804/131806 set on FOX HD
Aug 29 18:30:00.004 epg: arm channel timer

 1377795300 for FOX HD
Aug 29 18:30:00.004 epg: inform HTSP of now event change on FOX HD
Aug 29 18:30:00.004 epg: expire event 126684 from BBC 3 / CBBC
Aug 29 18:30:00.004 epg: now/next 126686/126688 set on BBC 3 / CBBC
Aug 29 18:30:00.004 epg: arm channel timer

1377795600 for BBC 3 / CBBC
Aug 29 18:30:00.004 epg: inform HTSP of now event change on BBC 3 / CBBC
Aug 29 18:30:00.004 epg: expire event 125512 from RTL Television
Aug 29 18:30:00.004 epg: now/next 125514/125516 set on RTL Television
Aug 29 18:30:00.004 epg: arm channel timer

 1377794700 for RTL Television
Aug 29 18:30:00.004 epg: inform HTSP of now event change on RTL Television
Aug 29 18:30:00.004 epg: expire event 127356 from RTL 5
Aug 29 18:30:00.004 epg: now/next 127358/127360 set on RTL 5
Aug 29 18:30:00.004 epg: arm channel timer

1377797400 for RTL 5
Aug 29 18:30:00.004 epg: inform HTSP of now event change on RTL 5
Aug 29 18:30:00.004 epg: expire event 127764 from RTL 5 HD
Aug 29 18:30:00.004 epg: now/next 127766/127768 set on RTL 5 HD
Aug 29 18:30:00.004 epg: arm channel timer

 1377797400 for RTL 5 HD
Aug 29 18:30:00.004 epg: inform HTSP of now event change on RTL 5 HD
Aug 29 18:30:00.004 epg: expire event 128036 from Horse & Country TV
Aug 29 18:30:00.004 epg: now/next 128038/128040 set on Horse & Country TV
Aug 29 18:30:00.004 epg: arm channel timer

1377795600 for Horse & Country TV
Aug 29 18:30:00.004 epg: inform HTSP of now event change on Horse & Country TV
Aug 29 18:30:00.004 epg: expire event 127956 from HISTORY
Aug 29 18:30:00.004 epg: now/next 127958/127960 set on HISTORY
Aug 29 18:30:00.004 epg: arm channel timer

 1377795600 for HISTORY
Aug 29 18:30:00.004 epg: inform HTSP of now event change on HISTORY
Aug 29 18:30:00.004 epg: expire event 127944 from HISTORY HD
Aug 29 18:30:00.004 epg: now/next 127946/127948 set on HISTORY HD
Aug 29 18:30:00.004 epg: arm channel timer

1377795600 for HISTORY HD
Aug 29 18:30:00.004 epg: inform HTSP of now event change on HISTORY HD
Aug 29 18:30:00.004 epg: expire event 127300 from Star Plus
Aug 29 18:30:00.004 epg: now/next 127302/127304 set on Star Plus
Aug 29 18:30:00.004 epg: arm channel timer

 1377795600 for Star Plus
Aug 29 18:30:00.004 epg: inform HTSP of now event change on Star Plus
Aug 29 18:30:00.004 epg: expire event 127416 from BBC World News
Aug 29 18:30:00.004 epg: now/next 127418/127420 set on BBC World News
Aug 29 18:30:00.004 epg: arm channel timer

1377794700 for BBC World News
Aug 29 18:30:00.004 epg: inform HTSP of now event change on BBC World News
Aug 29 18:30:00.004 epg: expire event 128054 from 24 Kitchen
Aug 29 18:30:00.004 epg: now/next 128056/128058 set on 24 Kitchen
Aug 29 18:30:00.004 epg: arm channel timer

 1377795600 for 24 Kitchen
Aug 29 18:30:00.004 epg: inform HTSP of now event change on 24 Kitchen
Aug 29 18:30:00.004 epg: expire event 128444 from CNN International
Aug 29 18:30:00.004 epg: now/next 128446/128448 set on CNN International
Aug 29 18:30:00.004 epg: arm channel timer

1377794700 for CNN International
Aug 29 18:30:00.004 epg: inform HTSP of now event change on CNN International
Aug 29 18:30:00.004 epg: expire event 127822 from Humor TV 24
Aug 29 18:30:00.005 epg: now/next 127824/127826 set on Humor TV 24
Aug 29 18:30:00.005 epg: arm channel timer

 1377795600 for Humor TV 24
Aug 29 18:30:00.005 epg: inform HTSP of now event change on Humor TV 24
Aug 29 18:30:00.005 epg: expire event 128412 from Investigation Discovery
Aug 29 18:30:00.005 epg: now/next 128414/128416 set on Investigation Discovery
Aug 29 18:30:00.005 epg: arm channel timer

1377796800 for Investigation Discovery
Aug 29 18:30:00.005 epg: inform HTSP of now event change on Investigation Discovery
Aug 29 18:30:00.005 epg: expire event 127572 from Syfy Universal
Aug 29 18:30:00.005 epg: now/next 127574/127576 set on Syfy Universal
Aug 29 18:30:00.005 epg: arm channel timer

 1377796800 for Syfy Universal
Aug 29 18:30:00.005 epg: inform HTSP of now event change on Syfy Universal
Aug 29 18:30:00.005 epg: expire event 127458 from 13TH STREET
Aug 29 18:30:00.005 epg: now/next 127460/127462 set on 13TH STREET
Aug 29 18:30:00.005 epg: arm channel timer

1377796800 for 13TH STREET
Aug 29 18:30:00.005 epg: inform HTSP of now event change on 13TH STREET
Aug 29 18:30:00.005 epg: expire event 128386 from Discovery Science
Aug 29 18:30:00.005 epg: now/next 128388/128390 set on Discovery Science
Aug 29 18:30:00.005 epg: arm channel timer

 1377795300 for Discovery Science
Aug 29 18:30:00.005 epg: inform HTSP of now event change on Discovery Science
Aug 29 18:30:00.005 epg: expire event 126996 from Cultura 24
Aug 29 18:30:00.005 epg: now/next 126998/127000 set on Cultura 24
Aug 29 18:30:00.005 epg: arm channel timer

1377796800 for Cultura 24
Aug 29 18:30:00.005 epg: inform HTSP of now event change on Cultura 24
Aug 29 18:30:18.002 epg: expire event 128212 from Pebble TV
Aug 29 18:30:18.002 epg: now/next 128214/128216 set on Pebble TV
Aug 29 18:30:18.002 epg: arm channel timer

 1377795620 for Pebble TV
Aug 29 18:30:18.002 epg: inform HTSP of now event change on Pebble TV
Aug 29 18:30:23.002 epg: expire event 127922 from FOX Sports 3 Eredivisie
Aug 29 18:30:23.002 epg: now/next 127924/127926 set on FOX Sports 3 Eredivisie
Aug 29 18:30:23.002 epg: arm channel timer

1377794728 for FOX Sports 3 Eredivisie
Aug 29 18:30:23.002 epg: inform HTSP of now event change on FOX Sports 3 Eredivisie
Aug 29 18:30:29.002 epg: expire event 145454 from FOX Sports 5 Eredivisie
Aug 29 18:30:29.002 epg: now/next 124318/124320 set on FOX Sports 5 Eredivisie
Aug 29 18:30:29.002 epg: arm channel timer

 1377795627 for FOX Sports 5 Eredivisie
Aug 29 18:30:29.002 epg: inform HTSP of now event change on FOX Sports 5 Eredivisie
Aug 29 18:34:00.002 epg: expire event 128118 from PassieTV/Dusk!
Aug 29 18:34:00.002 epg: now/next 128120/128122 set on PassieTV/Dusk!
Aug 29 18:34:00.002 epg: arm channel timer

1377794460 for PassieTV/Dusk!
Aug 29 18:34:00.002 epg: inform HTSP of now event change on PassieTV/Dusk!
Aug 29 18:34:20.122 subscription: "192.168.1.26 [ xbmc | XBMC Media Center ]" unsubscribing from "13TH STREET"
Aug 29 18:34:20.195 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Adding adapter "_dev_dvb_adapter0_STV0367_DVB_C_DVB_T610000000" for service "DDbridge_01/610,000 kHz/Veronica/Disney XD"
Aug 29 18:34:20.195 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Probing adapter "_dev_dvb_adapter0_STV0367_DVB_C_DVB_T610000000" without stealing for service "DDbridge_01/610,000 kHz/Veronica/Disney XD"
Aug 29 18:34:20.195 dvb: /dev/dvb/adapter0 stopping thread
Aug 29 18:34:20.196 dvb: /dev/dvb/adapter0 stopped thread
Aug 29 18:34:20.196 dvb: "/dev/dvb/adapter0" tuning to "610,000 kHz" (Transport start)
Aug 29 18:34:20.196 cwc: DDbridge_01/610,000 kHz/Veronica/Disney XD using CWC 192.168.1.26:15050
Aug 29 18:34:20.196 subscription: "192.168.1.26 [ xbmc | XBMC Media Center ]" subscribing on "Veronica/Disney XD", weight: 150, adapter: "DDbridge_01", network: "", mux: "610,000 kHz", provider: "Ziggo", service: "Veronica/Disney XD", quality: 100
Aug 29 18:34:20.512 dvb: /dev/dvb/adapter0 started dvr thread
Aug 29 18:34:20.512 viasat_baltic: install table handlers
Aug 29 18:34:20.512 uk_freesat: install table handlers
Aug 29 18:34:20.512 eit: install table handlers
Aug 29 18:34:20.540 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input]
Aug 29 18:34:20.540 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input] [Input on service]
Aug 29 18:34:20.541 eit: begin processing
Aug 29 18:34:20.646 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input] [Input on service] [Demuxed packets]
Aug 29 18:34:20.646 cwc: Insert new ECM (PID 5001) for service "Veronica/Disney XD"
Aug 29 18:34:20.647 cwc: Sending ECM (PID 5001) section=0/1, for service "Veronica/Disney XD" (seqno: 20201)
Aug 29 18:34:20.647 cwc: Sending ECM (PID 5001) section=1/1, for service "Veronica/Disney XD" (seqno: 20202)
Aug 29 18:34:20.648 cwc: Received NOK for service "Veronica/Disney XD" (PID 5001) (seqno: 20201 Req delay: 4 ms)
Aug 29 18:34:20.868 cwc: Received NOK for service "Veronica/Disney XD" (PID 5001) (seqno: 20202 Req delay: 224 ms)
Aug 29 18:34:20.868 cwc: Can not descramble service "Veronica/Disney XD", access denied (seqno: 20202 Req delay: 224 ms)
Aug 29 18:34:20.885 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input] [Input on service] [Demuxed packets] [No access]
Aug 29 18:34:22.002 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Adding adapter "_dev_dvb_adapter0_STV0367_DVB_C_DVB_T610000000" for service "DDbridge_01/610,000 kHz/Veronica/Disney XD"
Aug 29 18:34:23.002 dvb: /dev/dvb/adapter0 stopping thread
Aug 29 18:34:23.002 dvb: /dev/dvb/adapter0 stopped thread
Aug 29 18:34:23.003 eit: processing cancelled
Aug 29 18:34:23.003 dvb: "/dev/dvb/adapter0" tuning to "578,000 kHz" (Autoscan)
Aug 29 18:34:23.316 dvb: /dev/dvb/adapter0 started dvr thread
Aug 29 18:34:23.316 viasat_baltic: install table handlers
Aug 29 18:34:23.316 uk_freesat: install table handlers
Aug 29 18:34:23.316 eit: install table handlers
Aug 29 18:34:23.343 eit: begin processing
Aug 29 18:34:24.002 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Adding adapter "_dev_dvb_adapter0_STV0367_DVB_C_DVB_T610000000" for service "DDbridge_01/610,000 kHz/Veronica/Disney XD"
Aug 29 18:34:24.002 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Probing adapter "_dev_dvb_adapter0_STV0367_DVB_C_DVB_T610000000" without stealing for service "DDbridge_01/610,000 kHz/Veronica/Disney XD"
Aug 29 18:34:24.002 dvb: /dev/dvb/adapter0 stopping thread
Aug 29 18:34:24.002 dvb: /dev/dvb/adapter0 stopped thread
Aug 29 18:34:24.003 eit: processing cancelled
Aug 29 18:34:24.003 dvb: "/dev/dvb/adapter0" tuning to "610,000 kHz" (Transport start)
Aug 29 18:34:24.003 cwc: DDbridge_01/610,000 kHz/Veronica/Disney XD using CWC 192.168.1.26:15050
Aug 29 18:34:24.316 dvb: /dev/dvb/adapter0 started dvr thread
Aug 29 18:34:24.316 viasat_baltic: install table handlers
Aug 29 18:34:24.316 uk_freesat: install table handlers
Aug 29 18:34:24.316 eit: install table handlers
Aug 29 18:34:24.343 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input]
Aug 29 18:34:24.343 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input] [Input on service]
Aug 29 18:34:24.343 eit: begin processing
Aug 29 18:34:24.556 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input] [Input on service] [Demuxed packets]
Aug 29 18:34:24.556 cwc: Insert new ECM (PID 5001) for service "Veronica/Disney XD"
Aug 29 18:34:24.556 cwc: Sending ECM (PID 5001) section=0/1, for service "Veronica/Disney XD" (seqno: 20203)
Aug 29 18:34:24.556 cwc: Sending ECM (PID 5001) section=1/1, for service "Veronica/Disney XD" (seqno: 20204)
Aug 29 18:34:24.558 cwc: Received NOK for service "Veronica/Disney XD" (PID 5001) (seqno: 20203 Req delay: 0 ms)
Aug 29 18:34:24.560 cwc: Received NOK for service "Veronica/Disney XD" (PID 5001) (seqno: 20204 Req delay: 4 ms)
Aug 29 18:34:24.560 cwc: Can not descramble service "Veronica/Disney XD", access denied (seqno: 20204 Req delay: 4 ms)
Aug 29 18:34:24.583 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input] [Input on service] [Demuxed packets] [No access]
Aug 29 18:34:26.002 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Adding adapter "_dev_dvb_adapter0_STV0367_DVB_C_DVB_T610000000" for service "DDbridge_01/610,000 kHz/Veronica/Disney XD"
Aug 29 18:34:28.002 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Adding adapter "_dev_dvb_adapter0_STV0367_DVB_C_DVB_T610000000" for service "DDbridge_01/610,000 kHz/Veronica/Disney XD"
Aug 29 18:34:28.002 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Probing adapter "_dev_dvb_adapter0_STV0367_DVB_C_DVB_T610000000" without stealing for service "DDbridge_01/610,000 kHz/Veronica/Disney XD"
Aug 29 18:34:28.002 cwc: DDbridge_01/610,000 kHz/Veronica/Disney XD using CWC 192.168.1.26:15050
Aug 29 18:34:28.012 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input]
Aug 29 18:34:28.012 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input] [Input on service]
Aug 29 18:34:28.146 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input] [Input on service] [Demuxed packets]
Aug 29 18:34:28.146 cwc: Insert new ECM (PID 5001) for service "Veronica/Disney XD"
Aug 29 18:34:28.146 cwc: Sending ECM (PID 5001) section=0/1, for service "Veronica/Disney XD" (seqno: 20205)
Aug 29 18:34:28.146 cwc: Sending ECM (PID 5001) section=1/1, for service "Veronica/Disney XD" (seqno: 20206)
Aug 29 18:34:28.148 cwc: Received NOK for service "Veronica/Disney XD" (PID 5001) (seqno: 20205 Req delay: 4 ms)
Aug 29 18:34:28.150 cwc: Received NOK for service "Veronica/Disney XD" (PID 5001) (seqno: 20206 Req delay: 4 ms)
Aug 29 18:34:28.150 cwc: Can not descramble service "Veronica/Disney XD", access denied (seqno: 20206 Req delay: 4 ms)
Aug 29 18:34:28.172 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input] [Input on service] [Demuxed packets] [No access]
Aug 29 18:34:30.002 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Adding adapter "_dev_dvb_adapter0_STV0367_DVB_C_DVB_T610000000" for service "DDbridge_01/610,000 kHz/Veronica/Disney XD"
Aug 29 18:34:32.002 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Adding adapter "_dev_dvb_adapter0_STV0367_DVB_C_DVB_T610000000" for service "DDbridge_01/610,000 kHz/Veronica/Disney XD"
Aug 29 18:34:32.002 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Probing adapter "_dev_dvb_adapter0_STV0367_DVB_C_DVB_T610000000" without stealing for service "DDbridge_01/610,000 kHz/Veronica/Disney XD"
Aug 29 18:34:32.002 cwc: DDbridge_01/610,000 kHz/Veronica/Disney XD using CWC 192.168.1.26:15050
Aug 29 18:34:32.027 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input]
Aug 29 18:34:32.027 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input] [Input on service]
Aug 29 18:34:32.054 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input] [Input on service] [Demuxed packets]
Aug 29 18:34:32.054 cwc: Insert new ECM (PID 5001) for service "Veronica/Disney XD"
Aug 29 18:34:32.054 cwc: Sending ECM (PID 5001) section=0/1, for service "Veronica/Disney XD" (seqno: 20207)
Aug 29 18:34:32.054 cwc: Sending ECM (PID 5001) section=1/1, for service "Veronica/Disney XD" (seqno: 20208)
Aug 29 18:34:32.056 cwc: Received NOK for service "Veronica/Disney XD" (PID 5001) (seqno: 20207 Req delay: 4 ms)
Aug 29 18:34:32.058 cwc: Received NOK for service "Veronica/Disney XD" (PID 5001) (seqno: 20208 Req delay: 4 ms)
Aug 29 18:34:32.058 cwc: Can not descramble service "Veronica/Disney XD", access denied (seqno: 20208 Req delay: 4 ms)
Aug 29 18:34:32.080 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input] [Input on service] [Demuxed packets] [No access]
Aug 29 18:34:34.002 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Adding adapter "_dev_dvb_adapter0_STV0367_DVB_C_DVB_T610000000" for service "DDbridge_01/610,000 kHz/Veronica/Disney XD"
Aug 29 18:34:36.002 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Adding adapter "_dev_dvb_adapter0_STV0367_DVB_C_DVB_T610000000" for service "DDbridge_01/610,000 kHz/Veronica/Disney XD"
Aug 29 18:34:36.002 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Probing adapter "_dev_dvb_adapter0_STV0367_DVB_C_DVB_T610000000" without stealing for service "DDbridge_01/610,000 kHz/Veronica/Disney XD"
Aug 29 18:34:36.002 cwc: DDbridge_01/610,000 kHz/Veronica/Disney XD using CWC 192.168.1.26:15050
Aug 29 18:34:36.016 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input]
Aug 29 18:34:36.016 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input] [Input on service]
Aug 29 18:34:36.255 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input] [Input on service] [Demuxed packets]
Aug 29 18:34:36.255 cwc: Insert new ECM (PID 5001) for service "Veronica/Disney XD"
Aug 29 18:34:36.255 cwc: Sending ECM (PID 5001) section=0/1, for service "Veronica/Disney XD" (seqno: 20209)
Aug 29 18:34:36.255 cwc: Sending ECM (PID 5001) section=1/1, for service "Veronica/Disney XD" (seqno: 20210)
Aug 29 18:34:36.257 cwc: Received NOK for service "Veronica/Disney XD" (PID 5001) (seqno: 20209 Req delay: 0 ms)
Aug 29 18:34:36.258 cwc: Received NOK for service "Veronica/Disney XD" (PID 5001) (seqno: 20210 Req delay: 0 ms)
Aug 29 18:34:36.258 cwc: Can not descramble service "Veronica/Disney XD", access denied (seqno: 20210 Req delay: 0 ms)
Aug 29 18:34:36.282 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input] [Input on service] [Demuxed packets] [No access]
Aug 29 18:34:38.002 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Adding adapter "_dev_dvb_adapter0_STV0367_DVB_C_DVB_T610000000" for service "DDbridge_01/610,000 kHz/Veronica/Disney XD"
Aug 29 18:34:40.002 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Adding adapter "_dev_dvb_adapter0_STV0367_DVB_C_DVB_T610000000" for service "DDbridge_01/610,000 kHz/Veronica/Disney XD"
Aug 29 18:34:40.002 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Probing adapter "_dev_dvb_adapter0_STV0367_DVB_C_DVB_T610000000" without stealing for service "DDbridge_01/610,000 kHz/Veronica/Disney XD"
Aug 29 18:34:40.002 cwc: DDbridge_01/610,000 kHz/Veronica/Disney XD using CWC 192.168.1.26:15050
Aug 29 18:34:40.004 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input]
Aug 29 18:34:40.004 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input] [Input on service]
Aug 29 18:34:40.137 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input] [Input on service] [Demuxed packets]
Aug 29 18:34:40.137 cwc: Insert new ECM (PID 5001) for service "Veronica/Disney XD"
Aug 29 18:34:40.137 cwc: Sending ECM (PID 5001) section=0/1, for service "Veronica/Disney XD" (seqno: 20211)
Aug 29 18:34:40.137 cwc: Sending ECM (PID 5001) section=1/1, for service "Veronica/Disney XD" (seqno: 20212)
Aug 29 18:34:40.139 cwc: Received NOK for service "Veronica/Disney XD" (PID 5001) (seqno: 20211 Req delay: 4 ms)
Aug 29 18:34:40.140 cwc: Received NOK for service "Veronica/Disney XD" (PID 5001) (seqno: 20212 Req delay: 4 ms)
Aug 29 18:34:40.140 cwc: Can not descramble service "Veronica/Disney XD", access denied (seqno: 20212 Req delay: 4 ms)
Aug 29 18:34:40.163 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input] [Input on service] [Demuxed packets] [No access]
Aug 29 18:34:42.002 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Adding adapter "_dev_dvb_adapter0_STV0367_DVB_C_DVB_T610000000" for service "DDbridge_01/610,000 kHz/Veronica/Disney XD"
Aug 29 18:34:43.002 dvb: /dev/dvb/adapter0 stopping thread
Aug 29 18:34:43.002 dvb: /dev/dvb/adapter0 stopped thread
Aug 29 18:34:43.003 eit: processing cancelled
Aug 29 18:34:43.003 dvb: "/dev/dvb/adapter0" tuning to "372,000 kHz" (Autoscan)
Aug 29 18:34:44.000 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Adding adapter "_dev_dvb_adapter0_STV0367_DVB_C_DVB_T610000000" for service "DDbridge_01/610,000 kHz/Veronica/Disney XD"
Aug 29 18:34:44.000 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Probing adapter "_dev_dvb_adapter0_STV0367_DVB_C_DVB_T610000000" without stealing for service "DDbridge_01/610,000 kHz/Veronica/Disney XD"
Aug 29 18:34:44.000 dvb: "/dev/dvb/adapter0" tuning to "610,000 kHz" (Transport start)
Aug 29 18:34:44.000 cwc: DDbridge_01/610,000 kHz/Veronica/Disney XD using CWC 192.168.1.26:15050
Aug 29 18:34:44.312 dvb: /dev/dvb/adapter0 started dvr thread
Aug 29 18:34:44.312 viasat_baltic: install table handlers
Aug 29 18:34:44.312 uk_freesat: install table handlers
Aug 29 18:34:44.312 eit: install table handlers
Aug 29 18:34:44.339 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input]
Aug 29 18:34:44.339 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input] [Input on service]
Aug 29 18:34:44.340 eit: begin processing
Aug 29 18:34:44.446 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input] [Input on service] [Demuxed packets]
Aug 29 18:34:44.446 cwc: Insert new ECM (PID 5001) for service "Veronica/Disney XD"
Aug 29 18:34:44.446 cwc: Sending ECM (PID 5001) section=0/1, for service "Veronica/Disney XD" (seqno: 20213)
Aug 29 18:34:44.446 cwc: Sending ECM (PID 5001) section=1/1, for service "Veronica/Disney XD" (seqno: 20214)
Aug 29 18:34:44.449 cwc: Received NOK for service "Veronica/Disney XD" (PID 5001) (seqno: 20213 Req delay: 4 ms)
Aug 29 18:34:44.451 cwc: Received NOK for service "Veronica/Disney XD" (PID 5001) (seqno: 20214 Req delay: 8 ms)
Aug 29 18:34:44.451 cwc: Can not descramble service "Veronica/Disney XD", access denied (seqno: 20214 Req delay: 8 ms)
Aug 29 18:34:44.473 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input] [Input on service] [Demuxed packets] [No access]
Aug 29 18:34:46.002 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Adding adapter "_dev_dvb_adapter0_STV0367_DVB_C_DVB_T610000000" for service "DDbridge_01/610,000 kHz/Veronica/Disney XD"
Aug 29 18:34:48.002 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Adding adapter "_dev_dvb_adapter0_STV0367_DVB_C_DVB_T610000000" for service "DDbridge_01/610,000 kHz/Veronica/Disney XD"
Aug 29 18:34:48.002 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Probing adapter "_dev_dvb_adapter0_STV0367_DVB_C_DVB_T610000000" without stealing for service "DDbridge_01/610,000 kHz/Veronica/Disney XD"
Aug 29 18:34:48.002 cwc: DDbridge_01/610,000 kHz/Veronica/Disney XD using CWC 192.168.1.26:15050
Aug 29 18:34:48.009 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input]
Aug 29 18:34:48.009 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input] [Input on service]
Aug 29 18:34:48.036 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input] [Input on service] [Demuxed packets]
Aug 29 18:34:48.036 cwc: Insert new ECM (PID 5001) for service "Veronica/Disney XD"
Aug 29 18:34:48.036 cwc: Sending ECM (PID 5001) section=0/1, for service "Veronica/Disney XD" (seqno: 20215)
Aug 29 18:34:48.036 cwc: Sending ECM (PID 5001) section=1/1, for service "Veronica/Disney XD" (seqno: 20216)
Aug 29 18:34:48.038 cwc: Received NOK for service "Veronica/Disney XD" (PID 5001) (seqno: 20215 Req delay: 0 ms)
Aug 29 18:34:48.040 cwc: Received NOK for service "Veronica/Disney XD" (PID 5001) (seqno: 20216 Req delay: 4 ms)
Aug 29 18:34:48.040 cwc: Can not descramble service "Veronica/Disney XD", access denied (seqno: 20216 Req delay: 4 ms)
Aug 29 18:34:48.062 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input] [Input on service] [Demuxed packets] [No access]
Aug 29 18:34:50.002 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Adding adapter "_dev_dvb_adapter0_STV0367_DVB_C_DVB_T610000000" for service "DDbridge_01/610,000 kHz/Veronica/Disney XD"
Aug 29 18:34:52.002 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Adding adapter "_dev_dvb_adapter0_STV0367_DVB_C_DVB_T610000000" for service "DDbridge_01/610,000 kHz/Veronica/Disney XD"
Aug 29 18:34:52.002 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Probing adapter "_dev_dvb_adapter0_STV0367_DVB_C_DVB_T610000000" without stealing for service "DDbridge_01/610,000 kHz/Veronica/Disney XD"
Aug 29 18:34:52.002 cwc: DDbridge_01/610,000 kHz/Veronica/Disney XD using CWC 192.168.1.26:15050
Aug 29 18:34:52.024 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input]
Aug 29 18:34:52.024 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input] [Input on service]
Aug 29 18:34:52.237 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input] [Input on service] [Demuxed packets]
Aug 29 18:34:52.237 cwc: Insert new ECM (PID 5001) for service "Veronica/Disney XD"
Aug 29 18:34:52.237 cwc: Sending ECM (PID 5001) section=0/1, for service "Veronica/Disney XD" (seqno: 20217)
Aug 29 18:34:52.237 cwc: Sending ECM (PID 5001) section=1/1, for service "Veronica/Disney XD" (seqno: 20218)
Aug 29 18:34:52.239 cwc: Received NOK for service "Veronica/Disney XD" (PID 5001) (seqno: 20217 Req delay: 4 ms)
Aug 29 18:34:52.241 cwc: Received NOK for service "Veronica/Disney XD" (PID 5001) (seqno: 20218 Req delay: 4 ms)
Aug 29 18:34:52.241 cwc: Can not descramble service "Veronica/Disney XD", access denied (seqno: 20218 Req delay: 4 ms)
Aug 29 18:34:52.263 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input] [Input on service] [Demuxed packets] [No access]
Aug 29 18:34:54.002 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Adding adapter "_dev_dvb_adapter0_STV0367_DVB_C_DVB_T610000000" for service "DDbridge_01/610,000 kHz/Veronica/Disney XD"
Aug 29 18:34:56.002 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Adding adapter "_dev_dvb_adapter0_STV0367_DVB_C_DVB_T610000000" for service "DDbridge_01/610,000 kHz/Veronica/Disney XD"
Aug 29 18:34:56.002 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Probing adapter "_dev_dvb_adapter0_STV0367_DVB_C_DVB_T610000000" without stealing for service "DDbridge_01/610,000 kHz/Veronica/Disney XD"
Aug 29 18:34:56.002 cwc: DDbridge_01/610,000 kHz/Veronica/Disney XD using CWC 192.168.1.26:15050
Aug 29 18:34:56.012 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input]
Aug 29 18:34:56.012 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input] [Input on service]
Aug 29 18:34:56.145 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input] [Input on service] [Demuxed packets]
Aug 29 18:34:56.145 cwc: Insert new ECM (PID 5001) for service "Veronica/Disney XD"
Aug 29 18:34:56.145 cwc: Sending ECM (PID 5001) section=0/1, for service "Veronica/Disney XD" (seqno: 20219)
Aug 29 18:34:56.145 cwc: Sending ECM (PID 5001) section=1/1, for service "Veronica/Disney XD" (seqno: 20220)
Aug 29 18:34:56.148 cwc: Received NOK for service "Veronica/Disney XD" (PID 5001) (seqno: 20219 Req delay: 4 ms)
Aug 29 18:34:56.149 cwc: Received NOK for service "Veronica/Disney XD" (PID 5001) (seqno: 20220 Req delay: 4 ms)
Aug 29 18:34:56.150 cwc: Can not descramble service "Veronica/Disney XD", access denied (seqno: 20220 Req delay: 4 ms)
Aug 29 18:34:56.171 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input] [Input on service] [Demuxed packets] [No access]
Aug 29 18:34:58.002 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Adding adapter "_dev_dvb_adapter0_STV0367_DVB_C_DVB_T610000000" for service "DDbridge_01/610,000 kHz/Veronica/Disney XD"
Aug 29 18:35:00.002 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Adding adapter "_dev_dvb_adapter0_STV0367_DVB_C_DVB_T610000000" for service "DDbridge_01/610,000 kHz/Veronica/Disney XD"
Aug 29 18:35:00.002 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Probing adapter "_dev_dvb_adapter0_STV0367_DVB_C_DVB_T610000000" without stealing for service "DDbridge_01/610,000 kHz/Veronica/Disney XD"
Aug 29 18:35:00.002 cwc: DDbridge_01/610,000 kHz/Veronica/Disney XD using CWC 192.168.1.26:15050
Aug 29 18:35:00.002 epg: expire event 127214 from JimJam
Aug 29 18:35:00.002 epg: now/next 127216/127218 set on JimJam
Aug 29 18:35:00.002 epg: arm channel timer

 1377794400 for JimJam
Aug 29 18:35:00.002 epg: inform HTSP of now event change on JimJam
Aug 29 18:35:00.002 epg: expire event 128406 from BBC 4 / CBeebies
Aug 29 18:35:00.002 epg: now/next 128408/128410 set on BBC 4 / CBeebies
Aug 29 18:35:00.002 epg: arm channel timer

1377794700 for BBC 4 / CBeebies
Aug 29 18:35:00.002 epg: inform HTSP of now event change on BBC 4 / CBeebies
Aug 29 18:35:00.002 epg: expire event 127722 from Disney Junior
Aug 29 18:35:00.002 epg: now/next 127724/127726 set on Disney Junior
Aug 29 18:35:00.002 epg: arm channel timer

 1377795000 for Disney Junior
Aug 29 18:35:00.002 epg: inform HTSP of now event change on Disney Junior
Aug 29 18:35:00.002 epg: expire event 128488 from Comedy Central Family
Aug 29 18:35:00.002 epg: now/next 128490/128492 set on Comedy Central Family
Aug 29 18:35:00.002 epg: arm channel timer

1377795600 for Comedy Central Family
Aug 29 18:35:00.002 epg: inform HTSP of now event change on Comedy Central Family
Aug 29 18:35:00.002 epg: expire event 128342 from Ketnet/OP12
Aug 29 18:35:00.002 epg: now/next 128344/128346 set on Ketnet/OP12
Aug 29 18:35:00.002 epg: arm channel timer

 1377794700 for Ketnet/OP12
Aug 29 18:35:00.002 epg: inform HTSP of now event change on Ketnet/OP12
Aug 29 18:35:00.002 epg: expire event 127326 from RTL 4
Aug 29 18:35:00.002 epg: now/next 127328/127330 set on RTL 4
Aug 29 18:35:00.002 epg: arm channel timer

1377797400 for RTL 4
Aug 29 18:35:00.002 epg: inform HTSP of now event change on RTL 4
Aug 29 18:35:00.002 epg: expire event 128016 from RTL 4 HD
Aug 29 18:35:00.002 epg: now/next 128018/128020 set on RTL 4 HD
Aug 29 18:35:00.002 epg: arm channel timer

 1377797400 for RTL 4 HD
Aug 29 18:35:00.002 epg: inform HTSP of now event change on RTL 4 HD
Aug 29 18:35:00.002 epg: expire event 127754 from Discovery Channel HD
Aug 29 18:35:00.002 epg: now/next 127756/127758 set on Discovery Channel HD
Aug 29 18:35:00.002 epg: arm channel timer

1377795900 for Discovery Channel HD
Aug 29 18:35:00.002 epg: inform HTSP of now event change on Discovery Channel HD
Aug 29 18:35:00.002 epg: expire event 128426 from Discovery Channel
Aug 29 18:35:00.002 epg: now/next 128428/128430 set on Discovery Channel
Aug 29 18:35:00.002 epg: arm channel timer

 1377795900 for Discovery Channel
Aug 29 18:35:00.002 epg: inform HTSP of now event change on Discovery Channel
Aug 29 18:35:00.002 epg: expire event 127992 from Nick Jr.
Aug 29 18:35:00.002 epg: now/next 127994/127996 set on Nick Jr.
Aug 29 18:35:00.002 epg: arm channel timer

1377795600 for Nick Jr.
Aug 29 18:35:00.002 epg: inform HTSP of now event change on Nick Jr.
Aug 29 18:35:00.027 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input]
Aug 29 18:35:00.027 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input] [Input on service]
Aug 29 18:35:00.053 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input] [Input on service] [Demuxed packets]
Aug 29 18:35:00.053 cwc: Insert new ECM (PID 5001) for service "Veronica/Disney XD"
Aug 29 18:35:00.053 cwc: Sending ECM (PID 5001) section=0/1, for service "Veronica/Disney XD" (seqno: 20221)
Aug 29 18:35:00.053 cwc: Sending ECM (PID 5001) section=1/1, for service "Veronica/Disney XD" (seqno: 20222)
Aug 29 18:35:00.055 cwc: Received NOK for service "Veronica/Disney XD" (PID 5001) (seqno: 20221 Req delay: 4 ms)
Aug 29 18:35:00.057 cwc: Received NOK for service "Veronica/Disney XD" (PID 5001) (seqno: 20222 Req delay: 4 ms)
Aug 29 18:35:00.057 cwc: Can not descramble service "Veronica/Disney XD", access denied (seqno: 20222 Req delay: 4 ms)
Aug 29 18:35:00.080 Service: DDbridge_01/610,000 kHz/Veronica/Disney XD: Status changed to [Hardware input] [Input on service] [Demuxed packets] [No access]
Aug 29 18:35:02.002 Service: Subscription "192.168.1.26 [ xbmc | XBMC Media Center ]": Adding adapter "_dev_dvb_adapter0_STV0367_DVB_C_DVB_T610000000" for service "DDbridge_01/610,000 kHz/Veronica/Disney XD"
Aug 29 18:35:03.002 dvb: /dev/dvb/adapter0 stopping thread
Aug 29 18:35:03.002 dvb: /dev/dvb/adapter0 stopped thread
Aug 29 18:35:03.003 eit: processing cancelled
Aug 29 18:35:03.003 dvb: "/dev/dvb/adapter0" tuning to "514,000 kHz" (Autoscan)

Alex .

Hi,

One other thing to check: Does this happen only when watching via the xbmc-plugin, or also via the webinterface?

( so , basically, can you watch both unencrypted and encrypted channels using the webinterface?)

Alex.

( ps: on a side note: you probably don't need ukfreesat ota-grabber, so you can disable that one at least)

Süheyl Karakas

Hi Alex,

I haven't tried the webinterface... I'm running XBMCbuntu so I have no webinterface

Alex .

Süheyl Karakas wrote:
> Hi Alex,
>

> I haven't tried the webinterface... I'm running XBMCbuntu so I have no webinterface

Mmm, i do not know what xbmcubuntu is, but you use tvheadend and tvheadend has a webinterface.

Go to <ip of your tvheadendmachine> :9981/extjs.html

Does this show anything?
<<

Süheyl Karakas

I'm sorry, I misunderstood. The logging is from the webinterface of tvheadend. I'll have to install VLC-player first. One moment

Süheyl Karakas

I had to install Mozilla first, but there I don´t see anything at all...

Loglevel debug: enabled

Aug 29 19:01:54.047 HTTP: 192.168.1.28: /stream/channelid/253 -- 401

Aug 29 19:01:54.065 HTTP: 192.168.1.28: /stream/channelid/253 -- 401

Aug 29 19:02:00.002 epg: expire event 128330 from Canvas

Aug 29 19:02:00.002 epg: now/next 128332/129534 set on Canvas

Aug 29 19:02:00.002 epg: arm channel timer

1377799200 for Canvas Aug 29 19:02:00.002 epg: inform HTSP of now event change on Canvas Aug 29 19:02:00.002 epg: expire event 127618 from Canvas HD Aug 29 19:02:00.002 epg: now/next 127620/128962 set on Canvas HD Aug 29 19:02:00.002 epg: arm channel timer

1377799200 for Canvas HD

Aug 29 19:02:00.002 epg: inform HTSP of now event change on Canvas HD

Aug 29 19:02:13.880 HTTP: 192.168.1.28: /stream/channelid/1 -- 401

Aug 29 19:02:13.897 HTTP: 192.168.1.28: /stream/channelid/1 -- 401
<<

Alex .

Mmm, strange, so using the webinterface you cant see anything ?(even not the unencrypted channels?).

Also , you can go to that IP address from any other computer on your local lan, so you can try to watch video from some other machine.

I would say that should work anyhow, but can it be that somehow on XBMCbuntu the xbmc-client is first?

Süheyl Karakas

I've did that from another client. I have no browser installed on the XBMC machine. I'm not sure if the XBMC client is indeed priority 1. I'm new into Linux, so I don't know if and how to install a browser there.

Alex .

Ow, I just looked at you logfile. It is full with lines like:

Aug 29 18:27:21.023 cwc: Can not descramble service "13TH STREET", access denied (seqno: 20185 Req delay: 4 ms

And

Aug 29 18:34:20.647 cwc: Sending ECM (PID 5001) section=0/1, for service "Veronica/Disney XD" (seqno: 20201)
Aug 29 18:34:20.647 cwc: Sending ECM (PID 5001) section=1/1, for service "Veronica/Disney XD" (seqno: 20202)
Aug 29 18:34:20.648 cwc: Received NOK for service "Veronica/Disney XD" (PID 5001) (seqno: 20201 Req delay: 4 ms)

( NOK =, i guess, ' Not OK ')

So probably somehow Oscam does not work, or your card is not valid/updated/activated.

- In your webinterface, under CSA, codeword client, is the info needed to connect to oscam there? And is the line 'green'?
- Maybe best would be to also look at the oscam logfile.

- Is your code-card updated ? If not, maybe change cards with the one in your 'provider-decoder' to check.

Alex.

Ps what provider do you have?

Süheyl Karakas

Sorry, I had to do some shopping, but yes the line is green. The card is active.

Süheyl Karakas

Is it possible that it doesn't descramble because the server is a CCcam server and I'm using Oscam? I tried to use CCcam but then I couldn't get the line green. That's why I reverted to Oscam.
My brother is connecting to another server and I use the same configuration but connect to a different server.

Alex .

The fact that the line is green is a sign that at least tvheadend van connect to the oscam (or whatever cam) server. ( not necessarily that valid codes are generated for a certain request)

So, best is now to check the actual log of the cam-server (cccam in your case), since apparently no valid decryption key is obtained from that server.

This can have to do with all kinds of things in the cam-server, f.e.:
- wrong settings ( they vary from provider to provider)

- invalid card

So some questions might be:
- what provider do you have ?
- Did you use the cccam settings specific to that card?
- Is the card read at all ( what reader do you use?)

- Are you sure the card is valid and activated?( check using a regular decoder).

I am no cam-expert , so if oscam and cccam work i dont know. I just use OSCAM-server and it works fine.

PS
Süheyl Karakas wrote:

> Sorry, I had to do some shopping, but yes the line is green. The card is active.

We all have to eat ;-)
<<

Alex .

Süheyl Karakas wrote:
> Is it possible that it doesn't descramble because the server is a CCcam server and I'm using Oscam?

> I tried to use CCcam but then I couldn't get the line green. That's why I reverted to Oscam.

One more question:

This is very confusing: What do you mean, 'the server is cccam', ' i am using oscam', and 'that's why i reverted to oscam' .

Is the server cccam or oscam ?

Whatever it is, it sounds pretty likely the problem is over there somewhere.....
<<

Süheyl Karakas

Hi,

I'm connecting with my Oscam client to a CCcam server. I tried to connect with CCcam client to CCcam server. That was succesfull. I was able to see in the webinterface of CCcam that I was connected to the server. But in Tvheadend I was not able to get the card active (green).

That's why I changed it to Oscam. I'm connected to the server. The server delivers ECM's but somehow Oscam does not use them to descramble.

I've added the oscam log file

Alex .

Your problem really seems to come from your specific oscam-setup, so maybe better try ask at the oscam forum I guess.

Only thing I know is that OSCAM with a Ziggosmartcard and smartcardreader seems to work pretty well in general.

https://tvheadend.org/projects/tvheadend/wiki/Tvheadend_oscam_ziggo

Süheyl Karakas

I didn't had the "Update Card" checked. I'll try it again when I'm at home. Thank you for your efforts :-)

Süheyl Karakas

sadly that didn't work... Getting desperate now... :(

Alex .

Süheyl Karakas wrote:

> sadly that didn't work... Getting desperate now... :(

Hi,

Well, best would be that you give some more information and that you ask at the oscam-forum since it seems to be an oscam problem.

Also (most of it allready stated earlier):
- look at the camserverlogs ( not client).
- post some information about how your smartcard reader with smartcard is connected to the server.
( next to that, apparently you now checked 'update card', but did you perform the check on the card by using it in a regular ziggo tv tuner? The update card will only work ( i think) on an already activated card).

- Check all parameters as given in the link to the oscam/ziggo howto above ( also , using oscam server seems to work, so maybe try that?).

Hope this helps,

Alex.