Dreambox owners: Who wants to test DVB-CISSA descrambling?

nautilus7 · Mar 23, 2019

Is there a oscam.log-prev file there as well? I nee that also, because again the log is not complete.

harshy · Mar 23, 2019

There is yes but its too long to post here so it wont let me, let me upload it.

harshy · Mar 23, 2019

nautilus7 said:
Is there a oscam.log-prev file there as well? I nee that also, because again the log is not complete.

Code:

https://drive.google.com/open?id=1QSffZX0WfivWZ6RdqpuapU6zrqo40wRa

nautilus7 · Mar 23, 2019

Something is not right again... Make sure that your log size is 1000KB and not 100KB, as in the picture I posted previously, and try again please.

The log must include something like this:

Code:

2019/03/24 01:33:27 525B8586 r      (emu) Key found: F 00010020 00000000
2019/03/24 01:33:27 68249017 c   (dvbapi) Demuxer 0 controlword received for PID 0 CAID 2602 PROVID 000000 ECMPID 1FFF CHID 0000 VPID 0200
2019/03/24 01:33:27 68249017 c   (dvbapi) Demuxer 0 luckyshot new controlword ecm response hash 5830FC5CAF09E084015C5A6FCFC19DC0 (ecm table reset)
2019/03/24 01:33:27 68249017 c   (dvbapi) Demuxer 0 descrambling PID 0 CAID 2602 PROVID 000000 ECMPID 1FFF CHID 00 VPID 0200
2019/03/24 01:33:27 68249017 c   (dvbapi) generic delay: write cw 60 ms after ecmrequest
2019/03/24 01:33:27 68249017 c   (dvbapi) delayer: gone=30 ms, cfg=60 ms -> delay=30 ms
2019/03/24 01:33:27 68249017 c   (dvbapi) Demuxer 0 PID: 0 CAID: 2602 ECMPID: 1FFF is using index 0
2019/03/24 01:33:27 68249017 c   (dvbapi) Added new streampid 0200 with index 0 to ca0
2019/03/24 01:33:27 68249017 c   (dvbapi) Demuxer 0 disable stream 1 pid=0x0200 index=-1 on ca0
2019/03/24 01:33:27 68249017 c   (dvbapi) Open device /dev/dvb/adapter0/ca0 (fd 17)
2019/03/24 01:33:27 68249017 c   (dvbapi) Demuxer 0 enable stream 1 pid=0x0200 by index=0 on ca0
2019/03/24 01:33:27 68249017 c   (dvbapi) Added new streampid 1020 with index 0 to ca0
2019/03/24 01:33:27 68249017 c   (dvbapi) Demuxer 0 disable stream 2 pid=0x1020 index=-1 on ca0
2019/03/24 01:33:27 68249017 c   (dvbapi) Demuxer 0 enable stream 2 pid=0x1020 by index=0 on ca0
2019/03/24 01:33:27 68249017 c   (dvbapi) Added new streampid 1021 with index 0 to ca0
2019/03/24 01:33:27 68249017 c   (dvbapi) Demuxer 0 disable stream 3 pid=0x1021 index=-1 on ca0
2019/03/24 01:33:27 68249017 c   (dvbapi) Demuxer 0 enable stream 3 pid=0x1021 by index=0 on ca0
2019/03/24 01:33:27 68249017 c   (dvbapi) Demuxer 0 ca0 is using index 0 for streampid 0200 -> write odd part of cw!
[COLOR="seagreen"]2019/03/24 01:33:27 68249017 c   (dvbapi) Demuxer 0 writing odd part (00112233445566778899AABBCCDDEEFF) of controlword, replacing expired (00000000000000000000000000000000)[/COLOR]
[COLOR="seagreen"]2019/03/24 01:33:27 68249017 c   (dvbapi) Demuxer 0 write cw0 index: 0 (ca0)[/COLOR]
[COLOR="seagreen"]2019/03/24 01:33:27 68249017 c   (dvbapi) ERROR: ioctl(CA_SET_DESCR_MODE): Invalid argument[/COLOR]
[COLOR="seagreen"]2019/03/24 01:33:27 68249017 c   (dvbapi) ERROR: ioctl(CA_SET_DESCR_DATA): Inappropriate ioctl for device[/COLOR]
2019/03/24 01:33:27 68249017 c        (-) -- Skipped 1 duplicated log lines --
2019/03/24 01:33:27 68249017 c   (dvbapi) Demuxer 0 ca0 is using index 0 for streampid 1020 -> skip, odd part of cw already written!
2019/03/24 01:33:27 68249017 c   (dvbapi) Demuxer 0 ca0 is using index 0 for streampid 1021 -> skip, odd part of cw already written!
2019/03/24 01:33:27 68249017 c   (dvbapi) Demuxer 0 ca0 is using index 0 for streampid 0200 -> write even part of cw!
2019/03/24 01:33:27 68249017 c   (dvbapi) Demuxer 0 writing even part (00112233445566778899AABBCCDDEEFF) of controlword, replacing expired (00000000000000000000000000000000)
2019/03/24 01:33:27 68249017 c   (dvbapi) Demuxer 0 write cw1 index: 0 (ca0)
2019/03/24 01:33:27 68249017 c   (dvbapi) ERROR: ioctl(CA_SET_DESCR_MODE): Invalid argument
2019/03/24 01:33:27 68249017 c   (dvbapi) ERROR: ioctl(CA_SET_DESCR_DATA): Inappropriate ioctl for device
2019/03/24 01:33:27 68249017 c        (-) -- Skipped 1 duplicated log lines --
2019/03/24 01:33:27 68249017 c   (dvbapi) Demuxer 0 ca0 is using index 0 for streampid 1020 -> skip, even part of cw already written!
2019/03/24 01:33:27 68249017 c   (dvbapi) Demuxer 0 ca0 is using index 0 for streampid 1021 -> skip, even part of cw already written!
2019/03/24 01:33:27 68249017 c      (ecm) osnino (2602@000000/0000/0001/15:5830FC5CAF09E084015C5A6FCFC19DC0): found (25 ms) by emulator - Service-1

harshy · Mar 23, 2019

oh i done it wrong i set it to 100kb sorry let me try again.

harshy · Mar 23, 2019

Code:

https://drive.google.com/open?id=1VjYSs7jR5x0T98cGjarGEQx3-vbQiOHK

nautilus7 · Mar 24, 2019

It's not our lucky day... I give up.

harshy · Mar 24, 2019

Sorry i couldnt help

harshy · Mar 24, 2019

Can anyone else help the gentleman here, I imagine i done something wrong here.

marrakr · Mar 24, 2019

I'm using original image and can't find out any solution to decrypt recordings with oscam

grottiwe22 · Mar 24, 2019

receiver: Vu+ Ultimo 4K
working: no, black picture
log (with debug level 128):

Code:

<14>Mar 24 11:43:41 oscam: 6F165759 h    (webif) all debug_level=128
 in 24-Mar 11:45:34.30 from 192.168.0.9
<12>Mar 24 11:43:55 kernel: [11085.054254] [VID]: VIDEO_STOP 1  1
 in 24-Mar 11:45:48.48 from 192.168.0.9
<12>Mar 24 11:43:55 kernel: [11085.057805] [AUD]: AUDIO_STOP 0 
 in 24-Mar 11:45:48.49 from 192.168.0.9
<12>Mar 24 11:43:55 kernel: [11085.085595] [AUD]: AUDIO_CONTINUE 0 0 aph=0x0
 in 24-Mar 11:45:48.52 from 192.168.0.9
<12>Mar 24 11:43:55 kernel: [11085.089979] [AUD]: AUDIO_CONTINUE aph=0 0 0
 in 24-Mar 11:45:48.52 from 192.168.0.9
<12>Mar 24 11:43:55 kernel: [11085.156955] [AUD]: AUDIO_SELECT_SOURCE 0 
 in 24-Mar 11:45:48.59 from 192.168.0.9
<12>Mar 24 11:43:55 kernel: [11085.162038] [AUD]: AUDIO_SET_BYPASS_MODE 1 
 in 24-Mar 11:45:48.59 from 192.168.0.9
<12>Mar 24 11:43:55 kernel: [11085.166457] [AUD]: downmix 1 state : 1
 in 24-Mar 11:45:48.59 from 192.168.0.9
<12>Mar 24 11:43:55 kernel: [11085.170371] [AUD]: AUDIO_PAUSE 0 
 in 24-Mar 11:45:48.60 from 192.168.0.9
<12>Mar 24 11:43:55 kernel: [11085.173760] [AUD]: AUDIO_PLAY 0 decoder start : 0
 in 24-Mar 11:45:48.60 from 192.168.0.9
<12>Mar 24 11:43:55 kernel: [11085.179700] [VID]: VIDEO_SELECT_SOURCE 0  0
 in 24-Mar 11:45:48.61 from 192.168.0.9
<12>Mar 24 11:43:55 kernel: [11085.184001] [VID]: VIDEO_SET_STREAMTYPE 1 
 in 24-Mar 11:45:48.62 from 192.168.0.9
<12>Mar 24 11:43:55 kernel: [11085.188272] [VID]: VIDEO_FREEZE 0  0
 in 24-Mar 11:45:48.62 from 192.168.0.9
<12>Mar 24 11:43:55 kernel: [11085.191935] [VID]: VIDEO_PLAY 0  5 2
 in 24-Mar 11:45:48.62 from 192.168.0.9
<12>Mar 24 11:43:55 kernel: [11085.200834] [VID]: VIDEO_SLOWMOTION 0    1
 in 24-Mar 11:45:48.63 from 192.168.0.9
<12>Mar 24 11:43:56 kernel: [11085.205068] [VID]: VIDEO_FAST_FORWARD 0    1 0
 in 24-Mar 11:45:48.64 from 192.168.0.9
<12>Mar 24 11:43:56 kernel: [11085.209646] [VID]: VIDEO_CONTINUE 0  1 
 in 24-Mar 11:45:48.64 from 192.168.0.9
<12>Mar 24 11:43:56 kernel: [11085.213550] [AUD]: AUDIO_CONTINUE 0 1 aph=0xd00c4800
 in 24-Mar 11:45:48.65 from 192.168.0.9
<12>Mar 24 11:43:56 kernel: [11085.218534] [AUD]: Mute : 0
 in 24-Mar 11:45:48.65 from 192.168.0.9
<12>Mar 24 11:43:56 kernel: [11085.260002] [AUD]: AUDIO_CLEAR_BUFFER 1 0
 in 24-Mar 11:45:48.69 from 192.168.0.9
<12>Mar 24 11:43:56 kernel: [11085.278684] [VID]: VIDEO_CLEAR_BUFFER 0  1 1
 in 24-Mar 11:45:48.71 from 192.168.0.9
<12>Mar 24 11:43:56 kernel: [11085.291438] [VID]: VIDEO_GET_SIZE src w: 0 h:0 display w:0 h:0
 in 24-Mar 11:45:48.72 from 192.168.0.9
<12>Mar 24 11:43:56 kernel: [11085.297296] [VID]: VIDEO_GET_SIZE aspect: 1 0
 in 24-Mar 11:45:48.73 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) new socket connection fd: 14
 in 24-Mar 11:45:48.74 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) Got packet with opcode 9F803234 and size 56
 in 24-Mar 11:45:48.74 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) PMT Update on socket 14.
 in 24-Mar 11:45:48.74 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) Parsing PMT object:
 in 24-Mar 11:45:48.75 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi)   9F 80 32 34 03 00 01 01 00 1F 01 81 08 00 00 00 
 in 24-Mar 11:45:48.75 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi)   00 00 00 00 00 82 02 00 16 84 02 00 20 09 04 26 
 in 24-Mar 11:45:48.75 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi)   02 FF FF 85 04 00 00 00 08 1B 02 00 00 00 03 10 
 in 24-Mar 11:45:48.75 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi)   20 00 00 03 10 21 00 00 
 in 24-Mar 11:45:48.75 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) capmt:
 in 24-Mar 11:45:48.75 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi)   03 00 01 01 00 1F 01 81 08 00 00 00 00 00 00 00 
 in 24-Mar 11:45:48.75 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi)   00 82 02 00 16 84 02 00 20 09 04 26 02 FF FF 85 
 in 24-Mar 11:45:48.76 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi)   04 00 00 00 08 1B 02 00 00 00 03 10 20 00 00 03 
 in 24-Mar 11:45:48.76 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi)   10 21 00 00 
 in 24-Mar 11:45:48.76 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) Receiver sends PMT command 3 for channel 0001
 in 24-Mar 11:45:48.76 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) Receiver wants to demux srvid 0001 on adapter 0000 camask 0000 index 0016 pmtpid 0020
 in 24-Mar 11:45:48.76 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) Open device /dev/dvb/adapter0/demux0 (fd 15)
 in 24-Mar 11:45:48.76 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) Demuxer 0 Filter 1 started successfully (caid 0001 provid 000001 pid 0020)
 in 24-Mar 11:45:48.76 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) Demuxer 0 found user private descriptor (tag: 81 length: 08)
 in 24-Mar 11:45:48.76 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) Demuxer 0 assuming enigma private descriptor (namespace: 00000000 tsid: 0000 onid: 0000)
 in 24-Mar 11:45:48.77 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) Demuxer 0 found user private descriptor (tag: 82 length: 02)
 in 24-Mar 11:45:48.77 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) Demuxer 0 assuming enigma private descriptor
 in 24-Mar 11:45:48.77 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) Demuxer 0 found user private descriptor (tag: 84 length: 02)
 in 24-Mar 11:45:48.77 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) Demuxer 0 assuming enigma private descriptor
 in 24-Mar 11:45:48.77 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) Demuxer 0 found CA descriptor (tag: 09 length: 04)
 in 24-Mar 11:45:48.77 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) Demuxer 0 ecmpid 0 CAID: 2602 ECM_PID: 1FFF PROVID: 000000 
 in 24-Mar 11:45:48.77 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) Demuxer 0 found user private descriptor (tag: 85 length: 04)
 in 24-Mar 11:45:48.78 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) Demuxer 0 assuming enigma private descriptor
 in 24-Mar 11:45:48.78 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) Demuxer 0 found AVC video stream (type: 1B pid: 0200)
 in 24-Mar 11:45:48.78 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) Demuxer 0 found MPEG-1 audio stream (type: 03 pid: 1020)
 in 24-Mar 11:45:48.78 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) Demuxer 0 found MPEG-1 audio stream (type: 03 pid: 1021)
 in 24-Mar 11:45:48.79 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) Demuxer 0 found 1 ECMpids and 3 STREAMpids in caPMT
 in 24-Mar 11:45:48.79 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) Demuxer 0 serving srvid 0001 (DSI) on adapter 0000 camask 0000 index 0016 pmtpid 0020
 in 24-Mar 11:45:48.79 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) Demuxer 0/16 lets start descrambling (srvid = 0001 fd = 14 ecmpids = 1)
 in 24-Mar 11:45:48.79 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) Demuxer 0 prio ecmpid 0 2602@000000:1FFF:10000 weight: 1 (1 readers)
 in 24-Mar 11:45:48.79 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) Demuxer 0 found in channel cache: 2602@000000/0000/0001/00:(null)
 in 24-Mar 11:45:48.80 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) Demuxer 0 prio ecmpid 0 2602@000000:1FFF weight: 2 (found caid/provid/srvid in cache)
 in 24-Mar 11:45:48.80 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) Demuxer 0 found channel in cache and matching prio -> start descrambling ecmpid 0 
 in 24-Mar 11:45:48.80 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) Demuxer 0 sorting the ecmpids took 0 ms
 in 24-Mar 11:45:48.80 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) Demuxer 0 trying to descramble PID 0 CAID 2602 PROVID 000000 ECMPID 1FFF ANY CHID PMTPID 0020 VPID 0200
 in 24-Mar 11:45:48.81 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) Demuxer 0 try to start new filter for caid: 2602, provid: 000000, pid: 1FFF
 in 24-Mar 11:45:48.81 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) Open device /dev/dvb/adapter0/demux22 (fd 16)
 in 24-Mar 11:45:48.81 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) Demuxer 0 Filter 2 started successfully (caid 2602 provid 000000 pid 1FFF)
 in 24-Mar 11:45:48.81 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) Demuxer 0 Filter 2 set ecmtable to ODD+EVEN (CAID 2602 PROVID 000000 FD 16)
 in 24-Mar 11:45:48.81 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) Demuxer 0 Filter 2 set chid to ANY CHID on fd 16
 in 24-Mar 11:45:48.81 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) Demuxer 0 get controlword!
 in 24-Mar 11:45:48.81 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) Demuxer 0 request controlword for ecm 2602@000000/0000/0001/15:5830FC5CAF09E084015C5A6FCFC19DC0
 in 24-Mar 11:45:48.81 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 1BC3D812 r      (emu) Key found: F ED65DCC6 00000000
 in 24-Mar 11:45:48.81 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) Demuxer 0 controlword received for PID 0 CAID 2602 PROVID 000000 ECMPID 1FFF CHID 0000 VPID 0200
 in 24-Mar 11:45:48.81 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) Demuxer 0 luckyshot new controlword ecm response hash 5830FC5CAF09E084015C5A6FCFC19DC0 (ecm table reset)
 in 24-Mar 11:45:48.82 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) Demuxer 0 descrambling PID 0 CAID 2602 PROVID 000000 ECMPID 1FFF CHID 00 VPID 0200
 in 24-Mar 11:45:48.82 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) Demuxer 0 has 1 ecmpids, 3 streampids, 1 ecmfilters and 0 of max 31 emmfilters
 in 24-Mar 11:45:48.82 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) generic delay: write cw 60 ms after ecmrequest
 in 24-Mar 11:45:48.82 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) delayer: gone=3 ms, cfg=60 ms -> delay=57 ms
 in 24-Mar 11:45:48.82 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c   (dvbapi) Demuxer 0 PID: 0 CAID: 2602 ECMPID: 1FFF is using index 0
 in 24-Mar 11:45:48.82 from 192.168.0.9
<14>Mar 24 11:43:56 oscam: 3818CC6C c      (ecm) DVBApi (2602@000000/0000/0001/15:5830FC5CAF09E084015C5A6FCFC19DC0): found (2 ms) by emulator - DSI
 in 24-Mar 11:45:48.82 from 192.168.0.9
<12>Mar 24 11:43:56 kernel: [11085.419579] [VID]: VIDEO_SLOWMOTION 0    1
 in 24-Mar 11:45:48.85 from 192.168.0.9
<12>Mar 24 11:43:56 kernel: [11085.423826] [VID]: VIDEO_FAST_FORWARD 0    1 0
 in 24-Mar 11:45:48.86 from 192.168.0.9
<12>Mar 24 11:43:56 kernel: [11085.428348] [VID]: VIDEO_CONTINUE 0  1 
 in 24-Mar 11:45:48.86 from 192.168.0.9
<12>Mar 24 11:43:56 kernel: [11085.432238] [AUD]: AUDIO_CONTINUE 0 1 aph=0xd00c4800
 in 24-Mar 11:45:48.86 from 192.168.0.9
<12>Mar 24 11:43:56 kernel: [11085.437229] [AUD]: Mute : 0
 in 24-Mar 11:45:48.87 from 192.168.0.9
<14>Mar 24 11:44:01 oscam: 3818CC6C c   (dvbapi) Demuxer 0 try to start new filter for caid: 0001, provid: 000001, pid: 0011
 in 24-Mar 11:45:53.81 from 192.168.0.9
<14>Mar 24 11:44:01 oscam: 3818CC6C c   (dvbapi) Open device /dev/dvb/adapter0/demux22 (fd 17)
 in 24-Mar 11:45:53.81 from 192.168.0.9
<14>Mar 24 11:44:01 oscam: 3818CC6C c   (dvbapi) Demuxer 0 Filter 3 started successfully (caid 0001 provid 000001 pid 0011)
 in 24-Mar 11:45:53.82 from 192.168.0.9
<14>Mar 24 11:44:01 oscam: 3818CC6C c   (dvbapi) Demuxer 0 filter3[0] = 42, filter mask[0] = FF, flt&mask = 42 , buffer[0] = 42, buffer[0] & mask = 42
 in 24-Mar 11:45:54.31 from 192.168.0.9
<14>Mar 24 11:44:01 oscam: 3818CC6C c   (dvbapi) Demuxer 0 Filter 3 fetched SDT data (length = 0x01F):
 in 24-Mar 11:45:54.31 from 192.168.0.9
<14>Mar 24 11:44:01 oscam: 3818CC6C c   (dvbapi)   42 F0 1C 00 01 C1 00 00 FF FF FF 00 01 FC 80 0B 
 in 24-Mar 11:45:54.32 from 192.168.0.9
<14>Mar 24 11:44:01 oscam: 3818CC6C c   (dvbapi)   48 09 01 03 53 54 53 03 44 53 49 34 2D C4 09 
 in 24-Mar 11:45:54.32 from 192.168.0.9
<14>Mar 24 11:44:01 oscam: 3818CC6C c   (dvbapi) sdt-info dbg: sdt data: 
 in 24-Mar 11:45:54.32 from 192.168.0.9
<14>Mar 24 11:44:01 oscam: 3818CC6C c   (dvbapi)   42 F0 1C 00 01 C1 00 00 FF FF FF 00 01 FC 80 0B 
 in 24-Mar 11:45:54.32 from 192.168.0.9
<14>Mar 24 11:44:01 oscam: 3818CC6C c   (dvbapi)   48 09 01 03 53 54 53 03 44 53 49 34 2D C4 09 
 in 24-Mar 11:45:54.32 from 192.168.0.9
<14>Mar 24 11:44:01 oscam: 3818CC6C c   (dvbapi) sdt-info dbg: iso_mode: -1 offset: 0
 in 24-Mar 11:45:54.33 from 192.168.0.9
<14>Mar 24 11:44:01 oscam: 3818CC6C c   (dvbapi) sdt-info dbg: raw string: 
 in 24-Mar 11:45:54.33 from 192.168.0.9
<14>Mar 24 11:44:01 oscam: 3818CC6C c   (dvbapi)   53 54 53 
 in 24-Mar 11:45:54.33 from 192.168.0.9
<14>Mar 24 11:44:01 oscam: 3818CC6C c   (dvbapi) sdt-info dbg: encoded string: 
 in 24-Mar 11:45:54.33 from 192.168.0.9
<14>Mar 24 11:44:01 oscam: 3818CC6C c   (dvbapi)   53 54 53 
 in 24-Mar 11:45:54.33 from 192.168.0.9
<14>Mar 24 11:44:01 oscam: 3818CC6C c   (dvbapi) sdt-info dbg: iso_mode: -1 offset: 0
 in 24-Mar 11:45:54.34 from 192.168.0.9
<14>Mar 24 11:44:01 oscam: 3818CC6C c   (dvbapi) sdt-info dbg: raw string: 
 in 24-Mar 11:45:54.34 from 192.168.0.9
<14>Mar 24 11:44:01 oscam: 3818CC6C c   (dvbapi)   44 53 49 
 in 24-Mar 11:45:54.34 from 192.168.0.9
<14>Mar 24 11:44:01 oscam: 3818CC6C c   (dvbapi) sdt-info dbg: encoded string: 
 in 24-Mar 11:45:54.34 from 192.168.0.9
<14>Mar 24 11:44:01 oscam: 3818CC6C c   (dvbapi)   44 53 49 
 in 24-Mar 11:45:54.35 from 192.168.0.9
<14>Mar 24 11:44:01 oscam: 3818CC6C c   (dvbapi) sdt-info (provider: STS - channel: DSI)
 in 24-Mar 11:45:54.35 from 192.168.0.9
<14>Mar 24 11:44:01 oscam: 3818CC6C c   (dvbapi) Demuxer 0 stop filter 3 try 1 (fd: 17 api: 0, caid: 0001, provid: 000001, emmpid: 0011)
 in 24-Mar 11:45:54.35 from 192.168.0.9
<14>Mar 24 11:44:01 oscam: 3818CC6C c   (dvbapi) Demuxer 0 flushing stale input data of filter 3 (fd:17)
 in 24-Mar 11:45:54.35 from 192.168.0.9
<14>Mar 24 11:44:12 oscam: 3818CC6C c   (dvbapi) Demuxer 0 stop descrambling program number 0001 (DSI)
 in 24-Mar 11:46:4.76 from 192.168.0.9
<14>Mar 24 11:44:12 oscam: 3818CC6C c   (dvbapi) Demuxer 0 stop filter 1 try 1 (fd: 15 api: 0, caid: 0001, provid: 000001, emmpid: 0020)
 in 24-Mar 11:46:4.76 from 192.168.0.9
<14>Mar 24 11:44:12 oscam: 3818CC6C c   (dvbapi) Demuxer 0 flushing stale input data of filter 1 (fd:15)
 in 24-Mar 11:46:4.77 from 192.168.0.9
<14>Mar 24 11:44:12 oscam: 3818CC6C c   (dvbapi) Demuxer 0 stop filter 2 try 1 (fd: 16 api: 0, caid: 2602, provid: 000000, ecmpid: 1FFF)
 in 24-Mar 11:46:4.77 from 192.168.0.9
<14>Mar 24 11:44:12 oscam: 3818CC6C c   (dvbapi) Demuxer 0 flushing stale input data of filter 2 (fd:16)
 in 24-Mar 11:46:4.77 from 192.168.0.9
<14>Mar 24 11:44:12 oscam: 3818CC6C c   (dvbapi) Socket 14 reported hard connection close
 in 24-Mar 11:46:4.77 from 192.168.0.9

nautilus7 · Mar 24, 2019

Your log is no good. It's like harshy's log. See in my log how much additional info is shown between the "key found" message and the "found my emulator" message:

Code:

[COLOR="DarkGreen"]2019/03/24 01:33:27 525B8586 r      (emu) Key found: F 00010020 00000000
[/COLOR]2019/03/24 01:33:27 68249017 c   (dvbapi) Demuxer 0 controlword received for PID 0 CAID 2602 PROVID 000000 ECMPID 1FFF CHID 0000 VPID 0200
2019/03/24 01:33:27 68249017 c   (dvbapi) Demuxer 0 luckyshot new controlword ecm response hash 5830FC5CAF09E084015C5A6FCFC19DC0 (ecm table reset)
2019/03/24 01:33:27 68249017 c   (dvbapi) Demuxer 0 descrambling PID 0 CAID 2602 PROVID 000000 ECMPID 1FFF CHID 00 VPID 0200
2019/03/24 01:33:27 68249017 c   (dvbapi) generic delay: write cw 60 ms after ecmrequest
2019/03/24 01:33:27 68249017 c   (dvbapi) delayer: gone=30 ms, cfg=60 ms -> delay=30 ms
2019/03/24 01:33:27 68249017 c   (dvbapi) Demuxer 0 PID: 0 CAID: 2602 ECMPID: 1FFF is using index 0
2019/03/24 01:33:27 68249017 c   (dvbapi) Added new streampid 0200 with index 0 to ca0
2019/03/24 01:33:27 68249017 c   (dvbapi) Demuxer 0 disable stream 1 pid=0x0200 index=-1 on ca0
2019/03/24 01:33:27 68249017 c   (dvbapi) Open device /dev/dvb/adapter0/ca0 (fd 17)
2019/03/24 01:33:27 68249017 c   (dvbapi) Demuxer 0 enable stream 1 pid=0x0200 by index=0 on ca0
2019/03/24 01:33:27 68249017 c   (dvbapi) Added new streampid 1020 with index 0 to ca0
2019/03/24 01:33:27 68249017 c   (dvbapi) Demuxer 0 disable stream 2 pid=0x1020 index=-1 on ca0
2019/03/24 01:33:27 68249017 c   (dvbapi) Demuxer 0 enable stream 2 pid=0x1020 by index=0 on ca0
2019/03/24 01:33:27 68249017 c   (dvbapi) Added new streampid 1021 with index 0 to ca0
2019/03/24 01:33:27 68249017 c   (dvbapi) Demuxer 0 disable stream 3 pid=0x1021 index=-1 on ca0
2019/03/24 01:33:27 68249017 c   (dvbapi) Demuxer 0 enable stream 3 pid=0x1021 by index=0 on ca0
2019/03/24 01:33:27 68249017 c   (dvbapi) Demuxer 0 ca0 is using index 0 for streampid 0200 -> write odd part of cw!
2019/03/24 01:33:27 68249017 c   (dvbapi) Demuxer 0 writing odd part (00112233445566778899AABBCCDDEEFF) of controlword, replacing expired (00000000000000000000000000000000)
2019/03/24 01:33:27 68249017 c   (dvbapi) Demuxer 0 write cw0 index: 0 (ca0)
2019/03/24 01:33:27 68249017 c   (dvbapi) ERROR: ioctl(CA_SET_DESCR_MODE): Invalid argument
2019/03/24 01:33:27 68249017 c   (dvbapi) ERROR: ioctl(CA_SET_DESCR_DATA): Inappropriate ioctl for device
2019/03/24 01:33:27 68249017 c        (-) -- Skipped 1 duplicated log lines --
2019/03/24 01:33:27 68249017 c   (dvbapi) Demuxer 0 ca0 is using index 0 for streampid 1020 -> skip, odd part of cw already written!
2019/03/24 01:33:27 68249017 c   (dvbapi) Demuxer 0 ca0 is using index 0 for streampid 1021 -> skip, odd part of cw already written!
2019/03/24 01:33:27 68249017 c   (dvbapi) Demuxer 0 ca0 is using index 0 for streampid 0200 -> write even part of cw!
2019/03/24 01:33:27 68249017 c   (dvbapi) Demuxer 0 writing even part (00112233445566778899AABBCCDDEEFF) of controlword, replacing expired (00000000000000000000000000000000)
2019/03/24 01:33:27 68249017 c   (dvbapi) Demuxer 0 write cw1 index: 0 (ca0)
2019/03/24 01:33:27 68249017 c   (dvbapi) ERROR: ioctl(CA_SET_DESCR_MODE): Invalid argument
2019/03/24 01:33:27 68249017 c   (dvbapi) ERROR: ioctl(CA_SET_DESCR_DATA): Inappropriate ioctl for device
2019/03/24 01:33:27 68249017 c        (-) -- Skipped 1 duplicated log lines --
2019/03/24 01:33:27 68249017 c   (dvbapi) Demuxer 0 ca0 is using index 0 for streampid 1020 -> skip, even part of cw already written!
2019/03/24 01:33:27 68249017 c   (dvbapi) Demuxer 0 ca0 is using index 0 for streampid 1021 -> skip, even part of cw already written!
[COLOR="darkgreen"]2019/03/24 01:33:27 68249017 c      (ecm) osnino (2602@000000/0000/0001/15:5830FC5CAF09E084015C5A6FCFC19DC0): found (25 ms) by emulator - Service-1

[/COLOR]

Also I don't understand why your log has this weird format in the date/time part and this "kernel" info... Is this through enigma2 or something perhaps and not a direct/copy paste of the oscam.log file?

What is your image? Maybe non-openpli based images don't support offline descrambling? I am out of ideas...

nautilus7 · Mar 24, 2019

I compiled an aarch64 version, in case there is a Dreambox model with this architecture (I am not sure).

https://drive.google.com/open?id=1LgMRJJTwiedbOMFGgRTIHX-DlT_oz-JX

flavor · Mar 24, 2019

Experimental unsable images
Dm900

12130 V 27500 3/4

Code:

F 1402790C 00000000 A5EB22B2576F753BA5EB22B2576F753B ;34 Telekanal 4.8E

Code:

2019/03/24 18:24:37 00000000 s debug_level=128
2019/03/24 18:24:37 00000000 s     (main) System name    = Linux
2019/03/24 18:24:37 00000000 s     (main) Host name      = dm900
2019/03/24 18:24:37 00000000 s     (main) Release        = 3.14-1.17-dm900
2019/03/24 18:24:37 00000000 s     (main) Version        = #1 SMP Fri Feb 9 14:21:32 UTC 2018
2019/03/24 18:24:37 00000000 s     (main) Machine        = armv7l
2019/03/24 18:24:37 00000000 s     (main) Stb model      = dm900
2019/03/24 18:24:37 00000000 s     (main) creating pidfile /tmp/.oscam/oscam.pid with pid 17565
2019/03/24 18:24:37 00000000 s   (config) services reloaded: 0 services freed, 4 services loaded, rejected 0
2019/03/24 18:24:37 00000000 s      (emu) OSCam-Emu version 791
2019/03/24 18:24:37 00000000 s   (config) userdb reloaded: 1 accounts loaded, 0 expired, 0 disabled
2019/03/24 18:24:37 00000000 s     (main) signal handling initialized
2019/03/24 18:24:37 00000000 s   (config) 1007 provid's loaded
2019/03/24 18:24:37 00000000 s   (config) 1881 service-id's loaded in 6 ms
2019/03/24 18:24:37 00000000 s      (net) cs378x: initialized (fd=5, port=13001)
2019/03/24 18:24:37 00000000 s      (net) newcamd: initialized (fd=6, port=12121)
2019/03/24 18:24:37 00000000 s      (net) cccam: initialized (fd=7, port=12000)
2019/03/24 18:24:37 00000000 s   (reader) emulator [emu] creating thread for device emulator
2019/03/24 18:24:37 00000000 s     (main) waiting for local card init
2019/03/24 18:24:37 62088F58 r   (reader) emulator [emu] Reader initialized (device=emulator, detect=cd, mhz=357, cardmhz=357)
2019/03/24 18:24:37 4D15D0AD h    (webif) webif: decompressed 166249 bytes back into 404040 bytes
2019/03/24 18:24:37 4D15D0AD h    (webif) HTTP Server running. ip=0.0.0.0 port=8888
2019/03/24 18:24:38 62088F58 r   (reader) emulator [emu] card detected
2019/03/24 18:24:39 62088F58 r   (reader) emulator [emu] found card system emu
2019/03/24 18:24:39 62088F58 r   (reader) emulator [emu] THIS WAS A SUCCESSFUL START ATTEMPT No  1 out of max alloted of 1
2019/03/24 18:24:39 62088F58 r      (emu) Reading key file: /etc/tuxbox/config/SoftCam.Key
2019/03/24 18:24:39 62088F58 r      (emu) Total keys in memory: W:0 V:0 N:0 I:0 S:0 F:1 G:0 P:430 D:0 T:128 A:0
2019/03/24 18:24:39 00000000 s     (main) init for all local cards done
2019/03/24 18:24:39 00000000 s (emmcache) loaded 6 emmcache records from /tmp/.oscam/oscam.emmcache in 0 ms
2019/03/24 18:24:39 00000000 s (emmcache) loaded 0 emmstat records from /tmp/.oscam/oscam.emmstat in 0 ms
2019/03/24 18:24:39 49C53E8E c   (client) plain dvbapi-client granted (dvbapiau, au=auto (59 reader))
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 0028 0102 0000 0000
2019/03/24 18:24:39 49C53E8E c   (dvbapi) prio: ret=6 | a: 0000 000000 0028 0102 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 000A 0104 0000 0000
2019/03/24 18:24:39 49C53E8E c   (dvbapi) prio: ret=6 | a: 0000 000000 000A 0104 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 0014 0100 0000 0000
2019/03/24 18:24:39 49C53E8E c   (dvbapi) prio: ret=6 | a: 0000 000000 0014 0100 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Parsing rule: ret=2 | p: 0E00 000000  0000 10000 0000
2019/03/24 18:24:39 49C53E8E c   (dvbapi) prio: ret=0 | p: 0E00 000000 0000 0000 10000 -> map 0000 000000 0000 | prio 0 | delay 0
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Parsing rule: ret=2 | p: 2600 000000  0000 10000 0000
2019/03/24 18:24:39 49C53E8E c   (dvbapi) prio: ret=0 | p: 2600 000000 0000 0000 10000 -> map 0000 000000 0000 | prio 0 | delay 0
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Parsing rule: ret=2 | p: 1010 000000  0000 10000 0000
2019/03/24 18:24:39 49C53E8E c   (dvbapi) prio: ret=0 | p: 1010 000000 0000 0000 10000 -> map 0000 000000 0000 | prio 0 | delay 0
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Parsing rule: ret=3 | p: 1010 000000 3331 0000 10000 0000
2019/03/24 18:24:39 49C53E8E c   (dvbapi) prio: ret=0 | p: 1010 000000 3331 0000 10000 -> map 0000 000000 0000 | prio 0 | delay 0
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Parsing rule: ret=3 | p: 1010 000000 3332 0000 10000 0000
2019/03/24 18:24:39 49C53E8E c   (dvbapi) prio: ret=0 | p: 1010 000000 3332 0000 10000 -> map 0000 000000 0000 | prio 0 | delay 0
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Parsing rule: ret=3 | p: 1010 000000 3333 0000 10000 0000
2019/03/24 18:24:39 49C53E8E c   (dvbapi) prio: ret=0 | p: 1010 000000 3333 0000 10000 -> map 0000 000000 0000 | prio 0 | delay 0
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Parsing rule: ret=3 | p: 1010 000000 3336 0000 10000 0000
2019/03/24 18:24:39 49C53E8E c   (dvbapi) prio: ret=0 | p: 1010 000000 3336 0000 10000 -> map 0000 000000 0000 | prio 0 | delay 0
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Parsing rule: ret=3 | p: 1010 000000 3338 0000 10000 0000
2019/03/24 18:24:39 49C53E8E c   (dvbapi) prio: ret=0 | p: 1010 000000 3338 0000 10000 -> map 0000 000000 0000 | prio 0 | delay 0
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Parsing rule: ret=3 | p: 092B 000000 3334 0000 10000 0000
2019/03/24 18:24:39 49C53E8E c   (dvbapi) prio: ret=0 | p: 092B 000000 3334 0000 10000 -> map 0000 000000 0000 | prio 0 | delay 0
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Parsing rule: ret=3 | p: 092B 000000 3335 0000 10000 0000
2019/03/24 18:24:39 49C53E8E c   (dvbapi) prio: ret=0 | p: 092B 000000 3335 0000 10000 -> map 0000 000000 0000 | prio 0 | delay 0
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Parsing rule: ret=3 | p: 092B 000000 3337 0000 10000 0000
2019/03/24 18:24:39 49C53E8E c   (dvbapi) prio: ret=0 | p: 092B 000000 3337 0000 10000 -> map 0000 000000 0000 | prio 0 | delay 0
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Parsing rule: ret=3 | i: 5604 000000 0066 0000 10000 0000
2019/03/24 18:24:39 49C53E8E c   (dvbapi) prio: ret=0 | i: 5604 000000 0066 0000 10000 -> map 0000 000000 0000 | prio 0 | delay 0
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Parsing rule: ret=3 | i: 5604 000000 0067 0000 10000 0000
2019/03/24 18:24:39 49C53E8E c   (dvbapi) prio: ret=0 | i: 5604 000000 0067 0000 10000 -> map 0000 000000 0000 | prio 0 | delay 0
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Parsing rule: ret=3 | i: 5604 000000 0068 0000 10000 0000
2019/03/24 18:24:39 49C53E8E c   (dvbapi) prio: ret=0 | i: 5604 000000 0068 0000 10000 -> map 0000 000000 0000 | prio 0 | delay 0
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Parsing rule: ret=3 | i: 5604 000000 0069 0000 10000 0000
2019/03/24 18:24:39 49C53E8E c   (dvbapi) prio: ret=0 | i: 5604 000000 0069 0000 10000 -> map 0000 000000 0000 | prio 0 | delay 0
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Parsing rule: ret=3 | i: 5604 000000 006A 0000 10000 0000
2019/03/24 18:24:39 49C53E8E c   (dvbapi) prio: ret=0 | i: 5604 000000 006A 0000 10000 -> map 0000 000000 0000 | prio 0 | delay 0
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Parsing rule: ret=3 | i: 5604 000000 006B 0000 10000 0000
2019/03/24 18:24:39 49C53E8E c   (dvbapi) prio: ret=0 | i: 5604 000000 006B 0000 10000 -> map 0000 000000 0000 | prio 0 | delay 0
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Parsing rule: ret=3 | i: 5604 000000 006C 0000 10000 0000
2019/03/24 18:24:39 49C53E8E c   (dvbapi) prio: ret=0 | i: 5604 000000 006C 0000 10000 -> map 0000 000000 0000 | prio 0 | delay 0
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Parsing rule: ret=3 | i: 5604 000000 006D 0000 10000 0000
2019/03/24 18:24:39 49C53E8E c   (dvbapi) prio: ret=0 | i: 5604 000000 006D 0000 10000 -> map 0000 000000 0000 | prio 0 | delay 0
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Parsing rule: ret=3 | i: 5604 000000 0192 0000 10000 0000
2019/03/24 18:24:39 49C53E8E c   (dvbapi) prio: ret=0 | i: 5604 000000 0192 0000 10000 -> map 0000 000000 0000 | prio 0 | delay 0
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Parsing rule: ret=3 | i: 5604 000000 0191 0000 10000 0000
2019/03/24 18:24:39 49C53E8E c   (dvbapi) prio: ret=0 | i: 5604 000000 0191 0000 10000 -> map 0000 000000 0000 | prio 0 | delay 0
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Read 24 entries from oscam.dvbapi
2019/03/24 18:24:39 49C53E8E c   (dvbapi) dvbapi channelcache loaded from /etc/tuxbox/config/oscam.ccache
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Detected /dev/dvb/adapter0/demux0 Api: 0, userconfig boxtype: 1 maximum amount of possible filters is 32 (oscam limit is 32)
2019/03/24 18:24:39 49C53E8E c   (dvbapi) new socket connection fd: 14
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Got packet with opcode 9F803231 and size 53
2019/03/24 18:24:39 49C53E8E c   (dvbapi) PMT Update on socket 14.
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Parsing PMT object:
2019/03/24 18:24:39 49C53E8E c   (dvbapi)   9F 80 32 31 03 1A 0E 1D 00 21 01 81 08 00 30 00 
2019/03/24 18:24:39 49C53E8E c   (dvbapi)   00 00 10 00 55 82 02 01 00 84 02 1A 0E 85 03 01 
2019/03/24 18:24:39 49C53E8E c   (dvbapi)   41 32 86 01 00 09 04 26 00 FF FF 1B 1A 0F 00 00 
2019/03/24 18:24:39 49C53E8E c   (dvbapi)   03 1A 10 00 00 
2019/03/24 18:24:39 49C53E8E c   (dvbapi) capmt:
2019/03/24 18:24:39 49C53E8E c   (dvbapi)   03 1A 0E 1D 00 21 01 81 08 00 30 00 00 00 10 00 
2019/03/24 18:24:39 49C53E8E c   (dvbapi)   55 82 02 01 00 84 02 1A 0E 85 03 01 41 32 86 01 
2019/03/24 18:24:39 49C53E8E c   (dvbapi)   00 09 04 26 00 FF FF 1B 1A 0F 00 00 03 1A 10 00 
2019/03/24 18:24:39 49C53E8E c   (dvbapi)   00 
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Receiver sends PMT command 3 for channel 1A0E
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Receiver wants to demux srvid 1A0E on adapter 0000 camask 0001 index 0000 pmtpid 1A0E
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Open device /dev/dvb/adapter0/demux0 (fd 15)
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 Filter 1 started successfully (caid 0001 provid 000001 pid 1A0E)
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 found user private descriptor (tag: 81 length: 08)
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 assuming enigma private descriptor (namespace: 00300000 tsid: 0010 onid: 0055)
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 found user private descriptor (tag: 82 length: 02)
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 assuming enigma private descriptor
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 found user private descriptor (tag: 84 length: 02)
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 assuming enigma private descriptor
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 found user private descriptor (tag: 85 length: 03)
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 found user private descriptor (tag: 86 length: 01)
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 found CA descriptor (tag: 09 length: 04)
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 ecmpid 0 CAID: 2600 ECM_PID: 1FFF PROVID: 000000 
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 found AVC video stream (type: 1B pid: 1A0F)
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 found MPEG-1 audio stream (type: 03 pid: 1A10)
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 found 1 ECMpids and 2 STREAMpids in caPMT
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 serving srvid 1A0E (34) on adapter 0000 camask 0001 index 0000 pmtpid 1A0E
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0/16 lets start descrambling (srvid = 1A0E fd = 14 ecmpids = 1)
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 prio ecmpid 0 2600@000000:1FFF:0000 weight: 3 (file)
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 sorting the ecmpids took 1 ms
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 trying to descramble PID 0 CAID 2600 PROVID 000000 ECMPID 1FFF ANY CHID PMTPID 1A0E VPID 1A0F
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 try to start new filter for caid: 2600, provid: 000000, pid: 1FFF
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Open device /dev/dvb/adapter0/demux0 (fd 16)
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 Filter 2 started successfully (caid 2600 provid 000000 pid 1FFF)
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 Filter 2 set ecmtable to ODD+EVEN (CAID 2600 PROVID 000000 FD 16)
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 Filter 2 set chid to ANY CHID on fd 16
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 get controlword!
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 request controlword for ecm P: 2600:000000:1A0E:1FFF:0000: #ECM_L:13 #CW=00000000000000000000000000000000 HOP:00
2019/03/24 18:24:39 62088F58 r      (emu) Key found: F 1402790C 00000000
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 controlword received for PID 0 CAID 2600 PROVID 000000 ECMPID 1FFF CHID 0000 VPID 1A0F
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 luckyshot new controlword ecm response hash 68C303602D8EEF837DA2D0CE5E8EDCDA (ecm table reset)
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 descrambling PID 0 CAID 2600 PROVID 000000 ECMPID 1FFF CHID 00 VPID 1A0F
2019/03/24 18:24:39 49C53E8E c   (dvbapi) generic delay: write cw 60 ms after ecmrequest
2019/03/24 18:24:39 49C53E8E c   (dvbapi) delayer: gone=2 ms, cfg=60 ms -> delay=58 ms
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 has 1 ecmpids, 2 streampids, 1 ecmfilters and 0 of max 0 emmfilters
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 filter1[0] = 02, filter mask[0] = FF, flt&mask = 02 , buffer[0] = 02, buffer[0] & mask = 02
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 filter1[1] = 1A, filter mask[1] = FF, flt&mask = 1A , buffer[3] = 1A, buffer[3] & mask = 1A
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 filter1[2] = 0E, filter mask[2] = FF, flt&mask = 0E , buffer[4] = 0E, buffer[4] & mask = 0E
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 Filter 1 fetched PMT data (length = 0x026):
2019/03/24 18:24:39 49C53E8E c   (dvbapi)   02 B0 23 1A 0E DD 00 00 FA 0F F0 06 09 04 26 00 
2019/03/24 18:24:39 49C53E8E c   (dvbapi)   FF FF 1B FA 0F F0 00 03 FA 10 F0 06 0A 04 75 6B 
2019/03/24 18:24:39 49C53E8E c   (dvbapi)   72 00 B4 D6 8C 5E 
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 stop filter 1 try 1 (fd: 15 api: 0, caid: 0001, provid: 000001, emmpid: 1A0E)
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 flushing stale input data of filter 1 (fd:15)
2019/03/24 18:24:39 49C53E8E c   (dvbapi) pmt:
2019/03/24 18:24:39 49C53E8E c   (dvbapi)   02 B0 23 1A 0E DD 00 00 FA 0F F0 06 09 04 26 00 
2019/03/24 18:24:39 49C53E8E c   (dvbapi)   FF FF 1B FA 0F F0 00 03 FA 10 F0 06 0A 04 75 6B 
2019/03/24 18:24:39 49C53E8E c   (dvbapi)   72 00 B4 D6 8C 5E 
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 found CA descriptor (tag: 09 length: 04)
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 found AVC video stream (type: 1B pid: 1A0F)
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 found MPEG-1 audio stream (type: 03 pid: 1A10)
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 found ISO 639 language descriptor (tag: 0A length: 04)
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 found 1 ECMpids and 2 STREAMpids in PMT
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 serving srvid 1A0E (34) on adapter 0000 camask 0001 index 0000 pmtpid 1A0E
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 PID: 0 CAID: 2600 ECMPID: 1FFF is using index 0
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Added new streampid 1A0F with index 0 to ca0
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 disable stream 1 pid=0x1a0f index=-1 on ca0
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Open device /dev/dvb/adapter0/ca0 (fd 15)
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 enable stream 1 pid=0x1a0f by index=0 on ca0
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Added new streampid 1A10 with index 0 to ca0
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 disable stream 2 pid=0x1a10 index=-1 on ca0
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 enable stream 2 pid=0x1a10 by index=0 on ca0
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 ca0 is using index 0 for streampid 1A0F -> write odd part of cw!
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 writing odd part (A5EB22B2576F753B) of controlword, replacing expired (0000000000000000)
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 write cw0 index: 0 (ca0)
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 ca0 is using index 0 for streampid 1A10 -> skip, odd part of cw already written!
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 ca0 is using index 0 for streampid 1A0F -> write even part of cw!
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 writing even part (A5EB22B2576F753B) of controlword, replacing expired (0000000000000000)
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 write cw1 index: 0 (ca0)
2019/03/24 18:24:39 49C53E8E c   (dvbapi) Demuxer 0 ca0 is using index 0 for streampid 1A10 -> skip, even part of cw already written!
2019/03/24 18:24:39 49C53E8E c      (ecm) dvbapiau (P: 2600:000000:1A0E:1FFF:0000: #ECM_L:13 #CW=A5EB22B2576F753BA5EB22B2576F753B HOP:00): found (1 ms) by emulator - 34
2019/03/24 18:24:44 49C53E8E c   (dvbapi) Demuxer 0 try to start new filter for caid: 0001, provid: 000001, pid: 0011
2019/03/24 18:24:44 49C53E8E c   (dvbapi) Open device /dev/dvb/adapter0/demux0 (fd 17)
2019/03/24 18:24:44 49C53E8E c   (dvbapi) Demuxer 0 Filter 1 started successfully (caid 0001 provid 000001 pid 0011)
2019/03/24 18:24:45 49C53E8E c   (dvbapi) Demuxer 0 filter1[0] = 42, filter mask[0] = FF, flt&mask = 42 , buffer[0] = 42, buffer[0] & mask = 42
2019/03/24 18:24:45 49C53E8E c   (dvbapi) Demuxer 0 Filter 1 fetched SDT data (length = 0x181):
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   42 F1 7E 00 10 FD 00 00 00 55 FF 19 C8 FC 80 16 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   48 14 0C 07 58 54 52 41 20 54 56 0A 53 57 37 36 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   30 30 5F 46 54 41 19 C9 FC 80 17 48 15 0C 07 58 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   54 52 41 20 54 56 0B 53 57 37 36 30 30 5F 58 54 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   52 41 19 CA FC 80 17 48 15 0C 07 58 54 52 41 20 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   54 56 0B 53 57 37 36 30 31 5F 58 54 52 41 19 CE 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   FC 80 19 48 17 0C 07 58 54 52 41 20 54 56 0D 53 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   57 5F 4E 65 6F 74 69 6F 6E 43 49 2B 19 D2 FC 90 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   1A 48 18 01 0B 54 52 4B 20 55 6B 72 61 69 6E 61 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   0A 55 4B 52 41 49 4E 41 2D 53 44 19 DC FF 90 19 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   48 17 19 07 58 54 52 41 20 54 56 0D 46 4F 4F 54 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   42 41 4C 4C 20 31 20 48 44 19 E6 FF 90 19 48 17 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   01 0B 54 52 4B 20 55 6B 72 61 69 6E 65 09 46 4F 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   4F 54 42 41 4C 4C 31 19 F0 FF 90 19 48 17 19 07 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   58 54 52 41 20 54 56 0D 46 4F 4F 54 42 41 4C 4C 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   20 32 20 48 44 19 FA FF 80 17 48 15 16 0B 54 52 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   4B 20 55 6B 72 61 69 6E 65 07 44 6F 6E 62 61 73 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   73 1A 04 FF 90 1A 48 18 01 0B 54 52 4B 20 55 6B 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   72 61 69 6E 65 0A 46 4F 4F 54 42 41 4C 4C 20 32 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   1A 0E FF 90 12 48 10 16 0B 54 52 4B 20 55 6B 72 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   61 69 6E 65 02 33 34 1A 18 FF 90 16 48 14 01 0B 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   54 52 4B 20 55 6B 72 61 69 6E 65 06 4E 4C 4F 20 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   54 56 1A 22 FF 80 16 48 14 01 0B 54 52 4B 20 55 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   6B 72 61 69 6E 65 06 49 6E 64 69 67 6F B8 37 F1 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   CA 
2019/03/24 18:24:45 49C53E8E c   (dvbapi) sdt-info dbg: sdt data: 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   42 F1 7E 00 10 FD 00 00 00 55 FF 19 C8 FC 80 16 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   48 14 0C 07 58 54 52 41 20 54 56 0A 53 57 37 36 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   30 30 5F 46 54 41 19 C9 FC 80 17 48 15 0C 07 58 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   54 52 41 20 54 56 0B 53 57 37 36 30 30 5F 58 54 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   52 41 19 CA FC 80 17 48 15 0C 07 58 54 52 41 20 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   54 56 0B 53 57 37 36 30 31 5F 58 54 52 41 19 CE 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   FC 80 19 48 17 0C 07 58 54 52 41 20 54 56 0D 53 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   57 5F 4E 65 6F 74 69 6F 6E 43 49 2B 19 D2 FC 90 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   1A 48 18 01 0B 54 52 4B 20 55 6B 72 61 69 6E 61 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   0A 55 4B 52 41 49 4E 41 2D 53 44 19 DC FF 90 19 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   48 17 19 07 58 54 52 41 20 54 56 0D 46 4F 4F 54 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   42 41 4C 4C 20 31 20 48 44 19 E6 FF 90 19 48 17 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   01 0B 54 52 4B 20 55 6B 72 61 69 6E 65 09 46 4F 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   4F 54 42 41 4C 4C 31 19 F0 FF 90 19 48 17 19 07 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   58 54 52 41 20 54 56 0D 46 4F 4F 54 42 41 4C 4C 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   20 32 20 48 44 19 FA FF 80 17 48 15 16 0B 54 52 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   4B 20 55 6B 72 61 69 6E 65 07 44 6F 6E 62 61 73 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   73 1A 04 FF 90 1A 48 18 01 0B 54 52 4B 20 55 6B 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   72 61 69 6E 65 0A 46 4F 4F 54 42 41 4C 4C 20 32 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   1A 0E FF 90 12 48 10 16 0B 54 52 4B 20 55 6B 72 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   61 69 6E 65 02 33 34 1A 18 FF 90 16 48 14 01 0B 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   54 52 4B 20 55 6B 72 61 69 6E 65 06 4E 4C 4F 20 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   54 56 1A 22 FF 80 16 48 14 01 0B 54 52 4B 20 55 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   6B 72 61 69 6E 65 06 49 6E 64 69 67 6F B8 37 F1 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   CA 
2019/03/24 18:24:45 49C53E8E c   (dvbapi) sdt-info dbg: iso_mode: -1 offset: 0
2019/03/24 18:24:45 49C53E8E c   (dvbapi) sdt-info dbg: raw string: 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   54 52 4B 20 55 6B 72 61 69 6E 65 
2019/03/24 18:24:45 49C53E8E c   (dvbapi) sdt-info dbg: encoded string: 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   54 52 4B 20 55 6B 72 61 69 6E 65 
2019/03/24 18:24:45 49C53E8E c   (dvbapi) sdt-info dbg: iso_mode: -1 offset: 0
2019/03/24 18:24:45 49C53E8E c   (dvbapi) sdt-info dbg: raw string: 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   33 34 
2019/03/24 18:24:45 49C53E8E c   (dvbapi) sdt-info dbg: encoded string: 
2019/03/24 18:24:45 49C53E8E c   (dvbapi)   33 34 
2019/03/24 18:24:45 49C53E8E c   (dvbapi) sdt-info (provider: TRK Ukraine - channel: 34)
2019/03/24 18:24:45 49C53E8E c   (dvbapi) Demuxer 0 stop filter 1 try 1 (fd: 17 api: 0, caid: 0001, provid: 000001, emmpid: 0011)
2019/03/24 18:24:45 49C53E8E c   (dvbapi) Demuxer 0 flushing stale input data of filter 1 (fd:17)
2019/03/24 18:24:59 49C53E8E c   (dvbapi) Demuxer 0 try to start new filter for caid: 0001, provid: 000001, pid: 0001
2019/03/24 18:24:59 49C53E8E c   (dvbapi) Open device /dev/dvb/adapter0/demux0 (fd 18)
2019/03/24 18:24:59 49C53E8E c   (dvbapi) Demuxer 0 Filter 1 started successfully (caid 0001 provid 000001 pid 0001)
2019/03/24 18:25:00 49C53E8E c   (dvbapi) Demuxer 0 has 1 ecmpids, 2 streampids, 1 ecmfilters and 1 of max 0 emmfilters
2019/03/24 18:25:00 49C53E8E c   (dvbapi) Demuxer 0 filter1[0] = 01, filter mask[0] = FF, flt&mask = 01 , buffer[0] = 01, buffer[0] & mask = 01
2019/03/24 18:25:00 49C53E8E c   (dvbapi) Demuxer 0 Filter 1 fetched EMM data (emmlength = 0x018):
2019/03/24 18:25:00 49C53E8E c   (dvbapi)   01 B0 15 FF FF C5 00 00 09 04 0B 0F FA 17 09 04 
2019/03/24 18:25:00 49C53E8E c   (dvbapi)   17 12 FA 2B A5 3E B7 18 
2019/03/24 18:25:00 49C53E8E c   (dvbapi) receiving cat
2019/03/24 18:25:00 49C53E8E c   (dvbapi) cat:
2019/03/24 18:25:00 49C53E8E c   (dvbapi)   01 B0 15 FF FF C5 00 00 09 04 0B 0F FA 17 09 04 
2019/03/24 18:25:00 49C53E8E c   (dvbapi)   17 12 FA 2B A5 3E B7 18 
2019/03/24 18:25:00 49C53E8E c   (dvbapi) Added new emmpid 0 CAID: 0B0F EMM_PID: 1A17 PROVID: 000000	TYPE :UNIQUE:SHARED:GLOBAL:
2019/03/24 18:25:00 49C53E8E c   (dvbapi) Added new emmpid 1 CAID: 1712 EMM_PID: 1A2B PROVID: 000000	TYPE :UNIQUE:SHARED:GLOBAL:
2019/03/24 18:25:00 49C53E8E c   (dvbapi) Demuxer 0 stop filter 1 try 1 (fd: 18 api: 0, caid: 0001, provid: 000001, emmpid: 0001)
2019/03/24 18:25:00 49C53E8E c   (dvbapi) Demuxer 0 flushing stale input data of filter 1 (fd:18)
2019/03/24 18:25:00 49C53E8E c   (dvbapi) Demuxer 0 has 1 ecmpids, 2 streampids, 1 ecmfilters and 0 of max 31 emmfilters
2019/03/24 18:25:00 49C53E8E c   (dvbapi) Demuxer 0 matching reader emulator against available emmpids -> START!
2019/03/24 18:25:00 49C53E8E c   (dvbapi) Demuxer 0 matching reader emulator against available emmpids -> DONE!
2019/03/24 18:25:00 49C53E8E c   (dvbapi) Demuxer 0 handles 0 emm filters

nautilus7 · Mar 24, 2019

What; This is a common BISS 1 channel.

Did you understand the purpose of this thread?

satpong · Mar 25, 2019

@ nautilus7
Hi, it's working on dm7080HD with openATV 6.3 image

receiver: "dreambox DM7080"
working: "yes"
log (with debug level 128):

Code:

-------------------------------------------------------------------------------
**** OSCam <<  cardserver log switched at Mon Mar 25 16:14:45 2019
-------------------------------------------------------------------------------
2019/03/25 16:14:45 00000000 s **** OSCam << cardserver log switched, version 1.20_svn, build r11505-791 (mipsel-satdreamgr-linux-gnu)
2019/03/25 16:14:45 00000000 s debug_level=128
2019/03/25 16:14:45 00000000 s     (main) System name    = Linux
2019/03/25 16:14:45 00000000 s     (main) Host name      = dm7080
2019/03/25 16:14:45 00000000 s     (main) Release        = 3.4-4.0-dm7080
2019/03/25 16:14:45 00000000 s     (main) Version        = #1 SMP Fri Feb 9 15:16:04 UTC 2018
2019/03/25 16:14:45 00000000 s     (main) Machine        = mips
2019/03/25 16:14:45 00000000 s     (main) Stb model      = dm7080
2019/03/25 16:14:45 00000000 s     (main) Stb vumodel    = vuultimo
2019/03/25 16:14:45 00000000 s     (main) Stb boxtype    = vuultimo
2019/03/25 16:14:45 00000000 s     (main) creating pidfile /tmp/.oscam/oscam.pid with pid 935
2019/03/25 16:14:45 00000000 s      (emu) OSCam-Emu version 791
2019/03/25 16:14:45 00000000 s   (config) userdb reloaded: 1 accounts loaded, 0 expired, 0 disabled
2019/03/25 16:14:45 00000000 s     (main) signal handling initialized
2019/03/25 16:14:45 00000000 s   (config) 8 provid's loaded
2019/03/25 16:14:45 00000000 s   (config) 82 service-id's loaded in 2 ms
2019/03/25 16:14:45 00000000 s   (reader) emulator [emu] creating thread for device emulator
2019/03/25 16:14:45 00000000 s     (main) waiting for local card init
2019/03/25 16:14:45 40998879 r   (reader) emulator [emu] Reader initialized (device=emulator, detect=cd, mhz=357, cardmhz=357)
2019/03/25 16:14:45 1C3CED51 h    (webif) webif: decompressed 166249 bytes back into 404040 bytes
2019/03/25 16:14:45 1C3CED51 h    (webif) HTTP Server running. ip=0.0.0.0 port=8888
2019/03/25 16:14:46 40998879 r   (reader) emulator [emu] card detected
2019/03/25 16:14:47 40998879 r   (reader) emulator [emu] found card system emu
2019/03/25 16:14:47 40998879 r   (reader) emulator [emu] THIS WAS A SUCCESSFUL START ATTEMPT No  1 out of max alloted of 1
2019/03/25 16:14:47 40998879 r      (emu) Reading key file: /usr/keys/oscam/SoftCam.Key
2019/03/25 16:14:47 40998879 r      (emu) Total keys in memory: W:0 V:0 N:0 I:0 S:0 F:2 G:0 P:0 D:0 T:128 A:0
2019/03/25 16:14:48 00000000 s     (main) init for all local cards done
2019/03/25 16:14:48 00000000 s (emmcache) loading emmcache disabled since no reader is using it!
2019/03/25 16:14:48 00000000 s (emmcache) loading emmstats disabled since no reader is using it!
2019/03/25 16:14:48 59D293C7 c   (client) plain dvbapi-client granted (local, au=auto (1 reader))
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=2 | p: 0500 041950  0000 10000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=-1 | p: 0500 041950 0000 0000 10000 -> map 0000 000000 0000 | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=2 | p: 183E 000000  0000 10000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=-1 | p: 183E 000000 0000 0000 10000 -> map 0000 000000 0000 | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=2 | p: 0500 030B00  0000 10000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=-1 | p: 0500 030B00 0000 0000 10000 -> map 0000 000000 0000 | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=2 | p: 0E00 000000  0000 10000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=-1 | p: 0E00 000000 0000 0000 10000 -> map 0000 000000 0000 | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 1100 01F4 0000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=6 | a: 0000 000000 1100 01F4 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=4 | a: 0000 000000 000A 0104 10000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=4 | a: 0000 000000 000A 0104 10000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=4 | a: 0000 000000 0014 0100 10000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=4 | a: 0000 000000 0014 0100 10000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=4 | a: 0000 000000 0028 0102 10000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=4 | a: 0000 000000 0028 0102 10000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 1044 0064 0000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=6 | a: 0000 000000 1044 0064 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 107c 1004 0000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=6 | a: 0000 000000 107C 1004 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 107d 13EC 0000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=6 | a: 0000 000000 107D 13EC 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 107e 0C1C 0000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=6 | a: 0000 000000 107E 0C1C 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 10bf 00C8 0000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=6 | a: 0000 000000 10BF 00C8 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 10c0 012C 0000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=6 | a: 0000 000000 10C0 012C 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 1100 01F4 0000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=6 | a: 0000 000000 1100 01F4 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 1140 0A8C 0000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=6 | a: 0000 000000 1140 0A8C 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 11c0 0190 0000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=6 | a: 0000 000000 11C0 0190 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 1200 02BC 0000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=6 | a: 0000 000000 1200 02BC 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 1240 0320 0000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=6 | a: 0000 000000 1240 0320 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 1280 0258 0000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=6 | a: 0000 000000 1280 0258 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 12fc 0AF0 0000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=6 | a: 0000 000000 12FC 0AF0 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 1c00 0384 0000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=6 | a: 0000 000000 1C00 0384 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 1c40 0B54 0000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=6 | a: 0000 000000 1C40 0B54 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 4440 17D4 0000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=6 | a: 0000 000000 4440 17D4 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 4484 19C8 0000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=6 | a: 0000 000000 4484 19C8 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 44c8 1838 0000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=6 | a: 0000 000000 44C8 1838 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 4500 189C 0000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=6 | a: 0000 000000 4500 189C 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 4540 1900 0000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=6 | a: 0000 000000 4540 1900 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 45c0 1964 0000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=6 | a: 0000 000000 45C0 1964 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 4680 1DB0 0000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=6 | a: 0000 000000 4680 1DB0 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 46c0 1BBC 0000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=6 | a: 0000 000000 46C0 1BBC 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 4e80 1A90 0000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=6 | a: 0000 000000 4E80 1A90 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 4f80 1BBD 0000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=6 | a: 0000 000000 4F80 1BBD 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 1600 0578 0000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=6 | a: 0000 000000 1600 0578 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 1640 05DC 0000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=6 | a: 0000 000000 1640 05DC 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 1680 0640 0000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=6 | a: 0000 000000 1680 0640 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 16c0 06A4 0000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=6 | a: 0000 000000 16C0 06A4 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 1700 0708 0000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=6 | a: 0000 000000 1700 0708 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 1740 076C 0000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=6 | a: 0000 000000 1740 076C 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 1780 07D0 0000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=6 | a: 0000 000000 1780 07D0 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 183c 08FC 0000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=6 | a: 0000 000000 183C 08FC 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 187c 0960 0000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=6 | a: 0000 000000 187C 0960 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 18bd 09C4 0000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=6 | a: 0000 000000 18BD 09C4 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 18fd 0A28 0000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=6 | a: 0000 000000 18FD 0A28 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 193e 0834 0000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=6 | a: 0000 000000 193E 0834 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 197e 0898 0000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=6 | a: 0000 000000 197E 0898 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 1a40 03E8 0000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=6 | a: 0000 000000 1A40 03E8 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 1a80 044C 0000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=6 | a: 0000 000000 1A80 044C 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 1ac0 04B0 0000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=6 | a: 0000 000000 1AC0 04B0 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Parsing rule: ret=6 | a: 0000 000000 1b00 0514 0000 0000
2019/03/25 16:14:48 59D293C7 c   (dvbapi) prio: ret=6 | a: 0000 000000 1B00 0514 0000 -> map 2600 000000 1FFF | prio 0 | delay 0
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Read 50 entries from oscam.dvbapi
2019/03/25 16:14:48 59D293C7 c   (dvbapi) dvbapi channelcache loaded from /usr/keys/oscam/oscam.ccache
2019/03/25 16:14:48 59D293C7 c   (dvbapi) Detected /dev/dvb/adapter0/demux0 Api: 0, userconfig boxtype: 1 maximum amount of possible filters is 32 (oscam limit is 32)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) new socket connection fd: 11
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Got packet with opcode 9F803256 and size 90
2019/03/25 16:14:52 59D293C7 c   (dvbapi) PMT Update on socket 11.
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Parsing PMT object:
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   9F 80 32 56 03 04 4F 33 00 19 01 81 08 FF FF 00 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   00 00 0B 00 01 82 02 01 00 84 02 00 CB 85 04 00 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   00 00 01 0B 00 36 00 00 0B 00 37 00 00 0B 00 38 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   00 00 0B 00 39 00 00 0B 00 3A 00 00 1B 0C E5 00 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   00 03 0C E6 00 00 06 0C E7 00 00 03 0C EA 00 00 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   05 1F 73 00 00 0B 1F 74 00 00 
2019/03/25 16:14:52 59D293C7 c   (dvbapi) capmt:
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   03 04 4F 33 00 19 01 81 08 FF FF 00 00 00 0B 00 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   01 82 02 01 00 84 02 00 CB 85 04 00 00 00 01 0B 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   00 36 00 00 0B 00 37 00 00 0B 00 38 00 00 0B 00 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   39 00 00 0B 00 3A 00 00 1B 0C E5 00 00 03 0C E6 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   00 00 06 0C E7 00 00 03 0C EA 00 00 05 1F 73 00 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   00 0B 1F 74 00 00 
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Receiver sends PMT command 3 for channel 044F
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Receiver wants to demux srvid 044F on adapter 0000 camask 0001 index 0000 pmtpid 00CB
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Open device /dev/dvb/adapter0/demux0 (fd 12)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 Filter 1 started successfully (caid 0001 provid 000001 pid 00CB)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found user private descriptor (tag: 81 length: 08)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 assuming enigma private descriptor (namespace: FFFF0000 tsid: 000B onid: 0001)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found user private descriptor (tag: 82 length: 02)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 assuming enigma private descriptor
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found user private descriptor (tag: 84 length: 02)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 assuming enigma private descriptor
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found user private descriptor (tag: 85 length: 04)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 assuming enigma private descriptor
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found DSM-CC data stream (type: 0B pid: 0036)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found DSM-CC data stream (type: 0B pid: 0037)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found DSM-CC data stream (type: 0B pid: 0038)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found DSM-CC data stream (type: 0B pid: 0039)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found DSM-CC data stream (type: 0B pid: 003A)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found AVC video stream (type: 1B pid: 0CE5)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found MPEG-1 audio stream (type: 03 pid: 0CE6)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found MPEG-2 PES private data stream (type: 06 pid: 0CE7)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found MPEG-1 audio stream (type: 03 pid: 0CEA)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found MPEG-2 private sections stream (type: 05 pid: 1F73)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found DSM-CC data stream (type: 0B pid: 1F74)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found 0 ECMpids and 11 STREAMpids in caPMT
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 serving srvid 044F (één HD) on adapter 0000 camask 0001 index 0000 pmtpid 00CB
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0/16 no descrambling needed (srvid = 044F fd = 11 ecmpids = 0)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 filter1[0] = 02, filter mask[0] = FF, flt&mask = 02 , buffer[0] = 02, buffer[0] & mask = 02
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 filter1[1] = 04, filter mask[1] = FF, flt&mask = 04 , buffer[3] = 04, buffer[3] & mask = 04
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 filter1[2] = 4F, filter mask[2] = FF, flt&mask = 4F , buffer[4] = 4F, buffer[4] & mask = 4F
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 Filter 1 fetched PMT data (length = 0x185):
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   02 B1 82 04 4F F3 00 00 EC E5 F0 11 0B 02 42 3F 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   0E 03 C8 3D 60 10 06 C0 02 71 C0 04 00 0B E0 36 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   F0 33 52 01 09 66 04 00 F0 00 01 13 19 00 00 01 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   12 01 42 00 02 0F E2 00 00 01 A0 00 00 00 01 A0 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   13 04 53 47 57 00 14 0D 00 09 00 00 08 FF FF FF 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   FF FF FF FF FF 0B E0 37 F0 33 52 01 0E 66 04 00 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   F0 00 01 14 0D 00 0E 00 00 08 FF FF FF FF FF FF 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   FF FF 13 19 00 00 01 13 01 76 00 02 0F E2 00 00 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   03 51 00 00 00 03 51 1F 04 53 47 57 00 0B E0 38 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   F0 33 52 01 10 66 04 00 F0 00 01 14 0D 00 10 00 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   00 08 FF FF FF FF FF FF FF FF 13 19 00 00 01 14 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   01 76 00 02 0F E2 00 00 03 51 00 00 00 03 51 1F 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   04 53 47 57 00 0B E0 39 F0 1F 14 0D 00 12 00 00 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   08 FF FF FF FF FF FF FF FF 52 01 12 66 04 00 F0 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   00 01 13 05 00 00 01 15 00 0B E0 3A F0 1F 52 01 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   18 66 04 00 F0 00 01 14 0D 00 18 00 00 08 FF FF 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   FF FF FF FF FF FF 13 05 00 00 01 16 00 1B EC E5 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   F0 06 28 04 64 00 29 3F 03 EC E6 F0 06 0A 04 64 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   75 74 00 06 EC E7 F0 0C 56 0A 64 75 74 08 88 64 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   75 74 28 88 03 EC EA F0 06 0A 04 62 6E 6C 00 05 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   FF 73 F0 05 6F 03 00 01 E0 0B FF 74 F0 33 14 0D 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   00 28 00 00 08 A0 0B 00 00 00 6B 0E 40 52 01 28 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   13 19 00 00 00 34 01 00 20 01 0F E2 00 00 00 78 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   00 00 00 00 78 07 04 53 47 57 00 66 04 00 F0 00 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   01 E7 F2 4C CE 
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 stop filter 1 try 1 (fd: 12 api: 0, caid: 0001, provid: 000001, emmpid: 00CB)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 flushing stale input data of filter 1 (fd:12)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) pmt:
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   02 B1 82 04 4F F3 00 00 EC E5 F0 11 0B 02 42 3F 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   0E 03 C8 3D 60 10 06 C0 02 71 C0 04 00 0B E0 36 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   F0 33 52 01 09 66 04 00 F0 00 01 13 19 00 00 01 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   12 01 42 00 02 0F E2 00 00 01 A0 00 00 00 01 A0 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   13 04 53 47 57 00 14 0D 00 09 00 00 08 FF FF FF 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   FF FF FF FF FF 0B E0 37 F0 33 52 01 0E 66 04 00 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   F0 00 01 14 0D 00 0E 00 00 08 FF FF FF FF FF FF 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   FF FF 13 19 00 00 01 13 01 76 00 02 0F E2 00 00 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   03 51 00 00 00 03 51 1F 04 53 47 57 00 0B E0 38 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   F0 33 52 01 10 66 04 00 F0 00 01 14 0D 00 10 00 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   00 08 FF FF FF FF FF FF FF FF 13 19 00 00 01 14 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   01 76 00 02 0F E2 00 00 03 51 00 00 00 03 51 1F 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   04 53 47 57 00 0B E0 39 F0 1F 14 0D 00 12 00 00 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   08 FF FF FF FF FF FF FF FF 52 01 12 66 04 00 F0 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   00 01 13 05 00 00 01 15 00 0B E0 3A F0 1F 52 01 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   18 66 04 00 F0 00 01 14 0D 00 18 00 00 08 FF FF 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   FF FF FF FF FF FF 13 05 00 00 01 16 00 1B EC E5 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   F0 06 28 04 64 00 29 3F 03 EC E6 F0 06 0A 04 64 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   75 74 00 06 EC E7 F0 0C 56 0A 64 75 74 08 88 64 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   75 74 28 88 03 EC EA F0 06 0A 04 62 6E 6C 00 05 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   FF 73 F0 05 6F 03 00 01 E0 0B FF 74 F0 33 14 0D 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   00 28 00 00 08 A0 0B 00 00 00 6B 0E 40 52 01 28 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   13 19 00 00 00 34 01 00 20 01 0F E2 00 00 00 78 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   00 00 00 00 78 07 04 53 47 57 00 66 04 00 F0 00 
2019/03/25 16:14:52 59D293C7 c   (dvbapi)   01 E7 F2 4C CE 
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found system clock descriptor (tag: 0B length: 02)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found maximum bitrate descriptor (tag: 0E length: 03)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found smoothing buffer descriptor (tag: 10 length: 06)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found DSM-CC data stream (type: 0B pid: 0036)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found stream identifier descriptor (tag: 52 length: 01)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found data broadcast id descriptor (tag: 66 length: 04)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found DSM-CC carousel identifier descriptor (tag: 13 length: 19)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found DSM-CC association tag descriptor (tag: 14 length: 0D)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found DSM-CC data stream (type: 0B pid: 0037)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found stream identifier descriptor (tag: 52 length: 01)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found data broadcast id descriptor (tag: 66 length: 04)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found DSM-CC association tag descriptor (tag: 14 length: 0D)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found DSM-CC carousel identifier descriptor (tag: 13 length: 19)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found DSM-CC data stream (type: 0B pid: 0038)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found stream identifier descriptor (tag: 52 length: 01)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found data broadcast id descriptor (tag: 66 length: 04)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found DSM-CC association tag descriptor (tag: 14 length: 0D)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found DSM-CC carousel identifier descriptor (tag: 13 length: 19)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found DSM-CC data stream (type: 0B pid: 0039)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found DSM-CC association tag descriptor (tag: 14 length: 0D)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found stream identifier descriptor (tag: 52 length: 01)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found data broadcast id descriptor (tag: 66 length: 04)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found DSM-CC carousel identifier descriptor (tag: 13 length: 05)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found DSM-CC data stream (type: 0B pid: 003A)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found stream identifier descriptor (tag: 52 length: 01)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found data broadcast id descriptor (tag: 66 length: 04)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found DSM-CC association tag descriptor (tag: 14 length: 0D)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found DSM-CC carousel identifier descriptor (tag: 13 length: 05)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found AVC video stream (type: 1B pid: 0CE5)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found AVC video descriptor (tag: 28 length: 04)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found MPEG-1 audio stream (type: 03 pid: 0CE6)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found ISO 639 language descriptor (tag: 0A length: 04)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found MPEG-2 PES private data stream (type: 06 pid: 0CE7)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found teletext descriptor (tag: 56 length: 0A)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found MPEG-1 audio stream (type: 03 pid: 0CEA)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found ISO 639 language descriptor (tag: 0A length: 04)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found MPEG-2 private sections stream (type: 05 pid: 1F73)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found application signalling descriptor (tag: 6F length: 03)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found DSM-CC data stream (type: 0B pid: 1F74)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found DSM-CC association tag descriptor (tag: 14 length: 0D)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found stream identifier descriptor (tag: 52 length: 01)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found DSM-CC carousel identifier descriptor (tag: 13 length: 19)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found data broadcast id descriptor (tag: 66 length: 04)
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 found 0 ECMpids and 11 STREAMpids in PMT
2019/03/25 16:14:52 59D293C7 c   (dvbapi) Demuxer 0 serving srvid 044F (één HD) on adapter 0000 camask 0001 index 0000 pmtpid 00CB
2019/03/25 16:14:57 59D293C7 c   (dvbapi) Demuxer 0 try to start new filter for caid: 0001, provid: 000001, pid: 0011
2019/03/25 16:14:57 59D293C7 c   (dvbapi) Open device /dev/dvb/adapter0/demux0 (fd 12)
2019/03/25 16:14:57 59D293C7 c   (dvbapi) Demuxer 0 Filter 1 started successfully (caid 0001 provid 000001 pid 0011)
2019/03/25 16:14:59 59D293C7 c   (dvbapi) Demuxer 0 filter1[0] = 42, filter mask[0] = FF, flt&mask = 42 , buffer[0] = 42, buffer[0] & mask = 42
2019/03/25 16:14:59 59D293C7 c   (dvbapi) Demuxer 0 Filter 1 fetched SDT data (length = 0x0B2):
2019/03/25 16:14:59 59D293C7 c   (dvbapi)   42 F0 AF 00 0B FF 00 00 00 01 FF 04 4F FF 80 13 
2019/03/25 16:14:59 59D293C7 c   (dvbapi)   48 11 19 07 54 65 6C 65 6E 65 74 07 05 E9 E9 6E 
2019/03/25 16:14:59 59D293C7 c   (dvbapi)   20 48 44 04 50 FF 80 16 48 14 19 07 54 65 6C 65 
2019/03/25 16:14:59 59D293C7 c   (dvbapi)   6E 65 74 0A 05 43 61 6E 76 61 73 20 48 44 04 51 
2019/03/25 16:14:59 59D293C7 c   (dvbapi)   FF 80 13 48 11 19 07 54 65 6C 65 6E 65 74 07 05 
2019/03/25 16:14:59 59D293C7 c   (dvbapi)   4B 65 74 6E 65 74 04 54 FF 80 1F 48 1D 01 07 54 
2019/03/25 16:14:59 59D293C7 c   (dvbapi)   65 6C 65 6E 65 74 13 05 76 6C 61 61 6D 73 70 61 
2019/03/25 16:14:59 59D293C7 c   (dvbapi)   72 6C 65 6D 65 6E 74 2E 74 76 04 55 FF 90 14 48 
2019/03/25 16:14:59 59D293C7 c   (dvbapi)   12 01 07 54 65 6C 65 6E 65 74 08 05 53 74 6F 72 
2019/03/25 16:14:59 59D293C7 c   (dvbapi)   69 65 73 04 56 FF 90 16 48 14 01 07 54 65 6C 65 
2019/03/25 16:14:59 59D293C7 c   (dvbapi)   6E 65 74 0A 05 44 4F 42 42 49 54 20 54 56 DD DD 
2019/03/25 16:14:59 59D293C7 c   (dvbapi)   42 02 
2019/03/25 16:14:59 59D293C7 c   (dvbapi) sdt-info dbg: sdt data: 
2019/03/25 16:14:59 59D293C7 c   (dvbapi)   42 F0 AF 00 0B FF 00 00 00 01 FF 04 4F FF 80 13 
2019/03/25 16:14:59 59D293C7 c   (dvbapi)   48 11 19 07 54 65 6C 65 6E 65 74 07 05 E9 E9 6E 
2019/03/25 16:14:59 59D293C7 c   (dvbapi)   20 48 44 04 50 FF 80 16 48 14 19 07 54 65 6C 65 
2019/03/25 16:14:59 59D293C7 c   (dvbapi)   6E 65 74 0A 05 43 61 6E 76 61 73 20 48 44 04 51 
2019/03/25 16:14:59 59D293C7 c   (dvbapi)   FF 80 13 48 11 19 07 54 65 6C 65 6E 65 74 07 05 
2019/03/25 16:14:59 59D293C7 c   (dvbapi)   4B 65 74 6E 65 74 04 54 FF 80 1F 48 1D 01 07 54 
2019/03/25 16:14:59 59D293C7 c   (dvbapi)   65 6C 65 6E 65 74 13 05 76 6C 61 61 6D 73 70 61 
2019/03/25 16:14:59 59D293C7 c   (dvbapi)   72 6C 65 6D 65 6E 74 2E 74 76 04 55 FF 90 14 48 
2019/03/25 16:14:59 59D293C7 c   (dvbapi)   12 01 07 54 65 6C 65 6E 65 74 08 05 53 74 6F 72 
2019/03/25 16:14:59 59D293C7 c   (dvbapi)   69 65 73 04 56 FF 90 16 48 14 01 07 54 65 6C 65 
2019/03/25 16:14:59 59D293C7 c   (dvbapi)   6E 65 74 0A 05 44 4F 42 42 49 54 20 54 56 DD DD 
2019/03/25 16:14:59 59D293C7 c   (dvbapi)   42 02 
2019/03/25 16:14:59 59D293C7 c   (dvbapi) sdt-info dbg: iso_mode: -1 offset: 0
2019/03/25 16:14:59 59D293C7 c   (dvbapi) sdt-info dbg: raw string: 
2019/03/25 16:14:59 59D293C7 c   (dvbapi)   54 65 6C 65 6E 65 74 
2019/03/25 16:14:59 59D293C7 c   (dvbapi) sdt-info dbg: encoded string: 
2019/03/25 16:14:59 59D293C7 c   (dvbapi)   54 65 6C 65 6E 65 74 
2019/03/25 16:14:59 59D293C7 c   (dvbapi) sdt-info dbg: iso_mode: 9 offset: 1
2019/03/25 16:14:59 59D293C7 c   (dvbapi) sdt-info dbg: raw string: 
2019/03/25 16:14:59 59D293C7 c   (dvbapi)   E9 E9 6E 20 48 44 
2019/03/25 16:14:59 59D293C7 c   (dvbapi) sdt-info dbg: encoded string: 
2019/03/25 16:14:59 59D293C7 c   (dvbapi)   C3 A9 C3 A9 6E 20 48 44 
2019/03/25 16:14:59 59D293C7 c   (dvbapi) sdt-info (provider: Telenet - channel: één HD)
2019/03/25 16:14:59 59D293C7 c   (dvbapi) Demuxer 0 stop filter 1 try 1 (fd: 12 api: 0, caid: 0001, provid: 000001, emmpid: 0011)
2019/03/25 16:14:59 59D293C7 c   (dvbapi) Demuxer 0 flushing stale input data of filter 1 (fd:12)
2019/03/25 16:15:12 59D293C7 c   (dvbapi) Demuxer 0 try to start new filter for caid: 0001, provid: 000001, pid: 0001
2019/03/25 16:15:12 59D293C7 c   (dvbapi) Open device /dev/dvb/adapter0/demux0 (fd 12)
2019/03/25 16:15:12 59D293C7 c   (dvbapi) Demuxer 0 Filter 1 started successfully (caid 0001 provid 000001 pid 0001)
2019/03/25 16:15:13 59D293C7 c   (dvbapi) Demuxer 0 has 0 ecmpids, 11 streampids, 0 ecmfilters and 1 of max 0 emmfilters
2019/03/25 16:15:13 59D293C7 c   (dvbapi) Demuxer 0 filter1[0] = 01, filter mask[0] = FF, flt&mask = 01 , buffer[0] = 01, buffer[0] & mask = 01
2019/03/25 16:15:13 59D293C7 c   (dvbapi) Demuxer 0 Filter 1 fetched EMM data (emmlength = 0x037):
2019/03/25 16:15:13 59D293C7 c   (dvbapi)   01 B0 34 FF FF C1 00 00 09 04 18 01 E4 4D 09 04 
2019/03/25 16:15:13 59D293C7 c   (dvbapi)   18 61 E4 4E 09 04 4A C1 FF 41 09 04 18 50 E4 4F 
2019/03/25 16:15:13 59D293C7 c   (dvbapi)   09 11 05 00 E4 B0 13 01 20 14 03 05 1C 00 14 03 
2019/03/25 16:15:13 59D293C7 c   (dvbapi)   D0 00 C0 F9 71 BA 1D 
2019/03/25 16:15:13 59D293C7 c   (dvbapi) receiving cat
2019/03/25 16:15:13 59D293C7 c   (dvbapi) cat:
2019/03/25 16:15:13 59D293C7 c   (dvbapi)   01 B0 34 FF FF C1 00 00 09 04 18 01 E4 4D 09 04 
2019/03/25 16:15:13 59D293C7 c   (dvbapi)   18 61 E4 4E 09 04 4A C1 FF 41 09 04 18 50 E4 4F 
2019/03/25 16:15:13 59D293C7 c   (dvbapi)   09 11 05 00 E4 B0 13 01 20 14 03 05 1C 00 14 03 
2019/03/25 16:15:13 59D293C7 c   (dvbapi)   D0 00 C0 F9 71 BA 1D 
2019/03/25 16:15:13 59D293C7 c   (dvbapi) Added new emmpid 0 CAID: 1801 EMM_PID: 044D PROVID: 000000	TYPE :UNIQUE:SHARED:GLOBAL:
2019/03/25 16:15:13 59D293C7 c   (dvbapi) Added new emmpid 1 CAID: 1861 EMM_PID: 044E PROVID: 000000	TYPE :UNIQUE:SHARED:GLOBAL:
2019/03/25 16:15:13 59D293C7 c   (dvbapi) Added new emmpid 2 CAID: 4AC1 EMM_PID: 1F41 PROVID: 000009	TYPE :UNIQUE:SHARED:GLOBAL:
2019/03/25 16:15:13 59D293C7 c   (dvbapi) Added new emmpid 3 CAID: 1850 EMM_PID: 044F PROVID: 000000	TYPE :UNIQUE:SHARED:GLOBAL:
2019/03/25 16:15:13 59D293C7 c   (dvbapi) Added new emmpid 4 CAID: 0500 EMM_PID: 04B0 PROVID: 051C00	TYPE :UNIQUE:SHARED:GLOBAL:
2019/03/25 16:15:13 59D293C7 c   (dvbapi) Added new emmpid 5 CAID: 0500 EMM_PID: 04B0 PROVID: D000C0	TYPE :UNIQUE:SHARED:GLOBAL:
2019/03/25 16:15:13 59D293C7 c   (dvbapi) Demuxer 0 stop filter 1 try 1 (fd: 12 api: 0, caid: 0001, provid: 000001, emmpid: 0001)
2019/03/25 16:15:13 59D293C7 c   (dvbapi) Demuxer 0 flushing stale input data of filter 1 (fd:12)
2019/03/25 16:15:13 59D293C7 c   (dvbapi) Demuxer 0 has 0 ecmpids, 11 streampids, 0 ecmfilters and 0 of max 31 emmfilters
2019/03/25 16:15:13 59D293C7 c   (dvbapi) Demuxer 0 matching reader emulator against available emmpids -> START!
2019/03/25 16:15:13 59D293C7 c   (dvbapi) Demuxer 0 matching reader emulator against available emmpids -> DONE!
2019/03/25 16:15:13 59D293C7 c   (dvbapi) Demuxer 0 handles 0 emm filters
2019/03/25 16:15:43 59D293C7 c   (dvbapi) Demuxer 0 matching reader emulator against available emmpids -> START!
2019/03/25 16:15:43 59D293C7 c   (dvbapi) Demuxer 0 matching reader emulator against available emmpids -> DONE!
2019/03/25 16:15:43 59D293C7 c   (dvbapi) Demuxer 0 handles 0 emm filters
2019/03/25 16:16:13 59D293C7 c   (dvbapi) Demuxer 0 matching reader emulator against available emmpids -> START!
2019/03/25 16:16:13 59D293C7 c   (dvbapi) Demuxer 0 matching reader emulator against available emmpids -> DONE!
2019/03/25 16:16:13 59D293C7 c   (dvbapi) Demuxer 0 handles 0 emm filters
2019/03/25 16:16:29 59D293C7 c   (dvbapi) Demuxer 0 stop descrambling program number 044F (één HD)
2019/03/25 16:16:29 59D293C7 c   (dvbapi) Socket 11 reported hard connection close
2019/03/25 16:16:29 59D293C7 c   (dvbapi) new socket connection fd: 11
2019/03/25 16:16:29 59D293C7 c   (dvbapi) Got packet with opcode 9F803234 and size 56
2019/03/25 16:16:29 59D293C7 c   (dvbapi) PMT Update on socket 11.
2019/03/25 16:16:29 59D293C7 c   (dvbapi) Parsing PMT object:
2019/03/25 16:16:29 59D293C7 c   (dvbapi)   9F 80 32 34 03 00 01 01 00 1F 01 81 08 00 00 00 
2019/03/25 16:16:29 59D293C7 c   (dvbapi)   00 00 00 00 00 82 02 80 07 84 02 00 20 09 04 26 
2019/03/25 16:16:29 59D293C7 c   (dvbapi)   02 FF FF 85 04 00 00 00 08 1B 02 00 00 00 03 10 
2019/03/25 16:16:29 59D293C7 c   (dvbapi)   20 00 00 03 10 21 00 00 
2019/03/25 16:16:29 59D293C7 c   (dvbapi) capmt:
2019/03/25 16:16:29 59D293C7 c   (dvbapi)   03 00 01 01 00 1F 01 81 08 00 00 00 00 00 00 00 
2019/03/25 16:16:29 59D293C7 c   (dvbapi)   00 82 02 80 07 84 02 00 20 09 04 26 02 FF FF 85 
2019/03/25 16:16:29 59D293C7 c   (dvbapi)   04 00 00 00 08 1B 02 00 00 00 03 10 20 00 00 03 
2019/03/25 16:16:29 59D293C7 c   (dvbapi)   10 21 00 00 
2019/03/25 16:16:29 59D293C7 c   (dvbapi) Receiver sends PMT command 3 for channel 0001
2019/03/25 16:16:29 59D293C7 c   (dvbapi) Receiver wants to demux srvid 0001 on adapter 0000 camask 0080 index 0007 pmtpid 0020
2019/03/25 16:16:29 59D293C7 c   (dvbapi) Open device /dev/dvb/adapter0/demux0 (fd 12)
2019/03/25 16:16:29 59D293C7 c   (dvbapi) Demuxer 0 Filter 1 started successfully (caid 0001 provid 000001 pid 0020)
2019/03/25 16:16:29 59D293C7 c   (dvbapi) Demuxer 0 found user private descriptor (tag: 81 length: 08)
2019/03/25 16:16:29 59D293C7 c   (dvbapi) Demuxer 0 assuming enigma private descriptor (namespace: 00000000 tsid: 0000 onid: 0000)
2019/03/25 16:16:29 59D293C7 c   (dvbapi) Demuxer 0 found user private descriptor (tag: 82 length: 02)
2019/03/25 16:16:29 59D293C7 c   (dvbapi) Demuxer 0 assuming enigma private descriptor
2019/03/25 16:16:29 59D293C7 c   (dvbapi) Demuxer 0 found user private descriptor (tag: 84 length: 02)
2019/03/25 16:16:29 59D293C7 c   (dvbapi) Demuxer 0 assuming enigma private descriptor
2019/03/25 16:16:29 59D293C7 c   (dvbapi) Demuxer 0 found CA descriptor (tag: 09 length: 04)
2019/03/25 16:16:29 59D293C7 c   (dvbapi) Demuxer 0 ecmpid 0 CAID: 2602 ECM_PID: 1FFF PROVID: 000000 
2019/03/25 16:16:29 59D293C7 c   (dvbapi) Demuxer 0 found user private descriptor (tag: 85 length: 04)
2019/03/25 16:16:29 59D293C7 c   (dvbapi) Demuxer 0 assuming enigma private descriptor
2019/03/25 16:16:29 59D293C7 c   (dvbapi) Demuxer 0 found AVC video stream (type: 1B pid: 0200)
2019/03/25 16:16:29 59D293C7 c   (dvbapi) Demuxer 0 found MPEG-1 audio stream (type: 03 pid: 1020)
2019/03/25 16:16:29 59D293C7 c   (dvbapi) Demuxer 0 found MPEG-1 audio stream (type: 03 pid: 1021)
2019/03/25 16:16:29 59D293C7 c   (dvbapi) Demuxer 0 found 1 ECMpids and 3 STREAMpids in caPMT
2019/03/25 16:16:29 59D293C7 c   (dvbapi) Demuxer 0 serving srvid 0001 (DSI) on adapter 0000 camask 0080 index 0007 pmtpid 0020
2019/03/25 16:16:29 59D293C7 c   (dvbapi) Demuxer 0/16 lets start descrambling (srvid = 0001 fd = 11 ecmpids = 1)
2019/03/25 16:16:29 59D293C7 c   (dvbapi) Demuxer 0 prio ecmpid 0 2602@000000:1FFF:10000 weight: 1 (1 local and 0 cacheex readers)
2019/03/25 16:16:29 59D293C7 c   (dvbapi) Demuxer 0 sorting the ecmpids took 1 ms
2019/03/25 16:16:29 59D293C7 c   (dvbapi) Demuxer 0 trying to descramble PID 0 CAID 2602 PROVID 000000 ECMPID 1FFF ANY CHID PMTPID 0020 VPID 0200
2019/03/25 16:16:29 59D293C7 c   (dvbapi) Demuxer 0 try to start new filter for caid: 2602, provid: 000000, pid: 1FFF
2019/03/25 16:16:29 59D293C7 c   (dvbapi) Open device /dev/dvb/adapter0/demux7 (fd 13)
2019/03/25 16:16:29 59D293C7 c   (dvbapi) Demuxer 0 Filter 2 started successfully (caid 2602 provid 000000 pid 1FFF)
2019/03/25 16:16:29 59D293C7 c   (dvbapi) Demuxer 0 Filter 2 set ecmtable to ODD+EVEN (CAID 2602 PROVID 000000 FD 13)
2019/03/25 16:16:29 59D293C7 c   (dvbapi) Demuxer 0 Filter 2 set chid to ANY CHID on fd 13
2019/03/25 16:16:29 59D293C7 c   (dvbapi) Demuxer 0 get controlword!
2019/03/25 16:16:29 40998879 r      (emu) Key found: F ED65DCC6 00000000
2019/03/25 16:16:29 59D293C7 c   (dvbapi) Demuxer 0 request controlword for ecm 2602@000000/0000/0001/15:5830FC5CAF09E084015C5A6FCFC19DC0
2019/03/25 16:16:29 59D293C7 c   (dvbapi) Demuxer 0 controlword received for PID 0 CAID 2602 PROVID 000000 ECMPID 1FFF CHID 0000 VPID 0200
2019/03/25 16:16:29 59D293C7 c   (dvbapi) Demuxer 0 luckyshot new controlword ecm response hash 5830FC5CAF09E084015C5A6FCFC19DC0 (ecm table reset)
2019/03/25 16:16:29 59D293C7 c   (dvbapi) Demuxer 0 descrambling PID 0 CAID 2602 PROVID 000000 ECMPID 1FFF CHID 00 VPID 0200
2019/03/25 16:16:29 59D293C7 c   (dvbapi) Demuxer 0 has 1 ecmpids, 3 streampids, 1 ecmfilters and 0 of max 0 emmfilters
2019/03/25 16:16:29 59D293C7 c   (dvbapi) Demuxer 0 added to channel cache: 2602@000000/0000/0001/00:(null)
2019/03/25 16:16:29 59D293C7 c   (dvbapi) generic delay: write cw 60 ms after ecmrequest
2019/03/25 16:16:29 59D293C7 c   (dvbapi) delayer: gone=4 ms, cfg=60 ms -> delay=56 ms
2019/03/25 16:16:30 59D293C7 c   (dvbapi) Demuxer 0 PID: 0 CAID: 2602 ECMPID: 1FFF is using index 0
2019/03/25 16:16:30 59D293C7 c   (dvbapi) Added new streampid 0200 with index 0 to ca7
2019/03/25 16:16:30 59D293C7 c   (dvbapi) Demuxer 0 disable stream 1 pid=0x0200 index=-1 on ca7
2019/03/25 16:16:30 59D293C7 c   (dvbapi) Open device /dev/dvb/adapter0/ca7 (fd 14)
2019/03/25 16:16:30 59D293C7 c   (dvbapi) Demuxer 0 enable stream 1 pid=0x0200 by index=0 on ca7
2019/03/25 16:16:30 59D293C7 c   (dvbapi) Added new streampid 1020 with index 0 to ca7
2019/03/25 16:16:30 59D293C7 c   (dvbapi) Demuxer 0 disable stream 2 pid=0x1020 index=-1 on ca7
2019/03/25 16:16:30 59D293C7 c   (dvbapi) Demuxer 0 enable stream 2 pid=0x1020 by index=0 on ca7
2019/03/25 16:16:30 59D293C7 c   (dvbapi) Added new streampid 1021 with index 0 to ca7
2019/03/25 16:16:30 59D293C7 c   (dvbapi) Demuxer 0 disable stream 3 pid=0x1021 index=-1 on ca7
2019/03/25 16:16:30 59D293C7 c   (dvbapi) Demuxer 0 enable stream 3 pid=0x1021 by index=0 on ca7
2019/03/25 16:16:30 59D293C7 c   (dvbapi) Demuxer 0 ca7 is using index 0 for streampid 0200 -> write odd part of cw!
2019/03/25 16:16:30 59D293C7 c   (dvbapi) Demuxer 0 writing odd part (00112233445566778899AABBCCDDEEFF) of controlword, replacing expired (00000000000000000000000000000000)
2019/03/25 16:16:30 59D293C7 c   (dvbapi) Demuxer 0 write cw0 index: 0 (ca7)
2019/03/25 16:16:30 59D293C7 c   (dvbapi) Demuxer 0 ca7 is using index 0 for streampid 1020 -> skip, odd part of cw already written!
2019/03/25 16:16:30 59D293C7 c   (dvbapi) Demuxer 0 ca7 is using index 0 for streampid 1021 -> skip, odd part of cw already written!
2019/03/25 16:16:30 59D293C7 c   (dvbapi) Demuxer 0 ca7 is using index 0 for streampid 0200 -> write even part of cw!
2019/03/25 16:16:30 59D293C7 c   (dvbapi) Demuxer 0 writing even part (00112233445566778899AABBCCDDEEFF) of controlword, replacing expired (00000000000000000000000000000000)
2019/03/25 16:16:30 59D293C7 c   (dvbapi) Demuxer 0 write cw1 index: 0 (ca7)
2019/03/25 16:16:30 59D293C7 c   (dvbapi) Demuxer 0 ca7 is using index 0 for streampid 1020 -> skip, even part of cw already written!
2019/03/25 16:16:30 59D293C7 c   (dvbapi) Demuxer 0 ca7 is using index 0 for streampid 1021 -> skip, even part of cw already written!
2019/03/25 16:16:30 59D293C7 c      (ecm) local (2602@000000/0000/0001/15:5830FC5CAF09E084015C5A6FCFC19DC0): found (2 ms) by emulator - DSI
2019/03/25 16:16:35 59D293C7 c   (dvbapi) Demuxer 0 try to start new filter for caid: 0001, provid: 000001, pid: 0011
2019/03/25 16:16:35 59D293C7 c   (dvbapi) Open device /dev/dvb/adapter0/demux7 (fd 15)
2019/03/25 16:16:35 59D293C7 c   (dvbapi) Demuxer 0 Filter 3 started successfully (caid 0001 provid 000001 pid 0011)
2019/03/25 16:16:35 59D293C7 c   (dvbapi) Demuxer 0 filter3[0] = 42, filter mask[0] = FF, flt&mask = 42 , buffer[0] = 42, buffer[0] & mask = 42
2019/03/25 16:16:35 59D293C7 c   (dvbapi) Demuxer 0 Filter 3 fetched SDT data (length = 0x01F):
2019/03/25 16:16:35 59D293C7 c   (dvbapi)   42 F0 1C 00 01 C1 00 00 FF FF FF 00 01 FC 80 0B 
2019/03/25 16:16:35 59D293C7 c   (dvbapi)   48 09 01 03 53 54 53 03 44 53 49 34 2D C4 09 
2019/03/25 16:16:35 59D293C7 c   (dvbapi) sdt-info dbg: sdt data: 
2019/03/25 16:16:35 59D293C7 c   (dvbapi)   42 F0 1C 00 01 C1 00 00 FF FF FF 00 01 FC 80 0B 
2019/03/25 16:16:35 59D293C7 c   (dvbapi)   48 09 01 03 53 54 53 03 44 53 49 34 2D C4 09 
2019/03/25 16:16:35 59D293C7 c   (dvbapi) sdt-info dbg: iso_mode: -1 offset: 0
2019/03/25 16:16:35 59D293C7 c   (dvbapi) sdt-info dbg: raw string: 
2019/03/25 16:16:35 59D293C7 c   (dvbapi)   53 54 53 
2019/03/25 16:16:35 59D293C7 c   (dvbapi) sdt-info dbg: encoded string: 
2019/03/25 16:16:35 59D293C7 c   (dvbapi)   53 54 53 
2019/03/25 16:16:35 59D293C7 c   (dvbapi) sdt-info dbg: iso_mode: -1 offset: 0
2019/03/25 16:16:35 59D293C7 c   (dvbapi) sdt-info dbg: raw string: 
2019/03/25 16:16:35 59D293C7 c   (dvbapi)   44 53 49 
2019/03/25 16:16:35 59D293C7 c   (dvbapi) sdt-info dbg: encoded string: 
2019/03/25 16:16:35 59D293C7 c   (dvbapi)   44 53 49 
2019/03/25 16:16:35 59D293C7 c   (dvbapi) sdt-info (provider: STS - channel: DSI)
2019/03/25 16:16:35 59D293C7 c   (dvbapi) Demuxer 0 stop filter 3 try 1 (fd: 15 api: 0, caid: 0001, provid: 000001, emmpid: 0011)
2019/03/25 16:16:35 59D293C7 c   (dvbapi) Demuxer 0 flushing stale input data of filter 3 (fd:15)
2019/03/25 16:16:50 59D293C7 c   (dvbapi) Demuxer 0 try to start new filter for caid: 0001, provid: 000001, pid: 0001
2019/03/25 16:16:50 59D293C7 c   (dvbapi) Open device /dev/dvb/adapter0/demux7 (fd 17)
2019/03/25 16:16:50 59D293C7 c   (dvbapi) Demuxer 0 Filter 3 started successfully (caid 0001 provid 000001 pid 0001)
2019/03/25 16:16:50 59D293C7 c   (dvbapi) Demuxer 0 has 1 ecmpids, 3 streampids, 1 ecmfilters and 1 of max 0 emmfilters
2019/03/25 16:17:25 59D293C7 c   (dvbapi) Demuxer 0 stop descrambling program number 0001 (DSI)
2019/03/25 16:17:25 59D293C7 c   (dvbapi) Demuxer 0 stop filter 3 try 1 (fd: 17 api: 0, caid: 0001, provid: 000001, emmpid: 0001)
2019/03/25 16:17:25 59D293C7 c   (dvbapi) Demuxer 0 flushing stale input data of filter 3 (fd:17)
2019/03/25 16:17:25 59D293C7 c   (dvbapi) Demuxer 0 stop filter 1 try 1 (fd: 12 api: 0, caid: 0001, provid: 000001, emmpid: 0020)
2019/03/25 16:17:25 59D293C7 c   (dvbapi) Demuxer 0 flushing stale input data of filter 1 (fd:12)
2019/03/25 16:17:25 59D293C7 c   (dvbapi) Remove streampid 0200 using indexer 0 from ca7
2019/03/25 16:17:25 59D293C7 c   (dvbapi) Removed last indexer of streampid 0200 from ca7
2019/03/25 16:17:25 59D293C7 c   (dvbapi) Demuxer 0 disable stream 1 pid=0x0200 index=-1 on ca7
2019/03/25 16:17:25 59D293C7 c   (dvbapi) Remove streampid 1020 using indexer 0 from ca7
2019/03/25 16:17:25 59D293C7 c   (dvbapi) Removed last indexer of streampid 1020 from ca7
2019/03/25 16:17:25 59D293C7 c   (dvbapi) Demuxer 0 disable stream 2 pid=0x1020 index=-1 on ca7
2019/03/25 16:17:25 59D293C7 c   (dvbapi) Remove streampid 1021 using indexer 0 from ca7
2019/03/25 16:17:25 59D293C7 c   (dvbapi) Removed last indexer of streampid 1021 from ca7
2019/03/25 16:17:25 59D293C7 c   (dvbapi) Demuxer 0 disable stream 3 pid=0x1021 index=-1 on ca7
2019/03/25 16:17:25 59D293C7 c   (dvbapi) Demuxer 0 close now unused CA7 device
2019/03/25 16:17:25 59D293C7 c   (dvbapi) Demuxer 0 stop filter 2 try 1 (fd: 13 api: 0, caid: 2602, provid: 000000, ecmpid: 1FFF)
2019/03/25 16:17:25 59D293C7 c   (dvbapi) Demuxer 0 flushing stale input data of filter 2 (fd:13)
2019/03/25 16:17:25 59D293C7 c   (dvbapi) Socket 11 reported hard connection close
2019/03/25 16:17:26 59D293C7 c   (dvbapi) new socket connection fd: 11
2019/03/25 16:17:26 59D293C7 c   (dvbapi) Got packet with opcode 9F803256 and size 90
2019/03/25 16:17:26 59D293C7 c   (dvbapi) PMT Update on socket 11.
2019/03/25 16:17:26 59D293C7 c   (dvbapi) Parsing PMT object:
2019/03/25 16:17:26 59D293C7 c   (dvbapi)   9F 80 32 56 03 04 4F 33 00 19 01 81 08 FF FF 00 
2019/03/25 16:17:26 59D293C7 c   (dvbapi)   00 00 0B 00 01 82 02 01 00 84 02 00 CB 85 04 00 
2019/03/25 16:17:26 59D293C7 c   (dvbapi)   00 00 01 0B 00 36 00 00 0B 00 37 00 00 0B 00 38 
2019/03/25 16:17:26 59D293C7 c   (dvbapi)   00 00 0B 00 39 00 00 0B 00 3A 00 00 1B 0C E5 00 
2019/03/25 16:17:26 59D293C7 c   (dvbapi)   00 03 0C E6 00 00 06 0C E7 00 00 03 0C EA 00 00 
2019/03/25 16:17:26 59D293C7 c   (dvbapi)   05 1F 73 00 00 0B 1F 74 00 00 
2019/03/25 16:17:26 59D293C7 c   (dvbapi) capmt:
2019/03/25 16:17:26 59D293C7 c   (dvbapi)   03 04 4F 33 00 19 01 81 08 FF FF 00 00 00 0B 00 
2019/03/25 16:17:26 59D293C7 c   (dvbapi)   01 82 02 01 00 84 02 00 CB 85 04 00 00 00 01 0B 
2019/03/25 16:17:26 59D293C7 c   (dvbapi)   00 36 00 00 0B 00 37 00 00 0B 00 38 00 00 0B 00 
2019/03/25 16:17:26 59D293C7 c   (dvbapi)   39 00 00 0B 00 3A 00 00 1B 0C E5 00 00 03 0C E6 
2019/03/25 16:17:26 59D293C7 c   (dvbapi)   00 00 06 0C E7 00 00 03 0C EA 00 00 05 1F 73 00 
2019/03/25 16:17:26 59D293C7 c   (dvbapi)   00 0B 1F 74 00 00

satpong · Mar 25, 2019

Also tested with dreamos OE2.5 images (dm7080) and not working.
Works only with open images on dreambox.
(same problem like abertis 30.0°W, works only with open images)

oscam.log = empty

Code:

2019/03/25 16:48:38 00000000 s debug_level=128
2019/03/25 16:48:38 00000000 s     (main) System name    = Linux
2019/03/25 16:48:38 00000000 s     (main) Host name      = dm7080
2019/03/25 16:48:38 00000000 s     (main) Release        = 3.4-4.0-dm7080
2019/03/25 16:48:38 00000000 s     (main) Version        = #1 SMP Fri Feb 9 15:16:04 UTC 2018
2019/03/25 16:48:38 00000000 s     (main) Machine        = mips
2019/03/25 16:48:38 00000000 s     (main) Stb model      = dm7080
2019/03/25 16:48:38 00000000 s     (main) creating pidfile /tmp/.oscam/oscam.pid with pid 1072
2019/03/25 16:48:38 00000000 s      (emu) OSCam-Emu version 791
2019/03/25 16:48:38 00000000 s   (config) userdb reloaded: 1 accounts loaded, 0 expired, 0 disabled
2019/03/25 16:48:38 00000000 s     (main) signal handling initialized
2019/03/25 16:48:38 00000000 s   (config) 8 provid's loaded
2019/03/25 16:48:38 00000000 s   (config) 82 service-id's loaded in 1 ms
2019/03/25 16:48:38 00000000 s   (reader) emulator [emu] creating thread for device emulator
2019/03/25 16:48:38 00000000 s     (main) waiting for local card init
2019/03/25 16:48:38 3809A7E7 r   (reader) emulator [emu] Reader initialized (device=emulator, detect=cd, mhz=357, cardmhz=357)
2019/03/25 16:48:38 70A6F1EC h    (webif) webif: decompressed 166249 bytes back into 404040 bytes
2019/03/25 16:48:38 70A6F1EC h    (webif) HTTP Server running. ip=0.0.0.0 port=8888
2019/03/25 16:48:39 3809A7E7 r   (reader) emulator [emu] card detected
2019/03/25 16:48:40 3809A7E7 r   (reader) emulator [emu] found card system emu
2019/03/25 16:48:40 3809A7E7 r   (reader) emulator [emu] THIS WAS A SUCCESSFUL START ATTEMPT No  1 out of max alloted of 1
2019/03/25 16:48:40 3809A7E7 r      (emu) Reading key file: /usr/config/SoftCam.Key
2019/03/25 16:48:40 3809A7E7 r      (emu) Total keys in memory: W:0 V:0 N:0 I:0 S:0 F:2 G:0 P:0 D:0 T:128 A:0
2019/03/25 16:48:40 00000000 s     (main) init for all local cards done
2019/03/25 16:48:40 00000000 s (emmcache) loading emmcache disabled since no reader is using it!
2019/03/25 16:48:40 00000000 s (emmcache) loading emmstats disabled since no reader is using it!
2019/03/25 16:48:40 69C85076 c   (client) plain dvbapi-client granted (local, au=auto (1 reader))
2019/03/25 16:48:40 69C85076 c   (dvbapi) Read 0 entries from oscam.dvbapi
2019/03/25 16:48:40 69C85076 c   (dvbapi) dvbapi channelcache loaded from /usr/config/oscam.ccache
2019/03/25 16:48:40 69C85076 c   (dvbapi) Detected /dev/dvb/adapter0/demux0 Api: 0, userconfig boxtype: 1 maximum amount of possible filters is 32 (oscam limit is 32)
2019/03/25 16:49:05 69C85076 c   (dvbapi) new socket connection fd: 12
2019/03/25 16:49:05 69C85076 c   (dvbapi) Got packet with opcode 9F803F04 and size 8
2019/03/25 16:49:20 69C85076 c   (dvbapi) new socket connection fd: 13
2019/03/25 16:49:20 69C85076 c   (dvbapi) Got packet with opcode 9F803F04 and size 8
2019/03/25 16:49:20 69C85076 c   (dvbapi) Socket 13 reported hard connection close
2019/03/25 16:49:38 70A6F1EC h    (webif) Refresh Server requested by WebIF from 192.168.1.107
2019/03/25 16:50:48 69C85076 c   (dvbapi) new socket connection fd: 16
2019/03/25 16:50:48 69C85076 c   (dvbapi) Got packet with opcode 9F803F04 and size 8
2019/03/25 16:50:48 69C85076 c   (dvbapi) Socket 16 reported hard connection close

enigma2.log

Code:

-- Logs begin at Mon 2019-03-25 16:44:04 CET. --
Mar 25 16:59:05 dm7080 enigma2[1427]: setIoPrio best-effort level 5 ok
Mar 25 16:59:05 dm7080 enigma2[1427]: FILEPUSH THREAD START
Mar 25 16:59:05 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 0, m_skipmode_m = 0!
Mar 25 16:59:05 dm7080 enigma2[1427]: no version filtering
Mar 25 16:59:05 dm7080 enigma2[1427]: 0012:  4e 00 00 00 00 00
Mar 25 16:59:05 dm7080 enigma2[1427]: mask:  ff ff ff 00 00 00
Mar 25 16:59:05 dm7080 enigma2[1427]: mode:  00 00 00 00 00 00
Mar 25 16:59:05 dm7080 enigma2[1427]: skip
Mar 25 16:59:05 dm7080 enigma2[1427]: result: 239324, 9fffc4 (239324 109575988)
Mar 25 16:59:05 dm7080 enigma2[1427]: ok ... now we start!!
Mar 25 16:59:05 dm7080 enigma2[1427]: no version filtering
Mar 25 16:59:05 dm7080 enigma2[1427]: 0020:  02 00 01 00 00 00
Mar 25 16:59:05 dm7080 enigma2[1427]: mask:  ff ff ff 00 00 00
Mar 25 16:59:05 dm7080 enigma2[1427]: mode:  00 00 00 00 00 00
Mar 25 16:59:05 dm7080 enigma2[1427]: realpath /data/cissa-sample.txt: No such file or directory
Mar 25 16:59:05 dm7080 enigma2[1427]: realpath /data/cissa-sample.ts.****: No such file or directory
Mar 25 16:59:05 dm7080 enigma2[1427]: realpath /data/recordings.epl: No such file or directory
Mar 25 16:59:05 dm7080 enigma2[1427]: [TeleText] service started
Mar 25 16:59:05 dm7080 enigma2[1427]: new service started! trying to download cuts!
Mar 25 16:59:05 dm7080 enigma2[1427]: W/  [gMoviePlayer.__servicePlaying] :: <no detail>
Mar 25 16:59:05 dm7080 enigma2[1427]: I/  [gMoviePlayer.setPlaybackState] :: None None 1553529545.97
Mar 25 16:59:05 dm7080 enigma2[1427]: [HbbTV].aitInvalidated
Mar 25 16:59:05 dm7080 enigma2[1427]: I/  [gMoviePlayer.__restoreState] :: <no detail>
Mar 25 16:59:06 dm7080 enigma2[1427]: create buffer for widget 1920 x 525
Mar 25 16:59:06 dm7080 enigma2[1427]: [NotificationQueue::popNotification] domain InfoBar deferred_callable: False
Mar 25 16:59:06 dm7080 enigma2[1427]: create buffer for widget 728 x 363
Mar 25 16:59:06 dm7080 enigma2[1427]: + 1/1 TID 02
Mar 25 16:59:06 dm7080 enigma2[1427]: done!
Mar 25 16:59:06 dm7080 enigma2[1427]: eventNewProgramInfo 0 0
Mar 25 16:59:06 dm7080 enigma2[1427]: have 1 video stream(s) (0200), and 2 audio stream(s) (1020, 1021), and the pcr pid is 0200, and the text pid is ffffffff
Mar 25 16:59:06 dm7080 enigma2[1427]: PES filter: DMX_SET_PES_FILTER - Invalid argument
Mar 25 16:59:06 dm7080 enigma2[1427]: decoder state: play, vpid=512, apid=4128
Mar 25 16:59:06 dm7080 enigma2[1427]: DMX_SET_PES_FILTER(0x1020) - audio - ok
Mar 25 16:59:06 dm7080 enigma2[1427]: DEMUX_START - audio - ok
Mar 25 16:59:06 dm7080 enigma2[1427]: AUDIO_SET_BYPASS(1) - ok
Mar 25 16:59:06 dm7080 enigma2[1427]: AUDIO_PAUSE - ok
Mar 25 16:59:06 dm7080 enigma2[1427]: AUDIO_PLAY - ok
Mar 25 16:59:06 dm7080 enigma2[1427]: Video Device: /dev/dvb/adapter0/video0
Mar 25 16:59:06 dm7080 enigma2[1427]: demux device: /dev/dvb/adapter0/demux7
Mar 25 16:59:06 dm7080 enigma2[1427]: VIDEO_SET_STREAMTYPE 1 - ok
Mar 25 16:59:06 dm7080 enigma2[1427]: DMX_SET_PES_FILTER(0x200) - video - ok
Mar 25 16:59:06 dm7080 enigma2[1427]: DEMUX_START - video - ok
Mar 25 16:59:06 dm7080 enigma2[1427]: VIDEO_FREEZE - ok
Mar 25 16:59:06 dm7080 enigma2[1427]: VIDEO_PLAY - ok
Mar 25 16:59:06 dm7080 enigma2[1427]: VIDEO_SLOWMOTION(0) - ok
Mar 25 16:59:06 dm7080 enigma2[1427]: VIDEO_FAST_FORWARD(0) - ok
Mar 25 16:59:06 dm7080 enigma2[1427]: VIDEO_CONTINUE - ok
Mar 25 16:59:06 dm7080 enigma2[1427]: AUDIO_CONTINUE - ok
Mar 25 16:59:06 dm7080 enigma2[1427]: W/  [gMoviePlayer.__servicePlaying] :: <no detail>
Mar 25 16:59:06 dm7080 enigma2[1427]: I/  [gMoviePlayer.setPlaybackState] :: None None 1553529546.21
Mar 25 16:59:06 dm7080 enigma2[1427]: [eDBusInterface::Private::sendEvent 1
Mar 25 16:59:06 dm7080 enigma2[1427]: eDVBServicePlay::seekTo: jump 0
Mar 25 16:59:06 dm7080 enigma2[1427]: seek.
Mar 25 16:59:06 dm7080 enigma2[1427]: stopping thread.
Mar 25 16:59:06 dm7080 enigma2[1427]: FILEPUSH THREAD STOP
Mar 25 16:59:06 dm7080 enigma2[1427]: thread joined 0
Mar 25 16:59:06 dm7080 enigma2[1427]: AUDIO_CLEAR_BUFFER - ok
Mar 25 16:59:06 dm7080 enigma2[1427]: VIDEO_CLEAR_BUFFER - ok
Mar 25 16:59:06 dm7080 enigma2[1427]: before: 1
Mar 25 16:59:06 dm7080 enigma2[1427]: after: 1
Mar 25 16:59:06 dm7080 enigma2[1427]: setIoPrio best-effort level 5 ok
Mar 25 16:59:06 dm7080 enigma2[1427]: FILEPUSH THREAD START
Mar 25 16:59:06 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 4099340, m_skipmode_m = 0!
Mar 25 16:59:06 dm7080 enigma2[1427]: getOffset for pts 0x0
Mar 25 16:59:06 dm7080 enigma2[1427]: using: 0:0 -> 239324:239324
Mar 25 16:59:06 dm7080 enigma2[1427]: PCR        145d844bd found at 239324 pid 200 (47 02 00 bd 07 10 a2 ec 22 5e ff)
Mar 25 16:59:06 dm7080 enigma2[1427]: adding sample 239324: pts 0x0 -> pos 239324 (diff 0 bytes)
Mar 25 16:59:06 dm7080 enigma2[1427]: calculated diff 0 ms
Mar 25 16:59:06 dm7080 enigma2[1427]: aborting. Taking 239324 as offset for 0
Mar 25 16:59:06 dm7080 enigma2[1427]: ok, resolved skip (rel: 0, diff 0), now at 239324
Mar 25 16:59:06 dm7080 enigma2[1427]: HIT, 239324 < 239324 < 109575988, size: 10485700
Mar 25 16:59:06 dm7080 enigma2[1427]: [TeleText] serviceInfoChanged
Mar 25 16:59:06 dm7080 enigma2[1427]: [TeleText] TXT PID -1 DEMUX 7
Mar 25 16:59:06 dm7080 enigma2[1427]: doing version filtering
Mar 25 16:59:06 dm7080 enigma2[1427]: 0020:  02 00 01 01 00 00
Mar 25 16:59:06 dm7080 enigma2[1427]: mask:  ff ff ff 3f 00 00
Mar 25 16:59:06 dm7080 enigma2[1427]: mode:  00 00 00 3e 00 00
Mar 25 16:59:07 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 10725024, m_skipmode_m = 0!
Mar 25 16:59:07 dm7080 enigma2[1427]: HIT, 239324 < 10725024 < 109575988, size: 10485700
Mar 25 16:59:07 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 21210724, m_skipmode_m = 0!
Mar 25 16:59:07 dm7080 enigma2[1427]: HIT, 239324 < 21210724 < 109575988, size: 10485700
Mar 25 16:59:08 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 31696424, m_skipmode_m = 0!
Mar 25 16:59:08 dm7080 enigma2[1427]: HIT, 239324 < 31696424 < 109575988, size: 10485700
Mar 25 16:59:08 dm7080 enigma2[1427]: [    0] prepareClose running loop
Mar 25 16:59:08 dm7080 enigma2[1427]: [SEC-0] lock 0
Mar 25 16:59:08 dm7080 enigma2[1427]: [SEC-0] locked 0
Mar 25 16:59:08 dm7080 enigma2[1427]: [SEC-0] sendDiseqc: e01002 (DiSEqC peripherial power off)
Mar 25 16:59:08 dm7080 enigma2[1427]: [SEC-0] sleep 150ms
Mar 25 16:59:08 dm7080 enigma2[1427]: timeout 0012!
Mar 25 16:59:08 dm7080 enigma2[1427]: W/  [gMoviePlayer.__servicePlaying] :: <no detail>
Mar 25 16:59:09 dm7080 enigma2[1427]: I/  [gMoviePlayer.setPlaybackState] :: None None 1553529548.94
Mar 25 16:59:09 dm7080 enigma2[1427]: [SEC-0] delayed close frontend
Mar 25 16:59:09 dm7080 enigma2[1427]: [SEC-0] unlock 0
Mar 25 16:59:09 dm7080 enigma2[1427]: [    0] close frontend
Mar 25 16:59:09 dm7080 enigma2[1427]: [SEC-0] setVoltage 0V
Mar 25 16:59:09 dm7080 enigma2[1427]: action ->  MsgBoxActions ok
Mar 25 16:59:09 dm7080 enigma2[1427]: I/  [gMoviePlayer.__restoreState] :: <no detail>
Mar 25 16:59:09 dm7080 enigma2[1427]: eDVBServicePlay::seekTo: jump 3123166019
Mar 25 16:59:09 dm7080 enigma2[1427]: seek.
Mar 25 16:59:09 dm7080 enigma2[1427]: stopping thread.
Mar 25 16:59:09 dm7080 enigma2[1427]: FILEPUSH THREAD STOP
Mar 25 16:59:09 dm7080 enigma2[1427]: thread joined 0
Mar 25 16:59:09 dm7080 enigma2[1427]: AUDIO_CLEAR_BUFFER - ok
Mar 25 16:59:09 dm7080 enigma2[1427]: VIDEO_CLEAR_BUFFER - ok
Mar 25 16:59:09 dm7080 enigma2[1427]: before: 1
Mar 25 16:59:09 dm7080 enigma2[1427]: after: 1
Mar 25 16:59:09 dm7080 enigma2[1427]: setIoPrio best-effort level 5 ok
Mar 25 16:59:09 dm7080 enigma2[1427]: FILEPUSH THREAD START
Mar 25 16:59:09 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 39743576, m_skipmode_m = 0!
Mar 25 16:59:09 dm7080 enigma2[1427]: getOffset for pts 0xba27bb43
Mar 25 16:59:09 dm7080 enigma2[1427]: using: 3b6806:4d444e -> 84143160:109576176
Mar 25 16:59:09 dm7080 enigma2[1427]: eDVBTSTools::getPTS read error
Mar 25 16:59:09 dm7080 enigma2[1427]: no sample taken, refinement not possible.
Mar 25 16:59:09 dm7080 enigma2[1427]: aborting. Taking 67860511772 as offset for ba27bb43
Mar 25 16:59:09 dm7080 enigma2[1427]: ok, resolved skip (rel: 0, diff 3123166019), now at 67860511772
Mar 25 16:59:09 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 16:59:09 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 16:59:09 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 16:59:09 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:09 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:09 dm7080 enigma2[1427]: eDVBServicePlay::pause
Mar 25 16:59:09 dm7080 enigma2[1427]: decoder state: pause, vpid=512, apid=4128
Mar 25 16:59:09 dm7080 enigma2[1427]: VIDEO_SLOWMOTION(0) - ok
Mar 25 16:59:09 dm7080 enigma2[1427]: VIDEO_FAST_FORWARD(0) - ok
Mar 25 16:59:09 dm7080 enigma2[1427]: VIDEO_FREEZE - ok
Mar 25 16:59:09 dm7080 enigma2[1427]: AUDIO_PAUSE - ok
Mar 25 16:59:09 dm7080 enigma2[1427]: create buffer for widget 1920 x 525
Mar 25 16:59:09 dm7080 enigma2[1427]: [eDBusInterface::Private::sendEvent 2
Mar 25 16:59:09 dm7080 enigma2[1427]: resolved to PAUSE 0
Mar 25 16:59:09 dm7080 enigma2[1427]: I/  [TemplatedListFonts.__init__] :: Bigger: 32, Regular
Mar 25 16:59:09 dm7080 enigma2[1427]: I/  [TemplatedListFonts.__init__] :: Big: 30, Regular
Mar 25 16:59:09 dm7080 enigma2[1427]: I/  [TemplatedListFonts.__init__] :: Medium: 28, Regular
Mar 25 16:59:09 dm7080 enigma2[1427]: I/  [TemplatedListFonts.__init__] :: Small: 26, Regular
Mar 25 16:59:09 dm7080 enigma2[1427]: I/  [TemplatedListFonts.__init__] :: Smaller: 24, Regular
Mar 25 16:59:09 dm7080 enigma2[1427]: create buffer for widget 966 x 379
Mar 25 16:59:09 dm7080 enigma2[1427]: [eDBusInterface::Private::sendEvent 0
Mar 25 16:59:10 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 67860511772, m_skipmode_m = 0!
Mar 25 16:59:10 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 16:59:10 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 16:59:10 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 16:59:10 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:10 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:11 dm7080 enigma2[1427]: action ->  WizardActions down
Mar 25 16:59:11 dm7080 enigma2[1427]: action ->  DirectionActions downUp
Mar 25 16:59:11 dm7080 enigma2[1427]: unknown action DirectionActions/downUp! typo in keymap?
Mar 25 16:59:11 dm7080 enigma2[1427]: action ->  WizardActions down
Mar 25 16:59:11 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 67860511772, m_skipmode_m = 0!
Mar 25 16:59:11 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 16:59:11 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 16:59:11 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 16:59:11 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:11 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:11 dm7080 enigma2[1427]: action ->  DirectionActions downUp
Mar 25 16:59:11 dm7080 enigma2[1427]: unknown action DirectionActions/downUp! typo in keymap?
Mar 25 16:59:11 dm7080 enigma2[1427]: action ->  WizardActions up
Mar 25 16:59:11 dm7080 enigma2[1427]: action ->  DirectionActions upUp
Mar 25 16:59:11 dm7080 enigma2[1427]: unknown action DirectionActions/upUp! typo in keymap?
Mar 25 16:59:12 dm7080 enigma2[1427]: action ->  WizardActions ok
Mar 25 16:59:12 dm7080 enigma2[1427]: I/  [gMoviePlayer.__restoreState] :: <no detail>
Mar 25 16:59:12 dm7080 enigma2[1427]: playAgain
Mar 25 16:59:12 dm7080 enigma2[1427]: stopCurrent
Mar 25 16:59:12 dm7080 enigma2[1427]: stopService
Mar 25 16:59:12 dm7080 enigma2[1427]: stopping thread.
Mar 25 16:59:12 dm7080 enigma2[1427]: FILEPUSH THREAD STOP
Mar 25 16:59:12 dm7080 enigma2[1427]: thread joined 0
Mar 25 16:59:12 dm7080 enigma2[1427]: [TeleText] service stopped
Mar 25 16:59:12 dm7080 enigma2[1427]: [TeleText] send array('B', [1, 0, 0, 0])
Mar 25 16:59:12 dm7080 enigma2[1427]: disable dvb subtitles
Mar 25 16:59:12 dm7080 enigma2[1427]: disable teletext subtitles page ffffffffffffffff (und)
Mar 25 16:59:12 dm7080 enigma2[1427]: realpath /data/cissa-sample.ts.****: No such file or directory
Mar 25 16:59:12 dm7080 enigma2[1427]: realpath /data/recordings.epl: No such file or directory
Mar 25 16:59:12 dm7080 enigma2[1427]: decoder state: pause, vpid=-1, apid=-1
Mar 25 16:59:12 dm7080 enigma2[1427]: DEMUX_STOP - video - ok
Mar 25 16:59:12 dm7080 enigma2[1427]: VIDEO_STOP - ok
Mar 25 16:59:12 dm7080 enigma2[1427]: AUDIO_STOP - ok
Mar 25 16:59:12 dm7080 enigma2[1427]: DEMUX_STOP - audio - ok
Mar 25 16:59:12 dm7080 enigma2[1427]: AUDIO_CONTINUE - ok
Mar 25 16:59:12 dm7080 enigma2[1427]: playing 1:0:0:0:0:0:0:0:0:0:/data/cissa-sample.ts
Mar 25 16:59:12 dm7080 enigma2[1427]: realpath /data/cissa-sample.ts.****: No such file or directory
Mar 25 16:59:12 dm7080 enigma2[1427]: realpath /data/recordings.epl: No such file or directory
Mar 25 16:59:12 dm7080 enigma2[1427]: realpath /data/cissa-sample.ts.****: No such file or directory
Mar 25 16:59:12 dm7080 enigma2[1427]: realpath /data/recordings.epl: No such file or directory
Mar 25 16:59:12 dm7080 enigma2[1427]: no .**** file found, trying to find PMT pid
Mar 25 16:59:12 dm7080 enigma2[1427]: PMT pid found on pid 0020, service id 1
Mar 25 16:59:12 dm7080 enigma2[1427]: alloc PVR
Mar 25 16:59:12 dm7080 enigma2[1427]: allocate channel.. 0000:0000:00000000 (/data/cissa-sample.ts)
Mar 25 16:59:12 dm7080 enigma2[1427]: allocate pvr demux
Mar 25 16:59:12 dm7080 enigma2[1427]: getting program info failed.
Mar 25 16:59:12 dm7080 enigma2[1427]: disable teletext subtitles page ffffffffffffffff (und)
Mar 25 16:59:12 dm7080 enigma2[1427]: PES filter: DMX_SET_PES_FILTER - Invalid argument
Mar 25 16:59:12 dm7080 enigma2[1427]: decoder state: play, vpid=-1, apid=-1
Mar 25 16:59:12 dm7080 enigma2[1427]: W/  [gMoviePlayer.__servicePlaying] :: <no detail>
Mar 25 16:59:12 dm7080 enigma2[1427]: I/  [gMoviePlayer.setPlaybackState] :: None None 1553529552.27
Mar 25 16:59:12 dm7080 enigma2[1427]: loading streaminfo for /data/cissa-sample.ts
Mar 25 16:59:12 dm7080 enigma2[1427]: loading cuts..
Mar 25 16:59:12 dm7080 enigma2[1427]: 2 entries
Mar 25 16:59:12 dm7080 enigma2[1427]: PCR        145d844bd found at 239324 pid 200 (47 02 00 bd 07 10 a2 ec 22 5e ff)
Mar 25 16:59:12 dm7080 enigma2[1427]: PCR        14625890b found at 109353960 pid 200 (47 02 00 ba 07 10 a3 12 c4 85 fe)
Mar 25 16:59:12 dm7080 enigma2[1427]: getOffset for pts 0x0
Mar 25 16:59:12 dm7080 enigma2[1427]: samples step 41942988, pts begin 145d844bd, pts end 14625890b, offs begin 239324, offs end 109576176:
Mar 25 16:59:12 dm7080 enigma2[1427]: PCR        145d844bd found at 239324 pid 200 (47 02 00 bd 07 10 a2 ec 22 5e ff)
Mar 25 16:59:12 dm7080 enigma2[1427]: adding sample 239324: pts 0x0 -> pos 239324 (diff 0 bytes)
Mar 25 16:59:12 dm7080 enigma2[1427]: PCR        145f5f9bc found at 42191148 pid 200 (47 02 00 bd 07 10 a2 fa fc de 7e)
Mar 25 16:59:12 dm7080 enigma2[1427]: adding sample 42182312: pts 0x1db4ff -> pos 42191148 (diff 8836 bytes)
Mar 25 16:59:12 dm7080 enigma2[1427]: PCR        14613acc3 found at 84143160 pid 200 (47 02 00 bc 07 10 a3 09 d7 61 fe)
Mar 25 16:59:12 dm7080 enigma2[1427]: adding sample 84125300: pts 0x3b6806 -> pos 84143160 (diff 17860 bytes)
Mar 25 16:59:12 dm7080 enigma2[1427]: using: 0:0 -> 239324:239324
Mar 25 16:59:12 dm7080 enigma2[1427]: PCR        145d844bd found at 239324 pid 200 (47 02 00 bd 07 10 a2 ec 22 5e ff)
Mar 25 16:59:12 dm7080 enigma2[1427]: adding sample 239324: pts 0x0 -> pos 239324 (diff 0 bytes)
Mar 25 16:59:12 dm7080 enigma2[1427]: calculated diff 0 ms
Mar 25 16:59:12 dm7080 enigma2[1427]: aborting. Taking 239324 as offset for 0
Mar 25 16:59:12 dm7080 enigma2[1427]: getOffset for pts 0x4d444e
Mar 25 16:59:12 dm7080 enigma2[1427]: using: 3b6806:4d444e -> 84143160:109576176
Mar 25 16:59:12 dm7080 enigma2[1427]: eDVBTSTools::getPTS read error
Mar 25 16:59:12 dm7080 enigma2[1427]: no sample taken, refinement not possible.
Mar 25 16:59:12 dm7080 enigma2[1427]: aborting. Taking 109575988 as offset for 4d444e
Mar 25 16:59:12 dm7080 enigma2[1427]: source span: 0 .. 4d444e, translated to 239324..109575988
Mar 25 16:59:12 dm7080 enigma2[1427]: before: 1
Mar 25 16:59:12 dm7080 enigma2[1427]: after: 1
Mar 25 16:59:12 dm7080 enigma2[1427]: setIoPrio best-effort level 5 ok
Mar 25 16:59:12 dm7080 enigma2[1427]: FILEPUSH THREAD START
Mar 25 16:59:12 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 0, m_skipmode_m = 0!
Mar 25 16:59:12 dm7080 enigma2[1427]: skip
Mar 25 16:59:12 dm7080 enigma2[1427]: result: 239324, 9fffc4 (239324 109575988)
Mar 25 16:59:12 dm7080 enigma2[1427]: no version filtering
Mar 25 16:59:12 dm7080 enigma2[1427]: 0012:  4e 00 00 00 00 00
Mar 25 16:59:12 dm7080 enigma2[1427]: mask:  ff ff ff 00 00 00
Mar 25 16:59:12 dm7080 enigma2[1427]: mode:  00 00 00 00 00 00
Mar 25 16:59:12 dm7080 enigma2[1427]: ok ... now we start!!
Mar 25 16:59:12 dm7080 enigma2[1427]: no version filtering
Mar 25 16:59:12 dm7080 enigma2[1427]: 0020:  02 00 01 00 00 00
Mar 25 16:59:12 dm7080 enigma2[1427]: mask:  ff ff ff 00 00 00
Mar 25 16:59:12 dm7080 enigma2[1427]: mode:  00 00 00 00 00 00
Mar 25 16:59:12 dm7080 enigma2[1427]: realpath /data/cissa-sample.txt: No such file or directory
Mar 25 16:59:12 dm7080 enigma2[1427]: realpath /data/cissa-sample.ts.****: No such file or directory
Mar 25 16:59:12 dm7080 enigma2[1427]: realpath /data/recordings.epl: No such file or directory
Mar 25 16:59:12 dm7080 enigma2[1427]: [TeleText] service started
Mar 25 16:59:12 dm7080 enigma2[1427]: W/  [gMoviePlayer.__servicePlaying] :: <no detail>
Mar 25 16:59:12 dm7080 enigma2[1427]: I/  [gMoviePlayer.setPlaybackState] :: None None 1553529552.34
Mar 25 16:59:12 dm7080 enigma2[1427]: [HbbTV].aitInvalidated
Mar 25 16:59:12 dm7080 enigma2[1427]: + 1/1 TID 02
Mar 25 16:59:12 dm7080 enigma2[1427]: done!
Mar 25 16:59:12 dm7080 enigma2[1427]: eventNewProgramInfo 0 0
Mar 25 16:59:12 dm7080 enigma2[1427]: have 1 video stream(s) (0200), and 2 audio stream(s) (1020, 1021), and the pcr pid is 0200, and the text pid is ffffffff
Mar 25 16:59:12 dm7080 enigma2[1427]: PES filter: DMX_SET_PES_FILTER - Invalid argument
Mar 25 16:59:12 dm7080 enigma2[1427]: decoder state: play, vpid=512, apid=4128
Mar 25 16:59:12 dm7080 enigma2[1427]: DMX_SET_PES_FILTER(0x1020) - audio - ok
Mar 25 16:59:12 dm7080 enigma2[1427]: DEMUX_START - audio - ok
Mar 25 16:59:12 dm7080 enigma2[1427]: AUDIO_SET_BYPASS(1) - ok
Mar 25 16:59:12 dm7080 enigma2[1427]: AUDIO_PAUSE - ok
Mar 25 16:59:12 dm7080 enigma2[1427]: AUDIO_PLAY - ok
Mar 25 16:59:12 dm7080 enigma2[1427]: Video Device: /dev/dvb/adapter0/video0
Mar 25 16:59:12 dm7080 enigma2[1427]: demux device: /dev/dvb/adapter0/demux7
Mar 25 16:59:12 dm7080 enigma2[1427]: VIDEO_SET_STREAMTYPE 1 - ok
Mar 25 16:59:12 dm7080 enigma2[1427]: DMX_SET_PES_FILTER(0x200) - video - ok
Mar 25 16:59:12 dm7080 enigma2[1427]: DEMUX_START - video - ok
Mar 25 16:59:12 dm7080 enigma2[1427]: VIDEO_FREEZE - ok
Mar 25 16:59:12 dm7080 enigma2[1427]: VIDEO_PLAY - ok
Mar 25 16:59:12 dm7080 enigma2[1427]: VIDEO_SLOWMOTION(0) - ok
Mar 25 16:59:12 dm7080 enigma2[1427]: VIDEO_FAST_FORWARD(0) - ok
Mar 25 16:59:12 dm7080 enigma2[1427]: VIDEO_CONTINUE - ok
Mar 25 16:59:12 dm7080 enigma2[1427]: AUDIO_CONTINUE - ok
Mar 25 16:59:12 dm7080 enigma2[1427]: W/  [gMoviePlayer.__servicePlaying] :: <no detail>
Mar 25 16:59:12 dm7080 enigma2[1427]: I/  [gMoviePlayer.setPlaybackState] :: None None 1553529552.42
Mar 25 16:59:12 dm7080 enigma2[1427]: [eDBusInterface::Private::sendEvent 1
Mar 25 16:59:12 dm7080 enigma2[1427]: eDVBServicePlay::seekTo: jump 0
Mar 25 16:59:12 dm7080 enigma2[1427]: seek.
Mar 25 16:59:12 dm7080 enigma2[1427]: stopping thread.
Mar 25 16:59:12 dm7080 enigma2[1427]: FILEPUSH THREAD STOP
Mar 25 16:59:12 dm7080 enigma2[1427]: thread joined 0
Mar 25 16:59:12 dm7080 enigma2[1427]: AUDIO_CLEAR_BUFFER - ok
Mar 25 16:59:12 dm7080 enigma2[1427]: VIDEO_CLEAR_BUFFER - ok
Mar 25 16:59:12 dm7080 enigma2[1427]: before: 1
Mar 25 16:59:12 dm7080 enigma2[1427]: after: 1
Mar 25 16:59:12 dm7080 enigma2[1427]: setIoPrio best-effort level 5 ok
Mar 25 16:59:12 dm7080 enigma2[1427]: FILEPUSH THREAD START
Mar 25 16:59:12 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 2005772, m_skipmode_m = 0!
Mar 25 16:59:12 dm7080 enigma2[1427]: getOffset for pts 0x0
Mar 25 16:59:12 dm7080 enigma2[1427]: using: 0:0 -> 239324:239324
Mar 25 16:59:12 dm7080 enigma2[1427]: PCR        145d844bd found at 239324 pid 200 (47 02 00 bd 07 10 a2 ec 22 5e ff)
Mar 25 16:59:12 dm7080 enigma2[1427]: adding sample 239324: pts 0x0 -> pos 239324 (diff 0 bytes)
Mar 25 16:59:12 dm7080 enigma2[1427]: calculated diff 0 ms
Mar 25 16:59:12 dm7080 enigma2[1427]: aborting. Taking 239324 as offset for 0
Mar 25 16:59:12 dm7080 enigma2[1427]: ok, resolved skip (rel: 0, diff 0), now at 239324
Mar 25 16:59:12 dm7080 enigma2[1427]: HIT, 239324 < 239324 < 109575988, size: 10485700
Mar 25 16:59:12 dm7080 enigma2[1427]: [TeleText] serviceInfoChanged
Mar 25 16:59:12 dm7080 enigma2[1427]: [TeleText] TXT PID -1 DEMUX 7
Mar 25 16:59:12 dm7080 enigma2[1427]: doing version filtering
Mar 25 16:59:12 dm7080 enigma2[1427]: 0020:  02 00 01 01 00 00
Mar 25 16:59:12 dm7080 enigma2[1427]: mask:  ff ff ff 3f 00 00
Mar 25 16:59:12 dm7080 enigma2[1427]: mode:  00 00 00 3e 00 00
Mar 25 16:59:13 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 10725024, m_skipmode_m = 0!
Mar 25 16:59:13 dm7080 enigma2[1427]: HIT, 239324 < 10725024 < 109575988, size: 10485700
Mar 25 16:59:13 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 21210724, m_skipmode_m = 0!
Mar 25 16:59:14 dm7080 enigma2[1427]: HIT, 239324 < 21210724 < 109575988, size: 10485700
Mar 25 16:59:14 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 31696424, m_skipmode_m = 0!
Mar 25 16:59:14 dm7080 enigma2[1427]: HIT, 239324 < 31696424 < 109575988, size: 10485700
Mar 25 16:59:15 dm7080 enigma2[1427]: timeout 0012!
Mar 25 16:59:15 dm7080 enigma2[1427]: W/  [gMoviePlayer.__servicePlaying] :: <no detail>
Mar 25 16:59:15 dm7080 enigma2[1427]: I/  [gMoviePlayer.setPlaybackState] :: None None 1553529555.31
Mar 25 16:59:15 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 42182124, m_skipmode_m = 0!
Mar 25 16:59:15 dm7080 enigma2[1427]: HIT, 239324 < 42182124 < 109575988, size: 10485700
Mar 25 16:59:16 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 52667824, m_skipmode_m = 0!
Mar 25 16:59:16 dm7080 enigma2[1427]: HIT, 239324 < 52667824 < 109575988, size: 10485700
Mar 25 16:59:17 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 63153524, m_skipmode_m = 0!
Mar 25 16:59:17 dm7080 enigma2[1427]: HIT, 239324 < 63153524 < 109575988, size: 10485700
Mar 25 16:59:17 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 73639224, m_skipmode_m = 0!
Mar 25 16:59:17 dm7080 enigma2[1427]: HIT, 239324 < 73639224 < 109575988, size: 10485700
Mar 25 16:59:18 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 84124924, m_skipmode_m = 0!
Mar 25 16:59:18 dm7080 enigma2[1427]: HIT, 239324 < 84124924 < 109575988, size: 10485700
Mar 25 16:59:19 dm7080 enigma2[1427]: It's now  ma 25 mrt 2019 16:59:18 CET
Mar 25 16:59:19 dm7080 enigma2[1427]: [timer.py] next activation: 1553529659 (in 99999 ms)
Mar 25 16:59:19 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 94610624, m_skipmode_m = 0!
Mar 25 16:59:19 dm7080 enigma2[1427]: HIT, 239324 < 94610624 < 109575988, size: 10485700
Mar 25 16:59:20 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 105096324, m_skipmode_m = 0!
Mar 25 16:59:20 dm7080 enigma2[1427]: HIT, 239324 < 105096324 < 109575988, size: 4479664
Mar 25 16:59:20 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 16:59:20 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 16:59:20 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 16:59:20 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 16:59:20 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:20 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:20 dm7080 enigma2[1427]: eDVBServicePlay::pause
Mar 25 16:59:20 dm7080 enigma2[1427]: decoder state: pause, vpid=512, apid=4128
Mar 25 16:59:20 dm7080 enigma2[1427]: VIDEO_SLOWMOTION(0) - ok
Mar 25 16:59:20 dm7080 enigma2[1427]: VIDEO_FAST_FORWARD(0) - ok
Mar 25 16:59:20 dm7080 enigma2[1427]: VIDEO_FREEZE - ok
Mar 25 16:59:20 dm7080 enigma2[1427]: AUDIO_PAUSE - ok
Mar 25 16:59:20 dm7080 enigma2[1427]: create buffer for widget 1920 x 525
Mar 25 16:59:20 dm7080 enigma2[1427]: [eDBusInterface::Private::sendEvent 2
Mar 25 16:59:20 dm7080 enigma2[1427]: resolved to PAUSE 0
Mar 25 16:59:20 dm7080 enigma2[1427]: I/  [TemplatedListFonts.__init__] :: Bigger: 32, Regular
Mar 25 16:59:20 dm7080 enigma2[1427]: I/  [TemplatedListFonts.__init__] :: Big: 30, Regular
Mar 25 16:59:20 dm7080 enigma2[1427]: I/  [TemplatedListFonts.__init__] :: Medium: 28, Regular
Mar 25 16:59:20 dm7080 enigma2[1427]: I/  [TemplatedListFonts.__init__] :: Small: 26, Regular
Mar 25 16:59:20 dm7080 enigma2[1427]: I/  [TemplatedListFonts.__init__] :: Smaller: 24, Regular
Mar 25 16:59:20 dm7080 enigma2[1427]: create buffer for widget 966 x 379
Mar 25 16:59:20 dm7080 enigma2[1427]: [eDBusInterface::Private::sendEvent 0
Mar 25 16:59:21 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 16:59:21 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 16:59:21 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 16:59:21 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 16:59:21 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:21 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:22 dm7080 enigma2[1427]: It's now  ma 25 mrt 2019 16:59:21 CET
Mar 25 16:59:22 dm7080 enigma2[1427]: [timer.py] next activation: 1553529661 (in 99000 ms)
Mar 25 16:59:22 dm7080 enigma2[1427]: action ->  WizardActions down
Mar 25 16:59:22 dm7080 enigma2[1427]: action ->  DirectionActions downUp
Mar 25 16:59:22 dm7080 enigma2[1427]: unknown action DirectionActions/downUp! typo in keymap?
Mar 25 16:59:22 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 16:59:22 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 16:59:22 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 16:59:22 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 16:59:22 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:22 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:23 dm7080 enigma2[1427]: It's now  ma 25 mrt 2019 16:59:22 CET
Mar 25 16:59:23 dm7080 enigma2[1427]: [timer.py] next activation: 1553529662 (in 99000 ms)
Mar 25 16:59:23 dm7080 enigma2[1427]: action ->  WizardActions ok
Mar 25 16:59:23 dm7080 enigma2[1427]: I/  [gMoviePlayer.__restoreState] :: <no detail>
Mar 25 16:59:23 dm7080 enigma2[1427]: playAgain
Mar 25 16:59:23 dm7080 enigma2[1427]: stopCurrent
Mar 25 16:59:23 dm7080 enigma2[1427]: stopService
Mar 25 16:59:23 dm7080 enigma2[1427]: stopping thread.
Mar 25 16:59:23 dm7080 enigma2[1427]: FILEPUSH THREAD STOP
Mar 25 16:59:23 dm7080 enigma2[1427]: thread joined 0
Mar 25 16:59:23 dm7080 enigma2[1427]: [TeleText] service stopped
Mar 25 16:59:23 dm7080 enigma2[1427]: [TeleText] send array('B', [1, 0, 0, 0])
Mar 25 16:59:23 dm7080 enigma2[1427]: disable dvb subtitles
Mar 25 16:59:23 dm7080 enigma2[1427]: disable teletext subtitles page ffffffffffffffff (und)
Mar 25 16:59:23 dm7080 enigma2[1427]: realpath /data/cissa-sample.ts.****: No such file or directory
Mar 25 16:59:23 dm7080 enigma2[1427]: realpath /data/recordings.epl: No such file or directory
Mar 25 16:59:23 dm7080 enigma2[1427]: decoder state: pause, vpid=-1, apid=-1
Mar 25 16:59:23 dm7080 enigma2[1427]: DEMUX_STOP - video - ok
Mar 25 16:59:23 dm7080 enigma2[1427]: VIDEO_STOP - ok
Mar 25 16:59:23 dm7080 enigma2[1427]: AUDIO_STOP - ok
Mar 25 16:59:23 dm7080 enigma2[1427]: DEMUX_STOP - audio - ok
Mar 25 16:59:23 dm7080 enigma2[1427]: AUDIO_CONTINUE - ok
Mar 25 16:59:23 dm7080 enigma2[1427]: playing 1:0:0:0:0:0:0:0:0:0:/data/cissa-sample.ts
Mar 25 16:59:23 dm7080 enigma2[1427]: realpath /data/cissa-sample.ts.****: No such file or directory
Mar 25 16:59:23 dm7080 enigma2[1427]: realpath /data/recordings.epl: No such file or directory
Mar 25 16:59:23 dm7080 enigma2[1427]: realpath /data/cissa-sample.ts.****: No such file or directory
Mar 25 16:59:23 dm7080 enigma2[1427]: realpath /data/recordings.epl: No such file or directory
Mar 25 16:59:23 dm7080 enigma2[1427]: no .**** file found, trying to find PMT pid
Mar 25 16:59:23 dm7080 enigma2[1427]: PMT pid found on pid 0020, service id 1
Mar 25 16:59:23 dm7080 enigma2[1427]: alloc PVR
Mar 25 16:59:23 dm7080 enigma2[1427]: allocate channel.. 0000:0000:00000000 (/data/cissa-sample.ts)
Mar 25 16:59:23 dm7080 enigma2[1427]: allocate pvr demux
Mar 25 16:59:23 dm7080 enigma2[1427]: getting program info failed.
Mar 25 16:59:23 dm7080 enigma2[1427]: disable teletext subtitles page ffffffffffffffff (und)
Mar 25 16:59:23 dm7080 enigma2[1427]: PES filter: DMX_SET_PES_FILTER - Invalid argument
Mar 25 16:59:23 dm7080 enigma2[1427]: decoder state: play, vpid=-1, apid=-1
Mar 25 16:59:23 dm7080 enigma2[1427]: W/  [gMoviePlayer.__servicePlaying] :: <no detail>
Mar 25 16:59:23 dm7080 enigma2[1427]: I/  [gMoviePlayer.setPlaybackState] :: None None 1553529563.24
Mar 25 16:59:23 dm7080 enigma2[1427]: loading streaminfo for /data/cissa-sample.ts
Mar 25 16:59:23 dm7080 enigma2[1427]: loading cuts..
Mar 25 16:59:23 dm7080 enigma2[1427]: 2 entries
Mar 25 16:59:23 dm7080 enigma2[1427]: PCR        145d844bd found at 239324 pid 200 (47 02 00 bd 07 10 a2 ec 22 5e ff)
Mar 25 16:59:23 dm7080 enigma2[1427]: PCR        14625890b found at 109353960 pid 200 (47 02 00 ba 07 10 a3 12 c4 85 fe)
Mar 25 16:59:23 dm7080 enigma2[1427]: getOffset for pts 0x0
Mar 25 16:59:23 dm7080 enigma2[1427]: samples step 41942988, pts begin 145d844bd, pts end 14625890b, offs begin 239324, offs end 109576176:
Mar 25 16:59:23 dm7080 enigma2[1427]: PCR        145d844bd found at 239324 pid 200 (47 02 00 bd 07 10 a2 ec 22 5e ff)
Mar 25 16:59:23 dm7080 enigma2[1427]: adding sample 239324: pts 0x0 -> pos 239324 (diff 0 bytes)
Mar 25 16:59:23 dm7080 enigma2[1427]: PCR        145f5f9bc found at 42191148 pid 200 (47 02 00 bd 07 10 a2 fa fc de 7e)
Mar 25 16:59:23 dm7080 enigma2[1427]: adding sample 42182312: pts 0x1db4ff -> pos 42191148 (diff 8836 bytes)
Mar 25 16:59:23 dm7080 enigma2[1427]: PCR        14613acc3 found at 84143160 pid 200 (47 02 00 bc 07 10 a3 09 d7 61 fe)
Mar 25 16:59:23 dm7080 enigma2[1427]: adding sample 84125300: pts 0x3b6806 -> pos 84143160 (diff 17860 bytes)
Mar 25 16:59:23 dm7080 enigma2[1427]: using: 0:0 -> 239324:239324
Mar 25 16:59:23 dm7080 enigma2[1427]: PCR        145d844bd found at 239324 pid 200 (47 02 00 bd 07 10 a2 ec 22 5e ff)
Mar 25 16:59:23 dm7080 enigma2[1427]: adding sample 239324: pts 0x0 -> pos 239324 (diff 0 bytes)
Mar 25 16:59:23 dm7080 enigma2[1427]: calculated diff 0 ms
Mar 25 16:59:23 dm7080 enigma2[1427]: aborting. Taking 239324 as offset for 0
Mar 25 16:59:23 dm7080 enigma2[1427]: getOffset for pts 0x4d444e
Mar 25 16:59:23 dm7080 enigma2[1427]: using: 3b6806:4d444e -> 84143160:109576176
Mar 25 16:59:23 dm7080 enigma2[1427]: eDVBTSTools::getPTS read error
Mar 25 16:59:23 dm7080 enigma2[1427]: no sample taken, refinement not possible.
Mar 25 16:59:23 dm7080 enigma2[1427]: aborting. Taking 109575988 as offset for 4d444e
Mar 25 16:59:23 dm7080 enigma2[1427]: source span: 0 .. 4d444e, translated to 239324..109575988
Mar 25 16:59:23 dm7080 enigma2[1427]: before: 1
Mar 25 16:59:23 dm7080 enigma2[1427]: after: 1
Mar 25 16:59:23 dm7080 enigma2[1427]: setIoPrio best-effort level 5 ok
Mar 25 16:59:23 dm7080 enigma2[1427]: FILEPUSH THREAD START
Mar 25 16:59:23 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 0, m_skipmode_m = 0!
Mar 25 16:59:23 dm7080 enigma2[1427]: skip
Mar 25 16:59:23 dm7080 enigma2[1427]: result: 239324, 9fffc4 (239324 109575988)
Mar 25 16:59:23 dm7080 enigma2[1427]: no version filtering
Mar 25 16:59:23 dm7080 enigma2[1427]: 0012:  4e 00 00 00 00 00
Mar 25 16:59:23 dm7080 enigma2[1427]: mask:  ff ff ff 00 00 00
Mar 25 16:59:23 dm7080 enigma2[1427]: mode:  00 00 00 00 00 00
Mar 25 16:59:23 dm7080 enigma2[1427]: ok ... now we start!!
Mar 25 16:59:23 dm7080 enigma2[1427]: no version filtering
Mar 25 16:59:23 dm7080 enigma2[1427]: 0020:  02 00 01 00 00 00
Mar 25 16:59:23 dm7080 enigma2[1427]: mask:  ff ff ff 00 00 00
Mar 25 16:59:23 dm7080 enigma2[1427]: mode:  00 00 00 00 00 00
Mar 25 16:59:23 dm7080 enigma2[1427]: realpath /data/cissa-sample.txt: No such file or directory
Mar 25 16:59:23 dm7080 enigma2[1427]: realpath /data/cissa-sample.ts.****: No such file or directory
Mar 25 16:59:23 dm7080 enigma2[1427]: realpath /data/recordings.epl: No such file or directory
Mar 25 16:59:23 dm7080 enigma2[1427]: [TeleText] service started
Mar 25 16:59:23 dm7080 enigma2[1427]: W/  [gMoviePlayer.__servicePlaying] :: <no detail>
Mar 25 16:59:23 dm7080 enigma2[1427]: I/  [gMoviePlayer.setPlaybackState] :: None None 1553529563.3
Mar 25 16:59:23 dm7080 enigma2[1427]: [HbbTV].aitInvalidated
Mar 25 16:59:23 dm7080 enigma2[1427]: + 1/1 TID 02
Mar 25 16:59:23 dm7080 enigma2[1427]: done!
Mar 25 16:59:23 dm7080 enigma2[1427]: eventNewProgramInfo 0 0
Mar 25 16:59:23 dm7080 enigma2[1427]: have 1 video stream(s) (0200), and 2 audio stream(s) (1020, 1021), and the pcr pid is 0200, and the text pid is ffffffff
Mar 25 16:59:23 dm7080 enigma2[1427]: PES filter: DMX_SET_PES_FILTER - Invalid argument
Mar 25 16:59:23 dm7080 enigma2[1427]: decoder state: play, vpid=512, apid=4128
Mar 25 16:59:23 dm7080 enigma2[1427]: DMX_SET_PES_FILTER(0x1020) - audio - ok
Mar 25 16:59:23 dm7080 enigma2[1427]: DEMUX_START - audio - ok
Mar 25 16:59:23 dm7080 enigma2[1427]: AUDIO_SET_BYPASS(1) - ok
Mar 25 16:59:23 dm7080 enigma2[1427]: AUDIO_PAUSE - ok
Mar 25 16:59:23 dm7080 enigma2[1427]: AUDIO_PLAY - ok
Mar 25 16:59:23 dm7080 enigma2[1427]: Video Device: /dev/dvb/adapter0/video0
Mar 25 16:59:23 dm7080 enigma2[1427]: demux device: /dev/dvb/adapter0/demux7
Mar 25 16:59:23 dm7080 enigma2[1427]: VIDEO_SET_STREAMTYPE 1 - ok
Mar 25 16:59:23 dm7080 enigma2[1427]: DMX_SET_PES_FILTER(0x200) - video - ok
Mar 25 16:59:23 dm7080 enigma2[1427]: DEMUX_START - video - ok
Mar 25 16:59:23 dm7080 enigma2[1427]: VIDEO_FREEZE - ok
Mar 25 16:59:23 dm7080 enigma2[1427]: VIDEO_PLAY - ok
Mar 25 16:59:23 dm7080 enigma2[1427]: VIDEO_SLOWMOTION(0) - ok
Mar 25 16:59:23 dm7080 enigma2[1427]: VIDEO_FAST_FORWARD(0) - ok
Mar 25 16:59:23 dm7080 enigma2[1427]: VIDEO_CONTINUE - ok
Mar 25 16:59:23 dm7080 enigma2[1427]: AUDIO_CONTINUE - ok
Mar 25 16:59:23 dm7080 enigma2[1427]: W/  [gMoviePlayer.__servicePlaying] :: <no detail>
Mar 25 16:59:23 dm7080 enigma2[1427]: I/  [gMoviePlayer.setPlaybackState] :: None None 1553529563.39
Mar 25 16:59:23 dm7080 enigma2[1427]: [eDBusInterface::Private::sendEvent 1
Mar 25 16:59:23 dm7080 enigma2[1427]: eDVBServicePlay::seekTo: jump 0
Mar 25 16:59:23 dm7080 enigma2[1427]: seek.
Mar 25 16:59:23 dm7080 enigma2[1427]: stopping thread.
Mar 25 16:59:23 dm7080 enigma2[1427]: FILEPUSH THREAD STOP
Mar 25 16:59:23 dm7080 enigma2[1427]: thread joined 0
Mar 25 16:59:23 dm7080 enigma2[1427]: AUDIO_CLEAR_BUFFER - ok
Mar 25 16:59:23 dm7080 enigma2[1427]: VIDEO_CLEAR_BUFFER - ok
Mar 25 16:59:23 dm7080 enigma2[1427]: before: 1
Mar 25 16:59:23 dm7080 enigma2[1427]: after: 1
Mar 25 16:59:23 dm7080 enigma2[1427]: setIoPrio best-effort level 5 ok
Mar 25 16:59:23 dm7080 enigma2[1427]: FILEPUSH THREAD START
Mar 25 16:59:23 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 2005772, m_skipmode_m = 0!
Mar 25 16:59:23 dm7080 enigma2[1427]: getOffset for pts 0x0
Mar 25 16:59:23 dm7080 enigma2[1427]: using: 0:0 -> 239324:239324
Mar 25 16:59:23 dm7080 enigma2[1427]: PCR        145d844bd found at 239324 pid 200 (47 02 00 bd 07 10 a2 ec 22 5e ff)
Mar 25 16:59:23 dm7080 enigma2[1427]: adding sample 239324: pts 0x0 -> pos 239324 (diff 0 bytes)
Mar 25 16:59:23 dm7080 enigma2[1427]: calculated diff 0 ms
Mar 25 16:59:23 dm7080 enigma2[1427]: aborting. Taking 239324 as offset for 0
Mar 25 16:59:23 dm7080 enigma2[1427]: ok, resolved skip (rel: 0, diff 0), now at 239324
Mar 25 16:59:23 dm7080 enigma2[1427]: HIT, 239324 < 239324 < 109575988, size: 10485700
Mar 25 16:59:23 dm7080 enigma2[1427]: [TeleText] serviceInfoChanged
Mar 25 16:59:23 dm7080 enigma2[1427]: [TeleText] TXT PID -1 DEMUX 7
Mar 25 16:59:23 dm7080 enigma2[1427]: doing version filtering
Mar 25 16:59:23 dm7080 enigma2[1427]: 0020:  02 00 01 01 00 00
Mar 25 16:59:23 dm7080 enigma2[1427]: mask:  ff ff ff 3f 00 00
Mar 25 16:59:23 dm7080 enigma2[1427]: mode:  00 00 00 3e 00 00
Mar 25 16:59:24 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 10725024, m_skipmode_m = 0!
Mar 25 16:59:24 dm7080 enigma2[1427]: HIT, 239324 < 10725024 < 109575988, size: 10485700
Mar 25 16:59:24 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 21210724, m_skipmode_m = 0!
Mar 25 16:59:25 dm7080 enigma2[1427]: HIT, 239324 < 21210724 < 109575988, size: 10485700
Mar 25 16:59:25 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 31696424, m_skipmode_m = 0!
Mar 25 16:59:25 dm7080 enigma2[1427]: HIT, 239324 < 31696424 < 109575988, size: 10485700
Mar 25 16:59:26 dm7080 enigma2[1427]: timeout 0012!
Mar 25 16:59:26 dm7080 enigma2[1427]: W/  [gMoviePlayer.__servicePlaying] :: <no detail>
Mar 25 16:59:26 dm7080 enigma2[1427]: I/  [gMoviePlayer.setPlaybackState] :: None None 1553529566.28
Mar 25 16:59:26 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 42182124, m_skipmode_m = 0!
Mar 25 16:59:26 dm7080 enigma2[1427]: HIT, 239324 < 42182124 < 109575988, size: 10485700
Mar 25 16:59:27 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 52667824, m_skipmode_m = 0!
Mar 25 16:59:27 dm7080 enigma2[1427]: HIT, 239324 < 52667824 < 109575988, size: 10485700
Mar 25 16:59:28 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 63153524, m_skipmode_m = 0!
Mar 25 16:59:28 dm7080 enigma2[1427]: HIT, 239324 < 63153524 < 109575988, size: 10485700
Mar 25 16:59:28 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 73639224, m_skipmode_m = 0!
Mar 25 16:59:28 dm7080 enigma2[1427]: HIT, 239324 < 73639224 < 109575988, size: 10485700
Mar 25 16:59:29 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 84124924, m_skipmode_m = 0!
Mar 25 16:59:29 dm7080 enigma2[1427]: HIT, 239324 < 84124924 < 109575988, size: 10485700
Mar 25 16:59:30 dm7080 enigma2[1427]: action ->  OkCancelActions ok
Mar 25 16:59:30 dm7080 enigma2[1427]: unknown action OkCancelActions/ok! typo in keymap?
Mar 25 16:59:30 dm7080 enigma2[1427]: action ->  InfobarSeekActions unPauseService
Mar 25 16:59:30 dm7080 enigma2[1427]: unknown action InfobarSeekActions/unPauseService! typo in keymap?
Mar 25 16:59:30 dm7080 enigma2[1427]: action: unPauseService
Mar 25 16:59:30 dm7080 enigma2[1427]: action ->  InfobarSeekActions unPauseService
Mar 25 16:59:30 dm7080 enigma2[1427]: unpause
Mar 25 16:59:30 dm7080 enigma2[1427]: action ->  gbActions ok
Mar 25 16:59:30 dm7080 enigma2[1427]: unknown action gbActions/ok! typo in keymap?
Mar 25 16:59:30 dm7080 enigma2[1427]: action ->  InfobarShowHideActions toggleShow
Mar 25 16:59:30 dm7080 enigma2[1427]: create buffer for widget 1920 x 525
Mar 25 16:59:30 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 94610624, m_skipmode_m = 0!
Mar 25 16:59:30 dm7080 enigma2[1427]: HIT, 239324 < 94610624 < 109575988, size: 10485700
Mar 25 16:59:31 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 105096324, m_skipmode_m = 0!
Mar 25 16:59:31 dm7080 enigma2[1427]: HIT, 239324 < 105096324 < 109575988, size: 4479664
Mar 25 16:59:31 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 16:59:31 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 16:59:31 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 16:59:31 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 16:59:31 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:31 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:31 dm7080 enigma2[1427]: eDVBServicePlay::pause
Mar 25 16:59:31 dm7080 enigma2[1427]: decoder state: pause, vpid=512, apid=4128
Mar 25 16:59:31 dm7080 enigma2[1427]: VIDEO_SLOWMOTION(0) - ok
Mar 25 16:59:31 dm7080 enigma2[1427]: VIDEO_FAST_FORWARD(0) - ok
Mar 25 16:59:31 dm7080 enigma2[1427]: VIDEO_FREEZE - ok
Mar 25 16:59:31 dm7080 enigma2[1427]: AUDIO_PAUSE - ok
Mar 25 16:59:31 dm7080 enigma2[1427]: [eDBusInterface::Private::sendEvent 2
Mar 25 16:59:31 dm7080 enigma2[1427]: resolved to PAUSE 0
Mar 25 16:59:31 dm7080 enigma2[1427]: I/  [TemplatedListFonts.__init__] :: Bigger: 32, Regular
Mar 25 16:59:31 dm7080 enigma2[1427]: I/  [TemplatedListFonts.__init__] :: Big: 30, Regular
Mar 25 16:59:31 dm7080 enigma2[1427]: I/  [TemplatedListFonts.__init__] :: Medium: 28, Regular
Mar 25 16:59:31 dm7080 enigma2[1427]: I/  [TemplatedListFonts.__init__] :: Small: 26, Regular
Mar 25 16:59:31 dm7080 enigma2[1427]: I/  [TemplatedListFonts.__init__] :: Smaller: 24, Regular
Mar 25 16:59:31 dm7080 enigma2[1427]: create buffer for widget 966 x 379
Mar 25 16:59:31 dm7080 enigma2[1427]: [eDBusInterface::Private::sendEvent 0
Mar 25 16:59:32 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 16:59:32 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 16:59:32 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 16:59:32 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 16:59:32 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:32 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:33 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 16:59:33 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 16:59:33 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 16:59:33 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 16:59:33 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:33 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:34 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 16:59:34 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 16:59:34 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 16:59:34 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 16:59:34 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:34 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:35 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 16:59:35 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 16:59:35 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 16:59:35 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 16:59:35 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:35 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:36 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 16:59:36 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 16:59:36 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 16:59:36 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 16:59:36 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:36 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:37 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 16:59:37 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 16:59:37 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 16:59:37 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 16:59:37 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:37 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:38 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 16:59:38 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 16:59:38 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 16:59:38 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 16:59:38 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:38 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:39 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 16:59:39 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 16:59:39 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 16:59:39 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 16:59:39 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:39 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:40 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 16:59:40 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 16:59:40 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 16:59:40 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 16:59:40 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:40 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:41 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 16:59:41 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 16:59:41 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 16:59:41 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 16:59:41 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:41 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:42 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 16:59:42 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 16:59:42 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 16:59:42 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 16:59:42 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:42 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:43 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 16:59:43 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 16:59:43 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 16:59:43 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 16:59:43 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:43 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:44 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 16:59:44 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 16:59:44 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 16:59:44 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 16:59:44 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:44 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:45 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 16:59:45 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 16:59:45 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 16:59:45 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 16:59:45 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:45 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:46 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 16:59:46 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 16:59:46 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 16:59:46 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 16:59:46 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:46 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:47 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 16:59:47 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 16:59:47 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 16:59:47 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 16:59:47 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:47 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:48 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 16:59:48 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 16:59:48 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 16:59:48 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 16:59:48 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:48 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:49 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 16:59:49 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 16:59:49 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 16:59:49 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 16:59:49 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:49 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:50 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 16:59:50 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 16:59:50 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 16:59:50 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 16:59:50 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:50 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:51 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 16:59:51 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 16:59:51 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 16:59:51 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 16:59:51 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:51 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:52 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 16:59:52 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 16:59:52 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 16:59:52 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 16:59:52 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:52 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:53 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 16:59:53 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 16:59:53 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 16:59:53 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 16:59:53 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:53 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:54 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 16:59:54 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 16:59:54 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 16:59:54 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 16:59:54 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:54 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:55 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 16:59:55 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 16:59:55 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 16:59:55 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 16:59:55 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:55 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:56 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 16:59:56 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 16:59:56 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 16:59:56 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 16:59:56 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:56 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:57 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 16:59:57 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 16:59:57 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 16:59:57 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 16:59:57 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:57 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:58 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 16:59:58 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 16:59:58 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 16:59:58 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 16:59:58 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:58 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:59 dm7080 enigma2[1427]: action ->  WizardActions down
Mar 25 16:59:59 dm7080 enigma2[1427]: action ->  DirectionActions downUp
Mar 25 16:59:59 dm7080 enigma2[1427]: unknown action DirectionActions/downUp! typo in keymap?
Mar 25 16:59:59 dm7080 enigma2[1427]: action ->  WizardActions down
Mar 25 16:59:59 dm7080 enigma2[1427]: action ->  DirectionActions downUp
Mar 25 16:59:59 dm7080 enigma2[1427]: unknown action DirectionActions/downUp! typo in keymap?
Mar 25 16:59:59 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 16:59:59 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 16:59:59 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 16:59:59 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 16:59:59 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 16:59:59 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:00 dm7080 enigma2[1427]: action ->  WizardActions ok
Mar 25 17:00:00 dm7080 enigma2[1427]: I/  [gMoviePlayer.__restoreState] :: <no detail>
Mar 25 17:00:00 dm7080 enigma2[1427]: stopService
Mar 25 17:00:00 dm7080 enigma2[1427]: stopping thread.
Mar 25 17:00:00 dm7080 enigma2[1427]: FILEPUSH THREAD STOP
Mar 25 17:00:00 dm7080 enigma2[1427]: thread joined 0
Mar 25 17:00:00 dm7080 enigma2[1427]: [TeleText] service stopped
Mar 25 17:00:00 dm7080 enigma2[1427]: [TeleText] send array('B', [1, 0, 0, 0])
Mar 25 17:00:00 dm7080 enigma2[1427]: disable dvb subtitles
Mar 25 17:00:00 dm7080 enigma2[1427]: disable teletext subtitles page ffffffffffffffff (und)
Mar 25 17:00:00 dm7080 enigma2[1427]: realpath /data/cissa-sample.ts.****: No such file or directory
Mar 25 17:00:00 dm7080 enigma2[1427]: realpath /data/recordings.epl: No such file or directory
Mar 25 17:00:00 dm7080 enigma2[1427]: decoder state: pause, vpid=-1, apid=-1
Mar 25 17:00:00 dm7080 enigma2[1427]: DEMUX_STOP - video - ok
Mar 25 17:00:00 dm7080 enigma2[1427]: VIDEO_STOP - ok
Mar 25 17:00:00 dm7080 enigma2[1427]: AUDIO_STOP - ok
Mar 25 17:00:00 dm7080 enigma2[1427]: DEMUX_STOP - audio - ok
Mar 25 17:00:00 dm7080 enigma2[1427]: AUDIO_CONTINUE - ok
Mar 25 17:00:00 dm7080 enigma2[1427]: playing 1:0:0:0:0:0:0:0:0:0:/data/cissa-sample.ts
Mar 25 17:00:00 dm7080 enigma2[1427]: realpath /data/cissa-sample.ts.****: No such file or directory
Mar 25 17:00:00 dm7080 enigma2[1427]: realpath /data/recordings.epl: No such file or directory
Mar 25 17:00:00 dm7080 enigma2[1427]: realpath /data/cissa-sample.ts.****: No such file or directory
Mar 25 17:00:00 dm7080 enigma2[1427]: realpath /data/recordings.epl: No such file or directory
Mar 25 17:00:00 dm7080 enigma2[1427]: no .**** file found, trying to find PMT pid
Mar 25 17:00:00 dm7080 enigma2[1427]: PMT pid found on pid 0020, service id 1
Mar 25 17:00:00 dm7080 enigma2[1427]: alloc PVR
Mar 25 17:00:00 dm7080 enigma2[1427]: allocate channel.. 0000:0000:00000000 (/data/cissa-sample.ts)
Mar 25 17:00:00 dm7080 enigma2[1427]: allocate pvr demux
Mar 25 17:00:00 dm7080 enigma2[1427]: getting program info failed.
Mar 25 17:00:00 dm7080 enigma2[1427]: disable teletext subtitles page ffffffffffffffff (und)
Mar 25 17:00:00 dm7080 enigma2[1427]: PES filter: DMX_SET_PES_FILTER - Invalid argument
Mar 25 17:00:00 dm7080 enigma2[1427]: decoder state: play, vpid=-1, apid=-1
Mar 25 17:00:00 dm7080 enigma2[1427]: W/  [gMoviePlayer.__servicePlaying] :: <no detail>
Mar 25 17:00:00 dm7080 enigma2[1427]: I/  [gMoviePlayer.setPlaybackState] :: None None 1553529600.06
Mar 25 17:00:00 dm7080 enigma2[1427]: loading streaminfo for /data/cissa-sample.ts
Mar 25 17:00:00 dm7080 enigma2[1427]: loading cuts..
Mar 25 17:00:00 dm7080 enigma2[1427]: 2 entries
Mar 25 17:00:00 dm7080 enigma2[1427]: PCR        145d844bd found at 239324 pid 200 (47 02 00 bd 07 10 a2 ec 22 5e ff)
Mar 25 17:00:00 dm7080 enigma2[1427]: PCR        14625890b found at 109353960 pid 200 (47 02 00 ba 07 10 a3 12 c4 85 fe)
Mar 25 17:00:00 dm7080 enigma2[1427]: getOffset for pts 0x0
Mar 25 17:00:00 dm7080 enigma2[1427]: samples step 41942988, pts begin 145d844bd, pts end 14625890b, offs begin 239324, offs end 109576176:
Mar 25 17:00:00 dm7080 enigma2[1427]: PCR        145d844bd found at 239324 pid 200 (47 02 00 bd 07 10 a2 ec 22 5e ff)
Mar 25 17:00:00 dm7080 enigma2[1427]: adding sample 239324: pts 0x0 -> pos 239324 (diff 0 bytes)
Mar 25 17:00:00 dm7080 enigma2[1427]: PCR        145f5f9bc found at 42191148 pid 200 (47 02 00 bd 07 10 a2 fa fc de 7e)
Mar 25 17:00:00 dm7080 enigma2[1427]: adding sample 42182312: pts 0x1db4ff -> pos 42191148 (diff 8836 bytes)
Mar 25 17:00:00 dm7080 enigma2[1427]: PCR        14613acc3 found at 84143160 pid 200 (47 02 00 bc 07 10 a3 09 d7 61 fe)
Mar 25 17:00:00 dm7080 enigma2[1427]: adding sample 84125300: pts 0x3b6806 -> pos 84143160 (diff 17860 bytes)
Mar 25 17:00:00 dm7080 enigma2[1427]: using: 0:0 -> 239324:239324
Mar 25 17:00:00 dm7080 enigma2[1427]: PCR        145d844bd found at 239324 pid 200 (47 02 00 bd 07 10 a2 ec 22 5e ff)
Mar 25 17:00:00 dm7080 enigma2[1427]: adding sample 239324: pts 0x0 -> pos 239324 (diff 0 bytes)
Mar 25 17:00:00 dm7080 enigma2[1427]: calculated diff 0 ms
Mar 25 17:00:00 dm7080 enigma2[1427]: aborting. Taking 239324 as offset for 0
Mar 25 17:00:00 dm7080 enigma2[1427]: getOffset for pts 0x4d444e
Mar 25 17:00:00 dm7080 enigma2[1427]: using: 3b6806:4d444e -> 84143160:109576176
Mar 25 17:00:00 dm7080 enigma2[1427]: eDVBTSTools::getPTS read error
Mar 25 17:00:00 dm7080 enigma2[1427]: no sample taken, refinement not possible.
Mar 25 17:00:00 dm7080 enigma2[1427]: aborting. Taking 109575988 as offset for 4d444e
Mar 25 17:00:00 dm7080 enigma2[1427]: source span: 0 .. 4d444e, translated to 239324..109575988
Mar 25 17:00:00 dm7080 enigma2[1427]: before: 1
Mar 25 17:00:00 dm7080 enigma2[1427]: after: 1
Mar 25 17:00:00 dm7080 enigma2[1427]: setIoPrio best-effort level 5 ok
Mar 25 17:00:00 dm7080 enigma2[1427]: FILEPUSH THREAD START
Mar 25 17:00:00 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 0, m_skipmode_m = 0!
Mar 25 17:00:00 dm7080 enigma2[1427]: skip
Mar 25 17:00:00 dm7080 enigma2[1427]: result: 239324, 9fffc4 (239324 109575988)
Mar 25 17:00:00 dm7080 enigma2[1427]: no version filtering
Mar 25 17:00:00 dm7080 enigma2[1427]: 0012:  4e 00 00 00 00 00
Mar 25 17:00:00 dm7080 enigma2[1427]: mask:  ff ff ff 00 00 00
Mar 25 17:00:00 dm7080 enigma2[1427]: mode:  00 00 00 00 00 00
Mar 25 17:00:00 dm7080 enigma2[1427]: ok ... now we start!!
Mar 25 17:00:00 dm7080 enigma2[1427]: no version filtering
Mar 25 17:00:00 dm7080 enigma2[1427]: 0020:  02 00 01 00 00 00
Mar 25 17:00:00 dm7080 enigma2[1427]: mask:  ff ff ff 00 00 00
Mar 25 17:00:00 dm7080 enigma2[1427]: mode:  00 00 00 00 00 00
Mar 25 17:00:00 dm7080 enigma2[1427]: realpath /data/cissa-sample.txt: No such file or directory
Mar 25 17:00:00 dm7080 enigma2[1427]: realpath /data/cissa-sample.ts.****: No such file or directory
Mar 25 17:00:00 dm7080 enigma2[1427]: realpath /data/recordings.epl: No such file or directory
Mar 25 17:00:00 dm7080 enigma2[1427]: [TeleText] service started
Mar 25 17:00:00 dm7080 enigma2[1427]: W/  [gMoviePlayer.__servicePlaying] :: <no detail>
Mar 25 17:00:00 dm7080 enigma2[1427]: I/  [gMoviePlayer.setPlaybackState] :: None None 1553529600.12
Mar 25 17:00:00 dm7080 enigma2[1427]: [HbbTV].aitInvalidated
Mar 25 17:00:00 dm7080 enigma2[1427]: + 1/1 TID 02
Mar 25 17:00:00 dm7080 enigma2[1427]: done!
Mar 25 17:00:00 dm7080 enigma2[1427]: eventNewProgramInfo 0 0
Mar 25 17:00:00 dm7080 enigma2[1427]: have 1 video stream(s) (0200), and 2 audio stream(s) (1020, 1021), and the pcr pid is 0200, and the text pid is ffffffff
Mar 25 17:00:00 dm7080 enigma2[1427]: PES filter: DMX_SET_PES_FILTER - Invalid argument
Mar 25 17:00:00 dm7080 enigma2[1427]: decoder state: play, vpid=512, apid=4128
Mar 25 17:00:00 dm7080 enigma2[1427]: DMX_SET_PES_FILTER(0x1020) - audio - ok
Mar 25 17:00:00 dm7080 enigma2[1427]: DEMUX_START - audio - ok
Mar 25 17:00:00 dm7080 enigma2[1427]: AUDIO_SET_BYPASS(1) - ok
Mar 25 17:00:00 dm7080 enigma2[1427]: AUDIO_PAUSE - ok
Mar 25 17:00:00 dm7080 enigma2[1427]: AUDIO_PLAY - ok
Mar 25 17:00:00 dm7080 enigma2[1427]: Video Device: /dev/dvb/adapter0/video0
Mar 25 17:00:00 dm7080 enigma2[1427]: demux device: /dev/dvb/adapter0/demux7
Mar 25 17:00:00 dm7080 enigma2[1427]: VIDEO_SET_STREAMTYPE 1 - ok
Mar 25 17:00:00 dm7080 enigma2[1427]: DMX_SET_PES_FILTER(0x200) - video - ok
Mar 25 17:00:00 dm7080 enigma2[1427]: DEMUX_START - video - ok
Mar 25 17:00:00 dm7080 enigma2[1427]: VIDEO_FREEZE - ok
Mar 25 17:00:00 dm7080 enigma2[1427]: VIDEO_PLAY - ok
Mar 25 17:00:00 dm7080 enigma2[1427]: VIDEO_SLOWMOTION(0) - ok
Mar 25 17:00:00 dm7080 enigma2[1427]: VIDEO_FAST_FORWARD(0) - ok
Mar 25 17:00:00 dm7080 enigma2[1427]: VIDEO_CONTINUE - ok
Mar 25 17:00:00 dm7080 enigma2[1427]: AUDIO_CONTINUE - ok
Mar 25 17:00:00 dm7080 enigma2[1427]: W/  [gMoviePlayer.__servicePlaying] :: <no detail>
Mar 25 17:00:00 dm7080 enigma2[1427]: I/  [gMoviePlayer.setPlaybackState] :: None None 1553529600.22
Mar 25 17:00:00 dm7080 enigma2[1427]: [eDBusInterface::Private::sendEvent 1
Mar 25 17:00:00 dm7080 enigma2[1427]: eDVBServicePlay::seekTo: jump 0
Mar 25 17:00:00 dm7080 enigma2[1427]: seek.
Mar 25 17:00:00 dm7080 enigma2[1427]: stopping thread.
Mar 25 17:00:00 dm7080 enigma2[1427]: FILEPUSH THREAD STOP
Mar 25 17:00:00 dm7080 enigma2[1427]: thread joined 0
Mar 25 17:00:00 dm7080 enigma2[1427]: AUDIO_CLEAR_BUFFER - ok
Mar 25 17:00:00 dm7080 enigma2[1427]: VIDEO_CLEAR_BUFFER - ok
Mar 25 17:00:00 dm7080 enigma2[1427]: before: 1
Mar 25 17:00:00 dm7080 enigma2[1427]: after: 1
Mar 25 17:00:00 dm7080 enigma2[1427]: setIoPrio best-effort level 5 ok
Mar 25 17:00:00 dm7080 enigma2[1427]: FILEPUSH THREAD START
Mar 25 17:00:00 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 2136620, m_skipmode_m = 0!
Mar 25 17:00:00 dm7080 enigma2[1427]: getOffset for pts 0x0
Mar 25 17:00:00 dm7080 enigma2[1427]: using: 0:0 -> 239324:239324
Mar 25 17:00:00 dm7080 enigma2[1427]: PCR        145d844bd found at 239324 pid 200 (47 02 00 bd 07 10 a2 ec 22 5e ff)
Mar 25 17:00:00 dm7080 enigma2[1427]: adding sample 239324: pts 0x0 -> pos 239324 (diff 0 bytes)
Mar 25 17:00:00 dm7080 enigma2[1427]: calculated diff 0 ms
Mar 25 17:00:00 dm7080 enigma2[1427]: aborting. Taking 239324 as offset for 0
Mar 25 17:00:00 dm7080 enigma2[1427]: ok, resolved skip (rel: 0, diff 0), now at 239324
Mar 25 17:00:00 dm7080 enigma2[1427]: HIT, 239324 < 239324 < 109575988, size: 10485700
Mar 25 17:00:00 dm7080 enigma2[1427]: [TeleText] serviceInfoChanged
Mar 25 17:00:00 dm7080 enigma2[1427]: [TeleText] TXT PID -1 DEMUX 7
Mar 25 17:00:00 dm7080 enigma2[1427]: doing version filtering
Mar 25 17:00:00 dm7080 enigma2[1427]: 0020:  02 00 01 01 00 00
Mar 25 17:00:00 dm7080 enigma2[1427]: mask:  ff ff ff 3f 00 00
Mar 25 17:00:00 dm7080 enigma2[1427]: mode:  00 00 00 3e 00 00
Mar 25 17:00:01 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 10725024, m_skipmode_m = 0!
Mar 25 17:00:01 dm7080 enigma2[1427]: HIT, 239324 < 10725024 < 109575988, size: 10485700
Mar 25 17:00:01 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 21210724, m_skipmode_m = 0!
Mar 25 17:00:01 dm7080 enigma2[1427]: HIT, 239324 < 21210724 < 109575988, size: 10485700
Mar 25 17:00:02 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 31696424, m_skipmode_m = 0!
Mar 25 17:00:02 dm7080 enigma2[1427]: HIT, 239324 < 31696424 < 109575988, size: 10485700
Mar 25 17:00:03 dm7080 enigma2[1427]: timeout 0012!
Mar 25 17:00:03 dm7080 enigma2[1427]: W/  [gMoviePlayer.__servicePlaying] :: <no detail>
Mar 25 17:00:03 dm7080 enigma2[1427]: I/  [gMoviePlayer.setPlaybackState] :: None None 1553529603.1
Mar 25 17:00:03 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 42182124, m_skipmode_m = 0!
Mar 25 17:00:03 dm7080 enigma2[1427]: HIT, 239324 < 42182124 < 109575988, size: 10485700
Mar 25 17:00:04 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 52667824, m_skipmode_m = 0!
Mar 25 17:00:04 dm7080 enigma2[1427]: HIT, 239324 < 52667824 < 109575988, size: 10485700
Mar 25 17:00:04 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 63153524, m_skipmode_m = 0!
Mar 25 17:00:05 dm7080 enigma2[1427]: HIT, 239324 < 63153524 < 109575988, size: 10485700
Mar 25 17:00:05 dm7080 enigma2[1427]: [EPGC] cleanupOutdated
Mar 25 17:00:05 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 73639224, m_skipmode_m = 0!
Mar 25 17:00:05 dm7080 enigma2[1427]: HIT, 239324 < 73639224 < 109575988, size: 10485700
Mar 25 17:00:06 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 84124924, m_skipmode_m = 0!
Mar 25 17:00:06 dm7080 enigma2[1427]: HIT, 239324 < 84124924 < 109575988, size: 10485700
Mar 25 17:00:07 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 94610624, m_skipmode_m = 0!
Mar 25 17:00:07 dm7080 enigma2[1427]: HIT, 239324 < 94610624 < 109575988, size: 10485700
Mar 25 17:00:08 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 105096324, m_skipmode_m = 0!
Mar 25 17:00:08 dm7080 enigma2[1427]: HIT, 239324 < 105096324 < 109575988, size: 4479664
Mar 25 17:00:08 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 17:00:08 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 17:00:08 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 17:00:08 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail>
Mar 25 17:00:08 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 17:00:08 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail>
Mar 25 17:00:08 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:08 dm7080 enigma2[1427]: eDVBServicePlay::pause
Mar 25 17:00:08 dm7080 enigma2[1427]: decoder state: pause, vpid=512, apid=4128
Mar 25 17:00:08 dm7080 enigma2[1427]: VIDEO_SLOWMOTION(0) - ok
Mar 25 17:00:08 dm7080 enigma2[1427]: VIDEO_FAST_FORWARD(0) - ok
Mar 25 17:00:08 dm7080 enigma2[1427]: VIDEO_FREEZE - ok
Mar 25 17:00:08 dm7080 enigma2[1427]: AUDIO_PAUSE - ok
Mar 25 17:00:08 dm7080 enigma2[1427]: create buffer for widget 1920 x 525
Mar 25 17:00:08 dm7080 enigma2[1427]: [eDBusInterface::Private::sendEvent 2
Mar 25 17:00:08 dm7080 enigma2[1427]: resolved to PAUSE 0
Mar 25 17:00:08 dm7080 enigma2[1427]: I/  [TemplatedListFonts.__init__] :: Bigger: 32, Regular
Mar 25 17:00:08 dm7080 enigma2[1427]: I/  [TemplatedListFonts.__init__] :: Big: 30, Regular
Mar 25 17:00:08 dm7080 enigma2[1427]: I/  [TemplatedListFonts.__init__] :: Medium: 28, Regular
Mar 25 17:00:08 dm7080 enigma2[1427]: I/  [TemplatedListFonts.__init__] :: Small: 26, Regular
Mar 25 17:00:08 dm7080 enigma2[1427]: I/  [TemplatedListFonts.__init__] :: Smaller: 24, Regular
Mar 25 17:00:08 dm7080 enigma2[1427]: create buffer for widget 966 x 379
Mar 25 17:00:08 dm7080 enigma2[1427]: [eDBusInterface::Private::sendEvent 0
Mar 25 17:00:09 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 17:00:09 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 17:00:09 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 17:00:09 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 17:00:09 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:09 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:10 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 17:00:10 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 17:00:10 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 17:00:10 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 17:00:10 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:10 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:11 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 17:00:11 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 17:00:11 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 17:00:11 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 17:00:11 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:11 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:12 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 17:00:12 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 17:00:12 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 17:00:12 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 17:00:12 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:12 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:13 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 17:00:13 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 17:00:13 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 17:00:13 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 17:00:13 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:13 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:14 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 17:00:14 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 17:00:14 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 17:00:14 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 17:00:14 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:14 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:15 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 17:00:15 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 17:00:15 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 17:00:15 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 17:00:15 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:15 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:16 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 17:00:16 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 17:00:16 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 17:00:16 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 17:00:16 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:16 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:17 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 17:00:17 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 17:00:17 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 17:00:17 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 17:00:17 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:17 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:18 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 17:00:18 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 17:00:18 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 17:00:18 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 17:00:18 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:18 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:19 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 17:00:19 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 17:00:19 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 17:00:19 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 17:00:19 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:19 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:20 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 17:00:20 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 17:00:20 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 17:00:20 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 17:00:20 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:20 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:21 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 17:00:21 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 17:00:21 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 17:00:21 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 17:00:21 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:21 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:22 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 17:00:22 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 17:00:22 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 17:00:22 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 17:00:22 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:22 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:23 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 17:00:23 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 17:00:23 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 17:00:23 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 17:00:23 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:23 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:24 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 17:00:24 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 17:00:24 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 17:00:24 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 17:00:24 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:24 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:25 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 17:00:25 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 17:00:25 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 17:00:25 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 17:00:25 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:25 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:26 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 17:00:26 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 17:00:26 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 17:00:26 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 17:00:26 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:26 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:27 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 17:00:27 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 17:00:27 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 17:00:27 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 17:00:27 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:27 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:28 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 17:00:28 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 17:00:28 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 17:00:28 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 17:00:28 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:28 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:29 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 17:00:29 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 17:00:29 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 17:00:29 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 17:00:29 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:29 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:30 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 17:00:30 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 17:00:30 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 17:00:30 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 17:00:30 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:30 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:31 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 17:00:31 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 17:00:31 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 17:00:31 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 17:00:31 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:31 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:32 dm7080 enigma2[1427]: getNextSourceSpan, current offset is 109575988, m_skipmode_m = 0!
Mar 25 17:00:32 dm7080 enigma2[1427]: wait for driver eof ok
Mar 25 17:00:32 dm7080 enigma2[1427]: reached EOF, but we are in stream mode. delaying 1 second.
Mar 25 17:00:32 dm7080 enigma2[1427]: eDVBChannel: End of file!
Mar 25 17:00:32 dm7080 enigma2[1427]: I/  [PlayerImpl.stopPolling] :: <no detail> (2 times)
Mar 25 17:00:32 dm7080 enigma2[1427]: I/  [UPnPPlayer.stopPolling] :: <no detail> (2 times)

nautilus7 · Mar 25, 2019

OK, thanks!!!

In OpenATV, I see no error messages in the log.
Did the video/audio played smoothly, without any artifacts?

Regarding the DreamOS image... can you compare the version of the drivers in both images? Are they the same?

Are you able to playback other encrypted recording in the DreamOS image? You can test with a BISS1 recording for example (just make sure you disable oscam-emu when recording).

I am not sure how the Abertis channels work, but perhaps there is a limitation in DreamOS images.

Thanks for the report!

nautilus7 · Mar 25, 2019

satpong, more questions for you...

Do powervu channels (those which use DES) work with the DreamOS image?

Can you tell what are the system OE, Firmware and Kernel/Drivers for both images?
You can find those info under webif -> box info ->software.

satpong · Mar 26, 2019

Did the video/audio played smoothly, without any artifacts?
- Yes it works perfectly

Regarding the DreamOS image... can you compare the version of the drivers in both images? Are they the same?
- No they are different, OE2.5 = 2019-03-04, openATV = 2018-10-02

Are you able to playback other encrypted recording in the DreamOS image? You can test with a BISS1 recording for example (just make sure you disable oscam-emu when recording).
- No not working, tested with other biss1 sample (openATV = OK)

Do powervu channels (those which use DES) work with the DreamOS image?
- Yes working fine

Can you tell what are the system OE, Firmware and Kernel/Drivers for both images?
DreamOS:
Device & Versions
Device Name: dm7080
Dreambox OS Version: 4.3.2r3-6-gaa85e-2019-03-04
Image Version: Experimental 2019-03-12
Frontprocessor Version: V1.17
Webinterface Version: 1.9.0

OpenATV:
STB
Merk & model: Dreambox DM7080
Chipset (Frontprocessor Versie): Broadcom 7435 (1.17)
Totaal geheugen: 1132440 kB vrij / 1287584 kB totaal
Box Uptime: 0:02
Software
Systeem OE: OE-Alliance 4.3
Firmware versie: OpenATV 6.3.0 (2019-03-23)
Kernel versie / stuurprogramma datum: 3.4 / 20181002

Dreambox owners: Who wants to test DVB-CISSA descrambling?

nautilus7

harshy

Registered

harshy

Registered

nautilus7

harshy

Registered

harshy

Registered

nautilus7

harshy

Registered

harshy

Registered

marrakr

Registered

grottiwe22

nautilus7

nautilus7

flavor

nautilus7

satpong

satpong

nautilus7

nautilus7

satpong