Is there a oscam.log-prev file there as well? I nee that also, because again the log is not complete.
https://drive.google.com/open?id=1QSffZX0WfivWZ6RdqpuapU6zrqo40wRa
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
<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
[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
F 1402790C 00000000 A5EB22B2576F753BA5EB22B2576F753B ;34 Telekanal 4.8E
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
-------------------------------------------------------------------------------
**** 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
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
-- 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)