-- Logs begin at Thu 1970-01-01 01:00:00 CET. --
Oct 03 09:32:26 dm900 enigma2[267]: [    1] close frontend
Oct 03 09:32:26 dm900 enigma2[267]: [SEC-1] setVoltage 0V
Oct 03 09:32:26 dm900 enigma2[267]: W/  [HTTPAuthResource._assignLocalNetworks] :: [IPNetwork('192.168.178.41/24')]
Oct 03 09:32:26 dm900 enigma2[267]: I/  [HTTPAuthResource.isAuthenticated] :: Local auth is disabled - Bypassing Authcheck because host '::ffff:192.168.178.20/128' is local!
Oct 03 09:32:26 dm900 enigma2[267]: [HTTPRootResource].isSessionValid :: created session with id '0' for client with token 'fb4b49f00c963407006b7a4d8a842f74eb45132f'
Oct 03 09:32:35 dm900 enigma2[267]: nr_read 722 nr_write 389
Oct 03 09:32:35 dm900 enigma2[267]: sum 1111 prev_sum 1110
Oct 03 09:32:35 dm900 enigma2[267]: hdd was accessed since previous check!
Oct 03 09:32:35 dm900 enigma2[267]: [IDLE] 0 120 False
Oct 03 09:32:42 dm900 enigma2[267]: no ancillary data in audio stream... abort radiotext pes parser
Oct 03 09:32:47 dm900 enigma2[267]: nr_read 722 nr_write 389
Oct 03 09:32:47 dm900 enigma2[267]: sum 1111 prev_sum 1111
Oct 03 09:32:47 dm900 enigma2[267]: hdd IDLE!
Oct 03 09:32:47 dm900 enigma2[267]: [IDLE] 12.0003578663 120 False
Oct 03 09:32:59 dm900 enigma2[267]: action ->  InfobarInstantRecord instantRecord
Oct 03 09:32:59 dm900 enigma2[267]: self.recording: []
Oct 03 09:32:59 dm900 enigma2[267]: I/  [TemplatedListFonts.__init__] :: Bigger: 24, Regular
Oct 03 09:32:59 dm900 enigma2[267]: I/  [TemplatedListFonts.__init__] :: Big: 22, Regular
Oct 03 09:32:59 dm900 enigma2[267]: I/  [TemplatedListFonts.__init__] :: Medium: 20, Regular
Oct 03 09:32:59 dm900 enigma2[267]: I/  [TemplatedListFonts.__init__] :: Small: 18, Regular
Oct 03 09:32:59 dm900 enigma2[267]: I/  [TemplatedListFonts.__init__] :: Smaller: 14, Regular
Oct 03 09:32:59 dm900 enigma2[267]: create buffer for widget 650 x 328
Oct 03 09:32:59 dm900 enigma2[267]: nr_read 722 nr_write 389
Oct 03 09:32:59 dm900 enigma2[267]: sum 1111 prev_sum 1111
Oct 03 09:32:59 dm900 enigma2[267]: hdd IDLE!
Oct 03 09:32:59 dm900 enigma2[267]: [IDLE] 24.0193510056 120 False
Oct 03 09:33:01 dm900 enigma2[267]: action ->  WizardActions ok
Oct 03 09:33:01 dm900 enigma2[267]: I/  [InfoBar.__restoreState] :: <no detail>
Oct 03 09:33:01 dm900 enigma2[267]: I/  [InfoBar.setPlaybackState] ::   1507015981.66
Oct 03 09:33:01 dm900 enigma2[267]: pre:
Oct 03 09:33:01 dm900 enigma2[267]: []
Oct 03 09:33:01 dm900 enigma2[267]: [TIMER] record time changed, start prepare is now: Tue Oct  3 09:32:41 2017
Oct 03 09:33:01 dm900 enigma2[267]: sanitycheck
Oct 03 09:33:01 dm900 enigma2[267]: check
Oct 03 09:33:01 dm900 enigma2[267]: checkTimerlist
Oct 03 09:33:01 dm900 enigma2[267]: [Timer] Record <RecordTimerEntry instance at a446eaf0 name=Verklag mich doch! >
Oct 03 09:33:01 dm900 enigma2[267]: ProcessRepeated
Oct 03 09:33:01 dm900 enigma2[267]: It's now  Di 03 Okt 2017 09:33:01 CEST
Oct 03 09:33:01 dm900 enigma2[267]: [TIMER] activating state 1
Oct 03 09:33:01 dm900 enigma2[267]: recording service: <enigma.eServiceReference; proxy of <Swig Object of type 'eServiceReference *' at 0xa4452b90> >
Oct 03 09:33:01 dm900 enigma2[267]: record: 0
Oct 03 09:33:01 dm900 enigma2[267]: [add callback]
Oct 03 09:33:01 dm900 enigma2[267]: begin_date:  20171003 0933
Oct 03 09:33:01 dm900 enigma2[267]: service_name:  VOX HD
Oct 03 09:33:01 dm900 enigma2[267]: name: Verklag mich doch!
Oct 03 09:33:01 dm900 enigma2[267]: description:
Oct 03 09:33:01 dm900 enigma2[267]: [TIMER] Filename calculated as: '/media/hdd/movie/20171003 0933 - VOX HD - Verklag mich doch!.ts'
Oct 03 09:33:01 dm900 enigma2[267]: use cached_channel
Oct 03 09:33:01 dm900 enigma2[267]: allocate Channel: res 0
Oct 03 09:33:01 dm900 enigma2[267]: RECORD service event 7
Oct 03 09:33:01 dm900 enigma2[267]: tuned..
Oct 03 09:33:01 dm900 enigma2[267]: no version filtering
Oct 03 09:33:01 dm900 enigma2[267]: 0012:  4e ef 11 00 00 00
Oct 03 09:33:01 dm900 enigma2[267]: mask:  ff ff ff 00 00 00
Oct 03 09:33:01 dm900 enigma2[267]: mode:  00 00 00 00 00 00
Oct 03 09:33:01 dm900 enigma2[267]: [TIMER] record event 2
Oct 03 09:33:01 dm900 enigma2[267]: ok ... now we start!!
Oct 03 09:33:01 dm900 enigma2[267]: no version filtering
Oct 03 09:33:01 dm900 enigma2[267]: 0000:  00 00 00 00 00 00
Oct 03 09:33:01 dm900 enigma2[267]: mask:  ff 00 00 00 00 00
Oct 03 09:33:01 dm900 enigma2[267]: mode:  00 00 00 00 00 00
Oct 03 09:33:01 dm900 enigma2[267]: [eDVBCAService] add demux 0 to slot 1 service 1:0:19:EF11:421:1:C00000:0:0:0:
Oct 03 09:33:01 dm900 enigma2[267]: [eDVBCIInterfaces] addPMTHandler 1:0:19:EF11:421:1:C00000:0:0:0:
Oct 03 09:33:01 dm900 enigma2[267]: [eDVBCIInterfaces] gotPMT
Oct 03 09:33:01 dm900 enigma2[267]: RECORD service event 5
Oct 03 09:33:01 dm900 enigma2[267]: [TIMER] record event 6
Oct 03 09:33:01 dm900 enigma2[267]: [eDVBCIInterfaces] gotPMT
Oct 03 09:33:01 dm900 enigma2[267]: RECORD service event 6
Oct 03 09:33:01 dm900 enigma2[267]: [eDVBMetaParser::updateMetaDb] database meta info outdated, updating!
Oct 03 09:33:02 dm900 enigma2[267]: [eDVBMetaParser::updateMetaDb] setting tags to
Oct 03 09:33:02 dm900 enigma2[267]: [eMediaDatabase] Error in query:
Oct 03 09:33:02 dm900 enigma2[267]: driverText:
Oct 03 09:33:02 dm900 enigma2[267]: databaseText:
Oct 03 09:33:02 dm900 enigma2[267]: query epg event id 7852
Oct 03 09:33:02 dm900 enigma2[267]: found event.. store to disc
Oct 03 09:33:02 dm900 enigma2[267]: [TIMER] prepare ok, waiting for begin
Oct 03 09:33:02 dm900 enigma2[267]: [TIMER] activating state 2
Oct 03 09:33:02 dm900 enigma2[267]: [TIMER] start recording
Oct 03 09:33:02 dm900 enigma2[267]: [TIMER] record event 0
Oct 03 09:33:02 dm900 enigma2[267]: AddPopup, id = None domain = RecordTimer
Oct 03 09:33:02 dm900 enigma2[267]: Recording to /media/hdd/movie/20171003 0933 - VOX HD - Verklag mich doch!.ts...
Oct 03 09:33:02 dm900 enigma2[267]: start recording...
Oct 03 09:33:02 dm900 enigma2[267]: RECORD: have 1 video stream(s) (01ff), and 1 audio stream(s) (0203), and the pcr pid is 01ff, and the text pid is 0021
Oct 03 09:33:02 dm900 enigma2[267]: ADD PID: 0000
Oct 03 09:33:02 dm900 enigma2[267]: ADD PID: 0021
Oct 03 09:33:02 dm900 enigma2[267]: ADD PID: 01ff
Oct 03 09:33:02 dm900 enigma2[267]: ADD PID: 0203
Oct 03 09:33:02 dm900 enigma2[267]: before: 1
Oct 03 09:33:02 dm900 enigma2[267]: after: 1
Oct 03 09:33:02 dm900 enigma2[267]: setIoPrio realtime level 7 ok
Oct 03 09:33:02 dm900 enigma2[267]: [TIMER] record event 4
Oct 03 09:33:02 dm900 enigma2[267]: next real activation is Di 03 Okt 2017 09:50:00 CEST
Oct 03 09:33:02 dm900 enigma2[267]: [timer.py] next activation: 1507016082 (in 99976 ms)
Oct 03 09:33:02 dm900 enigma2[267]: eRecordFileThread (direct io) START
Oct 03 09:33:02 dm900 enigma2[267]: record write thread succesfully created!
Oct 03 09:33:02 dm900 enigma2[267]: setIoPrio realtime level 7 ok
Oct 03 09:33:02 dm900 enigma2[267]: after:
Oct 03 09:33:02 dm900 enigma2[267]: [<RecordTimer.RecordTimerEntry object at 0xa446eaf0>]
Oct 03 09:33:02 dm900 enigma2[267]: [NotificationQueue::popNotification] domain RecordTimer deferred_callable: False
Oct 03 09:33:02 dm900 enigma2[267]: create buffer for widget 600 x 200
Oct 03 09:33:02 dm900 enigma2[267]: +- 1/2 TID 4e
Oct 03 09:33:02 dm900 enigma2[267]: + 1/1 TID 00
Oct 03 09:33:02 dm900 enigma2[267]: done!
Oct 03 09:33:02 dm900 enigma2[267]: PATready
Oct 03 09:33:02 dm900 enigma2[267]: use pmtpid 0061 for service_id ef11
Oct 03 09:33:02 dm900 enigma2[267]: no version filtering
Oct 03 09:33:02 dm900 enigma2[267]: 0061:  02 ef 11 00 00 00
Oct 03 09:33:02 dm900 enigma2[267]: mask:  ff ff ff 00 00 00
Oct 03 09:33:02 dm900 enigma2[267]: mode:  00 00 00 00 00 00
Oct 03 09:33:02 dm900 enigma2[267]: doing version filtering
Oct 03 09:33:02 dm900 enigma2[267]: 0000:  00 00 00 0d 00 00
Oct 03 09:33:02 dm900 enigma2[267]: mask:  ff 00 00 3f 00 00
Oct 03 09:33:02 dm900 enigma2[267]: mode:  00 00 00 3e 00 00
Oct 03 09:33:02 dm900 enigma2[267]: ++ 2/2 TID 4e
Oct 03 09:33:02 dm900 enigma2[267]: done!
Oct 03 09:33:02 dm900 enigma2[267]: event id of now EIT event matched record event...
Oct 03 09:33:02 dm900 enigma2[267]: written EIT based /media/hdd/movie/20171003 0933 - VOX HD - Verklag mich doch!.eit
Oct 03 09:33:02 dm900 enigma2[267]: pcr of eit change: 41c082f8
Oct 03 09:33:02 dm900 enigma2[267]: [eDVBServiceRecord] now running: Verklag mich doch! (3600 seconds) (RECORDING)
Oct 03 09:33:02 dm900 enigma2[267]: [TIMER] record event 9
Oct 03 09:33:02 dm900 enigma2[267]: doing version filtering
Oct 03 09:33:02 dm900 enigma2[267]: 0012:  4e ef 11 3f 00 00
Oct 03 09:33:02 dm900 enigma2[267]: mask:  ff ff ff 3f 00 00
Oct 03 09:33:02 dm900 enigma2[267]: mode:  00 00 00 3e 00 00
Oct 03 09:33:02 dm900 enigma2[267]: + 1/1 TID 02
Oct 03 09:33:02 dm900 enigma2[267]: done!
Oct 03 09:33:02 dm900 enigma2[267]: HBBTV broadcast data on pid 0206
Oct 03 09:33:02 dm900 enigma2[267]: [eDVBCAService] don't send the same capmt twice
Oct 03 09:33:02 dm900 enigma2[267]: [eDVBCIInterfaces] gotPMT
Oct 03 09:33:02 dm900 enigma2[267]: RECORD service event 5
Oct 03 09:33:02 dm900 enigma2[267]: start recording...
Oct 03 09:33:02 dm900 enigma2[267]: RECORD: have 1 video stream(s) (01ff), and 1 audio stream(s) (0203) (0031), and the pcr pid is 01ff, and the text pid is 0021
Oct 03 09:33:02 dm900 enigma2[267]: ADD PID: 0031
Oct 03 09:33:02 dm900 enigma2[267]: ADD PID: 0061
Oct 03 09:33:02 dm900 enigma2[267]: [TIMER] record event 4
Oct 03 09:33:02 dm900 enigma2[267]: [TIMER] record event 6
Oct 03 09:33:02 dm900 enigma2[267]: doing version filtering
Oct 03 09:33:02 dm900 enigma2[267]: 0061:  02 ef 11 01 00 00
Oct 03 09:33:02 dm900 enigma2[267]: mask:  ff ff ff 3f 00 00
Oct 03 09:33:02 dm900 enigma2[267]: mode:  00 00 00 3e 00 00
Oct 03 09:33:04 dm900 enigma2[267]: Timeout!
Oct 03 09:33:04 dm900 enigma2[267]: I/  [InfoBar.__restoreState] :: <no detail>
Oct 03 09:33:04 dm900 enigma2[267]: I/  [InfoBar.setPlaybackState] ::   1507015984.11
Oct 03 09:33:10 dm900 enigma2[267]: action ->  InfobarChannelSelection switchChannelDown
Oct 03 09:33:10 dm900 enigma2[267]: reused converter!
Oct 03 09:33:10 dm900 enigma2[267]: reused converter!
Oct 03 09:33:10 dm900 enigma2[267]: reused converter!
Oct 03 09:33:11 dm900 enigma2[267]: action ->  ChannelSelectBaseActions selectServicePageDown
Oct 03 09:33:11 dm900 enigma2[267]: unknown action ChannelSelectBaseActions/selectServicePageDown! typo in keymap?
Oct 03 09:33:11 dm900 enigma2[267]: action ->  WizardActions right
Oct 03 09:33:11 dm900 enigma2[267]: unknown action WizardActions/right! typo in keymap?
Oct 03 09:33:11 dm900 enigma2[267]: nr_read 726 nr_write 492
Oct 03 09:33:11 dm900 enigma2[267]: sum 1218 prev_sum 1111
Oct 03 09:33:11 dm900 enigma2[267]: hdd was accessed since previous check!
Oct 03 09:33:11 dm900 enigma2[267]: [IDLE] 0 120 False
Oct 03 09:33:11 dm900 enigma2[267]: action ->  ChannelSelectBaseActions selectServicePageDown
Oct 03 09:33:11 dm900 enigma2[267]: unknown action ChannelSelectBaseActions/selectServicePageDown! typo in keymap?
Oct 03 09:33:11 dm900 enigma2[267]: action ->  WizardActions right
Oct 03 09:33:11 dm900 enigma2[267]: unknown action WizardActions/right! typo in keymap?
Oct 03 09:33:14 dm900 enigma2[267]: action ->  OkCancelActions ok
Oct 03 09:33:14 dm900 enigma2[267]: playing 1:0:19:69:C:85:C00000:0:0:0:
Oct 03 09:33:14 dm900 enigma2[267]: [eDVBCAService] free slot 0 demux 0 for service 1:0:19:EF11:421:1:C00000:0:0:0:
Oct 03 09:33:14 dm900 enigma2[267]: [eDVBCAService] don't send the same capmt twice
Oct 03 09:33:14 dm900 enigma2[267]: [eDBusInterface::Private::sendEvent 0
Oct 03 09:33:14 dm900 enigma2[267]: [TeleText] service stopped
Oct 03 09:33:14 dm900 enigma2[267]: [TeleText] send array('B', [1, 0, 0, 0])
Oct 03 09:33:14 dm900 enigma2[267]: disable dvb subtitles
Oct 03 09:33:14 dm900 enigma2[267]: disable teletext subtitles page ffffffffffffffff (und)
Oct 03 09:33:14 dm900 enigma2[267]: decoder state: play, vpid=-1, apid=-1
Oct 03 09:33:14 dm900 enigma2[267]: DEMUX_STOP - pcr - ok
Oct 03 09:33:14 dm900 enigma2[267]: DEMUX_STOP - video - ok
Oct 03 09:33:14 dm900 enigma2[267]: VIDEO_STOP - ok
Oct 03 09:33:14 dm900 enigma2[267]: AUDIO_STOP - ok
Oct 03 09:33:14 dm900 enigma2[267]: DEMUX_STOP - audio - ok
Oct 03 09:33:14 dm900 enigma2[267]: AUDIO_CONTINUE - ok
Oct 03 09:33:14 dm900 enigma2[267]: DEMUX_STOP - ttx - ok
Oct 03 09:33:14 dm900 enigma2[267]: [TeleText] service started
Oct 03 09:33:14 dm900 enigma2[267]: not pauseable.
Oct 03 09:33:14 dm900 enigma2[267]: W/  [InfoBar.__servicePlaying] :: <no detail>
Oct 03 09:33:14 dm900 enigma2[267]: I/  [InfoBar.setPlaybackState] :: None None 1507015994.12
Oct 03 09:33:14 dm900 enigma2[267]: allocate channel.. 000c:0085:00c00000
Oct 03 09:33:14 dm900 enigma2[267]: available channel.. 0421:0001:00c00000
Oct 03 09:33:14 dm900 enigma2[267]: [    1] opening frontend
Oct 03 09:33:14 dm900 enigma2[267]: [eDVBCAService] new channel 0x108d8a0!
Oct 03 09:33:14 dm900 enigma2[267]: [    1] tune type 1
Oct 03 09:33:14 dm900 enigma2[267]: RotorCmd ffffffff, lastRotorCmd ffffffff
Oct 03 09:33:14 dm900 enigma2[267]: [    1] prepare_sat System DVB-S2 Freq 12304750H SR 27501000 INV Auto FEC 9/10 orbpos 192 modulation QPSK pilot Off, rolloff 0.35
Oct 03 09:33:14 dm900 enigma2[267]: [    1] tuning to 1704 mhz
Oct 03 09:33:14 dm900 enigma2[267]: OURSTATE: tuning
Oct 03 09:33:14 dm900 enigma2[267]: [SEC-1] update oparm
Oct 03 09:33:14 dm900 enigma2[267]: [SEC-1] lock 0
Oct 03 09:33:14 dm900 enigma2[267]: [SEC-1] locked 1
Oct 03 09:33:14 dm900 enigma2[267]: [SEC-1] set static current limiting
Oct 03 09:33:14 dm900 enigma2[267]: allocate Channel: res 0
Oct 03 09:33:14 dm900 enigma2[267]: allocate demux
Oct 03 09:33:14 dm900 enigma2[267]: [SEC-1] invalidate current switch params
Oct 03 09:33:14 dm900 enigma2[267]: [SEC-1] setVoltage 18V
Oct 03 09:33:14 dm900 enigma2[267]: setInputSource input1 to A2
Oct 03 09:33:14 dm900 enigma2[267]: [SEC-1] sleep 10ms
Oct 03 09:33:14 dm900 enigma2[267]: [eDVBCAService] new service 1:0:19:69:C:85:C00000:0:0:0:
Oct 03 09:33:14 dm900 enigma2[267]: [eDVBCAService] add demux 1 to slot 0 service 1:0:19:69:C:85:C00000:0:0:0:
Oct 03 09:33:14 dm900 enigma2[267]: [eDVBCAService] use cached!
Oct 03 09:33:14 dm900 enigma2[267]: [eDVBCAService] demux 1 mask 02
Oct 03 09:33:14 dm900 enigma2[267]: [eDVBCAServiceConn] send 82 bytes to '/tmp/camd.socket'
Oct 03 09:33:14 dm900 enigma2[267]: 9f 80 32 4e 03 00 69 0d 00 2a 01 81 08 00 c0 00 00 00 0c 00 85 82 02 02 01 84 02 00 60 85 03 01 41 32 09 04 09 c4 fb 0d 09 04 09 8c fa 0d 09 04 09 af ff 0d 1b 00 ff 00 00 06 01 02 00 00 06 01 03 00 00 06 01 04 00 00 06 01 05 00 00 06 01 06 00 00
Oct 03 09:33:14 dm900 enigma2[267]: [eDVBCIInterfaces] addPMTHandler 1:0:19:69:C:85:C00000:0:0:0:
Oct 03 09:33:14 dm900 enigma2[267]: 'SKY/00c00000' is in provider list of slot 0... so use it
Oct 03 09:33:14 dm900 enigma2[267]: (1)CISlot 0, usecount now 1
Oct 03 09:33:14 dm900 enigma2[267]: setInputSource input1 to CI0
Oct 03 09:33:14 dm900 enigma2[267]: CI Slot 0 setSource(1)
Oct 03 09:33:14 dm900 enigma2[267]: [eDVBCIInterfaces] gotPMT
Oct 03 09:33:14 dm900 enigma2[267]: [eDVBCIInterfaces] gotPMT
Oct 03 09:33:14 dm900 enigma2[267]: have 1 video stream(s) (00ff), and 1 audio stream(s) (0102), and the pcr pid is 00ff, and the text pid is 0105
Oct 03 09:33:14 dm900 enigma2[267]: allocate demux
Oct 03 09:33:14 dm900 enigma2[267]: disable teletext subtitles page ffffffffffffffff (und)
Oct 03 09:33:14 dm900 enigma2[267]: decoder state: play, vpid=255, apid=258
Oct 03 09:33:14 dm900 enigma2[267]: DMX_SET_PES_FILTER(0xff) - pcr - ok
Oct 03 09:33:14 dm900 enigma2[267]: DEMUX_START - pcr - ok
Oct 03 09:33:14 dm900 enigma2[267]: DMX_SET_PES_FILTER(0x102) - audio - ok
Oct 03 09:33:14 dm900 enigma2[267]: DEMUX_START - audio - ok
Oct 03 09:33:14 dm900 enigma2[267]: AUDIO_SET_BYPASS(0) - ok
Oct 03 09:33:14 dm900 enigma2[267]: AUDIO_PAUSE - ok
Oct 03 09:33:14 dm900 enigma2[267]: AUDIO_PLAY - ok[SEC-1] setTone On
Oct 03 09:33:14 dm900 enigma2[267]: Video Device: /dev/dvb/adapter0/video0
Oct 03 09:33:14 dm900 enigma2[267]: demux device: /dev/dvb/adapter0/demux1
Oct 03 09:33:14 dm900 enigma2[267]: VIDEO_SET_STREAMTYPE 1 - ok
Oct 03 09:33:14 dm900 enigma2[267]: DMX_SET_PES_FILTER(0xff) - video - ok
Oct 03 09:33:14 dm900 enigma2[267]: DEMUX_START - video - ok
Oct 03 09:33:14 dm900 enigma2[267]: VIDEO_FREEZE - ok
Oct 03 09:33:14 dm900 enigma2[267]: VIDEO_PLAY - ok
Oct 03 09:33:14 dm900 enigma2[267]: DMX_SET_PES_FILTER(0x105) - ttx - ok
Oct 03 09:33:14 dm900 enigma2[267]: DEMUX_START - ttx - ok
Oct 03 09:33:14 dm900 enigma2[267]: VIDEO_SLOWMOTION(0) - ok
Oct 03 09:33:14 dm900 enigma2[267]: VIDEO_FAST_FORWARD(0) - ok
Oct 03 09:33:14 dm900 enigma2[267]: VIDEO_CONTINUE - ok
Oct 03 09:33:14 dm900 enigma2[267]: AUDIO_CONTINUE - ok
Oct 03 09:33:14 dm900 enigma2[267]: W/  [InfoBar.__servicePlaying] :: <no detail>
Oct 03 09:33:14 dm900 enigma2[267]: I/  [InfoBar.setPlaybackState] :: None None 1507015994.18
Oct 03 09:33:14 dm900 enigma2[267]: not pauseable.
Oct 03 09:33:14 dm900 enigma2[267]: [HbbTV].aitInvalidated
Oct 03 09:33:14 dm900 enigma2[267]: [SEC-1] sleep 10ms
Oct 03 09:33:14 dm900 enigma2[267]: I/  [InfoBar.__restoreState] :: <no detail>[SEC-1] update current switch params
Oct 03 09:33:14 dm900 enigma2[267]: [SEC-1] startTuneTimeout 5000
Oct 03 09:33:14 dm900 enigma2[267]: [SEC-1] setFrontend 1
Oct 03 09:33:14 dm900 enigma2[267]: [    1] setting frontend
Oct 03 09:33:14 dm900 enigma2[267]: [SEC-1] unlock 1
Oct 03 09:33:14 dm900 enigma2[267]: [SEC-1] sleep 500ms
Oct 03 09:33:14 dm900 enigma2[267]: create buffer for widget 1280 x 150
Oct 03 09:33:14 dm900 enigma2[267]: [    1] fe event: status 0, freq 1704750, inversion off, m_tuning 1 F
Oct 03 09:33:14 dm900 enigma2[267]: [    1] fe event: status 1f, freq 1704750, inversion off, m_tuning 1 N
Oct 03 09:33:14 dm900 enigma2[267]: OURSTATE: ok
Oct 03 09:33:14 dm900 enigma2[267]: [eDVBCAService] channel 0x108d8a0 running
Oct 03 09:33:14 dm900 enigma2[267]: [eDVBLocalTimeHandler] channel 0x108d8a0 running
Oct 03 09:33:14 dm900 enigma2[267]: no version filtering
Oct 03 09:33:14 dm900 enigma2[267]: 0014:  70 00 00 00 00 00
Oct 03 09:33:14 dm900 enigma2[267]: mask:  fc 00 00 00 00 00
Oct 03 09:33:14 dm900 enigma2[267]: mode:  00 00 00 00 00 00
Oct 03 09:33:14 dm900 enigma2[267]: [EPGC] channel 0x108d8a0 running
Oct 03 09:33:14 dm900 enigma2[267]: [EPGC] next update in 2 sec
Oct 03 09:33:14 dm900 enigma2[267]: stop release channel timer
Oct 03 09:33:14 dm900 enigma2[267]: no version filtering
Oct 03 09:33:14 dm900 enigma2[267]: 0012:  4e 00 69 00 00 00
Oct 03 09:33:14 dm900 enigma2[267]: mask:  ff ff ff 00 00 00
Oct 03 09:33:14 dm900 enigma2[267]: mode:  00 00 00 00 00 00
Oct 03 09:33:14 dm900 enigma2[267]: W/  [InfoBar.__servicePlaying] :: <no detail>
Oct 03 09:33:14 dm900 enigma2[267]: I/  [InfoBar.setPlaybackState] :: None None 1507015994.55
Oct 03 09:33:14 dm900 enigma2[267]: ok ... now we start!!
Oct 03 09:33:14 dm900 enigma2[267]: no version filtering
Oct 03 09:33:14 dm900 enigma2[267]: 0000:  00 00 00 00 00 00
Oct 03 09:33:14 dm900 enigma2[267]: mask:  ff 00 00 00 00 00
Oct 03 09:33:14 dm900 enigma2[267]: mode:  00 00 00 00 00 00
Oct 03 09:33:14 dm900 enigma2[267]: + 1/1 TID 00
Oct 03 09:33:14 dm900 enigma2[267]: done!
Oct 03 09:33:14 dm900 enigma2[267]: PATready
Oct 03 09:33:14 dm900 enigma2[267]: use pmtpid 0060 for service_id 0069
Oct 03 09:33:14 dm900 enigma2[267]: no version filtering
Oct 03 09:33:14 dm900 enigma2[267]: 0060:  02 00 69 00 00 00
Oct 03 09:33:14 dm900 enigma2[267]: mask:  ff ff ff 00 00 00
Oct 03 09:33:14 dm900 enigma2[267]: mode:  00 00 00 00 00 00
Oct 03 09:33:14 dm900 enigma2[267]: doing version filtering
Oct 03 09:33:14 dm900 enigma2[267]: 0000:  00 00 00 29 00 00
Oct 03 09:33:14 dm900 enigma2[267]: mask:  ff 00 00 3f 00 00
Oct 03 09:33:14 dm900 enigma2[267]: mode:  00 00 00 3e 00 00
Oct 03 09:33:14 dm900 enigma2[267]: + 1/1 TID 02
Oct 03 09:33:14 dm900 enigma2[267]: done!
Oct 03 09:33:14 dm900 enigma2[267]: [eDVBCAService] don't send the same capmt twice
Oct 03 09:33:14 dm900 enigma2[267]: [eDVBCIInterfaces] gotPMT
Oct 03 09:33:14 dm900 enigma2[267]: eventNewProgramInfo 0 0
Oct 03 09:33:14 dm900 enigma2[267]: have 1 video stream(s) (00ff), and 3 audio stream(s) (0102, 0103, 0104), and the pcr pid is 00ff, and the text pid is 0105
Oct 03 09:33:14 dm900 enigma2[267]: decoder state: play, vpid=255, apid=258
Oct 03 09:33:14 dm900 enigma2[267]: [TeleText] serviceInfoChanged
Oct 03 09:33:14 dm900 enigma2[267]: [TeleText] TXT PID 261 DEMUX 1
Oct 03 09:33:14 dm900 enigma2[267]: [TeleText] send array('B', [1, 1, 5, 1])
Oct 03 09:33:14 dm900 enigma2[267]: doing version filtering
Oct 03 09:33:14 dm900 enigma2[267]: 0060:  02 00 69 0d 00 00
Oct 03 09:33:14 dm900 enigma2[267]: mask:  ff ff ff 3f 00 00
Oct 03 09:33:14 dm900 enigma2[267]: mode:  00 00 00 3e 00 00
Oct 03 09:33:14 dm900 enigma2[267]: [SEC-1] set dynamic current limiting
Oct 03 09:33:15 dm900 enigma2[267]: +- 1/2 TID 4e
Oct 03 09:33:16 dm900 enigma2[267]: ++ 2/2 TID 4e
Oct 03 09:33:16 dm900 enigma2[267]: done!
Oct 03 09:33:16 dm900 enigma2[267]: W/  [InfoBar.__servicePlaying] :: <no detail>
Oct 03 09:33:16 dm900 enigma2[267]: I/  [InfoBar.setPlaybackState] :: None None 1507015996.17
Oct 03 09:33:16 dm900 enigma2[267]: doing version filtering
Oct 03 09:33:16 dm900 enigma2[267]: 0012:  4e 00 69 29 00 00
Oct 03 09:33:16 dm900 enigma2[267]: mask:  ff ff ff 3f 00 00
Oct 03 09:33:16 dm900 enigma2[267]: mode:  00 00 00 3e 00 00
Oct 03 09:33:16 dm900 enigma2[267]: sdt update done!
Oct 03 09:33:16 dm900 enigma2[267]: [EPGC] start caching events(1507015996)
Oct 03 09:33:15 dm900 enigma2[267]: [eDVBLocalTimeHandler] Receiver time is 'Tue Oct  3 09:33:16 2017'
Oct 03 09:33:15 dm900 enigma2[267]: [eDVBLocalTimeHandler] Transponder time is 'Tue Oct  3 09:33:15 2017'
Oct 03 09:33:15 dm900 enigma2[267]: [eDVBLocalTimeHandler] diff is -1
Oct 03 09:33:15 dm900 enigma2[267]: [eDVBLocalTimeHandler] diff < 120 .. use Transponder Time
Oct 03 09:33:15 dm900 enigma2[267]: [eDVBLocalTimeHandler] update RTC
Oct 03 09:33:15 dm900 enigma2[267]: [eDVBLocalTimeHandler] time_difference is -1
Oct 03 09:33:15 dm900 enigma2[267]: [eDVBLocalTimeHandler] update Linux Time
Oct 03 09:33:23 dm900 enigma2[267]: [EPGC] abort non avail schedule other reading
Oct 03 09:33:23 dm900 enigma2[267]: [EPGC] abort non avail viasat reading
Oct 03 09:33:23 dm900 enigma2[267]: [EPGC] nownext finished(1507016003)
Oct 03 09:33:23 dm900 enigma2[267]: nr_read 726 nr_write 605
Oct 03 09:33:23 dm900 enigma2[267]: sum 1331 prev_sum 1218
Oct 03 09:33:23 dm900 enigma2[267]: hdd was accessed since previous check!
Oct 03 09:33:23 dm900 enigma2[267]: [IDLE] 0 120 False
Oct 03 09:33:25 dm900 enigma2[267]: [EPGC] schedule finished(1507016005)
Oct 03 09:33:25 dm900 enigma2[267]: [EPGC] stop caching events(1507016005)
Oct 03 09:33:25 dm900 enigma2[267]: [EPGC] next update in 60 min
Oct 03 09:33:25 dm900 enigma2[267]: [EPGC] cleanup invalid data
Oct 03 09:33:29 dm900 enigma2[267]: action ->  InfobarChannelSelection zapUp
Oct 03 09:33:29 dm900 enigma2[267]: playing 1:0:19:72:D:85:C00000:0:0:0:
Oct 03 09:33:29 dm900 enigma2[267]: [eDVBCAService] free slot 0 demux 1 for service 1:0:19:69:C:85:C00000:0:0:0:
Oct 03 09:33:29 dm900 enigma2[267]: [eDVBCAService] free service 1:0:19:69:C:85:C00000:0:0:0:
Oct 03 09:33:29 dm900 enigma2[267]: [eFileMonitor] 1 events queued
Oct 03 09:33:29 dm900 enigma2[267]: [eDVBCIInterfaces] remove last pmt handler for service 1:0:19:69:C:85:C00000:0:0:0: send empty capmt
Oct 03 09:33:29 dm900 enigma2[267]: [eDVBCISlot] capmt version equal... increment old was 0d! new version is 0f
Oct 03 09:33:29 dm900 enigma2[267]: setInputSource input1 to A2
Oct 03 09:33:29 dm900 enigma2[267]: (3) slot 0 usecount is now 0
Oct 03 09:33:29 dm900 enigma2[267]: [eDBusInterface::Private::sendEvent 0
Oct 03 09:33:29 dm900 enigma2[267]: [TeleText] service stopped
Oct 03 09:33:29 dm900 enigma2[267]: [TeleText] send array('B', [1, 0, 0, 0])
Oct 03 09:33:29 dm900 enigma2[267]: disable dvb subtitles
Oct 03 09:33:29 dm900 enigma2[267]: disable teletext subtitles page ffffffffffffffff (und)
Oct 03 09:33:29 dm900 enigma2[267]: decoder state: play, vpid=-1, apid=-1
Oct 03 09:33:29 dm900 enigma2[267]: DEMUX_STOP - pcr - ok
Oct 03 09:33:29 dm900 enigma2[267]: DEMUX_STOP - video - ok
Oct 03 09:33:29 dm900 enigma2[267]: VIDEO_STOP - ok
Oct 03 09:33:29 dm900 enigma2[267]: AUDIO_STOP - ok
Oct 03 09:33:29 dm900 enigma2[267]: DEMUX_STOP - audio - ok
Oct 03 09:33:29 dm900 enigma2[267]: AUDIO_CONTINUE - ok
Oct 03 09:33:29 dm900 enigma2[267]: DEMUX_STOP - ttx - ok
Oct 03 09:33:29 dm900 enigma2[267]: start release channel timer
Oct 03 09:33:29 dm900 enigma2[267]: [TeleText] service started
Oct 03 09:33:29 dm900 enigma2[267]: create buffer for widget 1280 x 150
Oct 03 09:33:29 dm900 enigma2[267]: not pauseable.
Oct 03 09:33:29 dm900 enigma2[267]: W/  [InfoBar.__servicePlaying] :: <no detail>
Oct 03 09:33:29 dm900 enigma2[267]: I/  [InfoBar.setPlaybackState] :: None None 1507016009.07
Oct 03 09:33:29 dm900 enigma2[267]: [eDVBCAService] remove channel 0x108d8a0
Oct 03 09:33:29 dm900 enigma2[267]: [eDVBCAService] write leave transponder to '/tmp/camd.socket' ok
Oct 03 09:33:29 dm900 enigma2[267]: [eDVBLocalTimeHandler] remove channel 0x108d8a0
Oct 03 09:33:29 dm900 enigma2[267]: [EPGC] remove channel 0x108d8a0
Oct 03 09:33:29 dm900 enigma2[267]: [    1] preClose
Oct 03 09:33:29 dm900 enigma2[267]: allocate channel.. 000d:0085:00c00000
Oct 03 09:33:29 dm900 enigma2[267]: available channel.. 0421:0001:00c00000
Oct 03 09:33:29 dm900 enigma2[267]: [eDVBCAService] new channel 0x10afca0!
Oct 03 09:33:29 dm900 enigma2[267]: [    1] tune type 1
Oct 03 09:33:29 dm900 enigma2[267]: RotorCmd ffffffff, lastRotorCmd ffffffff
Oct 03 09:33:29 dm900 enigma2[267]: [    1] prepare_sat System DVB-S2 Freq 11992500H SR 27500000 INV Auto FEC 9/10 orbpos 192 modulation QPSK pilot Off, rolloff 0.35
Oct 03 09:33:29 dm900 enigma2[267]: [    1] tuning to 1392 mhz
Oct 03 09:33:29 dm900 enigma2[267]: OURSTATE: tuning
Oct 03 09:33:29 dm900 enigma2[267]: allocate Channel: res 0
Oct 03 09:33:29 dm900 enigma2[267]: [SEC-1] update oparm
Oct 03 09:33:29 dm900 enigma2[267]: [SEC-1] lock 0
Oct 03 09:33:29 dm900 enigma2[267]: [SEC-1] locked 1
Oct 03 09:33:29 dm900 enigma2[267]: allocate demux
Oct 03 09:33:29 dm900 enigma2[267]: [SEC-1] set static current limiting
Oct 03 09:33:29 dm900 enigma2[267]: setInputSource input1 to A2
Oct 03 09:33:29 dm900 enigma2[267]: [eDVBCAService] new service 1:0:19:72:D:85:C00000:0:0:0:
Oct 03 09:33:29 dm900 enigma2[267]: [eDVBCAService] add demux 1 to slot 0 service 1:0:19:72:D:85:C00000:0:0:0:
Oct 03 09:33:29 dm900 enigma2[267]: [eDVBCAService] use cached!
Oct 03 09:33:29 dm900 enigma2[267]: [eDVBCAService] demux 1 mask 02
Oct 03 09:33:29 dm900 enigma2[267]: [eDVBCAServiceConn] send 72 bytes to '/tmp/camd.socket'
Oct 03 09:33:29 dm900 enigma2[267]: 9f 80 32 44 03 00 72 13 00 2a 01 81 08 00 c0 00 00 00 0d 00 85 82 02 02 01 84 02 00 63 85 03 01 41 32 09 04 09 8c fa 01 09 04 09 c4 fb 01 09 04 09 af ff 01 06 00 20 00 00 1b 03 ff 00 00 06 04 02 00 00 06 04 03 00 00
Oct 03 09:33:29 dm900 enigma2[267]: [eDVBCIInterfaces] addPMTHandler 1:0:19:72:D:85:C00000:0:0:0:
Oct 03 09:33:29 dm900 enigma2[267]: 'SKY/00c00000' is in provider list of slot 0... so use it
Oct 03 09:33:29 dm900 enigma2[267]: (1)CISlot 0, usecount now 1
Oct 03 09:33:29 dm900 enigma2[267]: setInputSource input1 to CI0
Oct 03 09:33:29 dm900 enigma2[267]: [SEC-1] invalidate current switch params
Oct 03 09:33:29 dm900 enigma2[267]: [SEC-1] update current switch params
Oct 03 09:33:29 dm900 enigma2[267]: [SEC-1] startTuneTimeout 5000
Oct 03 09:33:29 dm900 enigma2[267]: [SEC-1] setFrontend 1
Oct 03 09:33:29 dm900 enigma2[267]: [    1] setting frontend
Oct 03 09:33:29 dm900 enigma2[267]: [SEC-1] unlock 1
Oct 03 09:33:29 dm900 enigma2[267]: [SEC-1] sleep 500ms
Oct 03 09:33:29 dm900 enigma2[267]: CI Slot 0 setSource(1)
Oct 03 09:33:29 dm900 enigma2[267]: [eDVBCIInterfaces] gotPMT
Oct 03 09:33:29 dm900 enigma2[267]: [eDVBCIInterfaces] gotPMT
Oct 03 09:33:29 dm900 enigma2[267]: have 1 video stream(s) (03ff), and 1 audio stream(s) (0402), and the pcr pid is 03ff, and the text pid is 0020
Oct 03 09:33:29 dm900 enigma2[267]: allocate demux
Oct 03 09:33:29 dm900 enigma2[267]: disable teletext subtitles page ffffffffffffffff (und)
Oct 03 09:33:29 dm900 enigma2[267]: decoder state: play, vpid=1023, apid=1026
Oct 03 09:33:29 dm900 enigma2[267]: DMX_SET_PES_FILTER(0x3ff) - pcr - ok
Oct 03 09:33:29 dm900 enigma2[267]: DEMUX_START - pcr - ok
Oct 03 09:33:29 dm900 enigma2[267]: DMX_SET_PES_FILTER(0x402) - audio - ok
Oct 03 09:33:29 dm900 enigma2[267]: DEMUX_START - audio - ok
Oct 03 09:33:29 dm900 enigma2[267]: AUDIO_SET_BYPASS(0) - ok
Oct 03 09:33:29 dm900 enigma2[267]: AUDIO_PAUSE - ok
Oct 03 09:33:29 dm900 enigma2[267]: AUDIO_PLAY - ok
Oct 03 09:33:29 dm900 enigma2[267]: Video Device: /dev/dvb/adapter0/video0
Oct 03 09:33:29 dm900 enigma2[267]: demux device: /dev/dvb/adapter0/demux1
Oct 03 09:33:29 dm900 enigma2[267]: VIDEO_SET_STREAMTYPE 1 - ok
Oct 03 09:33:29 dm900 enigma2[267]: DMX_SET_PES_FILTER(0x3ff) - video - ok
Oct 03 09:33:29 dm900 enigma2[267]: DEMUX_START - video - ok
Oct 03 09:33:29 dm900 enigma2[267]: VIDEO_FREEZE - ok
Oct 03 09:33:29 dm900 enigma2[267]: VIDEO_PLAY - ok
Oct 03 09:33:29 dm900 enigma2[267]: DMX_SET_PES_FILTER(0x20) - ttx - ok
Oct 03 09:33:29 dm900 enigma2[267]: DEMUX_START - ttx - ok
Oct 03 09:33:29 dm900 enigma2[267]: VIDEO_SLOWMOTION(0) - ok
Oct 03 09:33:29 dm900 enigma2[267]: VIDEO_FAST_FORWARD(0) - ok
Oct 03 09:33:29 dm900 enigma2[267]: VIDEO_CONTINUE - ok
Oct 03 09:33:29 dm900 enigma2[267]: AUDIO_CONTINUE - ok
Oct 03 09:33:29 dm900 enigma2[267]: W/  [InfoBar.__servicePlaying] :: <no detail>
Oct 03 09:33:29 dm900 enigma2[267]: I/  [InfoBar.setPlaybackState] :: None None 1507016009.09
Oct 03 09:33:29 dm900 enigma2[267]: not pauseable.
Oct 03 09:33:29 dm900 enigma2[267]: [HbbTV].aitInvalidated
Oct 03 09:33:29 dm900 enigma2[267]: [eFileMonitor] File {/tmp/ecm.info} has been deleted
Oct 03 09:33:29 dm900 enigma2[267]: [    1] fe event: status 0, freq 1392500, inversion off, m_tuning 1 F
Oct 03 09:33:29 dm900 enigma2[267]: [    1] fe event: status 1, freq 1392500, inversion off, m_tuning 1 N
Oct 03 09:33:29 dm900 enigma2[267]: [    1] fe event: status 1f, freq 1392500, inversion off, m_tuning 2 N
Oct 03 09:33:29 dm900 enigma2[267]: OURSTATE: ok
Oct 03 09:33:29 dm900 enigma2[267]: [eDVBCAService] channel 0x10afca0 running
Oct 03 09:33:29 dm900 enigma2[267]: [eDVBLocalTimeHandler] channel 0x10afca0 running
Oct 03 09:33:29 dm900 enigma2[267]: no version filtering
Oct 03 09:33:29 dm900 enigma2[267]: 0014:  70 00 00 00 00 00
Oct 03 09:33:29 dm900 enigma2[267]: mask:  fc 00 00 00 00 00
Oct 03 09:33:29 dm900 enigma2[267]: mode:  00 00 00 00 00 00
Oct 03 09:33:29 dm900 enigma2[267]: [EPGC] channel 0x10afca0 running
Oct 03 09:33:29 dm900 enigma2[267]: stop release channel timer
Oct 03 09:33:29 dm900 enigma2[267]: no version filtering
Oct 03 09:33:29 dm900 enigma2[267]: 0012:  4e 00 72 00 00 00
Oct 03 09:33:29 dm900 enigma2[267]: mask:  ff ff ff 00 00 00
Oct 03 09:33:29 dm900 enigma2[267]: mode:  00 00 00 00 00 00
Oct 03 09:33:29 dm900 enigma2[267]: [EPGC] next update in 2 sec
Oct 03 09:33:29 dm900 enigma2[267]: W/  [InfoBar.__servicePlaying] :: <no detail>
Oct 03 09:33:29 dm900 enigma2[267]: I/  [InfoBar.setPlaybackState] :: None None 1507016009.32
Oct 03 09:33:29 dm900 enigma2[267]: ok ... now we start!!
Oct 03 09:33:29 dm900 enigma2[267]: no version filtering
Oct 03 09:33:29 dm900 enigma2[267]: 0000:  00 00 00 00 00 00
Oct 03 09:33:29 dm900 enigma2[267]: mask:  ff 00 00 00 00 00
Oct 03 09:33:29 dm900 enigma2[267]: mode:  00 00 00 00 00 00
Oct 03 09:33:29 dm900 enigma2[267]: + 1/1 TID 00
Oct 03 09:33:29 dm900 enigma2[267]: done!
Oct 03 09:33:29 dm900 enigma2[267]: PATready
Oct 03 09:33:29 dm900 enigma2[267]: use pmtpid 0063 for service_id 0072
Oct 03 09:33:29 dm900 enigma2[267]: no version filtering
Oct 03 09:33:29 dm900 enigma2[267]: 0063:  02 00 72 00 00 00
Oct 03 09:33:29 dm900 enigma2[267]: mask:  ff ff ff 00 00 00
Oct 03 09:33:29 dm900 enigma2[267]: mode:  00 00 00 00 00 00
Oct 03 09:33:29 dm900 enigma2[267]: doing version filtering
Oct 03 09:33:29 dm900 enigma2[267]: 0000:  00 00 00 1d 00 00
Oct 03 09:33:29 dm900 enigma2[267]: mask:  ff 00 00 3f 00 00
Oct 03 09:33:29 dm900 enigma2[267]: mode:  00 00 00 3e 00 00
Oct 03 09:33:29 dm900 enigma2[267]: +- 1/2 TID 4e
Oct 03 09:33:29 dm900 enigma2[267]: + 1/1 TID 02
Oct 03 09:33:29 dm900 enigma2[267]: done!
Oct 03 09:33:29 dm900 enigma2[267]: [eDVBCAService] don't send the same capmt twice
Oct 03 09:33:29 dm900 enigma2[267]: [eDVBCIInterfaces] gotPMT
Oct 03 09:33:29 dm900 enigma2[267]: eventNewProgramInfo 0 0
Oct 03 09:33:29 dm900 enigma2[267]: have 1 video stream(s) (03ff), and 2 audio stream(s) (0402, 0403), and the pcr pid is 03ff, and the text pid is 0020
Oct 03 09:33:29 dm900 enigma2[267]: decoder state: play, vpid=1023, apid=1026
Oct 03 09:33:29 dm900 enigma2[267]: [TeleText] serviceInfoChanged
Oct 03 09:33:29 dm900 enigma2[267]: [TeleText] TXT PID 32 DEMUX 1
Oct 03 09:33:29 dm900 enigma2[267]: [TeleText] send array('B', [1, 0, 32, 1])
Oct 03 09:33:29 dm900 enigma2[267]: doing version filtering
Oct 03 09:33:29 dm900 enigma2[267]: 0063:  02 00 72 13 00 00
Oct 03 09:33:29 dm900 enigma2[267]: mask:  ff ff ff 3f 00 00
Oct 03 09:33:29 dm900 enigma2[267]: mode:  00 00 00 3e 00 00
Oct 03 09:33:27 dm900 enigma2[267]: [eDVBLocalTimeHandler] Receiver time is 'Tue Oct  3 09:33:29 2017'
Oct 03 09:33:27 dm900 enigma2[267]: [eDVBLocalTimeHandler] Transponder time is 'Tue Oct  3 09:33:27 2017'
Oct 03 09:33:27 dm900 enigma2[267]: [eDVBLocalTimeHandler] diff is -2
Oct 03 09:33:27 dm900 enigma2[267]: [eDVBLocalTimeHandler] diff < 120 .. use Transponder Time
Oct 03 09:33:27 dm900 enigma2[267]: [eDVBLocalTimeHandler] update RTC
Oct 03 09:33:27 dm900 enigma2[267]: [eDVBLocalTimeHandler] time_difference is -2
Oct 03 09:33:27 dm900 enigma2[267]: [eDVBLocalTimeHandler] update Linux Time
Oct 03 09:33:29 dm900 enigma2[267]: [SEC-1] set dynamic current limiting
Oct 03 09:33:30 dm900 enigma2[267]: VIDEO_GET_EVENT - ok
Oct 03 09:33:30 dm900 enigma2[267]: unhandled DVBAPI Video Event 32
Oct 03 09:33:30 dm900 enigma2[267]: ++ 2/2 TID 4e
Oct 03 09:33:30 dm900 enigma2[267]: done!
Oct 03 09:33:30 dm900 enigma2[267]: W/  [InfoBar.__servicePlaying] :: <no detail>
Oct 03 09:33:30 dm900 enigma2[267]: I/  [InfoBar.setPlaybackState] :: None None 1507016010.39
Oct 03 09:33:30 dm900 enigma2[267]: doing version filtering
Oct 03 09:33:30 dm900 enigma2[267]: 0012:  4e 00 72 01 00 00
Oct 03 09:33:30 dm900 enigma2[267]: mask:  ff ff ff 3f 00 00
Oct 03 09:33:30 dm900 enigma2[267]: mode:  00 00 00 3e 00 00
Oct 03 09:33:31 dm900 enigma2[267]: sdt update done!
Oct 03 09:33:31 dm900 enigma2[267]: [EPGC] start caching events(1507016011)
Oct 03 09:33:33 dm900 enigma2[267]: [eFileMonitor] 1 events queued
Oct 03 09:33:33 dm900 enigma2[267]: [eFileMonitor] File {/tmp/ecm.info} has been created
Oct 03 09:33:35 dm900 enigma2[267]: nr_read 726 nr_write 721
Oct 03 09:33:35 dm900 enigma2[267]: sum 1447 prev_sum 1331
Oct 03 09:33:35 dm900 enigma2[267]: hdd was accessed since previous check!
Oct 03 09:33:35 dm900 enigma2[267]: [IDLE] 0 120 False
Oct 03 09:33:38 dm900 enigma2[267]: [EPGC] abort non avail schedule other reading
Oct 03 09:33:38 dm900 enigma2[267]: [EPGC] abort non avail viasat reading
Oct 03 09:33:38 dm900 enigma2[267]: [EPGC] nownext finished(1507016018)
Oct 03 09:33:39 dm900 enigma2[267]: action ->  InfobarChannelSelection zapUp
Oct 03 09:33:39 dm900 enigma2[267]: playing 1:0:19:81:6:85:C00000:0:0:0:
Oct 03 09:33:39 dm900 enigma2[267]: [eDVBCAService] free slot 0 demux 1 for service 1:0:19:72:D:85:C00000:0:0:0:
Oct 03 09:33:39 dm900 enigma2[267]: [eDVBCAService] free service 1:0:19:72:D:85:C00000:0:0:0:
Oct 03 09:33:39 dm900 enigma2[267]: [eFileMonitor] 1 events queued
Oct 03 09:33:39 dm900 enigma2[267]: [eDVBCIInterfaces] remove last pmt handler for service 1:0:19:72:D:85:C00000:0:0:0: send empty capmt
Oct 03 09:33:39 dm900 enigma2[267]: [eDVBCISlot] capmt version equal... increment old was 13! new version is 15
Oct 03 09:33:39 dm900 enigma2[267]: setInputSource input1 to A2
Oct 03 09:33:39 dm900 enigma2[267]: (3) slot 0 usecount is now 0
Oct 03 09:33:39 dm900 enigma2[267]: [eDBusInterface::Private::sendEvent 0
Oct 03 09:33:39 dm900 enigma2[267]: [TeleText] service stopped
Oct 03 09:33:39 dm900 enigma2[267]: [TeleText] send array('B', [1, 0, 0, 0])
Oct 03 09:33:39 dm900 enigma2[267]: disable dvb subtitles
Oct 03 09:33:39 dm900 enigma2[267]: disable teletext subtitles page ffffffffffffffff (und)
Oct 03 09:33:39 dm900 enigma2[267]: decoder state: play, vpid=-1, apid=-1
Oct 03 09:33:39 dm900 enigma2[267]: DEMUX_STOP - pcr - ok
Oct 03 09:33:39 dm900 enigma2[267]: DEMUX_STOP - video - ok
Oct 03 09:33:39 dm900 enigma2[267]: VIDEO_STOP - ok
Oct 03 09:33:39 dm900 enigma2[267]: AUDIO_STOP - ok
Oct 03 09:33:39 dm900 enigma2[267]: DEMUX_STOP - audio - ok
Oct 03 09:33:39 dm900 enigma2[267]: AUDIO_CONTINUE - ok
Oct 03 09:33:39 dm900 enigma2[267]: DEMUX_STOP - ttx - ok
Oct 03 09:33:39 dm900 enigma2[267]: start release channel timer
Oct 03 09:33:39 dm900 enigma2[267]: [TeleText] service started
Oct 03 09:33:39 dm900 enigma2[267]: create buffer for widget 1280 x 150
Oct 03 09:33:39 dm900 enigma2[267]: not pauseable.
Oct 03 09:33:39 dm900 enigma2[267]: W/  [InfoBar.__servicePlaying] :: <no detail>
Oct 03 09:33:39 dm900 enigma2[267]: I/  [InfoBar.setPlaybackState] :: None None 1507016019.61
Oct 03 09:33:39 dm900 enigma2[267]: [eDVBCAService] remove channel 0x10afca0
Oct 03 09:33:39 dm900 enigma2[267]: [eDVBCAService] write leave transponder to '/tmp/camd.socket' ok
Oct 03 09:33:39 dm900 enigma2[267]: [eDVBLocalTimeHandler] remove channel 0x10afca0
Oct 03 09:33:39 dm900 enigma2[267]: [EPGC] remove channel 0x10afca0
Oct 03 09:33:39 dm900 enigma2[267]: [EPGC] abort caching events !!
Oct 03 09:33:39 dm900 enigma2[267]: [    1] preClose
Oct 03 09:33:39 dm900 enigma2[267]: allocate channel.. 0006:0085:00c00000
Oct 03 09:33:39 dm900 enigma2[267]: available channel.. 0421:0001:00c00000
Oct 03 09:33:39 dm900 enigma2[267]: [eDVBCAService] new channel 0x10c2000!
Oct 03 09:33:39 dm900 enigma2[267]: [    1] tune type 1
Oct 03 09:33:39 dm900 enigma2[267]: RotorCmd ffffffff, lastRotorCmd ffffffff
Oct 03 09:33:39 dm900 enigma2[267]: [    1] prepare_sat System DVB-S2 Freq 11914500H SR 27501000 INV Auto FEC 9/10 orbpos 192 modulation QPSK pilot Off, rolloff 0.35
Oct 03 09:33:39 dm900 enigma2[267]: [    1] tuning to 1314 mhz
Oct 03 09:33:39 dm900 enigma2[267]: OURSTATE: tuning
Oct 03 09:33:39 dm900 enigma2[267]: [SEC-1] update oparm
Oct 03 09:33:39 dm900 enigma2[267]: [SEC-1] lock 0
Oct 03 09:33:39 dm900 enigma2[267]: [SEC-1] locked 1
Oct 03 09:33:39 dm900 enigma2[267]: [SEC-1] set static current limiting
Oct 03 09:33:39 dm900 enigma2[267]: allocate Channel: res 0
Oct 03 09:33:39 dm900 enigma2[267]: allocate demux
Oct 03 09:33:39 dm900 enigma2[267]: [SEC-1] invalidate current switch params
Oct 03 09:33:39 dm900 enigma2[267]: [SEC-1] update current switch params
Oct 03 09:33:39 dm900 enigma2[267]: [SEC-1] startTuneTimeout 5000
Oct 03 09:33:39 dm900 enigma2[267]: [SEC-1] setFrontend 1
Oct 03 09:33:39 dm900 enigma2[267]: [    1] setting frontend
Oct 03 09:33:39 dm900 enigma2[267]: [SEC-1] unlock 1
Oct 03 09:33:39 dm900 enigma2[267]: [SEC-1] sleep 500ms
Oct 03 09:33:39 dm900 enigma2[267]: setInputSource input1 to A2
Oct 03 09:33:39 dm900 enigma2[267]: [eDVBCAService] new service 1:0:19:81:6:85:C00000:0:0:0:
Oct 03 09:33:39 dm900 enigma2[267]: [eDVBCAService] add demux 1 to slot 0 service 1:0:19:81:6:85:C00000:0:0:0:
Oct 03 09:33:39 dm900 enigma2[267]: [eDVBCAService] use cached!
Oct 03 09:33:39 dm900 enigma2[267]: [eDVBCAService] demux 1 mask 02
Oct 03 09:33:39 dm900 enigma2[267]: [eDVBCAServiceConn] send 77 bytes to '/tmp/camd.socket'
Oct 03 09:33:39 dm900 enigma2[267]: 9f 80 32 49 03 00 81 21 00 2a 01 81 08 00 c0 00 00 00 06 00 85 82 02 02 01 84 02 00 62 85 03 01 41 32 09 04 09 8c fa ba 09 04 09 c4 fb ba 09 04 09 af ff ba 06 00 20 00 00 1b 02 ff 00 00 06 03 02 00 00 06 03 03 00 00 06 03 04 00 00
Oct 03 09:33:39 dm900 enigma2[267]: [eDVBCIInterfaces] addPMTHandler 1:0:19:81:6:85:C00000:0:0:0:
Oct 03 09:33:39 dm900 enigma2[267]: 'SKY/00c00000' is in provider list of slot 0... so use it
Oct 03 09:33:39 dm900 enigma2[267]: (1)CISlot 0, usecount now 1
Oct 03 09:33:39 dm900 enigma2[267]: setInputSource input1 to CI0
Oct 03 09:33:39 dm900 enigma2[267]: CI Slot 0 setSource(1)
Oct 03 09:33:39 dm900 enigma2[267]: [eDVBCIInterfaces] gotPMT
Oct 03 09:33:39 dm900 enigma2[267]: [eDVBCIInterfaces] gotPMT
Oct 03 09:33:39 dm900 enigma2[267]: have 1 video stream(s) (02ff), and 1 audio stream(s) (0302), and the pcr pid is 02ff, and the text pid is 0020
Oct 03 09:33:39 dm900 enigma2[267]: allocate demux
Oct 03 09:33:39 dm900 enigma2[267]: disable teletext subtitles page ffffffffffffffff (und)
Oct 03 09:33:39 dm900 enigma2[267]: decoder state: play, vpid=767, apid=770
Oct 03 09:33:39 dm900 enigma2[267]: DMX_SET_PES_FILTER(0x2ff) - pcr - ok
Oct 03 09:33:39 dm900 enigma2[267]: DEMUX_START - pcr - ok
Oct 03 09:33:39 dm900 enigma2[267]: DMX_SET_PES_FILTER(0x302) - audio - ok
Oct 03 09:33:39 dm900 enigma2[267]: DEMUX_START - audio - ok
Oct 03 09:33:39 dm900 enigma2[267]: AUDIO_SET_BYPASS(0) - ok
Oct 03 09:33:39 dm900 enigma2[267]: AUDIO_PAUSE - ok
Oct 03 09:33:39 dm900 enigma2[267]: AUDIO_PLAY - ok
Oct 03 09:33:39 dm900 enigma2[267]: Video Device: /dev/dvb/adapter0/video0
Oct 03 09:33:39 dm900 enigma2[267]: demux device: /dev/dvb/adapter0/demux1
Oct 03 09:33:39 dm900 enigma2[267]: VIDEO_SET_STREAMTYPE 1 - ok
Oct 03 09:33:39 dm900 enigma2[267]: DMX_SET_PES_FILTER(0x2ff) - video - ok
Oct 03 09:33:39 dm900 enigma2[267]: DEMUX_START - video - ok
Oct 03 09:33:39 dm900 enigma2[267]: VIDEO_FREEZE - ok
Oct 03 09:33:39 dm900 enigma2[267]: VIDEO_PLAY - ok
Oct 03 09:33:39 dm900 enigma2[267]: DMX_SET_PES_FILTER(0x20) - ttx - ok
Oct 03 09:33:39 dm900 enigma2[267]: DEMUX_START - ttx - ok
Oct 03 09:33:39 dm900 enigma2[267]: VIDEO_SLOWMOTION(0) - ok
Oct 03 09:33:39 dm900 enigma2[267]: VIDEO_FAST_FORWARD(0) - ok
Oct 03 09:33:39 dm900 enigma2[267]: VIDEO_CONTINUE - ok
Oct 03 09:33:39 dm900 enigma2[267]: AUDIO_CONTINUE - ok
Oct 03 09:33:39 dm900 enigma2[267]: W/  [InfoBar.__servicePlaying] :: <no detail>
Oct 03 09:33:39 dm900 enigma2[267]: I/  [InfoBar.setPlaybackState] :: None None 1507016019.67
Oct 03 09:33:39 dm900 enigma2[267]: not pauseable.
Oct 03 09:33:39 dm900 enigma2[267]: [HbbTV].aitInvalidated
Oct 03 09:33:39 dm900 enigma2[267]: [eFileMonitor] File {/tmp/ecm.info} has been deleted
Oct 03 09:33:39 dm900 enigma2[267]: [    1] fe event: status 0, freq 1314500, inversion off, m_tuning 1 F
Oct 03 09:33:39 dm900 enigma2[267]: [    1] fe event: status 1f, freq 1314500, inversion off, m_tuning 1 N
Oct 03 09:33:39 dm900 enigma2[267]: OURSTATE: ok
Oct 03 09:33:39 dm900 enigma2[267]: [eDVBCAService] channel 0x10c2000 running
Oct 03 09:33:39 dm900 enigma2[267]: [eDVBLocalTimeHandler] channel 0x10c2000 running
Oct 03 09:33:39 dm900 enigma2[267]: no version filtering
Oct 03 09:33:39 dm900 enigma2[267]: 0014:  70 00 00 00 00 00
Oct 03 09:33:39 dm900 enigma2[267]: mask:  fc 00 00 00 00 00
Oct 03 09:33:39 dm900 enigma2[267]: mode:  00 00 00 00 00 00
Oct 03 09:33:39 dm900 enigma2[267]: [EPGC] channel 0x10c2000 running
Oct 03 09:33:39 dm900 enigma2[267]: stop release channel timer
Oct 03 09:33:39 dm900 enigma2[267]: no version filtering
Oct 03 09:33:39 dm900 enigma2[267]: 0012:  4e 00 81 00 00 00
Oct 03 09:33:39 dm900 enigma2[267]: mask:  ff ff ff 00 00 00
Oct 03 09:33:39 dm900 enigma2[267]: mode:  00 00 00 00 00 00
Oct 03 09:33:39 dm900 enigma2[267]: [EPGC] next update in 58 min
Oct 03 09:33:39 dm900 enigma2[267]: W/  [InfoBar.__servicePlaying] :: <no detail>
Oct 03 09:33:39 dm900 enigma2[267]: I/  [InfoBar.setPlaybackState] :: None None 1507016019.76
Oct 03 09:33:39 dm900 enigma2[267]: ok ... now we start!!
Oct 03 09:33:39 dm900 enigma2[267]: no version filtering
Oct 03 09:33:39 dm900 enigma2[267]: 0000:  00 00 00 00 00 00
Oct 03 09:33:39 dm900 enigma2[267]: mask:  ff 00 00 00 00 00
Oct 03 09:33:39 dm900 enigma2[267]: mode:  00 00 00 00 00 00
Oct 03 09:33:39 dm900 enigma2[267]: + 1/1 TID 00
Oct 03 09:33:39 dm900 enigma2[267]: done!
Oct 03 09:33:39 dm900 enigma2[267]: PATready
Oct 03 09:33:39 dm900 enigma2[267]: use pmtpid 0062 for service_id 0081
Oct 03 09:33:39 dm900 enigma2[267]: no version filtering
Oct 03 09:33:39 dm900 enigma2[267]: 0062:  02 00 81 00 00 00
Oct 03 09:33:39 dm900 enigma2[267]: mask:  ff ff ff 00 00 00
Oct 03 09:33:39 dm900 enigma2[267]: mode:  00 00 00 00 00 00
Oct 03 09:33:39 dm900 enigma2[267]: doing version filtering
Oct 03 09:33:39 dm900 enigma2[267]: 0000:  00 00 00 05 00 00
Oct 03 09:33:39 dm900 enigma2[267]: mask:  ff 00 00 3f 00 00
Oct 03 09:33:39 dm900 enigma2[267]: mode:  00 00 00 3e 00 00
Oct 03 09:33:39 dm900 enigma2[267]: It's now  Di 03 Okt 2017 09:33:39 CEST
Oct 03 09:33:39 dm900 enigma2[267]: [timer.py] next activation: 1507016119 (in 99028 ms)
Oct 03 09:33:40 dm900 enigma2[267]: + 1/1 TID 02
Oct 03 09:33:40 dm900 enigma2[267]: done!
Oct 03 09:33:40 dm900 enigma2[267]: [eDVBCAService] don't send the same capmt twice
Oct 03 09:33:40 dm900 enigma2[267]: [eDVBCIInterfaces] gotPMT
Oct 03 09:33:40 dm900 enigma2[267]: eventNewProgramInfo 0 0
Oct 03 09:33:40 dm900 enigma2[267]: have 1 video stream(s) (02ff), and 3 audio stream(s) (0302, 0303, 0304), and the pcr pid is 02ff, and the text pid is 0020
Oct 03 09:33:40 dm900 enigma2[267]: decoder state: play, vpid=767, apid=770
Oct 03 09:33:40 dm900 enigma2[267]: [TeleText] serviceInfoChanged
Oct 03 09:33:40 dm900 enigma2[267]: [TeleText] TXT PID 32 DEMUX 1
Oct 03 09:33:40 dm900 enigma2[267]: [TeleText] send array('B', [1, 0, 32, 1])
Oct 03 09:33:40 dm900 enigma2[267]: doing version filtering
Oct 03 09:33:40 dm900 enigma2[267]: 0062:  02 00 81 21 00 00
Oct 03 09:33:40 dm900 enigma2[267]: mask:  ff ff ff 3f 00 00
Oct 03 09:33:40 dm900 enigma2[267]: mode:  00 00 00 3e 00 00
Oct 03 09:33:40 dm900 enigma2[267]: [EPGC] cleanup invalid data
Oct 03 09:33:40 dm900 enigma2[267]: [SEC-1] set dynamic current limiting
Oct 03 09:33:40 dm900 enigma2[267]: -+ 1/2 TID 4e
Oct 03 09:33:40 dm900 enigma2[267]: It's now  Di 03 Okt 2017 09:33:40 CEST
Oct 03 09:33:40 dm900 enigma2[267]: [timer.py] next activation: 1507016120 (in 99030 ms)
Oct 03 09:33:41 dm900 enigma2[267]: ++ 2/2 TID 4e
Oct 03 09:33:41 dm900 enigma2[267]: done!
Oct 03 09:33:41 dm900 enigma2[267]: W/  [InfoBar.__servicePlaying] :: <no detail>
Oct 03 09:33:41 dm900 enigma2[267]: I/  [InfoBar.setPlaybackState] :: None None 1507016021.12
Oct 03 09:33:41 dm900 enigma2[267]: doing version filtering
Oct 03 09:33:41 dm900 enigma2[267]: 0012:  4e 00 81 2d 00 00
Oct 03 09:33:41 dm900 enigma2[267]: mask:  ff ff ff 3f 00 00
Oct 03 09:33:41 dm900 enigma2[267]: mode:  00 00 00 3e 00 00
Oct 03 09:33:41 dm900 enigma2[267]: sdt update done!
Oct 03 09:33:42 dm900 enigma2[267]: [eDVBLocalTimeHandler] Receiver time is 'Tue Oct  3 09:33:42 2017'
Oct 03 09:33:42 dm900 enigma2[267]: [eDVBLocalTimeHandler] Transponder time is 'Tue Oct  3 09:33:40 2017'
Oct 03 09:33:42 dm900 enigma2[267]: [eDVBLocalTimeHandler] diff is -2
Oct 03 09:33:42 dm900 enigma2[267]: [eDVBLocalTimeHandler] diff < 120 .. use Transponder Time
Oct 03 09:33:42 dm900 enigma2[267]: [eDVBLocalTimeHandler] update RTC
Oct 03 09:33:42 dm900 enigma2[267]: [eDVBLocalTimeHandler] time_difference is -2
Oct 03 09:33:42 dm900 enigma2[267]: [eDVBLocalTimeHandler] update Linux Time
Oct 03 09:33:43 dm900 enigma2[267]: [eFileMonitor] 1 events queued
Oct 03 09:33:43 dm900 enigma2[267]: [eFileMonitor] File {/tmp/ecm.info} has been created
Oct 03 09:33:47 dm900 enigma2[267]: nr_read 727 nr_write 825
Oct 03 09:33:47 dm900 enigma2[267]: sum 1552 prev_sum 1447
Oct 03 09:33:47 dm900 enigma2[267]: hdd was accessed since previous check!
Oct 03 09:33:47 dm900 enigma2[267]: [IDLE] 0 120 False
Oct 03 09:33:59 dm900 enigma2[267]: no ancillary data in audio stream... abort radiotext pes parser
Oct 03 09:33:59 dm900 enigma2[267]: nr_read 727 nr_write 931
Oct 03 09:33:59 dm900 enigma2[267]: sum 1658 prev_sum 1552
Oct 03 09:33:59 dm900 enigma2[267]: hdd was accessed since previous check!
Oct 03 09:33:59 dm900 enigma2[267]: [IDLE] 0 120 False
Oct 03 09:34:03 dm900 enigma2[267]: action ->  InfobarChannelSelection zapDown
Oct 03 09:34:03 dm900 enigma2[267]: playing 1:0:19:72:D:85:C00000:0:0:0:
Oct 03 09:34:03 dm900 enigma2[267]: [eDVBCAService] free slot 0 demux 1 for service 1:0:19:81:6:85:C00000:0:0:0:
Oct 03 09:34:03 dm900 enigma2[267]: [eDVBCAService] free service 1:0:19:81:6:85:C00000:0:0:0:
Oct 03 09:34:03 dm900 enigma2[267]: [eFileMonitor] 1 events queued
Oct 03 09:34:03 dm900 enigma2[267]: [eDVBCIInterfaces] remove last pmt handler for service 1:0:19:81:6:85:C00000:0:0:0: send empty capmt
Oct 03 09:34:03 dm900 enigma2[267]: [eDVBCISlot] capmt version equal... increment old was 21! new version is 23
Oct 03 09:34:03 dm900 enigma2[267]: setInputSource input1 to A2
Oct 03 09:34:03 dm900 enigma2[267]: (3) slot 0 usecount is now 0
Oct 03 09:34:03 dm900 enigma2[267]: [eDBusInterface::Private::sendEvent 0
Oct 03 09:34:03 dm900 enigma2[267]: [TeleText] service stopped
Oct 03 09:34:03 dm900 enigma2[267]: [TeleText] send array('B', [1, 0, 0, 0])
Oct 03 09:34:03 dm900 enigma2[267]: disable dvb subtitles
Oct 03 09:34:03 dm900 enigma2[267]: disable teletext subtitles page ffffffffffffffff (und)
Oct 03 09:34:03 dm900 enigma2[267]: decoder state: play, vpid=-1, apid=-1
Oct 03 09:34:03 dm900 enigma2[267]: DEMUX_STOP - pcr - ok
Oct 03 09:34:03 dm900 enigma2[267]: DEMUX_STOP - video - ok
Oct 03 09:34:03 dm900 enigma2[267]: VIDEO_STOP - ok
Oct 03 09:34:03 dm900 enigma2[267]: AUDIO_STOP - ok
Oct 03 09:34:03 dm900 enigma2[267]: DEMUX_STOP - audio - ok
Oct 03 09:34:03 dm900 enigma2[267]: AUDIO_CONTINUE - ok
Oct 03 09:34:03 dm900 enigma2[267]: DEMUX_STOP - ttx - ok
Oct 03 09:34:03 dm900 enigma2[267]: start release channel timer
Oct 03 09:34:03 dm900 enigma2[267]: [TeleText] service started
Oct 03 09:34:03 dm900 enigma2[267]: create buffer for widget 1280 x 150
Oct 03 09:34:03 dm900 enigma2[267]: not pauseable.
Oct 03 09:34:03 dm900 enigma2[267]: W/  [InfoBar.__servicePlaying] :: <no detail>
Oct 03 09:34:03 dm900 enigma2[267]: I/  [InfoBar.setPlaybackState] :: None None 1507016043.96
Oct 03 09:34:03 dm900 enigma2[267]: [eDVBCAService] remove channel 0x10c2000
Oct 03 09:34:03 dm900 enigma2[267]: [eDVBCAService] write leave transponder to '/tmp/camd.socket' ok
Oct 03 09:34:03 dm900 enigma2[267]: [eDVBLocalTimeHandler] remove channel 0x10c2000
Oct 03 09:34:03 dm900 enigma2[267]: [EPGC] remove channel 0x10c2000
Oct 03 09:34:03 dm900 enigma2[267]: [    1] preClose
Oct 03 09:34:03 dm900 enigma2[267]: allocate channel.. 000d:0085:00c00000
Oct 03 09:34:03 dm900 enigma2[267]: available channel.. 0421:0001:00c00000
Oct 03 09:34:03 dm900 enigma2[267]: [eDVBCAService] new channel 0x10c42a0!
Oct 03 09:34:03 dm900 enigma2[267]: [    1] tune type 1
Oct 03 09:34:03 dm900 enigma2[267]: RotorCmd ffffffff, lastRotorCmd ffffffff
Oct 03 09:34:03 dm900 enigma2[267]: [    1] prepare_sat System DVB-S2 Freq 11992500H SR 27500000 INV Auto FEC 9/10 orbpos 192 modulation QPSK pilot Off, rolloff 0.35
Oct 03 09:34:03 dm900 enigma2[267]: [    1] tuning to 1392 mhz
Oct 03 09:34:03 dm900 enigma2[267]: OURSTATE: tuning
Oct 03 09:34:03 dm900 enigma2[267]: [SEC-1] update oparm
Oct 03 09:34:03 dm900 enigma2[267]: [SEC-1] lock 0
Oct 03 09:34:03 dm900 enigma2[267]: [SEC-1] locked 1
Oct 03 09:34:03 dm900 enigma2[267]: [SEC-1] set static current limiting
Oct 03 09:34:03 dm900 enigma2[267]: allocate Channel: res 0
Oct 03 09:34:03 dm900 enigma2[267]: allocate demux
Oct 03 09:34:03 dm900 enigma2[267]: [SEC-1] invalidate current switch params
Oct 03 09:34:03 dm900 enigma2[267]: [SEC-1] update current switch params
Oct 03 09:34:03 dm900 enigma2[267]: [SEC-1] startTuneTimeout 5000
Oct 03 09:34:03 dm900 enigma2[267]: [SEC-1] setFrontend 1
Oct 03 09:34:03 dm900 enigma2[267]: [    1] setting frontend
Oct 03 09:34:03 dm900 enigma2[267]: [SEC-1] unlock 1
Oct 03 09:34:03 dm900 enigma2[267]: [SEC-1] sleep 500ms
Oct 03 09:34:03 dm900 enigma2[267]: setInputSource input1 to A2
Oct 03 09:34:03 dm900 enigma2[267]: [eDVBCAService] new service 1:0:19:72:D:85:C00000:0:0:0:
Oct 03 09:34:03 dm900 enigma2[267]: [eDVBCAService] add demux 1 to slot 0 service 1:0:19:72:D:85:C00000:0:0:0:
Oct 03 09:34:03 dm900 enigma2[267]: [eDVBCAService] use cached!
Oct 03 09:34:03 dm900 enigma2[267]: [eDVBCAService] demux 1 mask 02
Oct 03 09:34:03 dm900 enigma2[267]: [eDVBCAServiceConn] send 72 bytes to '/tmp/camd.socket'
Oct 03 09:34:03 dm900 enigma2[267]: 9f 80 32 44 03 00 72 13 00 2a 01 81 08 00 c0 00 00 00 0d 00 85 82 02 02 01 84 02 00 63 85 03 01 41 32 09 04 09 8c fa 01 09 04 09 c4 fb 01 09 04 09 af ff 01 06 00 20 00 00 1b 03 ff 00 00 06 04 02 00 00 06 04 03 00 00
Oct 03 09:34:03 dm900 enigma2[267]: [eDVBCIInterfaces] addPMTHandler 1:0:19:72:D:85:C00000:0:0:0:
Oct 03 09:34:03 dm900 enigma2[267]: 'SKY/00c00000' is in provider list of slot 0... so use it
Oct 03 09:34:03 dm900 enigma2[267]: (1)CISlot 0, usecount now 1
Oct 03 09:34:03 dm900 enigma2[267]: setInputSource input1 to CI0
Oct 03 09:34:04 dm900 enigma2[267]: CI Slot 0 setSource(1)
Oct 03 09:34:04 dm900 enigma2[267]: [eDVBCIInterfaces] gotPMT
Oct 03 09:34:04 dm900 enigma2[267]: [eDVBCIInterfaces] gotPMT
Oct 03 09:34:04 dm900 enigma2[267]: have 1 video stream(s) (03ff), and 1 audio stream(s) (0402), and the pcr pid is 03ff, and the text pid is 0020
Oct 03 09:34:04 dm900 enigma2[267]: allocate demux
Oct 03 09:34:04 dm900 enigma2[267]: disable teletext subtitles page ffffffffffffffff (und)
Oct 03 09:34:04 dm900 enigma2[267]: decoder state: play, vpid=1023, apid=1026
Oct 03 09:34:04 dm900 enigma2[267]: DMX_SET_PES_FILTER(0x3ff) - pcr - ok
Oct 03 09:34:04 dm900 enigma2[267]: DEMUX_START - pcr - ok
Oct 03 09:34:04 dm900 enigma2[267]: DMX_SET_PES_FILTER(0x402) - audio - ok
Oct 03 09:34:04 dm900 enigma2[267]: DEMUX_START - audio - ok
Oct 03 09:34:04 dm900 enigma2[267]: AUDIO_SET_BYPASS(0) - ok
Oct 03 09:34:04 dm900 enigma2[267]: AUDIO_PAUSE - ok
Oct 03 09:34:04 dm900 enigma2[267]: AUDIO_PLAY - ok
Oct 03 09:34:04 dm900 enigma2[267]: Video Device: /dev/dvb/adapter0/video0
Oct 03 09:34:04 dm900 enigma2[267]: demux device: /dev/dvb/adapter0/demux1
Oct 03 09:34:04 dm900 enigma2[267]: VIDEO_SET_STREAMTYPE 1 - ok
Oct 03 09:34:04 dm900 enigma2[267]: DMX_SET_PES_FILTER(0x3ff) - video - ok
Oct 03 09:34:04 dm900 enigma2[267]: DEMUX_START - video - ok
Oct 03 09:34:04 dm900 enigma2[267]: VIDEO_FREEZE - ok
Oct 03 09:34:04 dm900 enigma2[267]: VIDEO_PLAY - ok
Oct 03 09:34:04 dm900 enigma2[267]: DMX_SET_PES_FILTER(0x20) - ttx - ok
Oct 03 09:34:04 dm900 enigma2[267]: DEMUX_START - ttx - ok
Oct 03 09:34:04 dm900 enigma2[267]: VIDEO_SLOWMOTION(0) - ok
Oct 03 09:34:04 dm900 enigma2[267]: VIDEO_FAST_FORWARD(0) - ok
Oct 03 09:34:04 dm900 enigma2[267]: VIDEO_CONTINUE - ok
Oct 03 09:34:04 dm900 enigma2[267]: AUDIO_CONTINUE - ok
Oct 03 09:34:04 dm900 enigma2[267]: W/  [InfoBar.__servicePlaying] :: <no detail>
Oct 03 09:34:04 dm900 enigma2[267]: I/  [InfoBar.setPlaybackState] :: None None 1507016044.02
Oct 03 09:34:04 dm900 enigma2[267]: not pauseable.
Oct 03 09:34:04 dm900 enigma2[267]: [HbbTV].aitInvalidated
Oct 03 09:34:04 dm900 enigma2[267]: [eFileMonitor] File {/tmp/ecm.info} has been deleted
Oct 03 09:34:04 dm900 enigma2[267]: [    1] fe event: status 0, freq 1392500, inversion off, m_tuning 1 F
Oct 03 09:34:04 dm900 enigma2[267]: [    1] fe event: status 1, freq 1392500, inversion off, m_tuning 1 N
Oct 03 09:34:04 dm900 enigma2[267]: [    1] fe event: status 1f, freq 1392500, inversion off, m_tuning 2 N
Oct 03 09:34:04 dm900 enigma2[267]: OURSTATE: ok
Oct 03 09:34:04 dm900 enigma2[267]: [eDVBCAService] channel 0x10c42a0 running
Oct 03 09:34:04 dm900 enigma2[267]: [eDVBLocalTimeHandler] channel 0x10c42a0 running
Oct 03 09:34:04 dm900 enigma2[267]: no version filtering
Oct 03 09:34:04 dm900 enigma2[267]: 0014:  70 00 00 00 00 00
Oct 03 09:34:04 dm900 enigma2[267]: mask:  fc 00 00 00 00 00
Oct 03 09:34:04 dm900 enigma2[267]: mode:  00 00 00 00 00 00
Oct 03 09:34:04 dm900 enigma2[267]: [EPGC] channel 0x10c42a0 running
Oct 03 09:34:04 dm900 enigma2[267]: stop release channel timer
Oct 03 09:34:04 dm900 enigma2[267]: no version filtering
Oct 03 09:34:04 dm900 enigma2[267]: 0012:  4e 00 72 00 00 00
Oct 03 09:34:04 dm900 enigma2[267]: mask:  ff ff ff 00 00 00
Oct 03 09:34:04 dm900 enigma2[267]: mode:  00 00 00 00 00 00
Oct 03 09:34:04 dm900 enigma2[267]: [EPGC] next update in 2 sec
Oct 03 09:34:04 dm900 enigma2[267]: W/  [InfoBar.__servicePlaying] :: <no detail>
Oct 03 09:34:04 dm900 enigma2[267]: I/  [InfoBar.setPlaybackState] :: None None 1507016044.22
Oct 03 09:34:04 dm900 enigma2[267]: ok ... now we start!!
Oct 03 09:34:04 dm900 enigma2[267]: no version filtering
Oct 03 09:34:04 dm900 enigma2[267]: 0000:  00 00 00 00 00 00
Oct 03 09:34:04 dm900 enigma2[267]: mask:  ff 00 00 00 00 00
Oct 03 09:34:04 dm900 enigma2[267]: mode:  00 00 00 00 00 00
Oct 03 09:34:04 dm900 enigma2[267]: + 1/1 TID 00
Oct 03 09:34:04 dm900 enigma2[267]: done!
Oct 03 09:34:04 dm900 enigma2[267]: PATready
Oct 03 09:34:04 dm900 enigma2[267]: use pmtpid 0063 for service_id 0072
Oct 03 09:34:04 dm900 enigma2[267]: no version filtering
Oct 03 09:34:04 dm900 enigma2[267]: 0063:  02 00 72 00 00 00
Oct 03 09:34:04 dm900 enigma2[267]: mask:  ff ff ff 00 00 00
Oct 03 09:34:04 dm900 enigma2[267]: mode:  00 00 00 00 00 00
Oct 03 09:34:04 dm900 enigma2[267]: doing version filtering
Oct 03 09:34:04 dm900 enigma2[267]: 0000:  00 00 00 1d 00 00
Oct 03 09:34:04 dm900 enigma2[267]: mask:  ff 00 00 3f 00 00
Oct 03 09:34:04 dm900 enigma2[267]: mode:  00 00 00 3e 00 00
Oct 03 09:34:04 dm900 enigma2[267]: + 1/1 TID 02
Oct 03 09:34:04 dm900 enigma2[267]: done!
Oct 03 09:34:04 dm900 enigma2[267]: [eDVBCAService] don't send the same capmt twice
Oct 03 09:34:04 dm900 enigma2[267]: [eDVBCIInterfaces] gotPMT
Oct 03 09:34:04 dm900 enigma2[267]: eventNewProgramInfo 0 0
Oct 03 09:34:04 dm900 enigma2[267]: have 1 video stream(s) (03ff), and 2 audio stream(s) (0402, 0403), and the pcr pid is 03ff, and the text pid is 0020
Oct 03 09:34:04 dm900 enigma2[267]: decoder state: play, vpid=1023, apid=1026
Oct 03 09:34:04 dm900 enigma2[267]: [TeleText] serviceInfoChanged
Oct 03 09:34:04 dm900 enigma2[267]: [TeleText] TXT PID 32 DEMUX 1
Oct 03 09:34:04 dm900 enigma2[267]: [TeleText] send array('B', [1, 0, 32, 1])
Oct 03 09:34:04 dm900 enigma2[267]: doing version filtering
Oct 03 09:34:04 dm900 enigma2[267]: 0063:  02 00 72 13 00 00
Oct 03 09:34:04 dm900 enigma2[267]: mask:  ff ff ff 3f 00 00
Oct 03 09:34:04 dm900 enigma2[267]: mode:  00 00 00 3e 00 00
Oct 03 09:34:04 dm900 enigma2[267]: [SEC-1] set dynamic current limiting
Oct 03 09:34:04 dm900 enigma2[267]: -+ 1/2 TID 4e
Oct 03 09:34:05 dm900 enigma2[267]: sdt update done!
Oct 03 09:34:05 dm900 enigma2[267]: VIDEO_GET_EVENT - ok
Oct 03 09:34:05 dm900 enigma2[267]: unhandled DVBAPI Video Event 32
Oct 03 09:34:05 dm900 enigma2[267]: ++ 2/2 TID 4e
Oct 03 09:34:05 dm900 enigma2[267]: done!
Oct 03 09:34:05 dm900 enigma2[267]: W/  [InfoBar.__servicePlaying] :: <no detail>
Oct 03 09:34:05 dm900 enigma2[267]: I/  [InfoBar.setPlaybackState] :: None None 1507016045.52
Oct 03 09:34:05 dm900 enigma2[267]: doing version filtering
Oct 03 09:34:05 dm900 enigma2[267]: 0012:  4e 00 72 01 00 00
Oct 03 09:34:05 dm900 enigma2[267]: mask:  ff ff ff 3f 00 00
Oct 03 09:34:05 dm900 enigma2[267]: mode:  00 00 00 3e 00 00
Oct 03 09:34:05 dm900 enigma2[267]: [eDVBLocalTimeHandler] Receiver time is 'Tue Oct  3 09:34:05 2017'
Oct 03 09:34:03 dm900 enigma2[267]: [eDVBLocalTimeHandler] Transponder time is 'Tue Oct  3 09:34:03 2017'
Oct 03 09:34:03 dm900 enigma2[267]: [eDVBLocalTimeHandler] diff is -2
Oct 03 09:34:03 dm900 enigma2[267]: [eDVBLocalTimeHandler] diff < 120 .. use Transponder Time
Oct 03 09:34:03 dm900 enigma2[267]: [eDVBLocalTimeHandler] update RTC
Oct 03 09:34:05 dm900 enigma2[267]: [eDVBLocalTimeHandler] time_difference is -2
Oct 03 09:34:05 dm900 enigma2[267]: [eDVBLocalTimeHandler] update Linux Time
Oct 03 09:34:06 dm900 enigma2[267]: [EPGC] start caching events(1507016046)
Oct 03 09:34:07 dm900 enigma2[267]: 119589 ms latency per 1000 blits (8,361973 fps)
Oct 03 09:34:11 dm900 enigma2[267]: nr_read 727 nr_write 1048
Oct 03 09:34:11 dm900 enigma2[267]: sum 1775 prev_sum 1658
Oct 03 09:34:11 dm900 enigma2[267]: hdd was accessed since previous check!
Oct 03 09:34:11 dm900 enigma2[267]: [IDLE] 0 120 False
Oct 03 09:34:13 dm900 enigma2[267]: [EPGC] abort non avail schedule other reading
Oct 03 09:34:13 dm900 enigma2[267]: [EPGC] abort non avail viasat reading
Oct 03 09:34:13 dm900 enigma2[267]: [EPGC] nownext finished(1507016053)
Oct 03 09:34:13 dm900 enigma2[267]: [eFileMonitor] 1 events queued
Oct 03 09:34:13 dm900 enigma2[267]: [eFileMonitor] File {/tmp/ecm.info} has been created
Oct 03 09:34:15 dm900 enigma2[267]: [EPGC] schedule finished(1507016055)
Oct 03 09:34:15 dm900 enigma2[267]: [EPGC] stop caching events(1507016055)
Oct 03 09:34:15 dm900 enigma2[267]: [EPGC] next update in 60 min
Oct 03 09:34:15 dm900 enigma2[267]: [EPGC] cleanup invalid data
Oct 03 09:34:22 dm900 enigma2[267]: action ->  InfobarChannelSelection zapDown
Oct 03 09:34:22 dm900 enigma2[267]: playing 1:0:19:69:C:85:C00000:0:0:0:
Oct 03 09:34:22 dm900 enigma2[267]: [eDVBCAService] free slot 0 demux 1 for service 1:0:19:72:D:85:C00000:0:0:0:
Oct 03 09:34:22 dm900 enigma2[267]: [eDVBCAService] free service 1:0:19:72:D:85:C00000:0:0:0:
Oct 03 09:34:22 dm900 enigma2[267]: [eDVBCIInterfaces] remove last pmt handler for service 1:0:19:72:D:85:C00000:0:0:0: send empty capmt
Oct 03 09:34:22 dm900 enigma2[267]: [eDVBCISlot] capmt version equal... increment old was 13! new version is 15
Oct 03 09:34:22 dm900 enigma2[267]: setInputSource input1 to A2
Oct 03 09:34:22 dm900 enigma2[267]: (3) slot 0 usecount is now 0
Oct 03 09:34:22 dm900 enigma2[267]: [eDBusInterface::Private::sendEvent 0
Oct 03 09:34:22 dm900 enigma2[267]: [TeleText] service stopped
Oct 03 09:34:22 dm900 enigma2[267]: [TeleText] send array('B', [1, 0, 0, 0])
Oct 03 09:34:22 dm900 enigma2[267]: [eFileMonitor] 1 events queued
Oct 03 09:34:22 dm900 enigma2[267]: disable dvb subtitles
Oct 03 09:34:22 dm900 enigma2[267]: disable teletext subtitles page ffffffffffffffff (und)
Oct 03 09:34:22 dm900 enigma2[267]: decoder state: play, vpid=-1, apid=-1
Oct 03 09:34:22 dm900 enigma2[267]: DEMUX_STOP - pcr - ok
Oct 03 09:34:22 dm900 enigma2[267]: DEMUX_STOP - video - ok
Oct 03 09:34:22 dm900 enigma2[267]: VIDEO_STOP - ok
Oct 03 09:34:22 dm900 enigma2[267]: AUDIO_STOP - ok
Oct 03 09:34:22 dm900 enigma2[267]: DEMUX_STOP - audio - ok
Oct 03 09:34:22 dm900 enigma2[267]: AUDIO_CONTINUE - ok
Oct 03 09:34:22 dm900 enigma2[267]: DEMUX_STOP - ttx - ok
Oct 03 09:34:22 dm900 enigma2[267]: start release channel timer
Oct 03 09:34:22 dm900 enigma2[267]: [TeleText] service started
Oct 03 09:34:22 dm900 enigma2[267]: create buffer for widget 1280 x 150
Oct 03 09:34:22 dm900 enigma2[267]: not pauseable.
Oct 03 09:34:22 dm900 enigma2[267]: W/  [InfoBar.__servicePlaying] :: <no detail>
Oct 03 09:34:22 dm900 enigma2[267]: I/  [InfoBar.setPlaybackState] :: None None 1507016062.78
Oct 03 09:34:22 dm900 enigma2[267]: [eDVBCAService] remove channel 0x10c42a0
Oct 03 09:34:22 dm900 enigma2[267]: [eDVBCAService] write leave transponder to '/tmp/camd.socket' ok
Oct 03 09:34:22 dm900 enigma2[267]: [eDVBLocalTimeHandler] remove channel 0x10c42a0
Oct 03 09:34:22 dm900 enigma2[267]: [EPGC] remove channel 0x10c42a0
Oct 03 09:34:22 dm900 enigma2[267]: [    1] preClose
Oct 03 09:34:22 dm900 enigma2[267]: allocate channel.. 000c:0085:00c00000
Oct 03 09:34:22 dm900 enigma2[267]: available channel.. 0421:0001:00c00000
Oct 03 09:34:22 dm900 enigma2[267]: [eDVBCAService] new channel 0x10c6500!
Oct 03 09:34:22 dm900 enigma2[267]: [    1] tune type 1
Oct 03 09:34:22 dm900 enigma2[267]: RotorCmd ffffffff, lastRotorCmd ffffffff
Oct 03 09:34:22 dm900 enigma2[267]: [    1] prepare_sat System DVB-S2 Freq 12304750H SR 27501000 INV Auto FEC 9/10 orbpos 192 modulation QPSK pilot Off, rolloff 0.35
Oct 03 09:34:22 dm900 enigma2[267]: [    1] tuning to 1704 mhz
Oct 03 09:34:22 dm900 enigma2[267]: OURSTATE: tuning
Oct 03 09:34:22 dm900 enigma2[267]: [SEC-1] update oparm
Oct 03 09:34:22 dm900 enigma2[267]: [SEC-1] lock 0
Oct 03 09:34:22 dm900 enigma2[267]: [SEC-1] locked 1
Oct 03 09:34:22 dm900 enigma2[267]: [SEC-1] set static current limiting
Oct 03 09:34:22 dm900 enigma2[267]: allocate Channel: res 0
Oct 03 09:34:22 dm900 enigma2[267]: [SEC-1] invalidate current switch params
Oct 03 09:34:22 dm900 enigma2[267]: [SEC-1] update current switch params
Oct 03 09:34:22 dm900 enigma2[267]: [SEC-1] startTuneTimeout 5000
Oct 03 09:34:22 dm900 enigma2[267]: [SEC-1] setFrontend 1
Oct 03 09:34:22 dm900 enigma2[267]: [    1] setting frontend
Oct 03 09:34:22 dm900 enigma2[267]: [SEC-1] unlock 1
Oct 03 09:34:22 dm900 enigma2[267]: [SEC-1] sleep 500ms
Oct 03 09:34:22 dm900 enigma2[267]: allocate demux
Oct 03 09:34:22 dm900 enigma2[267]: setInputSource input1 to A2
Oct 03 09:34:22 dm900 enigma2[267]: [eDVBCAService] new service 1:0:19:69:C:85:C00000:0:0:0:
Oct 03 09:34:22 dm900 enigma2[267]: [eDVBCAService] add demux 1 to slot 0 service 1:0:19:69:C:85:C00000:0:0:0:
Oct 03 09:34:22 dm900 enigma2[267]: [eDVBCAService] use cached!
Oct 03 09:34:22 dm900 enigma2[267]: [eDVBCAService] demux 1 mask 02
Oct 03 09:34:22 dm900 enigma2[267]: [eDVBCAServiceConn] send 82 bytes to '/tmp/camd.socket'
Oct 03 09:34:22 dm900 enigma2[267]: 9f 80 32 4e 03 00 69 0d 00 2a 01 81 08 00 c0 00 00 00 0c 00 85 82 02 02 01 84 02 00 60 85 03 01 41 32 09 04 09 c4 fb 0d 09 04 09 8c fa 0d 09 04 09 af ff 0d 1b 00 ff 00 00 06 01 02 00 00 06 01 03 00 00 06 01 04 00 00 06 01 05 00 00 06 01 06 00 00
Oct 03 09:34:22 dm900 enigma2[267]: [eDVBCIInterfaces] addPMTHandler 1:0:19:69:C:85:C00000:0:0:0:
Oct 03 09:34:22 dm900 enigma2[267]: 'SKY/00c00000' is in provider list of slot 0... so use it
Oct 03 09:34:22 dm900 enigma2[267]: (1)CISlot 0, usecount now 1
Oct 03 09:34:22 dm900 enigma2[267]: setInputSource input1 to CI0
Oct 03 09:34:22 dm900 enigma2[267]: CI Slot 0 setSource(1)
Oct 03 09:34:22 dm900 enigma2[267]: [eDVBCIInterfaces] gotPMT
Oct 03 09:34:22 dm900 enigma2[267]: [eDVBCIInterfaces] gotPMT
Oct 03 09:34:22 dm900 enigma2[267]: have 1 video stream(s) (00ff), and 1 audio stream(s) (0102), and the pcr pid is 00ff, and the text pid is 0105
Oct 03 09:34:22 dm900 enigma2[267]: allocate demux
Oct 03 09:34:22 dm900 enigma2[267]: disable teletext subtitles page ffffffffffffffff (und)
Oct 03 09:34:22 dm900 enigma2[267]: decoder state: play, vpid=255, apid=258
Oct 03 09:34:22 dm900 enigma2[267]: DMX_SET_PES_FILTER(0xff) - pcr - ok
Oct 03 09:34:22 dm900 enigma2[267]: DEMUX_START - pcr - ok
Oct 03 09:34:22 dm900 enigma2[267]: DMX_SET_PES_FILTER(0x102) - audio - ok
Oct 03 09:34:22 dm900 enigma2[267]: DEMUX_START - audio - ok
Oct 03 09:34:22 dm900 enigma2[267]: AUDIO_SET_BYPASS(0) - ok
Oct 03 09:34:22 dm900 enigma2[267]: AUDIO_PAUSE - ok
Oct 03 09:34:22 dm900 enigma2[267]: AUDIO_PLAY - ok
Oct 03 09:34:22 dm900 enigma2[267]: Video Device: /dev/dvb/adapter0/video0
Oct 03 09:34:22 dm900 enigma2[267]: demux device: /dev/dvb/adapter0/demux1
Oct 03 09:34:22 dm900 enigma2[267]: VIDEO_SET_STREAMTYPE 1 - ok
Oct 03 09:34:22 dm900 enigma2[267]: DMX_SET_PES_FILTER(0xff) - video - ok
Oct 03 09:34:22 dm900 enigma2[267]: DEMUX_START - video - ok
Oct 03 09:34:22 dm900 enigma2[267]: VIDEO_FREEZE - ok
Oct 03 09:34:22 dm900 enigma2[267]: VIDEO_PLAY - ok
Oct 03 09:34:22 dm900 enigma2[267]: DMX_SET_PES_FILTER(0x105) - ttx - ok
Oct 03 09:34:22 dm900 enigma2[267]: DEMUX_START - ttx - ok
Oct 03 09:34:22 dm900 enigma2[267]: VIDEO_SLOWMOTION(0) - ok
Oct 03 09:34:22 dm900 enigma2[267]: VIDEO_FAST_FORWARD(0) - ok
Oct 03 09:34:22 dm900 enigma2[267]: VIDEO_CONTINUE - ok
Oct 03 09:34:22 dm900 enigma2[267]: AUDIO_CONTINUE - ok
Oct 03 09:34:22 dm900 enigma2[267]: W/  [InfoBar.__servicePlaying] :: <no detail>
Oct 03 09:34:22 dm900 enigma2[267]: I/  [InfoBar.setPlaybackState] :: None None 1507016062.84
Oct 03 09:34:22 dm900 enigma2[267]: not pauseable.
Oct 03 09:34:22 dm900 enigma2[267]: [HbbTV].aitInvalidated
Oct 03 09:34:22 dm900 enigma2[267]: [eFileMonitor] File {/tmp/ecm.info} has been deleted
Oct 03 09:34:22 dm900 enigma2[267]: [    1] fe event: status 0, freq 1704750, inversion off, m_tuning 1 F
Oct 03 09:34:22 dm900 enigma2[267]: [    1] fe event: status 1, freq 1704750, inversion off, m_tuning 1 N
Oct 03 09:34:23 dm900 enigma2[267]: [    1] fe event: status 1f, freq 1704750, inversion off, m_tuning 2 N
Oct 03 09:34:23 dm900 enigma2[267]: OURSTATE: ok
Oct 03 09:34:23 dm900 enigma2[267]: [eDVBCAService] channel 0x10c6500 running
Oct 03 09:34:23 dm900 enigma2[267]: [eDVBLocalTimeHandler] channel 0x10c6500 running
Oct 03 09:34:23 dm900 enigma2[267]: no version filtering
Oct 03 09:34:23 dm900 enigma2[267]: 0014:  70 00 00 00 00 00
Oct 03 09:34:23 dm900 enigma2[267]: mask:  fc 00 00 00 00 00
Oct 03 09:34:23 dm900 enigma2[267]: mode:  00 00 00 00 00 00
Oct 03 09:34:23 dm900 enigma2[267]: [EPGC] channel 0x10c6500 running
Oct 03 09:34:23 dm900 enigma2[267]: [EPGC] next update in 59 min
Oct 03 09:34:23 dm900 enigma2[267]: stop release channel timer
Oct 03 09:34:23 dm900 enigma2[267]: no version filtering
Oct 03 09:34:23 dm900 enigma2[267]: 0012:  4e 00 69 00 00 00
Oct 03 09:34:23 dm900 enigma2[267]: mask:  ff ff ff 00 00 00
Oct 03 09:34:23 dm900 enigma2[267]: mode:  00 00 00 00 00 00
Oct 03 09:34:23 dm900 enigma2[267]: W/  [InfoBar.__servicePlaying] :: <no detail>
Oct 03 09:34:23 dm900 enigma2[267]: I/  [InfoBar.setPlaybackState] :: None None 1507016063.03
Oct 03 09:34:23 dm900 enigma2[267]: ok ... now we start!!
Oct 03 09:34:23 dm900 enigma2[267]: no version filtering
Oct 03 09:34:23 dm900 enigma2[267]: 0000:  00 00 00 00 00 00
Oct 03 09:34:23 dm900 enigma2[267]: mask:  ff 00 00 00 00 00
Oct 03 09:34:23 dm900 enigma2[267]: mode:  00 00 00 00 00 00
Oct 03 09:34:23 dm900 enigma2[267]: + 1/1 TID 00
Oct 03 09:34:23 dm900 enigma2[267]: done!
Oct 03 09:34:23 dm900 enigma2[267]: PATready
Oct 03 09:34:23 dm900 enigma2[267]: use pmtpid 0060 for service_id 0069
Oct 03 09:34:23 dm900 enigma2[267]: no version filtering
Oct 03 09:34:23 dm900 enigma2[267]: 0060:  02 00 69 00 00 00
Oct 03 09:34:23 dm900 enigma2[267]: mask:  ff ff ff 00 00 00
Oct 03 09:34:23 dm900 enigma2[267]: mode:  00 00 00 00 00 00
Oct 03 09:34:23 dm900 enigma2[267]: doing version filtering
Oct 03 09:34:23 dm900 enigma2[267]: 0000:  00 00 00 29 00 00
Oct 03 09:34:23 dm900 enigma2[267]: mask:  ff 00 00 3f 00 00
Oct 03 09:34:23 dm900 enigma2[267]: mode:  00 00 00 3e 00 00
Oct 03 09:34:23 dm900 enigma2[267]: + 1/1 TID 02
Oct 03 09:34:23 dm900 enigma2[267]: done!
Oct 03 09:34:23 dm900 enigma2[267]: [eDVBCAService] don't send the same capmt twice
Oct 03 09:34:23 dm900 enigma2[267]: [eDVBCIInterfaces] gotPMT
Oct 03 09:34:23 dm900 enigma2[267]: eventNewProgramInfo 0 0
Oct 03 09:34:23 dm900 enigma2[267]: have 1 video stream(s) (00ff), and 3 audio stream(s) (0102, 0103, 0104), and the pcr pid is 00ff, and the text pid is 0105
Oct 03 09:34:23 dm900 enigma2[267]: decoder state: play, vpid=255, apid=258
Oct 03 09:34:23 dm900 enigma2[267]: [TeleText] serviceInfoChanged
Oct 03 09:34:23 dm900 enigma2[267]: [TeleText] TXT PID 261 DEMUX 1
Oct 03 09:34:23 dm900 enigma2[267]: [TeleText] send array('B', [1, 1, 5, 1])
Oct 03 09:34:23 dm900 enigma2[267]: doing version filtering
Oct 03 09:34:23 dm900 enigma2[267]: 0060:  02 00 69 0d 00 00
Oct 03 09:34:23 dm900 enigma2[267]: mask:  ff ff ff 3f 00 00
Oct 03 09:34:23 dm900 enigma2[267]: mode:  00 00 00 3e 00 00
Oct 03 09:34:23 dm900 enigma2[267]: [SEC-1] set dynamic current limiting
Oct 03 09:34:23 dm900 enigma2[267]: [EPGC] cleanupOutdated
Oct 03 09:34:23 dm900 enigma2[267]: [eFileMonitor] 1 events queued
Oct 03 09:34:23 dm900 enigma2[267]: [eFileMonitor] File {/tmp/ecm.info} has been created
Oct 03 09:34:23 dm900 enigma2[267]: +- 1/2 TID 4e
Oct 03 09:34:23 dm900 enigma2[267]: nr_read 728 nr_write 1158
Oct 03 09:34:23 dm900 enigma2[267]: sum 1886 prev_sum 1775
Oct 03 09:34:23 dm900 enigma2[267]: hdd was accessed since previous check!
Oct 03 09:34:23 dm900 enigma2[267]: [IDLE] 0 120 False
Oct 03 09:34:24 dm900 enigma2[267]: ++ 2/2 TID 4e
Oct 03 09:34:24 dm900 enigma2[267]: done!
Oct 03 09:34:24 dm900 enigma2[267]: W/  [InfoBar.__servicePlaying] :: <no detail>
Oct 03 09:34:24 dm900 enigma2[267]: I/  [InfoBar.setPlaybackState] :: None None 1507016064.53
Oct 03 09:34:24 dm900 enigma2[267]: doing version filtering
Oct 03 09:34:24 dm900 enigma2[267]: 0012:  4e 00 69 29 00 00
Oct 03 09:34:24 dm900 enigma2[267]: mask:  ff ff ff 3f 00 00
Oct 03 09:34:24 dm900 enigma2[267]: mode:  00 00 00 3e 00 00
Oct 03 09:34:24 dm900 enigma2[267]: sdt update done!
Oct 03 09:34:23 dm900 enigma2[267]: [eDVBLocalTimeHandler] Receiver time is 'Tue Oct  3 09:34:24 2017'
Oct 03 09:34:23 dm900 enigma2[267]: [eDVBLocalTimeHandler] Transponder time is 'Tue Oct  3 09:34:23 2017'
Oct 03 09:34:23 dm900 enigma2[267]: [eDVBLocalTimeHandler] diff is -1
Oct 03 09:34:23 dm900 enigma2[267]: [eDVBLocalTimeHandler] diff < 120 .. use Transponder Time
Oct 03 09:34:23 dm900 enigma2[267]: [eDVBLocalTimeHandler] update RTC
Oct 03 09:34:23 dm900 enigma2[267]: [eDVBLocalTimeHandler] time_difference is -1
Oct 03 09:34:23 dm900 enigma2[267]: [eDVBLocalTimeHandler] update Linux Time
Oct 03 09:34:30 dm900 enigma2[267]: action ->  InfobarChannelSelection switchChannelDown
Oct 03 09:34:30 dm900 enigma2[267]: reused converter!
Oct 03 09:34:30 dm900 enigma2[267]: reused converter!
Oct 03 09:34:30 dm900 enigma2[267]: reused converter!
Oct 03 09:34:31 dm900 enigma2[267]: action ->  OkCancelActions ok
Oct 03 09:34:31 dm900 enigma2[267]: playing 1:0:19:283D:3FB:1:C00000:0:0:0:
Oct 03 09:34:31 dm900 enigma2[267]: [eDVBCAService] free slot 0 demux 1 for service 1:0:19:69:C:85:C00000:0:0:0:
Oct 03 09:34:31 dm900 enigma2[267]: [eDVBCAService] free service 1:0:19:69:C:85:C00000:0:0:0:
Oct 03 09:34:31 dm900 enigma2[267]: [eDVBCIInterfaces] remove last pmt handler for service 1:0:19:69:C:85:C00000:0:0:0: send empty capmt
Oct 03 09:34:31 dm900 enigma2[267]: [eDVBCISlot] capmt version equal... increment old was 0d! new version is 0f
Oct 03 09:34:31 dm900 enigma2[267]: setInputSource input1 to A2
Oct 03 09:34:31 dm900 enigma2[267]: (3) slot 0 usecount is now 0
Oct 03 09:34:31 dm900 enigma2[267]: [eDBusInterface::Private::sendEvent 0
Oct 03 09:34:31 dm900 enigma2[267]: [TeleText] service stopped
Oct 03 09:34:31 dm900 enigma2[267]: [eFileMonitor] 1 events queued
Oct 03 09:34:31 dm900 enigma2[267]: [TeleText] send array('B', [1, 0, 0, 0])
Oct 03 09:34:31 dm900 enigma2[267]: disable dvb subtitles
Oct 03 09:34:31 dm900 enigma2[267]: disable teletext subtitles page ffffffffffffffff (und)
Oct 03 09:34:31 dm900 enigma2[267]: decoder state: play, vpid=-1, apid=-1
Oct 03 09:34:31 dm900 enigma2[267]: DEMUX_STOP - pcr - ok
Oct 03 09:34:31 dm900 enigma2[267]: DEMUX_STOP - video - ok
Oct 03 09:34:31 dm900 enigma2[267]: VIDEO_STOP - ok
Oct 03 09:34:31 dm900 enigma2[267]: AUDIO_STOP - ok
Oct 03 09:34:31 dm900 enigma2[267]: DEMUX_STOP - audio - ok
Oct 03 09:34:31 dm900 enigma2[267]: AUDIO_CONTINUE - ok
Oct 03 09:34:31 dm900 enigma2[267]: DEMUX_STOP - ttx - ok
Oct 03 09:34:31 dm900 enigma2[267]: start release channel timer
Oct 03 09:34:31 dm900 enigma2[267]: [TeleText] service started
Oct 03 09:34:31 dm900 enigma2[267]: not pauseable.
Oct 03 09:34:31 dm900 enigma2[267]: W/  [InfoBar.__servicePlaying] :: <no detail>
Oct 03 09:34:31 dm900 enigma2[267]: I/  [InfoBar.setPlaybackState] :: None None 1507016071.83
Oct 03 09:34:31 dm900 enigma2[267]: [eDVBCAService] remove channel 0x10c6500
Oct 03 09:34:31 dm900 enigma2[267]: [eDVBCAService] write leave transponder to '/tmp/camd.socket' ok
Oct 03 09:34:31 dm900 enigma2[267]: [eDVBLocalTimeHandler] remove channel 0x10c6500
Oct 03 09:34:31 dm900 enigma2[267]: [EPGC] remove channel 0x10c6500
Oct 03 09:34:31 dm900 enigma2[267]: [    1] preClose
Oct 03 09:34:31 dm900 enigma2[267]: allocate channel.. 03fb:0001:00c00000
Oct 03 09:34:31 dm900 enigma2[267]: available channel.. 0421:0001:00c00000
Oct 03 09:34:31 dm900 enigma2[267]: [eDVBCAService] new channel 0x108d8a0!
Oct 03 09:34:31 dm900 enigma2[267]: [    1] tune type 1
Oct 03 09:34:31 dm900 enigma2[267]: RotorCmd ffffffff, lastRotorCmd ffffffff
Oct 03 09:34:31 dm900 enigma2[267]: [    1] prepare_sat System DVB-S2 Freq 11494000H SR 22001000 INV Auto FEC 2/3 orbpos 192 modulation 8PSK pilot On, rolloff 0.35
Oct 03 09:34:31 dm900 enigma2[267]: [    1] tuning to 1744 mhz
Oct 03 09:34:31 dm900 enigma2[267]: OURSTATE: tuning
Oct 03 09:34:31 dm900 enigma2[267]: [SEC-1] update oparm
Oct 03 09:34:31 dm900 enigma2[267]: [SEC-1] lock 0
Oct 03 09:34:31 dm900 enigma2[267]: [SEC-1] locked 0
Oct 03 09:34:31 dm900 enigma2[267]: [SEC-0] set static current limiting
Oct 03 09:34:31 dm900 enigma2[267]: allocate Channel: res 0
Oct 03 09:34:31 dm900 enigma2[267]: allocate demux
Oct 03 09:34:31 dm900 enigma2[267]: [SEC-1] set tuner input A
Oct 03 09:34:31 dm900 enigma2[267]: setInputSource input1 to A2
Oct 03 09:34:31 dm900 enigma2[267]: have 1 video stream(s) (13ed), and 1 audio stream(s) (13ee), and the pcr pid is 13ed, and the text pid is 13f0
Oct 03 09:34:31 dm900 enigma2[267]: allocate demux
Oct 03 09:34:31 dm900 enigma2[267]: disable teletext subtitles page ffffffffffffffff (und)
Oct 03 09:34:31 dm900 enigma2[267]: decoder state: play, vpid=5101, apid=5102
Oct 03 09:34:31 dm900 enigma2[267]: DMX_SET_PES_FILTER(0x13ed) - pcr - ok
Oct 03 09:34:31 dm900 enigma2[267]: DEMUX_START - pcr - ok
Oct 03 09:34:31 dm900 enigma2[267]: DMX_SET_PES_FILTER(0x13ee) - audio - ok
Oct 03 09:34:31 dm900 enigma2[267]: DEMUX_START - audio - ok
Oct 03 09:34:31 dm900 enigma2[267]: AUDIO_SET_BYPASS(1) - ok
Oct 03 09:34:31 dm900 enigma2[267]: AUDIO_PAUSE - ok
Oct 03 09:34:31 dm900 enigma2[267]: AUDIO_PLAY - ok
Oct 03 09:34:31 dm900 enigma2[267]: Video Device: /dev/dvb/adapter0/video0
Oct 03 09:34:31 dm900 enigma2[267]: demux device: /dev/dvb/adapter0/demux1
Oct 03 09:34:31 dm900 enigma2[267]: VIDEO_SET_STREAMTYPE 1 - ok
Oct 03 09:34:31 dm900 enigma2[267]: DMX_SET_PES_FILTER(0x13ed) - video - ok
Oct 03 09:34:31 dm900 enigma2[267]: DEMUX_START - video - ok
Oct 03 09:34:31 dm900 enigma2[267]: VIDEO_FREEZE - ok
Oct 03 09:34:31 dm900 enigma2[267]: VIDEO_PLAY - ok
Oct 03 09:34:31 dm900 enigma2[267]: DMX_SET_PES_FILTER(0x13f0) - ttx - ok
Oct 03 09:34:31 dm900 enigma2[267]: DEMUX_START - ttx - ok
Oct 03 09:34:31 dm900 enigma2[267]: VIDEO_SLOWMOTION(0) - ok
Oct 03 09:34:31 dm900 enigma2[267]: VIDEO_FAST_FORWARD(0) - ok
Oct 03 09:34:31 dm900 enigma2[267]: VIDEO_CONTINUE - ok
Oct 03 09:34:31 dm900 enigma2[267]: AUDIO_CONTINUE - ok
Oct 03 09:34:31 dm900 enigma2[267]: W/  [InfoBar.__servicePlaying] :: <no detail>
Oct 03 09:34:31 dm900 enigma2[267]: I/  [InfoBar.setPlaybackState] :: None None 1507016071.84
Oct 03 09:34:31 dm900 enigma2[267]: not pauseable.
Oct 03 09:34:31 dm900 enigma2[267]: [HbbTV].aitInvalidated
Oct 03 09:34:31 dm900 enigma2[267]: I/  [InfoBar.__restoreState] :: <no detail>
Oct 03 09:34:31 dm900 enigma2[267]: create buffer for widget 1280 x 150
Oct 03 09:34:31 dm900 enigma2[267]: [SEC-1] invalidate current switch params
Oct 03 09:34:31 dm900 enigma2[267]: [SEC-0] setVoltage 18V
Oct 03 09:34:31 dm900 enigma2[267]: [SEC-1] sleep 10ms
Oct 03 09:34:31 dm900 enigma2[267]: [SEC-1] update current switch params
Oct 03 09:34:31 dm900 enigma2[267]: [SEC-1] startTuneTimeout 5000
Oct 03 09:34:31 dm900 enigma2[267]: [SEC-1] setFrontend 1
Oct 03 09:34:31 dm900 enigma2[267]: [    1] setting frontend
Oct 03 09:34:31 dm900 enigma2[267]: [SEC-1] unlock 0
Oct 03 09:34:31 dm900 enigma2[267]: [SEC-1] sleep 500ms
Oct 03 09:34:32 dm900 enigma2[267]: [eFileMonitor] File {/tmp/ecm.info} has been deleted
Oct 03 09:34:32 dm900 enigma2[267]: [    1] fe event: status 0, freq 1744000, inversion off, m_tuning 1 F
Oct 03 09:34:32 dm900 enigma2[267]: [    1] fe event: status 1f, freq 1744000, inversion off, m_tuning 1 N
Oct 03 09:34:32 dm900 enigma2[267]: OURSTATE: ok
Oct 03 09:34:32 dm900 enigma2[267]: [eDVBCAService] channel 0x108d8a0 running
Oct 03 09:34:32 dm900 enigma2[267]: [eDVBLocalTimeHandler] channel 0x108d8a0 running
Oct 03 09:34:32 dm900 enigma2[267]: no version filtering
Oct 03 09:34:32 dm900 enigma2[267]: 0014:  70 00 00 00 00 00
Oct 03 09:34:32 dm900 enigma2[267]: mask:  fc 00 00 00 00 00
Oct 03 09:34:32 dm900 enigma2[267]: mode:  00 00 00 00 00 00
Oct 03 09:34:32 dm900 enigma2[267]: [EPGC] channel 0x108d8a0 running
Oct 03 09:34:32 dm900 enigma2[267]: [EPGC] next update in 2 sec
Oct 03 09:34:32 dm900 enigma2[267]: stop release channel timer
Oct 03 09:34:32 dm900 enigma2[267]: no version filtering
Oct 03 09:34:32 dm900 enigma2[267]: 0012:  4e 28 3d 00 00 00
Oct 03 09:34:32 dm900 enigma2[267]: mask:  ff ff ff 00 00 00
Oct 03 09:34:32 dm900 enigma2[267]: mode:  00 00 00 00 00 00
Oct 03 09:34:32 dm900 enigma2[267]: ok ... now we start!!
Oct 03 09:34:32 dm900 enigma2[267]: no version filtering
Oct 03 09:34:32 dm900 enigma2[267]: 0000:  00 00 00 00 00 00
Oct 03 09:34:32 dm900 enigma2[267]: mask:  ff 00 00 00 00 00
Oct 03 09:34:32 dm900 enigma2[267]: mode:  00 00 00 00 00 00
Oct 03 09:34:32 dm900 enigma2[267]: [    0] fe event: status 1f, freq 1082750, inversion off, m_tuning 0 N
Oct 03 09:34:32 dm900 enigma2[267]: + 1/1 TID 00
Oct 03 09:34:32 dm900 enigma2[267]: done!
Oct 03 09:34:32 dm900 enigma2[267]: PATready
Oct 03 09:34:32 dm900 enigma2[267]: use pmtpid 13ec for service_id 283d
Oct 03 09:34:32 dm900 enigma2[267]: no version filtering
Oct 03 09:34:32 dm900 enigma2[267]: 13ec:  02 28 3d 00 00 00
Oct 03 09:34:32 dm900 enigma2[267]: mask:  ff ff ff 00 00 00
Oct 03 09:34:32 dm900 enigma2[267]: mode:  00 00 00 00 00 00
Oct 03 09:34:32 dm900 enigma2[267]: doing version filtering
Oct 03 09:34:32 dm900 enigma2[267]: 0000:  00 00 00 05 00 00
Oct 03 09:34:32 dm900 enigma2[267]: mask:  ff 00 00 3f 00 00
Oct 03 09:34:32 dm900 enigma2[267]: mode:  00 00 00 3e 00 00
Oct 03 09:34:32 dm900 enigma2[267]: [eDVBLocalTimeHandler] Receiver time is 'Tue Oct  3 09:34:32 2017'
Oct 03 09:34:31 dm900 enigma2[267]: [eDVBLocalTimeHandler] Transponder time is 'Tue Oct  3 09:34:31 2017'
Oct 03 09:34:31 dm900 enigma2[267]: [eDVBLocalTimeHandler] diff is -1
Oct 03 09:34:31 dm900 enigma2[267]: [eDVBLocalTimeHandler] diff < 120 .. use Transponder Time
Oct 03 09:34:31 dm900 enigma2[267]: [eDVBLocalTimeHandler] update RTC
Oct 03 09:34:31 dm900 enigma2[267]: [eDVBLocalTimeHandler] time_difference is -1
Oct 03 09:34:31 dm900 enigma2[267]: [eDVBLocalTimeHandler] update Linux Time
Oct 03 09:34:32 dm900 enigma2[267]: + 1/1 TID 02
Oct 03 09:34:32 dm900 enigma2[267]: done!
Oct 03 09:34:32 dm900 enigma2[267]: [eDVBCAService] new service 1:0:19:283D:3FB:1:C00000:0:0:0:
Oct 03 09:34:32 dm900 enigma2[267]: [eDVBCAService] add demux 1 to slot 0 service 1:0:19:283D:3FB:1:C00000:0:0:0:
Oct 03 09:34:32 dm900 enigma2[267]: HBBTV broadcast data on pid 087b
Oct 03 09:34:32 dm900 enigma2[267]: dvb subtitle  PID 13f1 with wrong subtitling type (24)... force 0x10!!
Oct 03 09:34:32 dm900 enigma2[267]: Rds PID 13f4 detected ? ! ?
Oct 03 09:34:32 dm900 enigma2[267]: HBBTV broadcast data on pid 1434
Oct 03 09:34:32 dm900 enigma2[267]: [eDVBCAService] demux 1 mask 02
Oct 03 09:34:32 dm900 enigma2[267]: [eDVBCAServiceConn] send 89 bytes to '/tmp/camd.socket'
Oct 03 09:34:32 dm900 enigma2[267]: 9f 80 32 55 03 28 3d 0b 00 18 01 81 08 00 c0 00 00 03 fb 00 01 82 02 02 01 84 02 13 ec 85 03 01 41 32 05 04 92 00 00 0c 04 98 00 00 0b 08 7b 00 00 1b 13 ed 00 00 03 13 ee 00 00 03 13 ef 00 00 06 13 f0 00 00 06 13 f1 00 00 06 13 f2 00 00 06 13 f4 00 00 0b 14 34 00 00
Oct 03 09:34:32 dm900 enigma2[267]: [eDVBCIInterfaces] addPMTHandler 1:0:19:283D:3FB:1:C00000:0:0:0:
Oct 03 09:34:32 dm900 enigma2[267]: [eDVBCIInterfaces] gotPMT
Oct 03 09:34:32 dm900 enigma2[267]: eventNewProgramInfo 0 0
Oct 03 09:34:32 dm900 enigma2[267]: start ait on pid 0492
Oct 03 09:34:32 dm900 enigma2[267]: no version filtering
Oct 03 09:34:32 dm900 enigma2[267]: 0492:  74 00 00 00 00 00
Oct 03 09:34:32 dm900 enigma2[267]: mask:  ff 00 00 00 00 00
Oct 03 09:34:32 dm900 enigma2[267]: mode:  00 00 00 00 00 00
Oct 03 09:34:32 dm900 enigma2[267]: have 1 video stream(s) (13ed), and 3 audio stream(s) (13ee, 13ef, 13f2), and the pcr pid is 13ed, and the text pid is 13f0
Oct 03 09:34:32 dm900 enigma2[267]: decoder state: play, vpid=5101, apid=5102
Oct 03 09:34:32 dm900 enigma2[267]: HBBTV broadcast data on pid 087b
Oct 03 09:34:32 dm900 enigma2[267]: dvb subtitle  PID 13f1 with wrong subtitling type (24)... force 0x10!!
Oct 03 09:34:32 dm900 enigma2[267]: Rds PID 13f4 detected ? ! ?
Oct 03 09:34:32 dm900 enigma2[267]: HBBTV broadcast data on pid 1434
Oct 03 09:34:32 dm900 enigma2[267]: [TeleText] serviceInfoChanged
Oct 03 09:34:32 dm900 enigma2[267]: [TeleText] TXT PID 5104 DEMUX 1
Oct 03 09:34:32 dm900 enigma2[267]: [TeleText] send array('B', [1, 19, 240, 1])
Oct 03 09:34:32 dm900 enigma2[267]: doing version filtering
Oct 03 09:34:32 dm900 enigma2[267]: 13ec:  02 28 3d 0b 00 00
Oct 03 09:34:32 dm900 enigma2[267]: mask:  ff ff ff 3f 00 00
Oct 03 09:34:32 dm900 enigma2[267]: mode:  00 00 00 3e 00 00
Oct 03 09:34:32 dm900 enigma2[267]: [SEC-0] set dynamic current limiting
Oct 03 09:34:32 dm900 enigma2[267]: VIDEO_GET_EVENT - ok
Oct 03 09:34:32 dm900 enigma2[267]: VIDEO_GET_EVENT - ok
Oct 03 09:34:32 dm900 enigma2[267]: VIDEO_GET_EVENT - ok
Oct 03 09:34:32 dm900 enigma2[267]: unhandled DVBAPI Video Event 32
Oct 03 09:34:32 dm900 enigma2[267]: -+ 1/2 TID 4e
Oct 03 09:34:32 dm900 enigma2[267]: VIDEO_GET_EVENT - ok
Oct 03 09:34:33 dm900 enigma2[267]: + 1/1 TID 74
Oct 03 09:34:33 dm900 enigma2[267]: done!
Oct 03 09:34:33 dm900 enigma2[267]: [eHbbtv] aitChanged pid=0x492
Oct 03 09:34:33 dm900 enigma2[267]: [eOipfApplication] Profile 0000, Version 1.1.1
Oct 03 09:34:33 dm900 enigma2[267]: [eOipfApplication] deu:HBBTV-Start-DSMCC+Web
Oct 03 09:34:33 dm900 enigma2[267]: [eHbbtv] New Application: HBBTV-Start-DSMCC+Web (orgid=19, appid=1, urlBase=http://itv.ard.de/ardstart/, initalPath=index.html, controlCode=1, visibility=2)
Oct 03 09:34:33 dm900 enigma2[267]: [eHbbtv] Resolving Application Locator: dvb://current.ait/13.1
Oct 03 09:34:33 dm900 enigma2[267]: [eHbbtv] We have 1 app(s) for service 1.1019.10301
Oct 03 09:34:33 dm900 enigma2[267]: [eHbbtv] 'dvb://current.ait/13.1' resolved to 'http://itv.ard.de/ardstart/index.html'
Oct 03 09:34:33 dm900 enigma2[267]: [eOipfApplication] Profile 0000, Version 1.1.1
Oct 03 09:34:33 dm900 enigma2[267]: [eOipfApplication] deu:EPG
Oct 03 09:34:33 dm900 enigma2[267]: [eHbbtv] New Application: EPG (orgid=19, appid=2, urlBase=http://itv.ard.de/ardepg/, initalPath=index.php, controlCode=2, visibility=2)
Oct 03 09:34:33 dm900 enigma2[267]: [eHbbtv] Resolving Application Locator: dvb://current.ait/13.2
Oct 03 09:34:33 dm900 enigma2[267]: [eHbbtv] We have 2 app(s) for service 1.1019.10301
Oct 03 09:34:33 dm900 enigma2[267]: [eHbbtv] 'dvb://current.ait/13.2' resolved to 'http://itv.ard.de/ardepg/index.php'
Oct 03 09:34:33 dm900 enigma2[267]: [eOipfApplication] Profile 0000, Version 1.1.1
Oct 03 09:34:33 dm900 enigma2[267]: [eOipfApplication] deu:ARD-Text-DSMCC
Oct 03 09:34:33 dm900 enigma2[267]: [eHbbtv] New Application: ARD-Text-DSMCC (orgid=19, appid=4, urlBase=http://itv2.ard.de/, initalPath=index.html, controlCode=2, visibility=2)
Oct 03 09:34:33 dm900 enigma2[267]: [eHbbtv] Resolving Application Locator: dvb://current.ait/13.4
Oct 03 09:34:33 dm900 enigma2[267]: [eHbbtv] We have 3 app(s) for service 1.1019.10301
Oct 03 09:34:33 dm900 enigma2[267]: [eHbbtv] 'dvb://current.ait/13.4' resolved to 'http://itv2.ard.de/index.html'
Oct 03 09:34:33 dm900 enigma2[267]: [eOipfApplication] Profile 0000, Version 1.1.1
Oct 03 09:34:33 dm900 enigma2[267]: [eOipfApplication] deu:Tagesschau
Oct 03 09:34:33 dm900 enigma2[267]: [eHbbtv] New Application: Tagesschau (orgid=19, appid=5, urlBase=http://www.tagesschau.de/, initalPath=hbbtv, controlCode=2, visibility=2)
Oct 03 09:34:33 dm900 enigma2[267]: [eHbbtv] Resolving Application Locator: dvb://current.ait/13.5
Oct 03 09:34:33 dm900 enigma2[267]: [eHbbtv] We have 4 app(s) for service 1.1019.10301
Oct 03 09:34:33 dm900 enigma2[267]: [eHbbtv] 'dvb://current.ait/13.5' resolved to 'http://www.tagesschau.de/hbbtv'
Oct 03 09:34:33 dm900 enigma2[267]: [eOipfApplication] Profile 0000, Version 1.1.1
Oct 03 09:34:33 dm900 enigma2[267]: [eOipfApplication] deu:Mediathek DasErste
Oct 03 09:34:33 dm900 enigma2[267]: [eHbbtv] New Application: Mediathek DasErste (orgid=19, appid=20, urlBase=http://hbbtv.daserste.de/, initalPath=index.php, controlCode=2, visibility=2)
Oct 03 09:34:33 dm900 enigma2[267]: [eHbbtv] Resolving Application Locator: dvb://current.ait/13.14
Oct 03 09:34:33 dm900 enigma2[267]: [eHbbtv] We have 5 app(s) for service 1.1019.10301
Oct 03 09:34:33 dm900 enigma2[267]: [eHbbtv] 'dvb://current.ait/13.14' resolved to 'http://hbbtv.daserste.de/index.php'
Oct 03 09:34:33 dm900 enigma2[267]: [eOipfApplication] Profile 0000, Version 1.1.1
Oct 03 09:34:33 dm900 enigma2[267]: [eOipfApplication] deu:HBBTV ARD-Mediathek
Oct 03 09:34:33 dm900 enigma2[267]: [eHbbtv] New Application: HBBTV ARD-Mediathek (orgid=19, appid=3, urlBase=http://hbbtv.ardmediathek.de/hbbtv-ard/, initalPath=mediathek/?devicegroup=hbbtv, controlCode=2, visibility=2)
Oct 03 09:34:33 dm900 enigma2[267]: [eHbbtv] Resolving Application Locator: dvb://current.ait/13.3
Oct 03 09:34:33 dm900 enigma2[267]: [eHbbtv] We have 6 app(s) for service 1.1019.10301
Oct 03 09:34:33 dm900 enigma2[267]: [eHbbtv] 'dvb://current.ait/13.3' resolved to 'http://hbbtv.ardmediathek.de/hbbtv-ard/mediathek/?devicegroup=hbbtv'
Oct 03 09:34:33 dm900 enigma2[267]: [eOipfApplication] Profile 0000, Version 1.1.1
Oct 03 09:34:33 dm900 enigma2[267]: [eOipfApplication] deu:BR-Mediathek
Oct 03 09:34:33 dm900 enigma2[267]: [eHbbtv] New Application: BR-Mediathek (orgid=19, appid=35, urlBase=http://www.br-online.de/mediathek-video-hbbtv/, initalPath=br.php, controlCode=2, visibility=2)
Oct 03 09:34:33 dm900 enigma2[267]: [eHbbtv] Resolving Application Locator: dvb://current.ait/13.23
Oct 03 09:34:33 dm900 enigma2[267]: [eHbbtv] We have 7 app(s) for service 1.1019.10301
Oct 03 09:34:33 dm900 enigma2[267]: [eHbbtv] 'dvb://current.ait/13.23' resolved to 'http://www.br-online.de/mediathek-video-hbbtv/br.php'
Oct 03 09:34:33 dm900 enigma2[267]: [eOipfApplication] Profile 0000, Version 1.1.1
Oct 03 09:34:33 dm900 enigma2[267]: [eOipfApplication] deu:HBBTV Tatort
Oct 03 09:34:33 dm900 enigma2[267]: [eHbbtv] New Application: HBBTV Tatort (orgid=19, appid=42, urlBase=http://hbbtv-tatort.daserste.de/, initalPath=index.php, controlCode=2, visibility=2)
Oct 03 09:34:33 dm900 enigma2[267]: [eHbbtv] Resolving Application Locator: dvb://current.ait/13.2a
Oct 03 09:34:33 dm900 enigma2[267]: [eHbbtv] We have 8 app(s) for service 1.1019.10301
Oct 03 09:34:33 dm900 enigma2[267]: [eHbbtv] 'dvb://current.ait/13.2a' resolved to 'http://hbbtv-tatort.daserste.de/index.php'
Oct 03 09:34:33 dm900 enigma2[267]: [eOipfApplication] Profile 0000, Version 1.1.1
Oct 03 09:34:33 dm900 enigma2[267]: [eOipfApplication] deu:HbbTV SR Mediathek
Oct 03 09:34:33 dm900 enigma2[267]: [eHbbtv] New Application: HbbTV SR Mediathek (orgid=19, appid=56, urlBase=http://hbbtv.sr-mediathek.de/, initalPath=index.php, controlCode=2, visibility=2)
Oct 03 09:34:33 dm900 enigma2[267]: [eHbbtv] Resolving Application Locator: dvb://current.ait/13.38
Oct 03 09:34:33 dm900 enigma2[267]: [eHbbtv] We have 9 app(s) for service 1.1019.10301
Oct 03 09:34:33 dm900 enigma2[267]: [eHbbtv] 'dvb://current.ait/13.38' resolved to 'http://hbbtv.sr-mediathek.de/index.php'
Oct 03 09:34:33 dm900 enigma2[267]: [eOipfApplication] Profile 0000, Version 1.1.1
Oct 03 09:34:33 dm900 enigma2[267]: [eOipfApplication] deu:HBBTV Das Erste Check Eins
Oct 03 09:34:33 dm900 enigma2[267]: [eHbbtv] New Application: HBBTV Das Erste Check Eins (orgid=19, appid=66, urlBase=http://hbbtv.daserste.de/, initalPath=?checkeins=1, controlCode=2, visibility=2)
Oct 03 09:34:33 dm900 enigma2[267]: [eHbbtv] Resolving Application Locator: dvb://current.ait/13.42
Oct 03 09:34:33 dm900 enigma2[267]: [eHbbtv] We have 10 app(s) for service 1.1019.10301
Oct 03 09:34:33 dm900 enigma2[267]: [eHbbtv] 'dvb://current.ait/13.42' resolved to 'http://hbbtv.daserste.de/?checkeins=1'
Oct 03 09:34:33 dm900 enigma2[267]: [HbbTV].readButtonApplicationReady, appid=13.1
Oct 03 09:34:33 dm900 enigma2[267]: [HbbTV].textApplicationReady, appid=13.4
Oct 03 09:34:33 dm900 enigma2[267]: doing version filtering
Oct 03 09:34:33 dm900 enigma2[267]: 0492:  74 00 00 03 00 00
Oct 03 09:34:33 dm900 enigma2[267]: mask:  ff 00 00 3f 00 00
Oct 03 09:34:33 dm900 enigma2[267]: mode:  00 00 00 3e 00 00
Oct 03 09:34:33 dm900 enigma2[267]: ++ 2/2 TID 4e
Oct 03 09:34:33 dm900 enigma2[267]: done!
Oct 03 09:34:33 dm900 enigma2[267]: W/  [InfoBar.__servicePlaying] :: <no detail>
Oct 03 09:34:33 dm900 enigma2[267]: I/  [InfoBar.setPlaybackState] :: None None 1507016073.54
Oct 03 09:34:33 dm900 enigma2[267]: doing version filtering
Oct 03 09:34:33 dm900 enigma2[267]: 0012:  4e 28 3d 2f 00 00
Oct 03 09:34:33 dm900 enigma2[267]: mask:  ff ff ff 3f 00 00
Oct 03 09:34:33 dm900 enigma2[267]: mode:  00 00 00 3e 00 00
Oct 03 09:34:33 dm900 enigma2[267]: [eFileMonitor] 1 events queued
Oct 03 09:34:33 dm900 enigma2[267]: [eFileMonitor] File {/tmp/ecm.info} has been created
Oct 03 09:34:33 dm900 enigma2[267]: sdt update done!
Oct 03 09:34:34 dm900 enigma2[267]: [EPGC] start caching events(1507016074)
Oct 03 09:34:35 dm900 enigma2[267]: nr_read 728 nr_write 1279
Oct 03 09:34:35 dm900 enigma2[267]: sum 2007 prev_sum 1886
Oct 03 09:34:35 dm900 enigma2[267]: hdd was accessed since previous check!
Oct 03 09:34:35 dm900 enigma2[267]: [IDLE] 0 120 False
Oct 03 09:34:40 dm900 enigma2[267]: action ->  InfobarChannelSelection switchChannelUp
Oct 03 09:34:40 dm900 enigma2[267]: reused converter!
Oct 03 09:34:40 dm900 enigma2[267]: reused converter!
Oct 03 09:34:40 dm900 enigma2[267]: reused converter!
Oct 03 09:34:40 dm900 enigma2[267]: action ->  ChannelSelectBaseActions selectServiceUp
Oct 03 09:34:40 dm900 enigma2[267]: unknown action ChannelSelectBaseActions/selectServiceUp! typo in keymap?
Oct 03 09:34:40 dm900 enigma2[267]: action ->  WizardActions up
Oct 03 09:34:40 dm900 enigma2[267]: unknown action WizardActions/up! typo in keymap?
Oct 03 09:34:41 dm900 enigma2[267]: [EPGC] abort non avail schedule other reading
Oct 03 09:34:41 dm900 enigma2[267]: [EPGC] abort non avail viasat reading
Oct 03 09:34:41 dm900 enigma2[267]: It's now  Di 03 Okt 2017 09:34:41 CEST
Oct 03 09:34:41 dm900 enigma2[267]: next real activation is Di 03 Okt 2017 09:50:00 CEST
Oct 03 09:34:41 dm900 enigma2[267]: [timer.py] next activation: 1507016181 (in 99061 ms)
Oct 03 09:34:42 dm900 enigma2[267]: action ->  ChannelSelectBaseActions selectServiceUp
Oct 03 09:34:42 dm900 enigma2[267]: unknown action ChannelSelectBaseActions/selectServiceUp! typo in keymap?
Oct 03 09:34:42 dm900 enigma2[267]: action ->  WizardActions up
Oct 03 09:34:42 dm900 enigma2[267]: unknown action WizardActions/up! typo in keymap?
Oct 03 09:34:43 dm900 enigma2[267]: action ->  OkCancelActions ok
Oct 03 09:34:43 dm900 enigma2[267]: playing 1:0:19:81:6:85:C00000:0:0:0:
Oct 03 09:34:43 dm900 enigma2[267]: [eDVBCAService] free slot 0 demux 1 for service 1:0:19:283D:3FB:1:C00000:0:0:0:
Oct 03 09:34:43 dm900 enigma2[267]: [eDVBCAService] free service 1:0:19:283D:3FB:1:C00000:0:0:0:
Oct 03 09:34:43 dm900 enigma2[267]: [eFileMonitor] 1 events queued
Oct 03 09:34:43 dm900 enigma2[267]: [eDBusInterface::Private::sendEvent 0
Oct 03 09:34:43 dm900 enigma2[267]: [TeleText] service stopped
Oct 03 09:34:43 dm900 enigma2[267]: [TeleText] send array('B', [1, 0, 0, 0])
Oct 03 09:34:43 dm900 enigma2[267]: disable dvb subtitles
Oct 03 09:34:43 dm900 enigma2[267]: disable teletext subtitles page ffffffffffffffff (und)
Oct 03 09:34:43 dm900 enigma2[267]: decoder state: play, vpid=-1, apid=-1
Oct 03 09:34:43 dm900 enigma2[267]: DEMUX_STOP - pcr - ok
Oct 03 09:34:43 dm900 enigma2[267]: DEMUX_STOP - video - ok
Oct 03 09:34:43 dm900 enigma2[267]: VIDEO_STOP - ok
Oct 03 09:34:43 dm900 enigma2[267]: AUDIO_STOP - ok
Oct 03 09:34:43 dm900 enigma2[267]: DEMUX_STOP - audio - ok
Oct 03 09:34:43 dm900 enigma2[267]: AUDIO_CONTINUE - ok
Oct 03 09:34:43 dm900 enigma2[267]: DEMUX_STOP - ttx - ok
Oct 03 09:34:43 dm900 enigma2[267]: start release channel timer
Oct 03 09:34:43 dm900 enigma2[267]: [TeleText] service started
Oct 03 09:34:43 dm900 enigma2[267]: not pauseable.
Oct 03 09:34:43 dm900 enigma2[267]: W/  [InfoBar.__servicePlaying] :: <no detail>
Oct 03 09:34:43 dm900 enigma2[267]: I/  [InfoBar.setPlaybackState] :: None None 1507016083.55
Oct 03 09:34:43 dm900 enigma2[267]: [eDVBCAService] remove channel 0x108d8a0
Oct 03 09:34:43 dm900 enigma2[267]: [eDVBCAService] write leave transponder to '/tmp/camd.socket' ok
Oct 03 09:34:43 dm900 enigma2[267]: [eDVBLocalTimeHandler] remove channel 0x108d8a0
Oct 03 09:34:43 dm900 enigma2[267]: [EPGC] remove channel 0x108d8a0
Oct 03 09:34:43 dm900 enigma2[267]: [EPGC] abort caching events !!
Oct 03 09:34:43 dm900 enigma2[267]: [    1] preClose
Oct 03 09:34:43 dm900 enigma2[267]: allocate channel.. 0006:0085:00c00000
Oct 03 09:34:43 dm900 enigma2[267]: available channel.. 0421:0001:00c00000
Oct 03 09:34:43 dm900 enigma2[267]: [    2] opening frontend
Oct 03 09:34:43 dm900 enigma2[267]: [eFileMonitor] 1 events queued
Oct 03 09:34:43 dm900 enigma2[267]: [eDVBCAService] new channel 0x108bee0!
Oct 03 09:34:43 dm900 enigma2[267]: [    2] tune type 1
Oct 03 09:34:43 dm900 enigma2[267]: RotorCmd ffffffff, lastRotorCmd ffffffff
Oct 03 09:34:43 dm900 enigma2[267]: [    2] prepare_sat System DVB-S2 Freq 11914500H SR 27501000 INV Auto FEC 9/10 orbpos 192 modulation QPSK pilot Off, rolloff 0.35
Oct 03 09:34:43 dm900 enigma2[267]: [    2] tuning to 1314 mhz
Oct 03 09:34:43 dm900 enigma2[267]: OURSTATE: tuning
Oct 03 09:34:43 dm900 enigma2[267]: allocate Channel: res 0
Oct 03 09:34:43 dm900 enigma2[267]: [SEC-2] update oparm
Oct 03 09:34:43 dm900 enigma2[267]: [SEC-2] lock 0
Oct 03 09:34:43 dm900 enigma2[267]: [SEC-2] locked 2
Oct 03 09:34:43 dm900 enigma2[267]: [SEC-2] set static current limiting
Oct 03 09:34:43 dm900 enigma2[267]: allocate demux
Oct 03 09:34:43 dm900 enigma2[267]: [SEC-2] set tuner input B
Oct 03 09:34:43 dm900 enigma2[267]: setInputSource input2 to A3
Oct 03 09:34:43 dm900 enigma2[267]: [eDVBCAService] new service 1:0:19:81:6:85:C00000:0:0:0:
Oct 03 09:34:43 dm900 enigma2[267]: [eDVBCAService] add demux 1 to slot 0 service 1:0:19:81:6:85:C00000:0:0:0:
Oct 03 09:34:43 dm900 enigma2[267]: [eDVBCAService] use cached!
Oct 03 09:34:43 dm900 enigma2[267]: [eDVBCAService] demux 1 mask 02
Oct 03 09:34:43 dm900 enigma2[267]: [eDVBCAServiceConn] send 77 bytes to '/tmp/camd.socket'
Oct 03 09:34:43 dm900 enigma2[267]: 9f 80 32 49 03 00 81 21 00 2a 01 81 08 00 c0 00 00 00 06 00 85 82 02 02 01 84 02 00 62 85 03 02 41 33 09 04 09 8c fa ba 09 04 09 c4 fb ba 09 04 09 af ff ba 06 00 20 00 00 1b 02 ff 00 00 06 03 02 00 00 06 03 03 00 00 06 03 04 00 00
Oct 03 09:34:43 dm900 enigma2[267]: [eDVBCIInterfaces] addPMTHandler 1:0:19:81:6:85:C00000:0:0:0:
Oct 03 09:34:43 dm900 enigma2[267]: 'SKY/00c00000' is in provider list of slot 0... so use it
Oct 03 09:34:43 dm900 enigma2[267]: (1)CISlot 0, usecount now 1
Oct 03 09:34:43 dm900 enigma2[267]: setInputSource input2 to CI0
Oct 03 09:34:43 dm900 enigma2[267]: [SEC-2] invalidate current switch params
Oct 03 09:34:43 dm900 enigma2[267]: [SEC-2] setVoltage 18V
Oct 03 09:34:43 dm900 enigma2[267]: [SEC-2] sleep 10ms
Oct 03 09:34:43 dm900 enigma2[267]: CI Slot 0 setSource(2)
Oct 03 09:34:43 dm900 enigma2[267]: [eDVBCIInterfaces] gotPMT
Oct 03 09:34:43 dm900 enigma2[267]: [eDVBCIInterfaces] gotPMT
Oct 03 09:34:43 dm900 enigma2[267]: have 1 video stream(s) (02ff), and 1 audio stream(s) (0302), and the pcr pid is 02ff, and the text pid is 0020
Oct 03 09:34:43 dm900 enigma2[267]: allocate demux
Oct 03 09:34:43 dm900 enigma2[267]: disable teletext subtitles page ffffffffffffffff (und)
Oct 03 09:34:43 dm900 enigma2[267]: decoder state: play, vpid=767, apid=770
Oct 03 09:34:43 dm900 enigma2[267]: DMX_SET_PES_FILTER(0x2ff) - pcr - ok
Oct 03 09:34:43 dm900 enigma2[267]: DEMUX_START - pcr - ok
Oct 03 09:34:43 dm900 enigma2[267]: DMX_SET_PES_FILTER(0x302) - audio - ok
Oct 03 09:34:43 dm900 enigma2[267]: DEMUX_START - audio - ok
Oct 03 09:34:43 dm900 enigma2[267]: AUDIO_SET_BYPASS(0) - ok
Oct 03 09:34:43 dm900 enigma2[267]: AUDIO_PAUSE - ok
Oct 03 09:34:43 dm900 enigma2[267]: AUDIO_PLAY - ok
Oct 03 09:34:43 dm900 enigma2[267]: Video Device: /dev/dvb/adapter0/video0
Oct 03 09:34:43 dm900 enigma2[267]: demux device: /dev/dvb/adapter0/demux1
Oct 03 09:34:43 dm900 enigma2[267]: VIDEO_SET_STREAMTYPE 1 - ok
Oct 03 09:34:43 dm900 enigma2[267]: DMX_SET_PES_FILTER(0x2ff) - video - ok
Oct 03 09:34:43 dm900 enigma2[267]: DEMUX_START - video - ok
Oct 03 09:34:43 dm900 enigma2[267]: VIDEO_FREEZE - ok
Oct 03 09:34:43 dm900 enigma2[267]: VIDEO_PLAY - [SEC-2] setTone On
Oct 03 09:34:43 dm900 enigma2[267]: ok
Oct 03 09:34:43 dm900 enigma2[267]: DMX_SET_PES_FILTER(0x20) - ttx - ok
Oct 03 09:34:43 dm900 enigma2[267]: DEMUX_START - ttx - ok
Oct 03 09:34:43 dm900 enigma2[267]: VIDEO_SLOWMOTION(0) - ok
Oct 03 09:34:43 dm900 enigma2[267]: VIDEO_FAST_FORWARD(0) - ok
Oct 03 09:34:43 dm900 enigma2[267]: VIDEO_CONTINUE - ok
Oct 03 09:34:43 dm900 enigma2[267]: AUDIO_CONTINUE - ok
Oct 03 09:34:43 dm900 enigma2[267]: W/  [InfoBar.__servicePlaying] :: <no detail>
Oct 03 09:34:43 dm900 enigma2[267]: I/  [InfoBar.setPlaybackState] :: None None 1507016083.67
Oct 03 09:34:43 dm900 enigma2[267]: not pauseable.
Oct 03 09:34:43 dm900 enigma2[267]: [HbbTV].aitInvalidated
Oct 03 09:34:43 dm900 enigma2[267]: [SEC-2] sleep 10ms
Oct 03 09:34:43 dm900 enigma2[267]: I/  [InfoBar.__restoreState] :: <no detail>
Oct 03 09:34:43 dm900 enigma2[267]: create buffer for widget 1280 x 150
Oct 03 09:34:43 dm900 enigma2[267]: [SEC-2] update current switch params
Oct 03 09:34:43 dm900 enigma2[267]: [SEC-2] startTuneTimeout 5000
Oct 03 09:34:43 dm900 enigma2[267]: [SEC-2] setFrontend 1
Oct 03 09:34:43 dm900 enigma2[267]: [    2] setting frontend
Oct 03 09:34:43 dm900 enigma2[267]: [SEC-2] unlock 2
Oct 03 09:34:43 dm900 enigma2[267]: [SEC-2] sleep 500ms
Oct 03 09:34:43 dm900 enigma2[267]: [eFileMonitor] File {/tmp/ecm.info} has been deleted
Oct 03 09:34:43 dm900 enigma2[267]: [eFileMonitor] File {/tmp/ecm.info} has been created
Oct 03 09:34:44 dm900 enigma2[267]: [    2] fe event: status 0, freq 1314500, inversion off, m_tuning 1 F
Oct 03 09:34:44 dm900 enigma2[267]: [    2] fe event: status 1f, freq 1314500, inversion off, m_tuning 1 N
Oct 03 09:34:44 dm900 enigma2[267]: OURSTATE: ok
Oct 03 09:34:44 dm900 enigma2[267]: [eDVBCAService] channel 0x108bee0 running
Oct 03 09:34:44 dm900 enigma2[267]: [eDVBLocalTimeHandler] channel 0x108bee0 running
Oct 03 09:34:44 dm900 enigma2[267]: no version filtering
Oct 03 09:34:44 dm900 enigma2[267]: 0014:  70 00 00 00 00 00
Oct 03 09:34:44 dm900 enigma2[267]: mask:  fc 00 00 00 00 00
Oct 03 09:34:44 dm900 enigma2[267]: mode:  00 00 00 00 00 00
Oct 03 09:34:44 dm900 enigma2[267]: [EPGC] channel 0x108bee0 running
Oct 03 09:34:44 dm900 enigma2[267]: stop release channel timer
Oct 03 09:34:44 dm900 enigma2[267]: no version filtering
Oct 03 09:34:44 dm900 enigma2[267]: 0012:  4e 00 81 00 00 00
Oct 03 09:34:44 dm900 enigma2[267]: mask:  ff ff ff 00 00 00
Oct 03 09:34:44 dm900 enigma2[267]: mode:  00 00 00 00 00 00
Oct 03 09:34:44 dm900 enigma2[267]: [EPGC] next update in 57 min
Oct 03 09:34:44 dm900 enigma2[267]: W/  [InfoBar.__servicePlaying] :: <no detail>
Oct 03 09:34:44 dm900 enigma2[267]: I/  [InfoBar.setPlaybackState] :: None None 1507016084.05
Oct 03 09:34:44 dm900 enigma2[267]: ok ... now we start!!
Oct 03 09:34:44 dm900 enigma2[267]: no version filtering
Oct 03 09:34:44 dm900 enigma2[267]: 0000:  00 00 00 00 00 00
Oct 03 09:34:44 dm900 enigma2[267]: mask:  ff 00 00 00 00 00
Oct 03 09:34:44 dm900 enigma2[267]: mode:  00 00 00 00 00 00
Oct 03 09:34:44 dm900 enigma2[267]: + 1/1 TID 00
Oct 03 09:34:44 dm900 enigma2[267]: done!
Oct 03 09:34:44 dm900 enigma2[267]: PATready
Oct 03 09:34:44 dm900 enigma2[267]: use pmtpid 0062 for service_id 0081
Oct 03 09:34:44 dm900 enigma2[267]: no version filtering
Oct 03 09:34:44 dm900 enigma2[267]: 0062:  02 00 81 00 00 00
Oct 03 09:34:44 dm900 enigma2[267]: mask:  ff ff ff 00 00 00
Oct 03 09:34:44 dm900 enigma2[267]: mode:  00 00 00 00 00 00
Oct 03 09:34:44 dm900 enigma2[267]: doing version filtering
Oct 03 09:34:44 dm900 enigma2[267]: 0000:  00 00 00 05 00 00
Oct 03 09:34:44 dm900 enigma2[267]: mask:  ff 00 00 3f 00 00
Oct 03 09:34:44 dm900 enigma2[267]: mode:  00 00 00 3e 00 00
Oct 03 09:34:44 dm900 enigma2[267]: + 1/1 TID 02
Oct 03 09:34:44 dm900 enigma2[267]: done!
Oct 03 09:34:44 dm900 enigma2[267]: [eDVBCAService] don't send the same capmt twice
Oct 03 09:34:44 dm900 enigma2[267]: [eDVBCIInterfaces] gotPMT
Oct 03 09:34:44 dm900 enigma2[267]: eventNewProgramInfo 0 0
Oct 03 09:34:44 dm900 enigma2[267]: have 1 video stream(s) (02ff), and 3 audio stream(s) (0302, 0303, 0304), and the pcr pid is 02ff, and the text pid is 0020
Oct 03 09:34:44 dm900 enigma2[267]: decoder state: play, vpid=767, apid=770
Oct 03 09:34:44 dm900 enigma2[267]: [TeleText] serviceInfoChanged
Oct 03 09:34:44 dm900 enigma2[267]: [TeleText] TXT PID 32 DEMUX 1
Oct 03 09:34:44 dm900 enigma2[267]: [TeleText] send array('B', [1, 0, 32, 1])
Oct 03 09:34:44 dm900 enigma2[267]: doing version filtering
Oct 03 09:34:44 dm900 enigma2[267]: 0062:  02 00 81 21 00 00
Oct 03 09:34:44 dm900 enigma2[267]: mask:  ff ff ff 3f 00 00
Oct 03 09:34:44 dm900 enigma2[267]: mode:  00 00 00 3e 00 00
Oct 03 09:34:44 dm900 enigma2[267]: [SEC-2] set dynamic current limiting
Oct 03 09:34:44 dm900 enigma2[267]: [EPGC] cleanup invalid data
Oct 03 09:34:44 dm900 enigma2[267]: sdt update done!
Oct 03 09:34:44 dm900 enigma2[267]: [eDVBLocalTimeHandler] Receiver time is 'Tue Oct  3 09:34:44 2017'
Oct 03 09:34:42 dm900 enigma2[267]: [eDVBLocalTimeHandler] Transponder time is 'Tue Oct  3 09:34:42 2017'
Oct 03 09:34:42 dm900 enigma2[267]: [eDVBLocalTimeHandler] diff is -2
Oct 03 09:34:42 dm900 enigma2[267]: [eDVBLocalTimeHandler] diff < 120 .. use Transponder Time
Oct 03 09:34:42 dm900 enigma2[267]: [eDVBLocalTimeHandler] update RTC
Oct 03 09:34:42 dm900 enigma2[267]: [eDVBLocalTimeHandler] time_difference is -2
Oct 03 09:34:42 dm900 enigma2[267]: [eDVBLocalTimeHandler] update Linux Time
Oct 03 09:34:44 dm900 enigma2[267]: -+ 1/2 TID 4e
Oct 03 09:34:45 dm900 enigma2[267]: ++ 2/2 TID 4e
Oct 03 09:34:45 dm900 enigma2[267]: done!
Oct 03 09:34:45 dm900 enigma2[267]: W/  [InfoBar.__servicePlaying] :: <no detail>
Oct 03 09:34:45 dm900 enigma2[267]: I/  [InfoBar.setPlaybackState] :: None None 1507016085.68
Oct 03 09:34:45 dm900 enigma2[267]: doing version filtering
Oct 03 09:34:45 dm900 enigma2[267]: 0012:  4e 00 81 2d 00 00
Oct 03 09:34:45 dm900 enigma2[267]: mask:  ff ff ff 3f 00 00
Oct 03 09:34:45 dm900 enigma2[267]: mode:  00 00 00 3e 00 00
Oct 03 09:34:46 dm900 enigma2[267]: [    1] prepareClose running loop
Oct 03 09:34:46 dm900 enigma2[267]: [SEC-1] lock 0
Oct 03 09:34:46 dm900 enigma2[267]: [SEC-1] locked 0
Oct 03 09:34:46 dm900 enigma2[267]: [SEC-1] delayed close frontend
Oct 03 09:34:46 dm900 enigma2[267]: [SEC-1] unlock 0
Oct 03 09:34:46 dm900 enigma2[267]: [    1] close frontend
Oct 03 09:34:46 dm900 enigma2[267]: [SEC-1] setTone Off
Oct 03 09:34:47 dm900 enigma2[267]: nr_read 729 nr_write 1392
Oct 03 09:34:47 dm900 enigma2[267]: sum 2121 prev_sum 2007
Oct 03 09:34:47 dm900 enigma2[267]: hdd was accessed since previous check!
Oct 03 09:34:47 dm900 enigma2[267]: [IDLE] 0 120 False
Oct 03 09:34:52 dm900 enigma2[267]: action ->  InfobarChannelSelection zapDown
Oct 03 09:34:52 dm900 enigma2[267]: playing 1:0:19:72:D:85:C00000:0:0:0:
Oct 03 09:34:52 dm900 enigma2[267]: [eDVBCAService] free slot 0 demux 1 for service 1:0:19:81:6:85:C00000:0:0:0:
Oct 03 09:34:52 dm900 enigma2[267]: [eDVBCAService] free service 1:0:19:81:6:85:C00000:0:0:0:
Oct 03 09:34:52 dm900 enigma2[267]: [eDVBCIInterfaces] remove last pmt handler for service 1:0:19:81:6:85:C00000:0:0:0: send empty capmt
Oct 03 09:34:52 dm900 enigma2[267]: [eDVBCISlot] capmt version equal... increment old was 21! new version is 23
Oct 03 09:34:52 dm900 enigma2[267]: setInputSource input2 to A3
Oct 03 09:34:52 dm900 enigma2[267]: (3) slot 0 usecount is now 0
Oct 03 09:34:52 dm900 enigma2[267]: [eDBusInterface::Private::sendEvent 0
Oct 03 09:34:52 dm900 enigma2[267]: [TeleText] service stopped
Oct 03 09:34:52 dm900 enigma2[267]: [eFileMonitor] 1 events queued
Oct 03 09:34:52 dm900 enigma2[267]: [TeleText] send array('B', [1, 0, 0, 0])
Oct 03 09:34:52 dm900 enigma2[267]: disable dvb subtitles
Oct 03 09:34:52 dm900 enigma2[267]: disable teletext subtitles page ffffffffffffffff (und)
Oct 03 09:34:52 dm900 enigma2[267]: decoder state: play, vpid=-1, apid=-1
Oct 03 09:34:52 dm900 enigma2[267]: DEMUX_STOP - pcr - ok
Oct 03 09:34:52 dm900 enigma2[267]: DEMUX_STOP - video - ok
Oct 03 09:34:52 dm900 enigma2[267]: VIDEO_STOP - ok
Oct 03 09:34:52 dm900 enigma2[267]: AUDIO_STOP - ok
Oct 03 09:34:52 dm900 enigma2[267]: DEMUX_STOP - audio - ok
Oct 03 09:34:52 dm900 enigma2[267]: AUDIO_CONTINUE - ok
Oct 03 09:34:52 dm900 enigma2[267]: DEMUX_STOP - ttx - ok
Oct 03 09:34:52 dm900 enigma2[267]: start release channel timer
Oct 03 09:34:52 dm900 enigma2[267]: [TeleText] service started
Oct 03 09:34:52 dm900 enigma2[267]: create buffer for widget 1280 x 150
Oct 03 09:34:52 dm900 enigma2[267]: not pauseable.
Oct 03 09:34:52 dm900 enigma2[267]: W/  [InfoBar.__servicePlaying] :: <no detail>
Oct 03 09:34:52 dm900 enigma2[267]: I/  [InfoBar.setPlaybackState] :: None None 1507016092.7
Oct 03 09:34:52 dm900 enigma2[267]: [eDVBCAService] remove channel 0x108bee0
Oct 03 09:34:52 dm900 enigma2[267]: [eDVBCAService] write leave transponder to '/tmp/camd.socket' ok
Oct 03 09:34:52 dm900 enigma2[267]: [eDVBLocalTimeHandler] remove channel 0x108bee0
Oct 03 09:34:52 dm900 enigma2[267]: [EPGC] remove channel 0x108bee0
Oct 03 09:34:52 dm900 enigma2[267]: [    2] preClose
Oct 03 09:34:52 dm900 enigma2[267]: allocate channel.. 000d:0085:00c00000
Oct 03 09:34:52 dm900 enigma2[267]: available channel.. 0421:0001:00c00000
Oct 03 09:34:52 dm900 enigma2[267]: [    1] opening frontend
Oct 03 09:34:52 dm900 enigma2[267]: [eDVBCAService] new channel 0x10ae2c0!
Oct 03 09:34:52 dm900 enigma2[267]: [    1] tune type 1
Oct 03 09:34:52 dm900 enigma2[267]: RotorCmd ffffffff, lastRotorCmd ffffffff
Oct 03 09:34:52 dm900 enigma2[267]: [    1] prepare_sat System DVB-S2 Freq 11992500H SR 27500000 INV Auto FEC 9/10 orbpos 192 modulation QPSK pilot Off, rolloff 0.35
Oct 03 09:34:52 dm900 enigma2[267]: [    1] tuning to 1392 mhz
Oct 03 09:34:52 dm900 enigma2[267]: OURSTATE: tuning
Oct 03 09:34:52 dm900 enigma2[267]: [SEC-1] update oparm
Oct 03 09:34:52 dm900 enigma2[267]: [SEC-1] lock 0
Oct 03 09:34:52 dm900 enigma2[267]: [SEC-1] locked 1
Oct 03 09:34:52 dm900 enigma2[267]: [SEC-1] set static current limiting
Oct 03 09:34:52 dm900 enigma2[267]: allocate Channel: res 0
Oct 03 09:34:52 dm900 enigma2[267]: allocate demux
Oct 03 09:34:52 dm900 enigma2[267]: [SEC-1] set tuner input B
Oct 03 09:34:52 dm900 enigma2[267]: [SEC-1] invalidate current switch params
Oct 03 09:34:52 dm900 enigma2[267]: [SEC-1] setVoltage 18V
Oct 03 09:34:52 dm900 enigma2[267]: setInputSource input1 to A2
Oct 03 09:34:52 dm900 enigma2[267]: [eDVBCAService] new service 1:0:19:72:D:85:C00000:0:0:0:
Oct 03 09:34:52 dm900 enigma2[267]: [SEC-1] sleep 10ms
Oct 03 09:34:52 dm900 enigma2[267]: [eDVBCAService] add demux 1 to slot 0 service 1:0:19:72:D:85:C00000:0:0:0:
Oct 03 09:34:52 dm900 enigma2[267]: [eDVBCAService] use cached!
Oct 03 09:34:52 dm900 enigma2[267]: [eDVBCAService] demux 1 mask 02
Oct 03 09:34:52 dm900 enigma2[267]: [eDVBCAServiceConn] send 72 bytes to '/tmp/camd.socket'
Oct 03 09:34:52 dm900 enigma2[267]: 9f 80 32 44 03 00 72 13 00 2a 01 81 08 00 c0 00 00 00 0d 00 85 82 02 02 01 84 02 00 63 85 03 01 41 32 09 04 09 8c fa 01 09 04 09 c4 fb 01 09 04 09 af ff 01 06 00 20 00 00 1b 03 ff 00 00 06 04 02 00 00 06 04 03 00 00
Oct 03 09:34:52 dm900 enigma2[267]: [eDVBCIInterfaces] addPMTHandler 1:0:19:72:D:85:C00000:0:0:0:
Oct 03 09:34:52 dm900 enigma2[267]: 'SKY/00c00000' is in provider list of slot 0... so use it
Oct 03 09:34:52 dm900 enigma2[267]: (1)CISlot 0, usecount now 1
Oct 03 09:34:52 dm900 enigma2[267]: setInputSource input1 to CI0
Oct 03 09:34:52 dm900 enigma2[267]: CI Slot 0 setSource(1)
Oct 03 09:34:52 dm900 enigma2[267]: [eDVBCIInterfaces] gotPMT
Oct 03 09:34:52 dm900 enigma2[267]: [eDVBCIInterfaces] gotPMT
Oct 03 09:34:52 dm900 enigma2[267]: have 1 video stream(s) (03ff), and 1 audio stream(s) (0402), and the pcr pid is 03ff, and the text pid is 0020
Oct 03 09:34:52 dm900 enigma2[267]: allocate demux
Oct 03 09:34:52 dm900 enigma2[267]: disable teletext subtitles page ffffffffffffffff (und)
Oct 03 09:34:52 dm900 enigma2[267]: decoder state: play, vpid=1023, apid=1026
Oct 03 09:34:52 dm900 enigma2[267]: DMX_SET_PES_FILTER(0x3ff) - pcr - ok
Oct 03 09:34:52 dm900 enigma2[267]: DEMUX_START - pcr - ok
Oct 03 09:34:52 dm900 enigma2[267]: DMX_SET_PES_FILTER(0x402) - audio - ok
Oct 03 09:34:52 dm900 enigma2[267]: DEMUX_START - audio - ok
Oct 03 09:34:52 dm900 enigma2[267]: AUDIO_SET_BYPASS(0) - ok
Oct 03 09:34:52 dm900 enigma2[267]: AUDIO_PAUSE - ok
Oct 03 09:34:52 dm900 enigma2[267]: AUDIO_PLAY - ok
Oct 03 09:34:52 dm900 enigma2[267]: Video Device: /dev/dvb/adapter0/video0
Oct 03 09:34:52 dm900 enigma2[267]: demux device: /dev/dvb/adapter0/demux1
Oct 03 09:34:52 dm900 enigma2[267]: [SEC-1] setTone OnVIDEO_SET_STREAMTYPE 1 - ok
Oct 03 09:34:52 dm900 enigma2[267]: DMX_SET_PES_FILTER(0x3ff) - video - ok
Oct 03 09:34:52 dm900 enigma2[267]: DEMUX_START - video -
Oct 03 09:34:52 dm900 enigma2[267]: ok
Oct 03 09:34:52 dm900 enigma2[267]: VIDEO_FREEZE - ok
Oct 03 09:34:52 dm900 enigma2[267]: VIDEO_PLAY - ok
Oct 03 09:34:52 dm900 enigma2[267]: DMX_SET_PES_FILTER(0x20) - ttx - ok
Oct 03 09:34:52 dm900 enigma2[267]: DEMUX_START - ttx - ok
Oct 03 09:34:52 dm900 enigma2[267]: VIDEO_SLOWMOTION(0) - ok
Oct 03 09:34:52 dm900 enigma2[267]: VIDEO_FAST_FORWARD(0) - ok
Oct 03 09:34:52 dm900 enigma2[267]: VIDEO_CONTINUE - ok
Oct 03 09:34:52 dm900 enigma2[267]: AUDIO_CONTINUE - ok
Oct 03 09:34:52 dm900 enigma2[267]: W/  [InfoBar.__servicePlaying] :: <no detail>
Oct 03 09:34:52 dm900 enigma2[267]: I/  [InfoBar.setPlaybackState] :: None None 1507016092.74
Oct 03 09:34:52 dm900 enigma2[267]: not pauseable.
Oct 03 09:34:52 dm900 enigma2[267]: [SEC-1] sleep 10ms
Oct 03 09:34:52 dm900 enigma2[267]: [HbbTV].aitInvalidated
Oct 03 09:34:52 dm900 enigma2[267]: [SEC-1] update current switch params
Oct 03 09:34:52 dm900 enigma2[267]: [SEC-1] startTuneTimeout 5000
Oct 03 09:34:52 dm900 enigma2[267]: [SEC-1] setFrontend 1
Oct 03 09:34:52 dm900 enigma2[267]: [    1] setting frontend
Oct 03 09:34:52 dm900 enigma2[267]: [SEC-1] unlock 1
Oct 03 09:34:52 dm900 enigma2[267]: [SEC-1] sleep 500ms
Oct 03 09:34:52 dm900 enigma2[267]: [eFileMonitor] File {/tmp/ecm.info} has been deleted
Oct 03 09:34:52 dm900 enigma2[267]: [    1] fe event: status 0, freq 1392500, inversion off, m_tuning 1 F
Oct 03 09:34:52 dm900 enigma2[267]: [    1] fe event: status 1, freq 1392500, inversion off, m_tuning 1 N
Oct 03 09:34:52 dm900 enigma2[267]: [    1] fe event: status 1f, freq 1392500, inversion off, m_tuning 2 N
Oct 03 09:34:52 dm900 enigma2[267]: OURSTATE: ok
Oct 03 09:34:52 dm900 enigma2[267]: [eDVBCAService] channel 0x10ae2c0 running
Oct 03 09:34:52 dm900 enigma2[267]: [eDVBLocalTimeHandler] channel 0x10ae2c0 running
Oct 03 09:34:52 dm900 enigma2[267]: no version filtering
Oct 03 09:34:52 dm900 enigma2[267]: 0014:  70 00 00 00 00 00
Oct 03 09:34:52 dm900 enigma2[267]: mask:  fc 00 00 00 00 00
Oct 03 09:34:52 dm900 enigma2[267]: mode:  00 00 00 00 00 00
Oct 03 09:34:52 dm900 enigma2[267]: [EPGC] channel 0x10ae2c0 running
Oct 03 09:34:52 dm900 enigma2[267]: [EPGC] next update in 59 min
Oct 03 09:34:52 dm900 enigma2[267]: stop release channel timer
Oct 03 09:34:52 dm900 enigma2[267]: no version filtering
Oct 03 09:34:52 dm900 enigma2[267]: 0012:  4e 00 72 00 00 00
Oct 03 09:34:52 dm900 enigma2[267]: mask:  ff ff ff 00 00 00
Oct 03 09:34:52 dm900 enigma2[267]: mode:  00 00 00 00 00 00
Oct 03 09:34:52 dm900 enigma2[267]: W/  [InfoBar.__servicePlaying] :: <no detail>
Oct 03 09:34:52 dm900 enigma2[267]: I/  [InfoBar.setPlaybackState] :: None None 1507016092.97
Oct 03 09:34:52 dm900 enigma2[267]: ok ... now we start!!
Oct 03 09:34:52 dm900 enigma2[267]: no version filtering
Oct 03 09:34:52 dm900 enigma2[267]: 0000:  00 00 00 00 00 00
Oct 03 09:34:52 dm900 enigma2[267]: mask:  ff 00 00 00 00 00
Oct 03 09:34:52 dm900 enigma2[267]: mode:  00 00 00 00 00 00
Oct 03 09:34:53 dm900 enigma2[267]: action ->  InfobarChannelSelection zapDown
Oct 03 09:34:53 dm900 enigma2[267]: playing 1:0:19:69:C:85:C00000:0:0:0:
Oct 03 09:34:53 dm900 enigma2[267]: [eDVBCAService] free slot 0 demux 1 for service 1:0:19:72:D:85:C00000:0:0:0:
Oct 03 09:34:53 dm900 enigma2[267]: [eDVBCAService] free service 1:0:19:72:D:85:C00000:0:0:0:
Oct 03 09:34:53 dm900 enigma2[267]: [eDVBCIInterfaces] remove last pmt handler for service 1:0:19:72:D:85:C00000:0:0:0: send empty capmt
Oct 03 09:34:53 dm900 enigma2[267]: [eDVBCISlot] capmt version equal... increment old was 13! new version is 15
Oct 03 09:34:53 dm900 enigma2[267]: setInputSource input1 to A2
Oct 03 09:34:53 dm900 enigma2[267]: (3) slot 0 usecount is now 0
Oct 03 09:34:53 dm900 enigma2[267]: [eDBusInterface::Private::sendEvent 0
Oct 03 09:34:53 dm900 enigma2[267]: [TeleText] service stopped
Oct 03 09:34:53 dm900 enigma2[267]: [TeleText] send array('B', [1, 0, 0, 0])
Oct 03 09:34:53 dm900 enigma2[267]: disable dvb subtitles
Oct 03 09:34:53 dm900 enigma2[267]: disable teletext subtitles page ffffffffffffffff (und)
Oct 03 09:34:53 dm900 enigma2[267]: decoder state: play, vpid=-1, apid=-1
Oct 03 09:34:53 dm900 enigma2[267]: DEMUX_STOP - pcr - ok
Oct 03 09:34:53 dm900 enigma2[267]: DEMUX_STOP - video - ok
Oct 03 09:34:53 dm900 enigma2[267]: VIDEO_STOP - ok
Oct 03 09:34:53 dm900 enigma2[267]: AUDIO_STOP - ok
Oct 03 09:34:53 dm900 enigma2[267]: DEMUX_STOP - audio - ok
Oct 03 09:34:53 dm900 enigma2[267]: AUDIO_CONTINUE - ok
Oct 03 09:34:53 dm900 enigma2[267]: DEMUX_STOP - ttx - ok
Oct 03 09:34:53 dm900 enigma2[267]: start release channel timer
Oct 03 09:34:53 dm900 enigma2[267]: [TeleText] service started
Oct 03 09:34:53 dm900 enigma2[267]: not pauseable.
Oct 03 09:34:53 dm900 enigma2[267]: W/  [InfoBar.__servicePlaying] :: <no detail>
Oct 03 09:34:53 dm900 enigma2[267]: I/  [InfoBar.setPlaybackState] :: None None 1507016093.06
Oct 03 09:34:53 dm900 enigma2[267]: [eDVBCAService] remove channel 0x10ae2c0
Oct 03 09:34:53 dm900 enigma2[267]: [eDVBCAService] write leave transponder to '/tmp/camd.socket' ok
Oct 03 09:34:53 dm900 enigma2[267]: [eDVBLocalTimeHandler] remove channel 0x10ae2c0
Oct 03 09:34:53 dm900 enigma2[267]: [EPGC] remove channel 0x10ae2c0
Oct 03 09:34:53 dm900 enigma2[267]: [    1] preClose
Oct 03 09:34:53 dm900 enigma2[267]: allocate channel.. 000c:0085:00c00000
Oct 03 09:34:53 dm900 enigma2[267]: available channel.. 0421:0001:00c00000
Oct 03 09:34:53 dm900 enigma2[267]: [eDVBCAService] new channel 0x108bee0!
Oct 03 09:34:53 dm900 enigma2[267]: [    1] tune type 1
Oct 03 09:34:53 dm900 enigma2[267]: RotorCmd ffffffff, lastRotorCmd ffffffff
Oct 03 09:34:53 dm900 enigma2[267]: [    1] prepare_sat System DVB-S2 Freq 12304750H SR 27501000 INV Auto FEC 9/10 orbpos 192 modulation QPSK pilot Off, rolloff 0.35
Oct 03 09:34:53 dm900 enigma2[267]: [    1] tuning to 1704 mhz
Oct 03 09:34:53 dm900 enigma2[267]: OURSTATE: tuning
Oct 03 09:34:53 dm900 enigma2[267]: allocate Channel: res 0
Oct 03 09:34:53 dm900 enigma2[267]: [SEC-1] update oparm
Oct 03 09:34:53 dm900 enigma2[267]: [SEC-1] lock 0
Oct 03 09:34:53 dm900 enigma2[267]: [SEC-1] locked 1
Oct 03 09:34:53 dm900 enigma2[267]: allocate demux
Oct 03 09:34:53 dm900 enigma2[267]: [SEC-1] set static current limiting
Oct 03 09:34:53 dm900 enigma2[267]: setInputSource input1 to A2
Oct 03 09:34:53 dm900 enigma2[267]: [eDVBCAService] new service 1:0:19:69:C:85:C00000:0:0:0:
Oct 03 09:34:53 dm900 enigma2[267]: [eDVBCAService] add demux 1 to slot 0 service 1:0:19:69:C:85:C00000:0:0:0:
Oct 03 09:34:53 dm900 enigma2[267]: [eDVBCAService] use cached!
Oct 03 09:34:53 dm900 enigma2[267]: [eDVBCAService] demux 1 mask 02
Oct 03 09:34:53 dm900 enigma2[267]: [eDVBCAServiceConn] send 82 bytes to '/tmp/camd.socket'
Oct 03 09:34:53 dm900 enigma2[267]: 9f 80 32 4e 03 00 69 0d 00 2a 01 81 08 00 c0 00 00 00 0c 00 85 82 02 02 01 84 02 00 60 85 03 01 41 32 09 04 09 c4 fb 0d 09 04 09 8c fa 0d 09 04 09 af ff 0d 1b 00 ff 00 00 06 01 02 00 00 06 01 03 00 00 06 01 04 00 00 06 01 05 00 00 06 01 06 00 00
Oct 03 09:34:53 dm900 enigma2[267]: [eDVBCIInterfaces] addPMTHandler 1:0:19:69:C:85:C00000:0:0:0:
Oct 03 09:34:53 dm900 enigma2[267]: 'SKY/00c00000' is in provider list of slot 0... so use it
Oct 03 09:34:53 dm900 enigma2[267]: (1)CISlot 0, usecount now 1
Oct 03 09:34:53 dm900 enigma2[267]: setInputSource input1 to CI0
Oct 03 09:34:53 dm900 enigma2[267]: CI Slot 0 setSource(1)
Oct 03 09:34:53 dm900 enigma2[267]: [eDVBCIInterfaces] gotPMT
Oct 03 09:34:53 dm900 enigma2[267]: [eDVBCIInterfaces] gotPMT
Oct 03 09:34:53 dm900 enigma2[267]: have 1 video stream(s) (00ff), and 1 audio stream(s) (0102), and the pcr pid is 00ff, and the text pid is 0105
Oct 03 09:34:53 dm900 enigma2[267]: allocate demux
Oct 03 09:34:53 dm900 enigma2[267]: disable teletext subtitles page ffffffffffffffff (und)
Oct 03 09:34:53 dm900 enigma2[267]: [SEC-1] invalidate current switch params
Oct 03 09:34:53 dm900 enigma2[267]: [SEC-1] update current switch params
Oct 03 09:34:53 dm900 enigma2[267]: [SEC-1] startTuneTimeout 5000
Oct 03 09:34:53 dm900 enigma2[267]: [SEC-1] setFrontend 1
Oct 03 09:34:53 dm900 enigma2[267]: [    1] setting frontend
Oct 03 09:34:53 dm900 enigma2[267]: [SEC-1] unlock 1
Oct 03 09:34:53 dm900 enigma2[267]: [SEC-1] sleep 500ms
Oct 03 09:34:53 dm900 enigma2[267]: decoder state: play, vpid=255, apid=258
Oct 03 09:34:53 dm900 enigma2[267]: DMX_SET_PES_FILTER(0xff) - pcr - ok
Oct 03 09:34:53 dm900 enigma2[267]: DEMUX_START - pcr - ok
Oct 03 09:34:53 dm900 enigma2[267]: DMX_SET_PES_FILTER(0x102) - audio - ok
Oct 03 09:34:53 dm900 enigma2[267]: DEMUX_START - audio - ok
Oct 03 09:34:53 dm900 enigma2[267]: AUDIO_SET_BYPASS(0) - ok
Oct 03 09:34:53 dm900 enigma2[267]: AUDIO_PAUSE - ok
Oct 03 09:34:53 dm900 enigma2[267]: AUDIO_PLAY - ok
Oct 03 09:34:53 dm900 enigma2[267]: Video Device: /dev/dvb/adapter0/video0
Oct 03 09:34:53 dm900 enigma2[267]: demux device: /dev/dvb/adapter0/demux1
Oct 03 09:34:53 dm900 enigma2[267]: VIDEO_SET_STREAMTYPE 1 - ok
Oct 03 09:34:53 dm900 enigma2[267]: DMX_SET_PES_FILTER(0xff) - video - ok
Oct 03 09:34:53 dm900 enigma2[267]: DEMUX_START - video - ok
Oct 03 09:34:53 dm900 enigma2[267]: VIDEO_FREEZE - ok
Oct 03 09:34:53 dm900 enigma2[267]: VIDEO_PLAY - ok
Oct 03 09:34:53 dm900 enigma2[267]: DMX_SET_PES_FILTER(0x105) - ttx - ok
Oct 03 09:34:53 dm900 enigma2[267]: DEMUX_START - ttx - ok
Oct 03 09:34:53 dm900 enigma2[267]: VIDEO_SLOWMOTION(0) - ok
Oct 03 09:34:53 dm900 enigma2[267]: VIDEO_FAST_FORWARD(0) - ok
Oct 03 09:34:53 dm900 enigma2[267]: VIDEO_CONTINUE - ok
Oct 03 09:34:53 dm900 enigma2[267]: AUDIO_CONTINUE - ok
Oct 03 09:34:53 dm900 enigma2[267]: W/  [InfoBar.__servicePlaying] :: <no detail>
Oct 03 09:34:53 dm900 enigma2[267]: I/  [InfoBar.setPlaybackState] :: None None 1507016093.11
Oct 03 09:34:53 dm900 enigma2[267]: not pauseable.
Oct 03 09:34:53 dm900 enigma2[267]: [HbbTV].aitInvalidated
Oct 03 09:34:53 dm900 enigma2[267]: [    1] fe event: status 0, freq 1704750, inversion off, m_tuning 1 F
Oct 03 09:34:53 dm900 enigma2[267]: [    1] fe event: status 1, freq 1704750, inversion off, m_tuning 1 N
Oct 03 09:34:53 dm900 enigma2[267]: [    1] fe event: status 1f, freq 1704750, inversion off, m_tuning 2 N
Oct 03 09:34:53 dm900 enigma2[267]: OURSTATE: ok
Oct 03 09:34:53 dm900 enigma2[267]: [eDVBCAService] channel 0x108bee0 running
Oct 03 09:34:53 dm900 enigma2[267]: [eDVBLocalTimeHandler] channel 0x108bee0 running
Oct 03 09:34:53 dm900 enigma2[267]: no version filtering
Oct 03 09:34:53 dm900 enigma2[267]: 0014:  70 00 00 00 00 00
Oct 03 09:34:53 dm900 enigma2[267]: mask:  fc 00 00 00 00 00
Oct 03 09:34:53 dm900 enigma2[267]: mode:  00 00 00 00 00 00
Oct 03 09:34:53 dm900 enigma2[267]: [EPGC] channel 0x108bee0 running
Oct 03 09:34:53 dm900 enigma2[267]: stop release channel timer
Oct 03 09:34:53 dm900 enigma2[267]: no version filtering
Oct 03 09:34:53 dm900 enigma2[267]: 0012:  4e 00 69 00 00 00
Oct 03 09:34:53 dm900 enigma2[267]: mask:  ff ff ff 00 00 00
Oct 03 09:34:53 dm900 enigma2[267]: mode:  00 00 00 00 00 00
Oct 03 09:34:53 dm900 enigma2[267]: [EPGC] next update in 58 min
Oct 03 09:34:53 dm900 enigma2[267]: W/  [InfoBar.__servicePlaying] :: <no detail>
Oct 03 09:34:53 dm900 enigma2[267]: I/  [InfoBar.setPlaybackState] :: None None 1507016093.26
Oct 03 09:34:53 dm900 enigma2[267]: ok ... now we start!!
Oct 03 09:34:53 dm900 enigma2[267]: no version filtering
Oct 03 09:34:53 dm900 enigma2[267]: 0000:  00 00 00 00 00 00
Oct 03 09:34:53 dm900 enigma2[267]: mask:  ff 00 00 00 00 00
Oct 03 09:34:53 dm900 enigma2[267]: mode:  00 00 00 00 00 00
Oct 03 09:34:53 dm900 enigma2[267]: + 1/1 TID 00
Oct 03 09:34:53 dm900 enigma2[267]: done!
Oct 03 09:34:53 dm900 enigma2[267]: PATready
Oct 03 09:34:53 dm900 enigma2[267]: use pmtpid 0060 for service_id 0069
Oct 03 09:34:53 dm900 enigma2[267]: no version filtering
Oct 03 09:34:53 dm900 enigma2[267]: 0060:  02 00 69 00 00 00
Oct 03 09:34:53 dm900 enigma2[267]: mask:  ff ff ff 00 00 00
Oct 03 09:34:53 dm900 enigma2[267]: mode:  00 00 00 00 00 00
Oct 03 09:34:53 dm900 enigma2[267]: doing version filtering
Oct 03 09:34:53 dm900 enigma2[267]: 0000:  00 00 00 29 00 00
Oct 03 09:34:53 dm900 enigma2[267]: mask:  ff 00 00 3f 00 00
Oct 03 09:34:53 dm900 enigma2[267]: mode:  00 00 00 3e 00 00
Oct 03 09:34:53 dm900 enigma2[267]: + 1/1 TID 02
Oct 03 09:34:53 dm900 enigma2[267]: done!
Oct 03 09:34:53 dm900 enigma2[267]: [eDVBCAService] don't send the same capmt twice
Oct 03 09:34:53 dm900 enigma2[267]: [eDVBCIInterfaces] gotPMT
Oct 03 09:34:53 dm900 enigma2[267]: eventNewProgramInfo 0 0
Oct 03 09:34:53 dm900 enigma2[267]: have 1 video stream(s) (00ff), and 3 audio stream(s) (0102, 0103, 0104), and the pcr pid is 00ff, and the text pid is 0105
Oct 03 09:34:53 dm900 enigma2[267]: decoder state: play, vpid=255, apid=258
Oct 03 09:34:53 dm900 enigma2[267]: [TeleText] serviceInfoChanged
Oct 03 09:34:53 dm900 enigma2[267]: [TeleText] TXT PID 261 DEMUX 1
Oct 03 09:34:53 dm900 enigma2[267]: [TeleText] send array('B', [1, 1, 5, 1])
Oct 03 09:34:53 dm900 enigma2[267]: doing version filtering
Oct 03 09:34:53 dm900 enigma2[267]: 0060:  02 00 69 0d 00 00
Oct 03 09:34:53 dm900 enigma2[267]: mask:  ff ff ff 3f 00 00
Oct 03 09:34:53 dm900 enigma2[267]: mode:  00 00 00 3e 00 00
Oct 03 09:34:53 dm900 enigma2[267]: sdt update done!
Oct 03 09:34:53 dm900 enigma2[267]: [eFileMonitor] 1 events queued
Oct 03 09:34:53 dm900 enigma2[267]: [eFileMonitor] File {/tmp/ecm.info} has been created
Oct 03 09:34:53 dm900 enigma2[267]: [SEC-1] set dynamic current limiting
Oct 03 09:34:53 dm900 enigma2[267]: +- 1/2 TID 4e
Oct 03 09:34:54 dm900 enigma2[267]: [eDVBLocalTimeHandler] Receiver time is 'Tue Oct  3 09:34:54 2017'
Oct 03 09:34:52 dm900 enigma2[267]: [eDVBLocalTimeHandler] Transponder time is 'Tue Oct  3 09:34:52 2017'
Oct 03 09:34:52 dm900 enigma2[267]: [eDVBLocalTimeHandler] diff is -2
Oct 03 09:34:52 dm900 enigma2[267]: [eDVBLocalTimeHandler] diff < 120 .. use Transponder Time
Oct 03 09:34:54 dm900 enigma2[267]: [eDVBLocalTimeHandler] update RTC
Oct 03 09:34:54 dm900 enigma2[267]: [eDVBLocalTimeHandler] time_difference is -2
Oct 03 09:34:54 dm900 enigma2[267]: [eDVBLocalTimeHandler] update Linux Time
Oct 03 09:34:54 dm900 enigma2[267]: ++ 2/2 TID 4e
Oct 03 09:34:54 dm900 enigma2[267]: done!
Oct 03 09:34:54 dm900 enigma2[267]: W/  [InfoBar.__servicePlaying] :: <no detail>
Oct 03 09:34:54 dm900 enigma2[267]: I/  [InfoBar.setPlaybackState] :: None None 1507016094.9
Oct 03 09:34:54 dm900 enigma2[267]: doing version filtering
Oct 03 09:34:54 dm900 enigma2[267]: 0012:  4e 00 69 29 00 00
Oct 03 09:34:54 dm900 enigma2[267]: mask:  ff ff ff 3f 00 00
Oct 03 09:34:54 dm900 enigma2[267]: mode:  00 00 00 3e 00 00
Oct 03 09:34:55 dm900 enigma2[267]: [    2] prepareClose running loop
Oct 03 09:34:55 dm900 enigma2[267]: [SEC-2] lock 0
Oct 03 09:34:55 dm900 enigma2[267]: [SEC-2] locked 2
Oct 03 09:34:55 dm900 enigma2[267]: [SEC-2] setTone Off
Oct 03 09:34:55 dm900 enigma2[267]: [SEC-2] sleep 25ms
Oct 03 09:34:55 dm900 enigma2[267]: [SEC-2] sendDiseqc: e01002 (DiSEqC peripherial power off)
Oct 03 09:34:55 dm900 enigma2[267]: [SEC-2] sleep 150ms
Oct 03 09:34:55 dm900 enigma2[267]: [SEC-2] delayed close frontend
Oct 03 09:34:55 dm900 enigma2[267]: [SEC-2] unlock 2
Oct 03 09:34:55 dm900 enigma2[267]: [    2] close frontend
Oct 03 09:34:55 dm900 enigma2[267]: [SEC-2] setVoltage 0V
Oct 03 09:34:56 dm900 enigma2[267]: [    1] fe event: status 21, freq 1704750, inversion off, m_tuning 2 N
Oct 03 09:34:56 dm900 enigma2[267]: FE_TIMEDOUT! ..abort
Oct 03 09:34:56 dm900 enigma2[267]: [    1] fe event: status 20, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:34:56 dm900 enigma2[267]: [    1] lost lock
Oct 03 09:34:56 dm900 enigma2[267]: [    1] fe event: status 21, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:34:56 dm900 enigma2[267]: [    1] fe event: status 20, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:34:59 dm900 enigma2[267]: [    1] fe event: status 21, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:34:59 dm900 enigma2[267]: [    1] lost lock
Oct 03 09:34:59 dm900 enigma2[267]: nr_read 729 nr_write 1486
Oct 03 09:34:59 dm900 enigma2[267]: sum 2215 prev_sum 2121
Oct 03 09:34:59 dm900 enigma2[267]: hdd was accessed since previous check!
Oct 03 09:34:59 dm900 enigma2[267]: [IDLE] 0 120 False
Oct 03 09:35:00 dm900 enigma2[267]: [    1] fe event: status 20, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:02 dm900 enigma2[267]: [    1] fe event: status 21, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:04 dm900 enigma2[267]: [    1] stateLostLock
Oct 03 09:35:04 dm900 enigma2[267]: OURSTATE: lost lock, trying to retune
Oct 03 09:35:04 dm900 enigma2[267]: [    1] tune type 1
Oct 03 09:35:04 dm900 enigma2[267]: RotorCmd ffffffff, lastRotorCmd ffffffff
Oct 03 09:35:04 dm900 enigma2[267]: [    1] prepare_sat System DVB-S2 Freq 12304750H SR 27501000 INV Auto FEC 9/10 orbpos 192 modulation QPSK pilot Off, rolloff 0.35
Oct 03 09:35:04 dm900 enigma2[267]: [    1] tuning to 1704 mhz
Oct 03 09:35:04 dm900 enigma2[267]: OURSTATE: tuning
Oct 03 09:35:04 dm900 enigma2[267]: [SEC-1] update oparm
Oct 03 09:35:04 dm900 enigma2[267]: [SEC-1] lock 0
Oct 03 09:35:04 dm900 enigma2[267]: [SEC-1] locked 1
Oct 03 09:35:04 dm900 enigma2[267]: [SEC-1] set static current limiting
Oct 03 09:35:04 dm900 enigma2[267]: [SEC-1] invalidate current switch params
Oct 03 09:35:04 dm900 enigma2[267]: [SEC-1] update current switch params
Oct 03 09:35:04 dm900 enigma2[267]: [SEC-1] startTuneTimeout 5000
Oct 03 09:35:04 dm900 enigma2[267]: [SEC-1] setFrontend 1
Oct 03 09:35:04 dm900 enigma2[267]: [    1] setting frontend
Oct 03 09:35:04 dm900 enigma2[267]: [SEC-1] unlock 1
Oct 03 09:35:04 dm900 enigma2[267]: [SEC-1] sleep 500ms
Oct 03 09:35:04 dm900 enigma2[267]: [    1] fe event: status 0, freq 1704750, inversion off, m_tuning 1 F
Oct 03 09:35:04 dm900 enigma2[267]: [    1] fe event: status 1, freq 1704750, inversion off, m_tuning 1 N
Oct 03 09:35:04 dm900 enigma2[267]: [    1] fe event: status 0, freq 1704750, inversion off, m_tuning 2 N
Oct 03 09:35:04 dm900 enigma2[267]: [    1] fe event: status 1, freq 1704750, inversion off, m_tuning 3 N
Oct 03 09:35:04 dm900 enigma2[267]: [    1] fe event: status 0, freq 1704750, inversion off, m_tuning 4 N
Oct 03 09:35:05 dm900 enigma2[267]: [SEC-1] set dynamic current limiting
Oct 03 09:35:05 dm900 enigma2[267]: [    1] fe event: status 1, freq 1704750, inversion off, m_tuning 5 N
Oct 03 09:35:05 dm900 enigma2[267]: [    1] fe event: status 0, freq 1704750, inversion off, m_tuning 6 N
Oct 03 09:35:05 dm900 enigma2[267]: [    1] fe event: status 1, freq 1704750, inversion off, m_tuning 7 N
Oct 03 09:35:05 dm900 enigma2[267]: [    1] fe event: status 0, freq 1704750, inversion off, m_tuning 8 N
Oct 03 09:35:05 dm900 enigma2[267]: [    1] fe event: status 1, freq 1704750, inversion off, m_tuning 9 N
Oct 03 09:35:05 dm900 enigma2[267]: [    1] fe event: status 0, freq 1704750, inversion off, m_tuning 10 N
Oct 03 09:35:05 dm900 enigma2[267]: [    1] fe event: status 1, freq 1704750, inversion off, m_tuning 11 N
Oct 03 09:35:06 dm900 enigma2[267]: [    1] fe event: status 20, freq 1704750, inversion off, m_tuning 12 N
Oct 03 09:35:06 dm900 enigma2[267]: FE_TIMEDOUT! ..abort
Oct 03 09:35:06 dm900 enigma2[267]: OURSTATE: failed
Oct 03 09:35:06 dm900 enigma2[267]: tune failed.
Oct 03 09:35:06 dm900 enigma2[267]: DVB service failed to tune - error 1
Oct 03 09:35:06 dm900 enigma2[267]: I/  [InfoBar.setPlaybackState] :: tuning... Tunen fehlgeschlagen! 1507016106.06
Oct 03 09:35:06 dm900 enigma2[267]: create buffer for widget 600 x 140
Oct 03 09:35:06 dm900 enigma2[267]: sdt update done!
Oct 03 09:35:06 dm900 enigma2[267]: [    1] fe event: status 21, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:06 dm900 enigma2[267]: [    1] lost lock
Oct 03 09:35:06 dm900 enigma2[267]: [    1] fe event: status 20, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:06 dm900 enigma2[267]: [    1] fe event: status 21, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:06 dm900 enigma2[267]: [    1] fe event: status 20, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:06 dm900 enigma2[267]: [    1] fe event: status 21, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:06 dm900 enigma2[267]: [    1] fe event: status 20, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:07 dm900 enigma2[267]: [    1] fe event: status 21, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:07 dm900 enigma2[267]: [    1] fe event: status 20, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:07 dm900 enigma2[267]: [    1] fe event: status 21, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:07 dm900 enigma2[267]: [    1] fe event: status 20, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:07 dm900 enigma2[267]: [    1] fe event: status 21, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:07 dm900 enigma2[267]: [    1] fe event: status 20, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:07 dm900 enigma2[267]: [    1] fe event: status 21, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:08 dm900 enigma2[267]: [    1] fe event: status 20, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:08 dm900 enigma2[267]: [    1] fe event: status 21, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:08 dm900 enigma2[267]: [    1] fe event: status 20, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:08 dm900 enigma2[267]: [    1] fe event: status 21, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:08 dm900 enigma2[267]: [    1] fe event: status 20, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:08 dm900 enigma2[267]: [    1] fe event: status 21, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:08 dm900 enigma2[267]: [    1] fe event: status 20, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:08 dm900 enigma2[267]: [    1] fe event: status 21, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:08 dm900 enigma2[267]: [    1] fe event: status 20, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:09 dm900 enigma2[267]: [    1] fe event: status 21, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:09 dm900 enigma2[267]: [    1] fe event: status 20, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:09 dm900 enigma2[267]: [    1] fe event: status 21, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:09 dm900 enigma2[267]: [    1] fe event: status 20, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:09 dm900 enigma2[267]: [    1] lost lock
Oct 03 09:35:09 dm900 enigma2[267]: [    1] fe event: status 21, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:09 dm900 enigma2[267]: [    1] fe event: status 20, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:10 dm900 enigma2[267]: [    1] fe event: status 21, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:10 dm900 enigma2[267]: [    1] fe event: status 20, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:10 dm900 enigma2[267]: [    1] fe event: status 21, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:10 dm900 enigma2[267]: [    1] fe event: status 20, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:10 dm900 enigma2[267]: [    1] fe event: status 21, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:10 dm900 enigma2[267]: [    1] fe event: status 20, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:10 dm900 enigma2[267]: [    1] fe event: status 21, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:10 dm900 enigma2[267]: [    1] fe event: status 20, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:11 dm900 enigma2[267]: [    1] fe event: status 21, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:11 dm900 enigma2[267]: [    1] fe event: status 20, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:11 dm900 enigma2[267]: [    1] fe event: status 21, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:11 dm900 enigma2[267]: [    1] fe event: status 20, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:11 dm900 enigma2[267]: [    1] fe event: status 21, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:11 dm900 enigma2[267]: [    1] fe event: status 20, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:11 dm900 enigma2[267]: nr_read 731 nr_write 1586
Oct 03 09:35:11 dm900 enigma2[267]: sum 2317 prev_sum 2215
Oct 03 09:35:11 dm900 enigma2[267]: hdd was accessed since previous check!
Oct 03 09:35:11 dm900 enigma2[267]: [IDLE] 0 120 False
Oct 03 09:35:11 dm900 enigma2[267]: [    1] fe event: status 21, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:12 dm900 enigma2[267]: [    1] fe event: status 20, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:12 dm900 enigma2[267]: [    1] fe event: status 21, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:12 dm900 enigma2[267]: [    1] fe event: status 20, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:12 dm900 enigma2[267]: [    1] fe event: status 21, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:12 dm900 enigma2[267]: [    1] fe event: status 20, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:12 dm900 enigma2[267]: [    1] fe event: status 21, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:13 dm900 enigma2[267]: [    1] fe event: status 20, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:13 dm900 enigma2[267]: [    1] fe event: status 21, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:13 dm900 enigma2[267]: no ancillary data in audio stream... abort radiotext pes parser
Oct 03 09:35:13 dm900 enigma2[267]: [    1] fe event: status 20, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:13 dm900 enigma2[267]: [    1] fe event: status 21, freq 1704750, inversion off, m_tuning 0 N
Oct 03 09:35:13 dm900 enigma2[267]: action ->  InfobarChannelSelection zapUp
Oct 03 09:35:13 dm900 enigma2[267]: playing 1:0:19:72:D:85:C00000:0:0:0:
Oct 03 09:35:13 dm900 enigma2[267]: [eDVBCAService] free slot 0 demux 1 for service 1:0:19:69:C:85:C00000:0:0:0:
Oct 03 09:35:13 dm900 enigma2[267]: [eDVBCAService] free service 1:0:19:69:C:85:C00000:0:0:0:
Oct 03 09:35:13 dm900 enigma2[267]: [eFileMonitor] 1 events queued
Oct 03 09:35:13 dm900 enigma2[267]: [eDVBCIInterfaces] remove last pmt handler for service 1:0:19:69:C:85:C00000:0:0:0: send empty capmt
Oct 03 09:35:13 dm900 enigma2[267]: [eDVBCISlot] capmt version equal... increment old was 0d! new version is 0f
Oct 03 09:35:13 dm900 enigma2[267]: setInputSource input1 to A2
Oct 03 09:35:13 dm900 enigma2[267]: (3) slot 0 usecount is now 0
Oct 03 09:35:13 dm900 enigma2[267]: [eDBusInterface::Private::sendEvent 0
Oct 03 09:35:13 dm900 enigma2[267]: [TeleText] service stopped
Oct 03 09:35:13 dm900 enigma2[267]: [TeleText] send array('B', [1, 0, 0, 0])
Oct 03 09:35:13 dm900 enigma2[267]: disable dvb subtitles
Oct 03 09:35:13 dm900 enigma2[267]: disable teletext subtitles page ffffffffffffffff (und)
Oct 03 09:35:13 dm900 enigma2[267]: decoder state: play, vpid=-1, apid=-1
Oct 03 09:35:13 dm900 enigma2[267]: DEMUX_STOP - pcr - ok
Oct 03 09:35:13 dm900 enigma2[267]: DEMUX_STOP - video - ok
Oct 03 09:35:13 dm900 enigma2[267]: VIDEO_STOP - ok
Oct 03 09:35:13 dm900 enigma2[267]: AUDIO_STOP - ok
Oct 03 09:35:13 dm900 enigma2[267]: DEMUX_STOP - audio - ok
Oct 03 09:35:13 dm900 enigma2[267]: AUDIO_CONTINUE - ok
Oct 03 09:35:13 dm900 enigma2[267]: DEMUX_STOP - ttx - ok
Oct 03 09:35:13 dm900 enigma2[267]: start release channel timer
Oct 03 09:35:13 dm900 enigma2[267]: [TeleText] service started
Oct 03 09:35:13 dm900 enigma2[267]: create buffer for widget 1280 x 150
Oct 03 09:35:13 dm900 enigma2[267]: not pauseable.
Oct 03 09:35:13 dm900 enigma2[267]: W/  [InfoBar.__servicePlaying] :: <no detail>
Oct 03 09:35:13 dm900 enigma2[267]: I/  [InfoBar.setPlaybackState] :: None None 1507016113.47
Oct 03 09:35:13 dm900 enigma2[267]: [eDVBCAService] remove channel 0x108bee0
Oct 03 09:35:13 dm900 enigma2[267]: [eDVBCAService] write leave transponder to '/tmp/camd.socket' ok
Oct 03 09:35:13 dm900 enigma2[267]: [eDVBLocalTimeHandler] remove channel 0x108bee0
Oct 03 09:35:13 dm900 enigma2[267]: [EPGC] remove channel 0x108bee0
Oct 03 09:35:13 dm900 enigma2[267]: [    1] preClose
Oct 03 09:35:13 dm900 enigma2[267]: allocate channel.. 000d:0085:00c00000
Oct 03 09:35:13 dm900 enigma2[267]: available channel.. 0421:0001:00c00000
Oct 03 09:35:13 dm900 enigma2[267]: [eDVBCAService] new channel 0x108bee0!
Oct 03 09:35:13 dm900 enigma2[267]: [    1] tune type 1
Oct 03 09:35:13 dm900 enigma2[267]: RotorCmd ffffffff, lastRotorCmd ffffffff
Oct 03 09:35:13 dm900 enigma2[267]: [    1] prepare_sat System DVB-S2 Freq 11992500H SR 27500000 INV Auto FEC 9/10 orbpos 192 modulation QPSK pilot Off, rolloff 0.35
Oct 03 09:35:13 dm900 enigma2[267]: [    1] tuning to 1392 mhz
Oct 03 09:35:13 dm900 enigma2[267]: OURSTATE: tuning
Oct 03 09:35:13 dm900 enigma2[267]: [SEC-1] update oparm
Oct 03 09:35:13 dm900 enigma2[267]: [SEC-1] lock 0
Oct 03 09:35:13 dm900 enigma2[267]: [SEC-1] locked 1
Oct 03 09:35:13 dm900 enigma2[267]: [SEC-1] set static current limiting
Oct 03 09:35:13 dm900 enigma2[267]: allocate Channel: res 0
Oct 03 09:35:13 dm900 enigma2[267]: allocate demux
Oct 03 09:35:13 dm900 enigma2[267]: [SEC-1] invalidate current switch params
Oct 03 09:35:13 dm900 enigma2[267]: [SEC-1] update current switch params
Oct 03 09:35:13 dm900 enigma2[267]: [SEC-1] startTuneTimeout 5000
Oct 03 09:35:13 dm900 enigma2[267]: [SEC-1] setFrontend 1
Oct 03 09:35:13 dm900 enigma2[267]: [    1] setting frontend
Oct 03 09:35:13 dm900 enigma2[267]: [SEC-1] unlock 1
Oct 03 09:35:13 dm900 enigma2[267]: [SEC-1] sleep 500ms
Oct 03 09:35:13 dm900 enigma2[267]: setInputSource input1 to A2
Oct 03 09:35:13 dm900 enigma2[267]: [eDVBCAService] new service 1:0:19:72:D:85:C00000:0:0:0:
Oct 03 09:35:13 dm900 enigma2[267]: [eDVBCAService] add demux 1 to slot 0 service 1:0:19:72:D:85:C00000:0:0:0:
Oct 03 09:35:13 dm900 enigma2[267]: [eDVBCAService] use cached!
Oct 03 09:35:13 dm900 enigma2[267]: [eDVBCAService] demux 1 mask 02
Oct 03 09:35:13 dm900 enigma2[267]: [eDVBCAServiceConn] send 72 bytes to '/tmp/camd.socket'
Oct 03 09:35:13 dm900 enigma2[267]: 9f 80 32 44 03 00 72 13 00 2a 01 81 08 00 c0 00 00 00 0d 00 85 82 02 02 01 84 02 00 63 85 03 01 41 32 09 04 09 8c fa 01 09 04 09 c4 fb 01 09 04 09 af ff 01 06 00 20 00 00 1b 03 ff 00 00 06 04 02 00 00 06 04 03 00 00
Oct 03 09:35:13 dm900 enigma2[267]: [eDVBCIInterfaces] addPMTHandler 1:0:19:72:D:85:C00000:0:0:0:
Oct 03 09:35:13 dm900 enigma2[267]: 'SKY/00c00000' is in provider list of slot 0... so use it
Oct 03 09:35:13 dm900 enigma2[267]: (1)CISlot 0, usecount now 1
Oct 03 09:35:13 dm900 enigma2[267]: setInputSource input1 to CI0
Oct 03 09:35:13 dm900 enigma2[267]: CI Slot 0 setSource(1)
Oct 03 09:35:13 dm900 enigma2[267]: [eDVBCIInterfaces] gotPMT
Oct 03 09:35:13 dm900 enigma2[267]: [eDVBCIInterfaces] gotPMT
Oct 03 09:35:13 dm900 enigma2[267]: have 1 video stream(s) (03ff), and 1 audio stream(s) (0402), and the pcr pid is 03ff, and the text pid is 0020
Oct 03 09:35:13 dm900 enigma2[267]: allocate demux
Oct 03 09:35:13 dm900 enigma2[267]: disable teletext subtitles page ffffffffffffffff (und)
Oct 03 09:35:13 dm900 enigma2[267]: decoder state: play, vpid=1023, apid=1026
Oct 03 09:35:13 dm900 enigma2[267]: DMX_SET_PES_FILTER(0x3ff) - pcr - ok
Oct 03 09:35:13 dm900 enigma2[267]: DEMUX_START - pcr - ok
Oct 03 09:35:13 dm900 enigma2[267]: DMX_SET_PES_FILTER(0x402) - audio - ok
Oct 03 09:35:13 dm900 enigma2[267]: DEMUX_START - audio - ok
Oct 03 09:35:13 dm900 enigma2[267]: AUDIO_SET_BYPASS(0) - ok
Oct 03 09:35:13 dm900 enigma2[267]: AUDIO_PAUSE - ok
Oct 03 09:35:13 dm900 enigma2[267]: AUDIO_PLAY - ok
Oct 03 09:35:13 dm900 enigma2[267]: Video Device: /dev/dvb/adapter0/video0
Oct 03 09:35:13 dm900 enigma2[267]: demux device: /dev/dvb/adapter0/demux1
Oct 03 09:35:13 dm900 enigma2[267]: VIDEO_SET_STREAMTYPE 1 - ok
Oct 03 09:35:13 dm900 enigma2[267]: DMX_SET_PES_FILTER(0x3ff) - video - ok
Oct 03 09:35:13 dm900 enigma2[267]: DEMUX_START - video - ok
Oct 03 09:35:13 dm900 enigma2[267]: VIDEO_FREEZE - ok
Oct 03 09:35:13 dm900 enigma2[267]: VIDEO_PLAY - ok
Oct 03 09:35:13 dm900 enigma2[267]: DMX_SET_PES_FILTER(0x20) - ttx - ok
Oct 03 09:35:13 dm900 enigma2[267]: DEMUX_START - ttx - ok
Oct 03 09:35:13 dm900 enigma2[267]: VIDEO_SLOWMOTION(0) - ok
Oct 03 09:35:13 dm900 enigma2[267]: VIDEO_FAST_FORWARD(0) - ok
Oct 03 09:35:13 dm900 enigma2[267]: VIDEO_CONTINUE - ok
Oct 03 09:35:13 dm900 enigma2[267]: AUDIO_CONTINUE - ok
Oct 03 09:35:13 dm900 enigma2[267]: W/  [InfoBar.__servicePlaying] :: <no detail>
Oct 03 09:35:13 dm900 enigma2[267]: I/  [InfoBar.setPlaybackState] :: None None 1507016113.52
Oct 03 09:35:13 dm900 enigma2[267]: not pauseable.
Oct 03 09:35:13 dm900 enigma2[267]: [HbbTV].aitInvalidated
Oct 03 09:35:13 dm900 enigma2[267]: [eFileMonitor] 1 events queued
Oct 03 09:35:13 dm900 enigma2[267]: [eFileMonitor] File {/tmp/ecm.info} has been deleted
Oct 03 09:35:13 dm900 enigma2[267]: [eFileMonitor] File {/tmp/ecm.info} has been created
Oct 03 09:35:13 dm900 enigma2[267]: [    1] fe event: status 0, freq 1392500, inversion off, m_tuning 1 F
Oct 03 09:35:13 dm900 enigma2[267]: [    1] fe event: status 1, freq 1392500, inversion off, m_tuning 1 N
Oct 03 09:35:13 dm900 enigma2[267]: [    1] fe event: status 0, freq 1392500, inversion off, m_tuning 2 N
Oct 03 09:35:13 dm900 enigma2[267]: [    1] fe event: status 1, freq 1392500, inversion off, m_tuning 3 N
Oct 03 09:35:13 dm900 enigma2[267]: [    1] fe event: status 0, freq 1392500, inversion off, m_tuning 4 N
Oct 03 09:35:13 dm900 enigma2[267]: [SEC-1] set dynamic current limiting
Oct 03 09:35:14 dm900 enigma2[267]: 66438 ms latency per 1000 blits (15,051627 fps)
Oct 03 09:35:14 dm900 enigma2[267]: [    1] fe event: status 1, freq 1392500, inversion off, m_tuning 5 N
Oct 03 09:35:14 dm900 enigma2[267]: [    1] fe event: status 0, freq 1392500, inversion off, m_tuning 6 N
Oct 03 09:35:14 dm900 enigma2[267]: [    1] fe event: status 1, freq 1392500, inversion off, m_tuning 7 N
Oct 03 09:35:14 dm900 enigma2[267]: [    1] fe event: status 0, freq 1392500, inversion off, m_tuning 8 N
Oct 03 09:35:14 dm900 enigma2[267]: [    1] fe event: status 1, freq 1392500, inversion off, m_tuning 9 N
Oct 03 09:35:14 dm900 enigma2[267]: [    1] fe event: status 0, freq 1392500, inversion off, m_tuning 10 N
Oct 03 09:35:14 dm900 enigma2[267]: [    1] fe event: status 1, freq 1392500, inversion off, m_tuning 11 N
Oct 03 09:35:14 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 12 N
Oct 03 09:35:14 dm900 enigma2[267]: FE_TIMEDOUT! ..abort
Oct 03 09:35:14 dm900 enigma2[267]: OURSTATE: failed
Oct 03 09:35:14 dm900 enigma2[267]: tune failed.
Oct 03 09:35:14 dm900 enigma2[267]: DVB service failed to tune - error 1
Oct 03 09:35:14 dm900 enigma2[267]: I/  [InfoBar.setPlaybackState] :: tuning... Tunen fehlgeschlagen! 1507016114.97
Oct 03 09:35:14 dm900 enigma2[267]: create buffer for widget 600 x 140
Oct 03 09:35:14 dm900 enigma2[267]: ignore sdt update data.... incorrect transponder tuned!!!
Oct 03 09:35:15 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:15 dm900 enigma2[267]: [    1] lost lock
Oct 03 09:35:15 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:15 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:15 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:15 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:15 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:15 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:16 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:16 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:16 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:16 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:16 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:16 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:16 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:17 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:17 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:17 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:17 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:17 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:17 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:17 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:17 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:18 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:18 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:18 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:18 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:18 dm900 enigma2[267]: [    1] lost lock
Oct 03 09:35:18 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:18 dm900 enigma2[267]: It's now  Di 03 Okt 2017 09:35:18 CEST
Oct 03 09:35:18 dm900 enigma2[267]: [timer.py] next activation: 1507016218 (in 99063 ms)
Oct 03 09:35:18 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:19 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:19 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:19 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:19 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:19 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:19 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:19 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:19 dm900 enigma2[267]: It's now  Di 03 Okt 2017 09:35:19 CEST
Oct 03 09:35:19 dm900 enigma2[267]: [timer.py] next activation: 1507016219 (in 99063 ms)
Oct 03 09:35:19 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:20 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:20 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:20 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:20 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:20 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:20 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:20 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:20 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:21 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:21 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:21 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:21 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:21 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:21 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:21 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:22 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:22 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:22 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:22 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:22 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:22 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:23 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:23 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:23 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:23 dm900 enigma2[267]: [EPGC] cleanupOutdated
Oct 03 09:35:23 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:23 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:23 dm900 enigma2[267]: nr_read 732 nr_write 1681
Oct 03 09:35:23 dm900 enigma2[267]: sum 2413 prev_sum 2317
Oct 03 09:35:23 dm900 enigma2[267]: hdd was accessed since previous check!
Oct 03 09:35:23 dm900 enigma2[267]: [IDLE] 0 120 False
Oct 03 09:35:23 dm900 enigma2[267]: [    1] stateLostLock
Oct 03 09:35:23 dm900 enigma2[267]: OURSTATE: lost lock, trying to retune
Oct 03 09:35:23 dm900 enigma2[267]: [    1] tune type 1
Oct 03 09:35:23 dm900 enigma2[267]: RotorCmd ffffffff, lastRotorCmd ffffffff
Oct 03 09:35:23 dm900 enigma2[267]: [    1] prepare_sat System DVB-S2 Freq 11992500H SR 27500000 INV Auto FEC 9/10 orbpos 192 modulation QPSK pilot Off, rolloff 0.35
Oct 03 09:35:23 dm900 enigma2[267]: [    1] tuning to 1392 mhz
Oct 03 09:35:23 dm900 enigma2[267]: OURSTATE: tuning
Oct 03 09:35:23 dm900 enigma2[267]: [SEC-1] update oparm
Oct 03 09:35:23 dm900 enigma2[267]: [SEC-1] lock 0
Oct 03 09:35:23 dm900 enigma2[267]: [SEC-1] locked 1
Oct 03 09:35:23 dm900 enigma2[267]: [SEC-1] set static current limiting
Oct 03 09:35:23 dm900 enigma2[267]: [SEC-1] invalidate current switch params
Oct 03 09:35:23 dm900 enigma2[267]: [SEC-1] update current switch params
Oct 03 09:35:23 dm900 enigma2[267]: [SEC-1] startTuneTimeout 5000
Oct 03 09:35:23 dm900 enigma2[267]: [SEC-1] setFrontend 1
Oct 03 09:35:23 dm900 enigma2[267]: [    1] setting frontend
Oct 03 09:35:23 dm900 enigma2[267]: [SEC-1] unlock 1
Oct 03 09:35:23 dm900 enigma2[267]: [SEC-1] sleep 500ms
Oct 03 09:35:23 dm900 enigma2[267]: [    1] fe event: status 0, freq 1392500, inversion off, m_tuning 1 F
Oct 03 09:35:23 dm900 enigma2[267]: [    1] fe event: status 1, freq 1392500, inversion off, m_tuning 1 N
Oct 03 09:35:24 dm900 enigma2[267]: [    1] fe event: status 0, freq 1392500, inversion off, m_tuning 2 N
Oct 03 09:35:24 dm900 enigma2[267]: [    1] fe event: status 1, freq 1392500, inversion off, m_tuning 3 N
Oct 03 09:35:24 dm900 enigma2[267]: [    1] fe event: status 0, freq 1392500, inversion off, m_tuning 4 N
Oct 03 09:35:24 dm900 enigma2[267]: [SEC-1] set dynamic current limiting
Oct 03 09:35:24 dm900 enigma2[267]: [    1] fe event: status 1, freq 1392500, inversion off, m_tuning 5 N
Oct 03 09:35:24 dm900 enigma2[267]: [    1] fe event: status 0, freq 1392500, inversion off, m_tuning 6 N
Oct 03 09:35:24 dm900 enigma2[267]: [    1] fe event: status 1, freq 1392500, inversion off, m_tuning 7 N
Oct 03 09:35:24 dm900 enigma2[267]: [    1] fe event: status 0, freq 1392500, inversion off, m_tuning 8 N
Oct 03 09:35:24 dm900 enigma2[267]: [    1] fe event: status 1, freq 1392500, inversion off, m_tuning 9 N
Oct 03 09:35:25 dm900 enigma2[267]: [    1] fe event: status 0, freq 1392500, inversion off, m_tuning 10 N
Oct 03 09:35:25 dm900 enigma2[267]: [    1] fe event: status 1, freq 1392500, inversion off, m_tuning 11 N
Oct 03 09:35:25 dm900 enigma2[267]: [    1] fe event: status 0, freq 1392500, inversion off, m_tuning 12 N
Oct 03 09:35:25 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 13 N
Oct 03 09:35:25 dm900 enigma2[267]: FE_TIMEDOUT! ..abort
Oct 03 09:35:25 dm900 enigma2[267]: OURSTATE: failed
Oct 03 09:35:25 dm900 enigma2[267]: tune failed.
Oct 03 09:35:25 dm900 enigma2[267]: DVB service failed to tune - error 1
Oct 03 09:35:25 dm900 enigma2[267]: I/  [InfoBar.setPlaybackState] :: None None 1507016125.41
Oct 03 09:35:25 dm900 enigma2[267]: ignore sdt update data.... incorrect transponder tuned!!!
Oct 03 09:35:25 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:25 dm900 enigma2[267]: [    1] lost lock
Oct 03 09:35:25 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:25 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:25 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:25 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:26 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:26 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:26 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:26 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:26 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:26 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:26 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:26 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:27 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:27 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:27 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:27 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:27 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:27 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:27 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:28 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:28 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:28 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:28 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:28 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:28 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:28 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:28 dm900 enigma2[267]: [    1] lost lock
Oct 03 09:35:29 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:29 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:29 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:29 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:29 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:29 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:29 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:30 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:30 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:30 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:30 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:30 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:30 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:30 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:30 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:31 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:31 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:31 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:31 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:31 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:31 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:31 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:32 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:32 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:32 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:32 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:32 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:32 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:32 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:33 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:33 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:33 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:33 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:33 dm900 enigma2[267]: no ancillary data in audio stream... abort radiotext pes parser
Oct 03 09:35:33 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:33 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:33 dm900 enigma2[267]: [    1] stateLostLock
Oct 03 09:35:33 dm900 enigma2[267]: OURSTATE: lost lock, trying to retune
Oct 03 09:35:33 dm900 enigma2[267]: [    1] tune type 1
Oct 03 09:35:33 dm900 enigma2[267]: RotorCmd ffffffff, lastRotorCmd ffffffff
Oct 03 09:35:33 dm900 enigma2[267]: [    1] prepare_sat System DVB-S2 Freq 11992500H SR 27500000 INV Auto FEC 9/10 orbpos 192 modulation QPSK pilot Off, rolloff 0.35
Oct 03 09:35:33 dm900 enigma2[267]: [    1] tuning to 1392 mhz
Oct 03 09:35:33 dm900 enigma2[267]: OURSTATE: tuning
Oct 03 09:35:33 dm900 enigma2[267]: [SEC-1] update oparm
Oct 03 09:35:33 dm900 enigma2[267]: [SEC-1] lock 0
Oct 03 09:35:33 dm900 enigma2[267]: [SEC-1] locked 1
Oct 03 09:35:33 dm900 enigma2[267]: [SEC-1] set static current limiting
Oct 03 09:35:33 dm900 enigma2[267]: [SEC-1] invalidate current switch params
Oct 03 09:35:33 dm900 enigma2[267]: [SEC-1] update current switch params
Oct 03 09:35:33 dm900 enigma2[267]: [SEC-1] startTuneTimeout 5000
Oct 03 09:35:33 dm900 enigma2[267]: [SEC-1] setFrontend 1
Oct 03 09:35:33 dm900 enigma2[267]: [    1] setting frontend
Oct 03 09:35:33 dm900 enigma2[267]: [SEC-1] unlock 1
Oct 03 09:35:33 dm900 enigma2[267]: [SEC-1] sleep 500ms
Oct 03 09:35:34 dm900 enigma2[267]: [    1] fe event: status 0, freq 1392500, inversion off, m_tuning 1 F
Oct 03 09:35:34 dm900 enigma2[267]: [    1] fe event: status 1, freq 1392500, inversion off, m_tuning 1 N
Oct 03 09:35:34 dm900 enigma2[267]: [    1] fe event: status 0, freq 1392500, inversion off, m_tuning 2 N
Oct 03 09:35:34 dm900 enigma2[267]: [    1] fe event: status 1, freq 1392500, inversion off, m_tuning 3 N
Oct 03 09:35:34 dm900 enigma2[267]: [    1] fe event: status 0, freq 1392500, inversion off, m_tuning 4 N
Oct 03 09:35:34 dm900 enigma2[267]: [SEC-1] set dynamic current limiting
Oct 03 09:35:34 dm900 enigma2[267]: [    1] fe event: status 1, freq 1392500, inversion off, m_tuning 5 N
Oct 03 09:35:34 dm900 enigma2[267]: [    1] fe event: status 0, freq 1392500, inversion off, m_tuning 6 N
Oct 03 09:35:34 dm900 enigma2[267]: [    1] fe event: status 1, freq 1392500, inversion off, m_tuning 7 N
Oct 03 09:35:34 dm900 enigma2[267]: [    1] fe event: status 0, freq 1392500, inversion off, m_tuning 8 N
Oct 03 09:35:35 dm900 enigma2[267]: [    1] fe event: status 1, freq 1392500, inversion off, m_tuning 9 N
Oct 03 09:35:35 dm900 enigma2[267]: [    1] fe event: status 0, freq 1392500, inversion off, m_tuning 10 N
Oct 03 09:35:35 dm900 enigma2[267]: [    1] fe event: status 1, freq 1392500, inversion off, m_tuning 11 N
Oct 03 09:35:35 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 12 N
Oct 03 09:35:35 dm900 enigma2[267]: FE_TIMEDOUT! ..abort
Oct 03 09:35:35 dm900 enigma2[267]: OURSTATE: failed
Oct 03 09:35:35 dm900 enigma2[267]: tune failed.
Oct 03 09:35:35 dm900 enigma2[267]: DVB service failed to tune - error 1
Oct 03 09:35:35 dm900 enigma2[267]: I/  [InfoBar.setPlaybackState] :: None None 1507016135.57
Oct 03 09:35:35 dm900 enigma2[267]: ignore sdt update data.... incorrect transponder tuned!!!
Oct 03 09:35:35 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:35 dm900 enigma2[267]: [    1] lost lock
Oct 03 09:35:35 dm900 enigma2[267]: nr_read 732 nr_write 1774
Oct 03 09:35:35 dm900 enigma2[267]: sum 2506 prev_sum 2413
Oct 03 09:35:35 dm900 enigma2[267]: hdd was accessed since previous check!
Oct 03 09:35:35 dm900 enigma2[267]: [IDLE] 0 120 False
Oct 03 09:35:35 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:35 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:36 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:36 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:36 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:36 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:36 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:36 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:36 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:37 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:37 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:37 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:37 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:37 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:37 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:37 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:38 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:38 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:38 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:38 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:38 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:38 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:38 dm900 enigma2[267]: [    1] fe event: status 21, freq 1392500, inversion off, m_tuning 0 N
Oct 03 09:35:38 dm900 enigma2[267]: [    1] fe event: status 20, freq 1392500, inversion off, m_tuning 0 N