solo 4k erst Spinner dann bleibt Bild stehen

    Diese Seite verwendet Cookies. Durch die Nutzung unserer Seite erklären Sie sich damit einverstanden, dass wir Cookies setzen. Weitere Informationen

    • solo 4k erst Spinner dann bleibt Bild stehen

      Hallo,

      bei meiner Solo 4k kommt ca alle 30 Minuten der Spinner und 2 Minuten später bleibt das Bild stehen und das Gerät hängt sich auf.
      Habe VTI 9.0.3 drauf.


      Bitte um Hilfe
      Gruß Markus

      Dieser Beitrag wurde bereits 7 mal editiert, zuletzt von Markus1973 ()

    • Irgendwas alle 30min aktiv ?
      Wetteraktualisierung, EPG, Cronjob, .....
      ----------------------------------------------------------------------------------------------------------------------------------------------------------------
      KAPIERVORGANG beendet.

      Zubehör : Philips 46PFL-9705 / 37PFL-9604, Samsung HT-E6759W, Samsung SPF 107H-105P-87H, Qnap TS-253A, Harmony 650, Fritzbox 7490, Cisco WAP4410N, Netgear M4100-D12G, TPLink HS100/HS110/LB110

    • Wetter ist aktiv.
      Aber das stört bei meinen beiden anderen Boxen auch nicht (Solo SE V2).

      Edit:
      Der Fehler hat warscheinlich mit dem Ci+ bzw Sky oder OScam zu tun.
      Den Fehler habe ich bis jetzt nur bei einem Sky Sender gehabt.
      Habe jetzt auf ARD seit 2,5 Stunden keinen Absturz mehr.
      Gucke HD+ über OScam 1.2.0 rev 11233 und Sky V14 über das Sky Ci+ Modul.
      Spoiler anzeigen
      22:03:25.996 [e2-core] [VTi] version: 9.0.3 --> build: 2016-07-28 (d75da0c) | vti-master
      22:03:27.480 [e2-python] action -> WizardActions back
      22:03:27.480 [e2-python] unknown action WizardActions/back! typo in keymap?
      22:03:27.480 [e2-python] action -> OkCancelActions cancel
      22:03:28.140 [e2-python] action -> WizardActions back
      22:03:28.140 [e2-python] unknown action WizardActions/back! typo in keymap?
      22:03:28.140 [e2-python] action -> OkCancelActions cancel
      22:03:29.420 [e2-python] action -> InfobarMenuActions mainMenu
      22:03:29.420 [e2-python] loading mainmenu XML...
      22:03:29.423 [e2-python] Subtitles Subtitles
      22:03:29.424 [e2-python] TimerEdit TimerEditList
      22:03:29.424 [e2-python] PluginBrowser PluginBrowser
      22:03:30.060 [e2-python] action -> WizardActions left
      22:03:30.360 [e2-python] action -> WizardActions left
      22:03:30.720 [e2-python] action -> WizardActions ok
      22:03:30.720 [e2-python] unknown action WizardActions/ok! typo in keymap?
      22:03:30.720 [e2-python] action -> OkCancelActions ok
      22:03:30.749 [e2-python] False
      22:03:30.759 [e2-python] warning, skin is missing element helpShadow in <class 'Plugins.Extensions.FilebrowserVTi.plugin.FilebrowserScreenVTi'>
      22:03:30.759 [e2-python] warning, skin is missing element helpBack in <class 'Plugins.Extensions.FilebrowserVTi.plugin.FilebrowserScreenVTi'>
      22:03:30.760 [e2-python] warning, skin is missing element list_right_head in <class 'Plugins.Extensions.FilebrowserVTi.plugin.FilebrowserScreenVTi'>
      22:03:30.763 [e2-python] warning, skin is missing element list_left_head in <class 'Plugins.Extensions.FilebrowserVTi.plugin.FilebrowserScreenVTi'>
      22:03:31.380 [e2-python] action -> WizardActions down
      22:03:31.383 [e2-python] [FilebrowserVTI] fallback to default Enigma2 Translation for Mode
      22:03:31.640 [e2-python] action -> WizardActions ok
      22:03:32.720 [e2-python] action -> WizardActions ok
      22:03:32.723 [e2-python] [FilebrowserVTI] fallback to default Enigma2 Translation for Mode
      22:03:33.580 [e2-python] action -> WizardActions back
      22:03:34.920 [e2-python] action -> WizardActions back
      22:03:34.920 [e2-python] unknown action WizardActions/back! typo in keymap?
      22:03:34.920 [e2-python] action -> OkCancelActions cancel
      22:03:35.460 [e2-python] action -> InfobarChannelSelection showFavourites
      22:03:35.468 [e2-core] [ServiceList] cannot access /tmp/livepreview
      22:03:35.468 [e2-core] [ServiceList] initiate service mapping
      22:03:36.380 [e2-python] action -> ChannelSelectBaseActions prevBouquet
      22:03:36.950 [e2-python] action -> ChannelSelectBaseActions prevBouquet
      22:03:38.170 [e2-python] action -> OkCancelActions ok
      22:03:38.171 [e2-python] playing service..
      22:03:38.175 [e2-python] looking for Extended Data EventID: 54039
      22:03:38.175 [e2-python] Extended Data Event found
      22:03:38.176 [e2-python] Event has Extended Data: {"title":"Spiel f\u00fcr dein Land","subtitle":"Der gro\u00dfe L\u00e4nderwettstreit","airtime":1475345700,"categoryName":"Unterhaltung","genre":"Quizshow","year":"2016","isNew":"","country":"D","ageRating":"","season":"","episode":"4","channelid":"1","isLastEpisode":"","highlightCategory":"Top Tipp","image":"http:\/\/images.tvmovie.de\/220x142\/North\/a229d040-870e-11e6-a937-991b0ab5d171-1.jpg","imagebase":"","showviewNumber":"","conclusion":"Deutschland gewann die Show bislang schon 2 Mal","isDolbyDigital":"","movieStarValue":"","ratings":"","leadText":"Drei Nationen k\u00e4mpfen um 50.000 Euro","search":"","id":"94709524"}
      22:03:38.177 [e2-python] looking for Extended Data EventID: 54040
      22:03:38.177 [e2-python] Extended Data Event found
      22:03:38.177 [e2-python] Event has Extended Data: {"title":"Tagesthemen","subtitle":"Mit Wetter","airtime":1475356500,"categoryName":"Reportage","genre":"Nachrichtenmagazin","year":"2016","isNew":"","country":"D","ageRating":"","season":"","episode":"","channelid":"1","isLastEpisode":"","highlightCategory":"","image":"","imagebase":"","showviewNumber":"","conclusion":"","isDolbyDigital":"","movieStarValue":"","ratings":"","leadText":"","search":"","id":"94709434"}
      22:03:38.178 [e2-core] [eDVBServiceFCCPlay::changeFCCMode][1:0:19:283D:3FB:1:C00000:0:0:0:] disable FCC decoding.
      22:03:38.178 [e2-core] [eDVBServiceFCCPlay::FCCDecoderStop][1:0:19:283D:3FB:1:C00000:0:0:0:]
      22:03:38.180 [e2-core] decoder state: play, vpid=-1, apid=-1
      22:03:38.180 [e2-core] DEMUX_STOP - pcr - ok
      22:03:38.204 [e2-core] AUDIO_STOP - ok
      22:03:38.204 [e2-core] DEMUX_STOP - audio - ok
      22:03:38.204 [e2-core] AUDIO_CONTINUE - ok
      22:03:38.204 [e2-core] DEMUX_STOP - ttx - ok
      22:03:38.205 [e2-core] [eTSMPEGDecoder] FCC_DECODER_STOP OK!
      22:03:38.205 [e2-core] [eFCCServiceManager] stop FCC service sref : 1:0:19:283D:3FB:1:C00000:0:0:0:
      22:03:38.205 [e2-core] [eDVBCAService] free slot 0 demux 0 for service 1:0:19:283D:3FB:1:C00000:0:0:0:
      22:03:38.206 [e2-core] [eDVBCAService] free service 1:0:19:283D:3FB:1:C00000:0:0:0:
      22:03:38.207 [e2-core] [eFCCServiceManager] stop FCC service sref : 1:0:19:2873:425:1:C00000:0:0:0:
      22:03:38.207 [e2-core] [eDVBCAService] free slot 0 demux 3 for service 1:0:19:2873:425:1:C00000:0:0:0:
      22:03:38.207 [e2-core] [eDVBCAService] free service 1:0:19:2873:425:1:C00000:0:0:0:
      22:03:38.208 [e2-core] [eFCCServiceManager] stop FCC service sref : 1:0:19:2B66:3F3:1:C00000:0:0:0:
      22:03:38.208 [e2-core] [eDVBCAService] free slot 0 demux 1 for service 1:0:19:2B66:3F3:1:C00000:0:0:0:
      22:03:38.209 [e2-core] [eDVBCAService] free service 1:0:19:2B66:3F3:1:C00000:0:0:0:
      22:03:38.210 [e2-core] decoder state: stop, vpid=-1, apid=-1
      22:03:38.211 [e2-core] [eTSMPEGDecoder] FCC_STOP OK!
      22:03:38.211 [e2-core] [eFCCDecoder] close /dev/fcc1
      22:03:38.211 [e2-core] [eDVBCAService] remove channel 0x145ac50
      22:03:38.212 [e2-core] [eDVBLocalTimerHandler] remove channel 0x145ac50
      22:03:38.212 [e2-core] [eEPGCache] remove channel 0x145ac50
      22:03:38.215 [e2-core] decoder state: stop, vpid=-1, apid=-1
      22:03:38.216 [e2-core] [eTSMPEGDecoder] FCC_STOP OK!
      22:03:38.217 [e2-core] [eFCCDecoder] close /dev/fcc2
      22:03:38.217 [e2-core] [eDVBCAService] remove channel 0x14292f8
      22:03:38.217 [e2-core] [eDVBLocalTimerHandler] remove channel 0x14292f8
      22:03:38.217 [e2-core] [eEPGCache] remove channel 0x14292f8
      22:03:38.220 [e2-core] [eEPGCache] abort caching events !!
      22:03:38.223 [e2-core] decoder state: play, vpid=-1, apid=-1
      22:03:38.224 [e2-core] [eTSMPEGDecoder] FCC_STOP OK!
      22:03:38.224 [e2-core] [eFCCDecoder] close /dev/fcc0
      22:03:38.225 [e2-core] [eDVBCAService] remove channel 0xb65ec8
      22:03:38.225 [e2-core] [eDVBLocalTimerHandler] remove channel 0xb65ec8
      22:03:38.225 [e2-core] [eEPGCache] remove channel 0xb65ec8
      22:03:38.227 [e2-core] [eEPGCache] abort caching events !!
      22:03:38.230 [e2-core] allocate channel.. 000c:0085
      22:03:38.232 [e2-core] [eDVBCAService] new channel 0xb65ec8!
      22:03:38.232 [e2-core] (0)tune
      22:03:38.233 [e2-core] RotorCmd ffffffff, lastRotorCmd ffffffff
      22:03:38.233 [e2-core] prepare_sat System 1 Freq 12304500 Pol 0 SR 27500000 INV 2 FEC 9 orbpos 192 system 1 modulation 1 pilot 2, rolloff 0
      22:03:38.233 [e2-core] tuning to 1704 mhz
      22:03:38.233 [e2-core] OURSTATE: tuning
      22:03:38.233 [e2-core] allocate Channel: res 0
      22:03:38.233 [e2-core] allocate demux
      22:03:38.233 [e2-core] resolve: resolve ${sysconfdir}/scan_tp_valid_check.py
      22:03:38.233 [e2-core] resolve: -> /etc/scan_tp_valid_check.py
      22:03:38.233 [e2-core] [eDVBServiceFCCPlay::changeFCCMode][1:0:19:69:C:85:C00000:0:0:0:] enable FCC decoding.
      22:03:38.234 [e2-core] 'SKY/00c00000' is in provider list of slot 0... so use it
      22:03:38.234 [e2-core] (1)CISlot 0, usecount now 1
      22:03:38.247 [e2-python] looking for Extended Data EventID: 18480
      22:03:38.247 [e2-python] Extended Data Event found
      22:03:38.248 [e2-python] But Extended Data is empty
      22:03:38.250 [e2-python] looking for Extended Data EventID: 18481
      22:03:38.251 [e2-python] Extended Data Event found
      22:03:38.251 [e2-python] But Extended Data is empty
      22:03:38.262 [e2-python] not pauseable.
      22:03:38.262 [e2-python] RemovePopup, id = ZapError
      22:03:38.270 [e2-core] [SEC] set static current limiting
      22:03:38.289 [e2-core] [SEC] invalidate current switch params
      22:03:38.290 [e2-core] set sequence pos 3
      22:03:38.291 [e2-core] [SEC] setTone 1
      22:03:38.291 [e2-core] [SEC] sleep 10ms
      22:03:38.310 [e2-core] [SEC] update current switch params
      22:03:38.310 [e2-core] [SEC] startTuneTimeout 5000
      22:03:38.310 [e2-core] [SEC] setFrontend 1
      22:03:38.310 [e2-core] setting frontend 0
      22:03:38.311 [e2-core] [SEC] sleep 500ms
      22:03:38.330 [e2-core] (0)fe event: status 0, inversion off, m_tuning 1
      22:03:38.369 [e2-core] (0)fe event: status 7, inversion off, m_tuning 2
      22:03:38.529 [e2-core] (0)fe event: status 1f, inversion off, m_tuning 3
      22:03:38.530 [e2-core] OURSTATE: ok
      22:03:38.530 [e2-core] [eDVBCAService] channel 0xb65ec8 running
      22:03:38.530 [e2-core] [eDVBLocalTimerHandler] channel 0xb65ec8 running
      22:03:38.530 [e2-core] no version filtering
      22:03:38.530 [e2-core] 0014: 70 00 00 00 00 00
      22:03:38.530 [e2-core] mask: fc 00 00 00 00 00
      22:03:38.530 [e2-core] mode: 00 00 00 00 00 00
      22:03:38.530 [e2-core] [eEPGCache] channel 0xb65ec8 running
      22:03:38.531 [e2-core] stop release channel timer
      22:03:38.531 [e2-core] no version filtering
      22:03:38.531 [e2-core] 0012: 4e 00 69 00 00 00
      22:03:38.531 [e2-core] mask: ff ff ff 00 00 00
      22:03:38.531 [e2-core] mode: 00 00 00 00 00 00
      22:03:38.533 [e2-core] ok ... now we start!!
      22:03:38.534 [e2-core] no version filtering
      22:03:38.534 [e2-core] 0000: 00 00 00 00 00 00
      22:03:38.534 [e2-core] mask: ff 00 00 00 00 00
      22:03:38.534 [e2-core] mode: 00 00 00 00 00 00
      22:03:38.534 [e2-core] eventNewProgramInfo 0 0
      22:03:38.534 [e2-core] [eDVBServiceFCCPlay::updateFCCDecoder][1:0:19:69:C:85:C00000:0:0:0:]
      22:03:38.534 [e2-core] have 1 video stream(s) (00ff), and 1 audio stream(s) (0102), and the pcr pid is 00ff, and the text pid is 0021 (Cached)
      22:03:38.534 [e2-core] allocate demux
      22:03:38.535 [e2-core] [eFCCDecoder] alloc /dev/fcc0
      22:03:38.535 [e2-core] [eTSMPEGDecoder] FCC_START OK!
      22:03:38.535 [e2-core] [eEPGCache] next update in 2 sec
      22:03:38.535 [e2-core] disable teletext subtitles
      22:03:38.554 [e2-core] [eTSMPEGDecoder] FCC_DECODER_START OK!
      22:03:38.555 [e2-core] decoder state: play, vpid=255, apid=258
      22:03:38.555 [e2-core] DMX_SET_PES_FILTER(0xff) - pcr - ok
      22:03:38.555 [e2-core] DEMUX_START - pcr - ok
      22:03:38.555 [e2-core] DMX_SET_PES_FILTER(0x102) - audio - ok
      22:03:38.555 [e2-core] DEMUX_START - audio - ok
      22:03:38.555 [e2-core] AUDIO_SET_BYPASS(0) - ok
      22:03:38.555 [e2-core] AUDIO_PAUSE - ok
      22:03:38.557 [e2-core] AUDIO_PLAY - ok
      22:03:38.557 [e2-core] Video Device: /dev/dvb/adapter0/video0
      22:03:38.557 [e2-core] demux device: /dev/dvb/adapter0/demux0
      22:03:38.557 [e2-core] DMX_SET_PES_FILTER(0x21) - ttx - ok
      22:03:38.557 [e2-core] DEMUX_START - ttx - ok
      22:03:38.561 [e2-core] VIDEO_SLOWMOTION(0) - ok
      22:03:38.562 [e2-core] VIDEO_FAST_FORWARD(0) - ok
      22:03:38.562 [e2-core] VIDEO_CONTINUE - ok
      22:03:38.562 [e2-core] AUDIO_CONTINUE - ok
      22:03:38.563 [e2-python] not pauseable.
      22:03:38.575 [e2-core] allocate channel.. 0006:0085
      22:03:38.575 [e2-core] available channel.. 000c:0085
      22:03:38.578 [e2-core] [eDVBCAService] new channel 0x14e39c0!
      22:03:38.578 [e2-core] (2)tune
      22:03:38.578 [e2-core] RotorCmd ffffffff, lastRotorCmd ffffffff
      22:03:38.578 [e2-core] prepare_sat System 1 Freq 11914500 Pol 0 SR 27500000 INV 2 FEC 9 orbpos 192 system 1 modulation 1 pilot 2, rolloff 0
      22:03:38.578 [e2-core] tuning to 1314 mhz
      22:03:38.578 [e2-core] OURSTATE: tuning
      22:03:38.578 [e2-core] allocate Channel: res 0
      22:03:38.578 [e2-core] allocate demux
      22:03:38.579 [e2-core] resolve: resolve ${sysconfdir}/scan_tp_valid_check.py
      22:03:38.579 [e2-core] resolve: -> /etc/scan_tp_valid_check.py
      22:03:38.579 [e2-core] [SEC] set static current limiting
      22:03:38.580 [e2-core] [SEC] invalidate current switch params
      22:03:38.580 [e2-core] set sequence pos 3
      22:03:38.580 [e2-core] set sequence pos 3
      22:03:38.580 [e2-core] [SEC] update current switch params
      22:03:38.580 [e2-core] [SEC] startTuneTimeout 5000
      22:03:38.580 [e2-core] [SEC] setFrontend 1
      22:03:38.580 [e2-core] setting frontend 2
      22:03:38.580 [e2-core] [SEC] sleep 500ms
      22:03:38.599 [e2-core] (2)fe event: status 0, inversion off, m_tuning 1
      22:03:38.639 [e2-core] + 1/1 TID 00
      22:03:38.640 [e2-core] done!
      22:03:38.640 [e2-core] PATready
      22:03:38.640 [e2-core] use pmtpid 0060 for service_id 0069
      22:03:38.641 [e2-core] no version filtering
      22:03:38.641 [e2-core] 0060: 02 00 69 00 00 00
      22:03:38.641 [e2-core] mask: ff ff ff 00 00 00
      22:03:38.641 [e2-core] mode: 00 00 00 00 00 00
      22:03:38.641 [e2-core] doing version filtering
      22:03:38.641 [e2-core] 0000: 00 00 00 2f 00 00
      22:03:38.641 [e2-core] mask: ff 00 00 3f 00 00
      22:03:38.641 [e2-core] mode: 00 00 00 3e 00 00
      22:03:38.643 [e2-core] (2)fe event: status 7, inversion off, m_tuning 2
      22:03:38.699 [e2-core] + 1/1 TID 02
      22:03:38.700 [e2-core] done!
      22:03:38.700 [e2-core] eventNewProgramInfo 0 0
      22:03:38.701 [e2-core] [eDVBServiceFCCPlay::updateFCCDecoder][1:0:19:69:C:85:C00000:0:0:0:]
      22:03:38.701 [e2-core] have 1 video stream(s) (00ff), and 2 audio stream(s) (0102, 0103), and the pcr pid is 00ff, and the text pid is 0021
      22:03:38.701 [e2-core] disable teletext subtitles
      22:03:38.702 [e2-core] decoder state: play, vpid=255, apid=258
      22:03:38.709 [e2-core] [eDVBCAService] new service 1:0:19:69:C:85:C00000:0:0:0:
      22:03:38.709 [e2-core] [eDVBCAService] add demux 0 to slot 0 service 1:0:19:69:C:85:C00000:0:0:0:
      22:03:38.709 [e2-core] 'SKY/00c00000' is in provider list of slot 0... so use it
      22:03:38.709 [e2-core] demux 0 mask 01 prevhash 00000000
      22:03:38.711 [e2-core] [eDVBCAService] send 67 bytes
      22:03:38.711 [e2-core] 9f 80 32 3f 03 00 69 23 00 25 01 81 08 00 c0 00 00 00 0c 00 85 82 02 01 00 84 02 00 60 09 04 09 c4 fb 0d 09 04 09 af ff 0d 09 04 09 8c fa 0d 06 00 21 00 00 1b 00 ff 00 00 06 01 02 00 00 06 01 03 00 00
      22:03:38.711 [e2-core] doing version filtering
      22:03:38.711 [e2-core] 0060: 02 00 69 23 00 00
      22:03:38.711 [e2-core] mask: ff ff ff 3f 00 00
      22:03:38.711 [e2-core] mode: 00 00 00 3e 00 00
      22:03:38.910 [e2-core] [SEC] set dynamic current limiting
      22:03:38.934 [e2-core] sdt update done!
      22:03:38.935 [e2-core] (2)fe event: status 1f, inversion off, m_tuning 3
      22:03:38.935 [e2-core] OURSTATE: ok
      22:03:38.935 [e2-core] [eDVBCAService] channel 0x14e39c0 running
      22:03:38.935 [e2-core] [eDVBLocalTimerHandler] channel 0x14e39c0 running
      22:03:38.935 [e2-core] no version filtering
      22:03:38.935 [e2-core] 0014: 70 00 00 00 00 00
      22:03:38.935 [e2-core] mask: fc 00 00 00 00 00
      22:03:38.935 [e2-core] mode: 00 00 00 00 00 00
      22:03:38.936 [e2-core] [eEPGCache] channel 0x14e39c0 running
      22:03:38.936 [e2-core] [eEPGCache] next update in 2 sec
      22:03:38.936 [e2-core] stop release channel timer
      22:03:38.936 [e2-core] no version filtering
      22:03:38.936 [e2-core] 0012: 4e 01 0b 00 00 00
      22:03:38.936 [e2-core] mask: ff ff ff 00 00 00
      22:03:38.937 [e2-core] mode: 00 00 00 00 00 00
      22:03:38.937 [e2-core] ok ... now we start!!
      22:03:38.937 [e2-core] no version filtering
      22:03:38.937 [e2-core] 0000: 00 00 00 00 00 00
      22:03:38.937 [e2-core] mask: ff 00 00 00 00 00
      22:03:38.937 [e2-core] mode: 00 00 00 00 00 00
      22:03:38.938 [e2-core] eventNewProgramInfo 0 0
      22:03:38.938 [e2-core] [eDVBServiceFCCPlay::updateFCCDecoder][1:0:19:10B:6:85:C00000:0:0:0:]
      22:03:38.938 [e2-core] have 1 video stream(s) (07ff), and 1 audio stream(s) (0802), and the pcr pid is 07ff, and the text pid is 0020 (Cached)
      22:03:38.938 [e2-core] allocate demux
      22:03:38.938 [e2-core] [eFCCDecoder] alloc /dev/fcc1
      22:03:38.939 [e2-core] [eTSMPEGDecoder] FCC_START OK!
      22:03:38.941 [e2-core] allocate channel.. 0003:0085
      22:03:38.941 [e2-core] available channel.. 000c:0085
      22:03:38.941 [e2-core] available channel.. 0006:0085
      22:03:38.943 [e2-core] [eDVBCAService] new channel 0x1770580!
      22:03:38.944 [e2-core] (3)tune
      22:03:38.944 [e2-core] RotorCmd ffffffff, lastRotorCmd ffffffff
      22:03:38.944 [e2-core] prepare_sat System 1 Freq 11719500 Pol 0 SR 27500000 INV 2 FEC 9 orbpos 192 system 1 modulation 1 pilot 2, rolloff 0
      22:03:38.944 [e2-core] tuning to 1119 mhz
      22:03:38.944 [e2-core] OURSTATE: tuning
      22:03:38.944 [e2-core] allocate Channel: res 0
      22:03:38.944 [e2-core] allocate demux
      22:03:38.945 [e2-core] resolve: resolve ${sysconfdir}/scan_tp_valid_check.py
      22:03:38.945 [e2-core] resolve: -> /etc/scan_tp_valid_check.py
      22:03:38.946 [e2-core] [SEC] set static current limiting
      22:03:38.946 [e2-core] [SEC] invalidate current switch params
      22:03:38.947 [e2-core] set sequence pos 3
      22:03:38.947 [e2-core] set sequence pos 3
      22:03:38.947 [e2-core] [SEC] update current switch params
      22:03:38.947 [e2-core] [SEC] startTuneTimeout 5000
      22:03:38.947 [e2-core] [SEC] setFrontend 1
      22:03:38.947 [e2-core] setting frontend 3
      22:03:38.947 [e2-core] [SEC] sleep 500ms
      22:03:38.959 [e2-core] (3)fe event: status 0, inversion off, m_tuning 1
      22:03:38.979 [e2-core] + 1/1 TID 00
      22:03:38.979 [e2-core] done!
      22:03:38.980 [e2-core] PATready
      22:03:38.980 [e2-core] no PAT entry found.. start delay
      22:03:38.980 [e2-core] doing version filtering
      22:03:38.981 [e2-core] 0000: 00 00 00 2f 00 00
      22:03:38.981 [e2-core] mask: ff 00 00 3f 00 00
      22:03:38.981 [e2-core] mode: 00 00 00 3e 00 00
      22:03:39.000 [e2-core] (3)fe event: status 7, inversion off, m_tuning 2
      22:03:39.099 [e2-core] [SEC] set dynamic current limiting
      22:03:39.160 [e2-core] (3)fe event: status 1f, inversion off, m_tuning 3
      22:03:39.160 [e2-core] OURSTATE: ok
      22:03:39.160 [e2-core] [eDVBCAService] channel 0x1770580 running
      22:03:39.160 [e2-core] [eDVBLocalTimerHandler] channel 0x1770580 running
      22:03:39.161 [e2-core] no version filtering
      22:03:39.161 [e2-core] 0014: 70 00 00 00 00 00
      22:03:39.161 [e2-core] mask: fc 00 00 00 00 00
      22:03:39.161 [e2-core] mode: 00 00 00 00 00 00
      22:03:39.161 [e2-core] [eEPGCache] channel 0x1770580 running
      22:03:39.162 [e2-core] [eEPGCache] next update in 2 sec
      22:03:39.162 [e2-core] stop release channel timer
      22:03:39.162 [e2-core] no version filtering
      22:03:39.162 [e2-core] 0012: 4e 00 15 00 00 00
      22:03:39.162 [e2-core] mask: ff ff ff 00 00 00
      22:03:39.162 [e2-core] mode: 00 00 00 00 00 00
      22:03:39.163 [e2-core] ok ... now we start!!
      22:03:39.163 [e2-core] no version filtering
      22:03:39.163 [e2-core] 0000: 00 00 00 00 00 00
      22:03:39.163 [e2-core] mask: ff 00 00 00 00 00
      22:03:39.163 [e2-core] mode: 00 00 00 00 00 00
      22:03:39.165 [e2-core] allocate channel.. 000d:0085
      22:03:39.166 [e2-core] available channel.. 000c:0085
      22:03:39.166 [e2-core] available channel.. 0006:0085
      22:03:39.166 [e2-core] available channel.. 0003:0085
      22:03:39.166 [e2-core] opening frontend 4
      22:03:39.169 [e2-core] [eDVBCAService] new channel 0x181e0e8!
      22:03:39.169 [e2-core] (4)tune
      22:03:39.169 [e2-core] RotorCmd ffffffff, lastRotorCmd ffffffff
      22:03:39.169 [e2-core] prepare_sat System 1 Freq 11992500 Pol 0 SR 27500000 INV 2 FEC 9 orbpos 192 system 1 modulation 1 pilot 2, rolloff 0
      22:03:39.169 [e2-core] tuning to 1392 mhz
      22:03:39.169 [e2-core] OURSTATE: tuning
      22:03:39.169 [e2-core] allocate Channel: res 0
      22:03:39.170 [e2-core] allocate demux
      22:03:39.170 [e2-core] resolve: resolve ${sysconfdir}/scan_tp_valid_check.py
      22:03:39.170 [e2-core] resolve: -> /etc/scan_tp_valid_check.py
      22:03:39.171 [e2-core] [SEC] set static current limiting
      22:03:39.171 [e2-core] [SEC] invalidate current switch params
      22:03:39.172 [e2-core] set sequence pos 3
      22:03:39.172 [e2-core] set sequence pos 3
      22:03:39.172 [e2-core] [SEC] update current switch params
      22:03:39.172 [e2-core] [SEC] startTuneTimeout 5000
      22:03:39.172 [e2-core] [SEC] setFrontend 1
      22:03:39.172 [e2-core] setting frontend 4
      22:03:39.172 [e2-core] [SEC] sleep 500ms
      22:03:39.191 [e2-core] (4)fe event: status 0, inversion off, m_tuning 1
      22:03:39.209 [e2-core] + 1/1 TID 00
      22:03:39.210 [e2-core] done!
      22:03:39.210 [e2-core] PATready
      22:03:39.210 [e2-core] use pmtpid 0068 for service_id 0015
      22:03:39.211 [e2-core] no version filtering
      22:03:39.211 [e2-core] 0068: 02 00 15 00 00 00
      22:03:39.211 [e2-core] mask: ff ff ff 00 00 00
      22:03:39.211 [e2-core] mode: 00 00 00 00 00 00
      22:03:39.211 [e2-core] doing version filtering
      22:03:39.212 [e2-core] 0000: 00 00 00 33 00 00
      22:03:39.212 [e2-core] mask: ff 00 00 3f 00 00
      22:03:39.212 [e2-core] mode: 00 00 00 3e 00 00
      22:03:39.230 [e2-core] (4)fe event: status 7, inversion off, m_tuning 2
      22:03:39.289 [e2-core] + 1/1 TID 02
      22:03:39.290 [e2-core] done!
      22:03:39.290 [e2-core] eventNewProgramInfo 0 0
      22:03:39.290 [e2-core] [eDVBServiceFCCPlay::updateFCCDecoder][1:0:16:15:3:85:C00000:0:0:0:]
      22:03:39.291 [e2-core] have 1 video stream(s) (08ff), and 1 audio stream(s) (0900), and the pcr pid is 08ff, and the text pid is 0020
      22:03:39.291 [e2-core] allocate demux
      22:03:39.291 [e2-core] [eFCCDecoder] alloc /dev/fcc2
      22:03:39.291 [e2-core] [eTSMPEGDecoder] FCC_START OK!
      22:03:39.292 [e2-core] [eDVBCAService] new service 1:0:16:15:3:85:C00000:0:0:0:
      22:03:39.292 [e2-core] [eDVBCAService] add demux 2 to slot 0 service 1:0:16:15:3:85:C00000:0:0:0:
      22:03:39.292 [e2-core] demux 2 mask 04 prevhash 00000000
      22:03:39.293 [e2-core] [eDVBCAService] send 62 bytes
      22:03:39.293 [e2-core] 9f 80 32 3a 03 00 15 05 00 25 01 81 08 00 c0 00 00 00 03 00 85 82 02 04 02 84 02 00 68 09 04 09 c4 fb 7e 09 04 09 8c fa 7e 09 04 09 af ff 7e 06 00 20 00 00 1b 08 ff 00 00 03 09 00 00 00
      22:03:39.294 [e2-core] doing version filtering
      22:03:39.294 [e2-core] 0068: 02 00 15 05 00 00
      22:03:39.294 [e2-core] mask: ff ff ff 3f 00 00
      22:03:39.294 [e2-core] mode: 00 00 00 3e 00 00
      22:03:39.349 [e2-core] -+ 1/2 TID 4e
      22:03:39.390 [e2-core] (4)fe event: status 1f, inversion off, m_tuning 3
      22:03:39.390 [e2-core] OURSTATE: ok
      22:03:39.390 [e2-core] [eDVBCAService] channel 0x181e0e8 running
      22:03:39.390 [e2-core] [eDVBLocalTimerHandler] channel 0x181e0e8 running
      22:03:39.391 [e2-core] no version filtering
      22:03:39.391 [e2-core] 0014: 70 00 00 00 00 00
      22:03:39.391 [e2-core] mask: fc 00 00 00 00 00
      22:03:39.391 [e2-core] mode: 00 00 00 00 00 00
      22:03:39.391 [e2-core] [eEPGCache] channel 0x181e0e8 running
      22:03:39.391 [e2-core] [eEPGCache] next update in 2 sec
      22:03:39.392 [e2-core] stop release channel timer
      22:03:39.392 [e2-core] no version filtering
      22:03:39.392 [e2-core] 0012: 4e 01 15 00 00 00
      22:03:39.392 [e2-core] mask: ff ff ff 00 00 00
      22:03:39.392 [e2-core] mode: 00 00 00 00 00 00
      22:03:39.393 [e2-core] ok ... now we start!!
      22:03:39.393 [e2-core] no version filtering
      22:03:39.393 [e2-core] 0000: 00 00 00 00 00 00
      22:03:39.393 [e2-core] mask: ff 00 00 00 00 00
      22:03:39.393 [e2-core] mode: 00 00 00 00 00 00
      22:03:39.396 [e2-core] allocate channel.. 000e:0085
      22:03:39.396 [e2-core] available channel.. 000c:0085
      22:03:39.396 [e2-core] available channel.. 0006:0085
      22:03:39.396 [e2-core] available channel.. 0003:0085
      22:03:39.396 [e2-core] available channel.. 000d:0085
      22:03:39.396 [e2-core] opening frontend 5
      22:03:39.399 [e2-core] [eDVBCAService] new channel 0x1738900!
      22:03:39.399 [e2-core] (5)tune
      22:03:39.399 [e2-core] RotorCmd ffffffff, lastRotorCmd ffffffff
      22:03:39.399 [e2-core] prepare_sat System 1 Freq 11875500 Pol 0 SR 27500000 INV 2 FEC 3 orbpos 192 system 1 modulation 2 pilot 2, rolloff 0
      22:03:39.400 [e2-core] tuning to 1275 mhz
      22:03:39.400 [e2-core] OURSTATE: tuning
      22:03:39.400 [e2-core] allocate Channel: res 0
      22:03:39.400 [e2-core] allocate demux
      22:03:39.400 [e2-core] resolve: resolve ${sysconfdir}/scan_tp_valid_check.py
      22:03:39.400 [e2-core] resolve: -> /etc/scan_tp_valid_check.py
      22:03:39.401 [e2-core] [SEC] set static current limiting
      22:03:39.401 [e2-core] [SEC] invalidate current switch params
      22:03:39.401 [e2-core] set sequence pos 3
      22:03:39.401 [e2-core] set sequence pos 3
      22:03:39.401 [e2-core] [SEC] update current switch params
      22:03:39.402 [e2-core] [SEC] startTuneTimeout 5000
      22:03:39.402 [e2-core] [SEC] setFrontend 1
      22:03:39.402 [e2-core] setting frontend 5
      22:03:39.402 [e2-core] [SEC] sleep 500ms
      22:03:39.420 [e2-core] (5)fe event: status 0, inversion off, m_tuning 1
      22:03:39.440 [e2-core] + 1/1 TID 00
      22:03:39.440 [e2-core] done!
      22:03:39.440 [e2-core] PATready
      22:03:39.441 [e2-core] no PAT entry found.. start delay
      22:03:39.441 [e2-core] doing version filtering
      22:03:39.441 [e2-core] 0000: 00 00 00 0d 00 00
      22:03:39.441 [e2-core] mask: ff 00 00 3f 00 00
      22:03:39.441 [e2-core] mode: 00 00 00 3e 00 00
      22:03:39.459 [e2-core] (5)fe event: status 7, inversion off, m_tuning 2
      22:03:39.460 [e2-core] [SEC] set dynamic current limiting
      22:03:39.520 [e2-core] (5)fe event: status 1f, inversion off, m_tuning 3
      22:03:39.520 [e2-core] OURSTATE: ok
      22:03:39.520 [e2-core] [eDVBCAService] channel 0x1738900 running
      22:03:39.520 [e2-core] [eDVBLocalTimerHandler] channel 0x1738900 running
      22:03:39.521 [e2-core] no version filtering
      22:03:39.521 [e2-core] 0014: 70 00 00 00 00 00
      22:03:39.521 [e2-core] mask: fc 00 00 00 00 00
      22:03:39.521 [e2-core] mode: 00 00 00 00 00 00
      22:03:39.521 [e2-core] [eEPGCache] channel 0x1738900 running
      22:03:39.521 [e2-core] [eEPGCache] next update in 2 sec
      22:03:39.522 [e2-core] stop release channel timer
      22:03:39.522 [e2-core] no version filtering
      22:03:39.522 [e2-core] 0012: 4e 01 93 00 00 00
      22:03:39.522 [e2-core] mask: ff ff ff 00 00 00
      22:03:39.522 [e2-core] mode: 00 00 00 00 00 00
      22:03:39.523 [e2-core] ok ... now we start!!
      22:03:39.523 [e2-core] no version filtering
      22:03:39.523 [e2-core] 0000: 00 00 00 00 00 00
      22:03:39.523 [e2-core] mask: ff 00 00 00 00 00
      22:03:39.523 [e2-core] mode: 00 00 00 00 00 00
      22:03:39.560 [e2-core] + 1/1 TID 00
      22:03:39.560 [e2-core] done!
      22:03:39.561 [e2-core] PATready
      22:03:39.561 [e2-core] use pmtpid 0070 for service_id 0193
      22:03:39.561 [e2-core] no version filtering
      22:03:39.561 [e2-core] 0070: 02 01 93 00 00 00
      22:03:39.561 [e2-core] mask: ff ff ff 00 00 00
      22:03:39.561 [e2-core] mode: 00 00 00 00 00 00
      22:03:39.562 [e2-core] doing version filtering
      22:03:39.562 [e2-core] 0000: 00 00 00 11 00 00
      22:03:39.562 [e2-core] mask: ff 00 00 3f 00 00
      22:03:39.562 [e2-core] mode: 00 00 00 3e 00 00
      22:03:39.579 [e2-core] +- 1/2 TID 4e
      22:03:39.585 [e2-core] sdt update done!
      22:03:39.585 [e2-core] + 1/1 TID 02
      22:03:39.585 [e2-core] done!
      22:03:39.585 [e2-core] eventNewProgramInfo 0 0
      22:03:39.586 [e2-core] [eDVBServiceFCCPlay::updateFCCDecoder][1:0:16:193:E:85:C00000:0:0:0:]
      22:03:39.586 [e2-core] have 1 video stream(s) (10ff), and 2 audio stream(s) (1100, 1101), and the pcr pid is 10ff, and the text pid is ffffffff
      22:03:39.586 [e2-core] allocate demux
      22:03:39.586 [e2-core] [eFCCDecoder] alloc /dev/fcc3
      22:03:39.587 [e2-core] [eTSMPEGDecoder] FCC_START OK!
      22:03:39.588 [e2-core] [eDVBCAService] new service 1:0:16:193:E:85:C00000:0:0:0:
      22:03:39.589 [e2-core] [eDVBCAService] add demux 4 to slot 0 service 1:0:16:193:E:85:C00000:0:0:0:
      22:03:39.589 [e2-core] demux 4 mask 10 prevhash 00000000
      22:03:39.590 [e2-core] [eDVBCAService] send 56 bytes
      22:03:39.590 [e2-core] 9f 80 32 34 03 01 93 09 00 1f 01 81 08 00 c0 00 00 00 0e 00 85 82 02 10 04 84 02 00 70 09 04 09 c4 fb 2d 09 04 09 8c fa 2d 1b 10 ff 00 00 03 11 00 00 00 03 11 01 00 00
      22:03:39.590 [e2-core] doing version filtering
      22:03:39.590 [e2-core] 0070: 02 01 93 09 00 00
      22:03:39.590 [e2-core] mask: ff ff ff 3f 00 00
      22:03:39.590 [e2-core] mode: 00 00 00 3e 00 00
      22:03:39.690 [e2-core] [SEC] set dynamic current limiting
      22:03:39.715 [e2-core] sdt update done!
      22:03:39.769 [e2-core] +- 1/2 TID 4e
      22:03:39.910 [e2-core] [SEC] set dynamic current limiting
      22:03:39.970 [e2-core] [eDVBLocalTimerHandler] diff is -1
      22:03:39.970 [e2-core] [eDVBLocalTimerHandler] diff < 120 .. use Transponder Time
      22:03:40.079 [e2-core] [eDVBLocalTimerHandler] update RTC
      22:03:40.080 [e2-core] [eDVBLocalTimerHandler] time update to 22:03:38
      22:03:40.080 [e2-core] [eDVBLocalTimerHandler] m_time_difference is -1
      22:03:40.080 [e2-core] [eDVBLocalTimerHandler] set Linux Time
      22:03:38.082 [e2-core] [eDVBLocalTimerHandler] diff is 0
      22:03:38.082 [e2-core] [eDVBLocalTimerHandler] diff < 120 .. use Transponder Time
      22:03:38.082 [e2-core] [eDVBLocalTimerHandler] not changed
      22:03:38.082 [e2-core] [eDVBLocalTimerHandler] diff is 0
      22:03:38.082 [e2-core] [eDVBLocalTimerHandler] diff < 120 .. use Transponder Time
      22:03:38.082 [e2-core] [eDVBLocalTimerHandler] not changed
      22:03:38.083 [e2-core] [eDVBLocalTimerHandler] diff is 0
      22:03:38.083 [e2-core] [eDVBLocalTimerHandler] diff < 120 .. use Transponder Time
      22:03:38.083 [e2-core] [eDVBLocalTimerHandler] not changed
      22:03:38.083 [e2-core] [eDVBLocalTimerHandler] diff is 0
      22:03:38.083 [e2-core] [eDVBLocalTimerHandler] diff < 120 .. use Transponder Time
      22:03:38.083 [e2-core] [eDVBLocalTimerHandler] not changed
      22:03:38.084 [e2-core] DVB service failed to tune - error 3
      22:03:40.074 [e2-core] [eFCCServiceManager][1:0:19:10B:6:85:C00000:0:0:0:] set service to state failed.
      22:03:40.074 [e2-core] [eFCCServiceManager] stop FCC service sref : 1:0:19:10B:6:85:C00000:0:0:0:
      22:03:40.075 [e2-core] decoder state: stop, vpid=-1, apid=-1
      22:03:40.076 [e2-core] [eTSMPEGDecoder] FCC_STOP OK!
      22:03:40.076 [e2-core] [eFCCDecoder] close /dev/fcc1
      22:03:40.077 [e2-core] [eDVBCAService] remove channel 0x14e39c0
      22:03:40.079 [e2-core] [eDVBLocalTimerHandler] remove channel 0x14e39c0
      22:03:40.079 [e2-core] [eEPGCache] remove channel 0x14e39c0
      22:03:40.100 [e2-core] +- 1/2 TID 4e
      22:03:40.100 [e2-core] -+ 1/2 TID 4e
      22:03:40.299 [e2-core] ++ 2/2 TID 4e
      22:03:40.300 [e2-core] done!
      22:03:40.304 [e2-python] looking for Extended Data EventID: 18480
      22:03:40.305 [e2-python] Extended Data Event found
      22:03:40.305 [e2-python] But Extended Data is empty
      22:03:40.306 [e2-python] looking for Extended Data EventID: 18481
      22:03:40.307 [e2-python] Extended Data Event found
      22:03:40.307 [e2-python] But Extended Data is empty
      22:03:40.319 [e2-core] doing version filtering
      22:03:40.319 [e2-core] 0012: 4e 00 69 01 00 00
      22:03:40.319 [e2-core] mask: ff ff ff 3f 00 00
      22:03:40.319 [e2-core] mode: 00 00 00 3e 00 00
      22:03:40.439 [e2-core] DVB service failed to tune - error 3
      22:03:40.440 [e2-core] [eFCCServiceManager][1:0:19:115:D:85:C00000:0:0:0:] set service to state failed.
      22:03:40.440 [e2-core] [eFCCServiceManager] stop FCC service sref : 1:0:19:115:D:85:C00000:0:0:0:
      22:03:40.441 [e2-core] [eDVBCAService] remove channel 0x181e0e8
      22:03:40.441 [e2-core] [eDVBLocalTimerHandler] remove channel 0x181e0e8
      22:03:40.441 [e2-core] [eEPGCache] remove channel 0x181e0e8
      22:03:40.479 [e2-core] ++ 2/2 TID 4e
      22:03:40.480 [e2-core] done!
      22:03:40.480 [e2-core] doing version filtering
      22:03:40.480 [e2-core] 0012: 4e 00 15 11 00 00
      22:03:40.481 [e2-core] mask: ff ff ff 3f 00 00
      22:03:40.481 [e2-core] mode: 00 00 00 3e 00 00
      22:03:40.525 [e2-core] [eEPGCache] start caching events(1475352220)
      22:03:41.029 [e2-core] ++ 2/2 TID 4e
      22:03:41.029 [e2-core] done!
      22:03:41.030 [e2-core] doing version filtering
      22:03:41.030 [e2-core] 0012: 4e 01 93 0b 00 00
      22:03:41.030 [e2-core] mask: ff ff ff 3f 00 00
      22:03:41.030 [e2-core] mode: 00 00 00 3e 00 00
      22:03:41.151 [e2-core] [eEPGCache] start caching events(1475352221)
      22:03:41.229 [e2-core] VIDEO_GET_EVENT - ok
      22:03:41.249 [e2-core] VIDEO_GET_EVENT - ok
      22:03:41.250 [e2-python] [AutoFramerate] got framerate: 25000
      22:03:41.269 [e2-core] VIDEO_GET_EVENT - ok
      22:03:41.511 [e2-core] [eEPGCache] start caching events(1475352221)
      22:03:41.610 [e2-python] action -> GlobalActions volumeMute
      22:03:41.612 [e2-python] setValue 0
      22:03:42.900 [e2-python] action -> InfobarChannelSelection switchChannelUp
      22:03:43.099 [e2-core] close frontend 2
      22:03:43.460 [e2-core] close frontend 4
      22:03:44.260 [e2-python] action -> ChannelSelectBaseActions prevBouquet
      22:03:47.339 [e2-core] child has terminated
      22:03:47.340 [e2-core] pipes closed
      22:03:47.529 [e2-core] [eEPGCache] abort non avail schedule other reading
      22:03:47.531 [e2-core] [eEPGCache] abort non avail viasat reading
      22:03:47.531 [e2-core] [eEPGCache] abort non avail mhw reading
      22:03:47.548 [e2-core] [eEPGCache] nownext finished(1475352227)
      22:03:48.155 [e2-core] [eEPGCache] abort non avail schedule other reading
      22:03:48.167 [e2-core] [eEPGCache] abort non avail viasat reading
      22:03:48.229 [e2-core] child has terminated
      22:03:48.332 [e2-core] pipes closed
      22:03:48.334 [e2-core] [eEPGCache] abort non avail mhw reading
      22:03:48.337 [e2-core] [eEPGCache] nownext finished(1475352228)
      22:03:48.410 [e2-python] action -> OkCancelActions ok
      22:03:48.411 [e2-python] playing service..
      22:03:48.414 [e2-python] looking for Extended Data EventID: 18480
      22:03:48.415 [e2-python] Extended Data Event found
      22:03:48.415 [e2-python] But Extended Data is empty
      22:03:48.416 [e2-python] looking for Extended Data EventID: 18481
      22:03:48.416 [e2-python] Extended Data Event found
      22:03:48.416 [e2-python] But Extended Data is empty
      22:03:48.417 [e2-core] [eDVBServiceFCCPlay::changeFCCMode][1:0:19:69:C:85:C00000:0:0:0:] disable FCC decoding.
      22:03:48.417 [e2-core] [eDVBCIInterfaces] remove last pmt handler for service 1:0:19:69:C:85:C00000:0:0:0: send empty capmt
      22:03:48.420 [e2-core] (3) slot 0 usecount is now 0
      22:03:48.420 [e2-core] [eDVBServiceFCCPlay::FCCDecoderStop][1:0:19:69:C:85:C00000:0:0:0:]
      22:03:48.422 [e2-core] decoder state: play, vpid=-1, apid=-1
      22:03:48.422 [e2-core] DEMUX_STOP - pcr - ok
      22:03:48.427 [e2-core] AUDIO_STOP - ok
      22:03:48.428 [e2-core] DEMUX_STOP - audio - ok
      22:03:48.428 [e2-core] AUDIO_CONTINUE - ok
      22:03:48.428 [e2-core] DEMUX_STOP - ttx - ok
      22:03:48.428 [e2-core] [eTSMPEGDecoder] FCC_DECODER_STOP OK!
      22:03:48.429 [e2-core] [eFCCServiceManager] stop FCC service sref : 1:0:16:193:E:85:C00000:0:0:0:
      22:03:48.429 [e2-core] [eDVBCAService] free slot 0 demux 4 for service 1:0:16:193:E:85:C00000:0:0:0:
      22:03:48.429 [e2-core] [eDVBCAService] free service 1:0:16:193:E:85:C00000:0:0:0:
      22:03:48.431 [e2-core] [eFCCServiceManager] stop FCC service sref : 1:0:19:69:C:85:C00000:0:0:0:
      22:03:48.431 [e2-core] [eDVBCAService] free slot 0 demux 0 for service 1:0:19:69:C:85:C00000:0:0:0:
      22:03:48.432 [e2-core] [eDVBCAService] free service 1:0:19:69:C:85:C00000:0:0:0:
      22:03:48.432 [e2-core] [eFCCServiceManager] stop FCC service sref : 1:0:16:15:3:85:C00000:0:0:0:
      22:03:48.432 [e2-core] [eDVBCAService] free slot 0 demux 2 for service 1:0:16:15:3:85:C00000:0:0:0:
      22:03:48.433 [e2-core] [eDVBCAService] free service 1:0:16:15:3:85:C00000:0:0:0:
      22:03:48.435 [e2-core] decoder state: stop, vpid=-1, apid=-1
      22:03:48.436 [e2-core] [eTSMPEGDecoder] FCC_STOP OK!
      22:03:48.437 [e2-core] [eFCCDecoder] close /dev/fcc2
      22:03:48.437 [e2-core] [eDVBCAService] remove channel 0x1770580
      22:03:48.437 [e2-core] [eDVBLocalTimerHandler] remove channel 0x1770580
      22:03:48.437 [e2-core] [eEPGCache] remove channel 0x1770580
      22:03:48.439 [e2-core] [eEPGCache] abort caching events !!
      22:03:48.443 [e2-core] decoder state: play, vpid=-1, apid=-1
      22:03:48.444 [e2-core] [eTSMPEGDecoder] FCC_STOP OK!
      22:03:48.445 [e2-core] [eFCCDecoder] close /dev/fcc0
      22:03:48.445 [e2-core] [eDVBCAService] remove channel 0xb65ec8
      22:03:48.445 [e2-core] [eDVBLocalTimerHandler] remove channel 0xb65ec8
      22:03:48.445 [e2-core] [eEPGCache] remove channel 0xb65ec8
      22:03:48.446 [e2-core] [eEPGCache] abort caching events !!
      22:03:48.450 [e2-core] decoder state: stop, vpid=-1, apid=-1
      22:03:48.452 [e2-core] [eTSMPEGDecoder] FCC_STOP OK!
      22:03:48.452 [e2-core] [eFCCDecoder] close /dev/fcc3
      22:03:48.452 [e2-core] start release channel timer
      22:03:48.452 [e2-core] [eDVBCAService] remove channel 0x1738900
      22:03:48.453 [e2-core] [eDVBLocalTimerHandler] remove channel 0x1738900
      22:03:48.453 [e2-core] [eEPGCache] remove channel 0x1738900
      22:03:48.454 [e2-core] [eEPGCache] abort caching events !!
      22:03:48.458 [e2-core] allocate channel.. 0411:0001
      22:03:48.461 [e2-core] [eDVBCAService] new channel 0xb65ec8!
      22:03:48.461 [e2-core] (0)tune
      22:03:48.461 [e2-core] RotorCmd ffffffff, lastRotorCmd ffffffff
      22:03:48.461 [e2-core] prepare_sat System 1 Freq 11082250 Pol 0 SR 22000000 INV 2 FEC 3 orbpos 192 system 1 modulation 2 pilot 2, rolloff 2
      22:03:48.461 [e2-core] tuning to 1332 mhz
      22:03:48.461 [e2-core] OURSTATE: tuning
      22:03:48.462 [e2-core] allocate Channel: res 0
      22:03:48.462 [e2-core] allocate demux
      22:03:48.462 [e2-core] resolve: resolve ${sysconfdir}/scan_tp_valid_check.py
      22:03:48.462 [e2-core] resolve: -> /etc/scan_tp_valid_check.py
      22:03:48.462 [e2-core] [eDVBServiceFCCPlay::changeFCCMode][1:0:1:2EC3:411:1:C00000:0:0:0:] enable FCC decoding.
      22:03:48.462 [e2-core] '1:0:1:2EC3:411:1:C00000:0:0:0:' is in service list of slot 0... so use it
      22:03:48.462 [e2-core] (1)CISlot 0, usecount now 1
      22:03:48.472 [e2-python] looking for Extended Data EventID: 26496
      22:03:48.473 [e2-python] Extended Data Event found
      22:03:48.473 [e2-python] But Extended Data is empty
      22:03:48.475 [e2-python] looking for Extended Data EventID: 26498
      22:03:48.475 [e2-python] Extended Data Event found
      22:03:48.475 [e2-python] Event has Extended Data: {"title":"Das perfekte Dinner","subtitle":"","airtime":1475354100,"categoryName":"Reportage","genre":"Doku-Soap","year":"2006","isNew":"","country":"D","ageRating":"","season":"","episode":"","channelid":"215","isLastEpisode":"","highlightCategory":"","image":"http:\/\/images.tvmovie.de\/220x142\/North\/9a93c1b0-7ab6-11e6-b11c-95652bbb374f-1.jpg","imagebase":"","showviewNumber":"","conclusion":"","isDolbyDigital":"","movieStarValue":"","ratings":"","leadText":"","search":"","id":"94443149"}
      22:03:48.494 [e2-python] not pauseable.
      22:03:48.495 [e2-python] RemovePopup, id = ZapError
      22:03:48.499 [e2-core] [SEC] set static current limiting
      22:03:48.520 [e2-core] [SEC] invalidate current switch params
      22:03:48.521 [e2-core] set sequence pos 3
      22:03:48.521 [e2-core] [SEC] setTone 0
      22:03:48.521 [e2-core] [SEC] sleep 10ms
      22:03:48.539 [e2-core] [SEC] update current switch params
      22:03:48.540 [e2-core] [SEC] startTuneTimeout 5000
      22:03:48.540 [e2-core] [SEC] setFrontend 1
      22:03:48.540 [e2-core] setting frontend 0
      22:03:48.540 [e2-core] [SEC] sleep 500ms
      22:03:48.559 [e2-core] (0)fe event: status 0, inversion off, m_tuning 1
      22:03:48.599 [e2-core] (0)fe event: status 7, inversion off, m_tuning 2
      22:03:48.659 [e2-core] (0)fe event: status 1f, inversion off, m_tuning 3
      22:03:48.659 [e2-core] OURSTATE: ok
      22:03:48.659 [e2-core] [eDVBCAService] channel 0xb65ec8 running
      22:03:48.660 [e2-core] [eDVBLocalTimerHandler] channel 0xb65ec8 running
      22:03:48.660 [e2-core] no version filtering
      22:03:48.660 [e2-core] 0014: 70 00 00 00 00 00
      22:03:48.660 [e2-core] mask: fc 00 00 00 00 00
      22:03:48.660 [e2-core] mode: 00 00 00 00 00 00
      22:03:48.660 [e2-core] [eEPGCache] channel 0xb65ec8 running
      22:03:48.661 [e2-core] stop release channel timer
      22:03:48.661 [e2-core] [eEPGCache] next update in 2 sec
      22:03:48.661 [e2-core] no version filtering
      22:03:48.661 [e2-core] 0012: 4e 2e c3 00 00 00
      22:03:48.661 [e2-core] mask: ff ff ff 00 00 00
      22:03:48.661 [e2-core] mode: 00 00 00 00 00 00
      22:03:48.663 [e2-core] ok ... now we start!!
      22:03:48.664 [e2-core] no version filtering
      22:03:48.664 [e2-core] 0000: 00 00 00 00 00 00
      22:03:48.664 [e2-core] mask: ff 00 00 00 00 00
      22:03:48.664 [e2-core] mode: 00 00 00 00 00 00
      22:03:48.664 [e2-core] eventNewProgramInfo 0 0
      22:03:48.664 [e2-core] [eDVBServiceFCCPlay::updateFCCDecoder][1:0:1:2EC3:411:1:C00000:0:0:0:]
      22:03:48.664 [e2-core] have 1 video stream(s) (02bc), and 1 audio stream(s) (02c6), and the pcr pid is 02bc, and the text pid is ffffffff (Cached)
      22:03:48.664 [e2-core] allocate demux
      22:03:48.665 [e2-core] [eFCCDecoder] alloc /dev/fcc0
      22:03:48.665 [e2-core] [eTSMPEGDecoder] FCC_START OK!
      22:03:48.665 [e2-core] disable teletext subtitles
      22:03:48.673 [e2-core] PES filter: DMX_SET_PES_FILTER - Invalid argument
      22:03:48.694 [e2-core] [eTSMPEGDecoder] FCC_DECODER_START OK!
      22:03:48.695 [e2-core] decoder state: play, vpid=700, apid=710
      22:03:48.695 [e2-core] DMX_SET_PES_FILTER(0x2bc) - pcr - ok
      22:03:48.695 [e2-core] DEMUX_START - pcr - ok
      22:03:48.695 [e2-core] DMX_SET_PES_FILTER(0x2c6) - audio - ok
      22:03:48.695 [e2-core] DEMUX_START - audio - ok
      22:03:48.695 [e2-core] AUDIO_SET_BYPASS(1) - ok
      22:03:48.696 [e2-core] AUDIO_PAUSE - ok
      22:03:48.697 [e2-core] AUDIO_PLAY - ok
      22:03:48.697 [e2-core] Video Device: /dev/dvb/adapter0/video0
      22:03:48.697 [e2-core] demux device: /dev/dvb/adapter0/demux0
      22:03:48.697 [e2-core] VIDEO_SLOWMOTION(0) - ok
      22:03:48.697 [e2-core] VIDEO_FAST_FORWARD(0) - ok
      22:03:48.697 [e2-core] VIDEO_CONTINUE - ok
      22:03:48.697 [e2-core] AUDIO_CONTINUE - ok
      22:03:48.698 [e2-python] not pauseable.
      22:03:48.709 [e2-core] allocate channel.. 0004:0085
      22:03:48.709 [e2-core] available channel.. 0411:0001
      22:03:48.710 [e2-core] opening frontend 1
      22:03:48.714 [e2-core] [eDVBCAService] new channel 0x1770580!
      22:03:48.714 [e2-core] (1)tune
      22:03:48.714 [e2-core] RotorCmd ffffffff, lastRotorCmd ffffffff
      22:03:48.715 [e2-core] prepare_sat System 1 Freq 12031500 Pol 0 SR 27500000 INV 2 FEC 9 orbpos 192 system 1 modulation 1 pilot 2, rolloff 0
      22:03:48.715 [e2-core] tuning to 1431 mhz
      22:03:48.715 [e2-core] OURSTATE: tuning
      22:03:48.715 [e2-core] allocate Channel: res 0
      22:03:48.715 [e2-core] allocate demux
      22:03:48.715 [e2-core] resolve: resolve ${sysconfdir}/scan_tp_valid_check.py
      22:03:48.715 [e2-core] resolve: -> /etc/scan_tp_valid_check.py
      22:03:48.716 [e2-core] [SEC] set static current limiting
      22:03:48.716 [e2-core] [SEC] invalidate current switch params
      22:03:48.716 [e2-core] [SEC] setVoltage 2
      22:03:48.717 [e2-core] [SEC] sleep 10ms
      22:03:48.729 [e2-core] [SEC] setTone 1
      22:03:48.730 [e2-core] [SEC] sleep 10ms
      22:03:48.749 [e2-core] [SEC] update current switch params
      22:03:48.749 [e2-core] [SEC] startTuneTimeout 5000
      22:03:48.749 [e2-core] [SEC] setFrontend 1
      22:03:48.749 [e2-core] setting frontend 1
      22:03:48.750 [e2-core] [SEC] sleep 500ms
      22:03:48.769 [e2-core] (1)fe event: status 0, inversion off, m_tuning 1
      22:03:48.809 [e2-core] (1)fe event: status 7, inversion off, m_tuning 2
      22:03:48.829 [e2-core] +- 1/2 TID 4e
      22:03:48.920 [e2-core] (5)fe event: status 7, inversion off, m_tuning 0
      22:03:48.920 [e2-core] stateLostLock
      22:03:48.959 [e2-core] (1)fe event: status 1f, inversion off, m_tuning 3
      22:03:48.959 [e2-core] OURSTATE: ok
      22:03:48.959 [e2-core] [eDVBCAService] channel 0x1770580 running
      22:03:48.959 [e2-core] [eDVBLocalTimerHandler] channel 0x1770580 running
      22:03:48.960 [e2-core] no version filtering
      22:03:48.960 [e2-core] 0014: 70 00 00 00 00 00
      22:03:48.960 [e2-core] mask: fc 00 00 00 00 00
      22:03:48.960 [e2-core] mode: 00 00 00 00 00 00
      22:03:48.960 [e2-core] [eEPGCache] channel 0x1770580 running
      22:03:48.961 [e2-core] stop release channel timer
      22:03:48.961 [e2-core] no version filtering
      22:03:48.961 [e2-core] 0012: 4e 00 1d 00 00 00
      22:03:48.961 [e2-core] mask: ff ff ff 00 00 00
      22:03:48.961 [e2-core] mode: 00 00 00 00 00 00
      22:03:48.962 [e2-core] ok ... now we start!!
      22:03:48.962 [e2-core] no version filtering
      22:03:48.962 [e2-core] 0000: 00 00 00 00 00 00
      22:03:48.962 [e2-core] mask: ff 00 00 00 00 00
      22:03:48.962 [e2-core] mode: 00 00 00 00 00 00
      22:03:48.962 [e2-core] eventNewProgramInfo 0 0
      22:03:48.962 [e2-core] [eDVBServiceFCCPlay::updateFCCDecoder][1:0:16:1D:4:85:C00000:0:0:0:]
      22:03:48.962 [e2-core] have 1 video stream(s) (0eff), and 1 audio stream(s) (0f00), and the pcr pid is 0eff, and the text pid is 0020 (Cached)
      22:03:48.963 [e2-core] allocate demux
      22:03:48.963 [e2-core] [eFCCDecoder] alloc /dev/fcc1
      22:03:48.963 [e2-core] [eTSMPEGDecoder] FCC_START OK!
      22:03:48.964 [e2-core] [eEPGCache] next update in 2 sec
      22:03:48.965 [e2-core] allocate channel.. 000f:0085
      22:03:48.966 [e2-core] available channel.. 0411:0001
      22:03:48.966 [e2-core] available channel.. 0004:0085
      22:03:48.966 [e2-core] opening frontend 2
      22:03:48.969 [e2-core] [eDVBCAService] new channel 0x14e39c0!
      22:03:48.969 [e2-core] (2)tune
      22:03:48.969 [e2-core] RotorCmd ffffffff, lastRotorCmd ffffffff
      22:03:48.969 [e2-core] prepare_sat System 0 Freq 10920750 Pol 0 SR 22000000 INV 2 FEC 5 orbpos 192 system 0 modulation 1 pilot 2, rolloff 0
      22:03:48.969 [e2-core] tuning to 1170 mhz
      22:03:48.969 [e2-core] OURSTATE: tuning
      22:03:48.969 [e2-core] allocate Channel: res 0
      22:03:48.970 [e2-core] allocate demux
      22:03:48.970 [e2-core] resolve: resolve ${sysconfdir}/scan_tp_valid_check.py
      22:03:48.970 [e2-core] resolve: -> /etc/scan_tp_valid_check.py
      22:03:48.970 [e2-core] [SEC] set static current limiting
      22:03:48.971 [e2-core] [SEC] invalidate current switch params
      22:03:48.971 [e2-core] set sequence pos 3
      22:03:48.972 [e2-core] set sequence pos 3
      22:03:48.972 [e2-core] [SEC] update current switch params
      22:03:48.972 [e2-core] [SEC] startTuneTimeout 5000
      22:03:48.972 [e2-core] [SEC] setFrontend 1
      22:03:48.972 [e2-core] setting frontend 2
      22:03:48.972 [e2-core] [SEC] sleep 500ms
      22:03:48.989 [e2-core] (2)fe event: status 0, inversion off, m_tuning 1
      22:03:49.029 [e2-core] (2)fe event: status 7, inversion off, m_tuning 2
      22:03:49.049 [e2-core] + 1/1 TID 00
      22:03:49.049 [e2-core] done!
      22:03:49.050 [e2-core] PATready
      22:03:49.050 [e2-core] use pmtpid 006e for service_id 001d
      22:03:49.050 [e2-core] no version filtering
      22:03:49.050 [e2-core] 006e: 02 00 1d 00 00 00
      22:03:49.050 [e2-core] mask: ff ff ff 00 00 00
      22:03:49.050 [e2-core] mode: 00 00 00 00 00 00
      22:03:49.051 [e2-core] doing version filtering
      22:03:49.051 [e2-core] 0000: 00 00 00 2f 00 00
      22:03:49.051 [e2-core] mask: ff 00 00 3f 00 00
      22:03:49.051 [e2-core] mode: 00 00 00 3e 00 00
      22:03:49.053 [e2-core] [SEC] set dynamic current limiting
      22:03:49.069 [e2-core] + 1/1 TID 02
      22:03:49.070 [e2-core] done!
      22:03:49.070 [e2-core] eventNewProgramInfo 0 0
      22:03:49.070 [e2-core] [eDVBServiceFCCPlay::updateFCCDecoder][1:0:16:1D:4:85:C00000:0:0:0:]
      22:03:49.071 [e2-core] have 1 video stream(s) (0eff), and 2 audio stream(s) (0f00, 0f01), and the pcr pid is 0eff, and the text pid is 0020
      22:03:49.071 [e2-core] [eDVBCAService] new service 1:0:16:1D:4:85:C00000:0:0:0:
      22:03:49.071 [e2-core] [eDVBCAService] add demux 1 to slot 0 service 1:0:16:1D:4:85:C00000:0:0:0:
      22:03:49.071 [e2-core] demux 1 mask 02 prevhash 00000000
      22:03:49.072 [e2-core] [eDVBCAService] send 67 bytes
      22:03:49.072 [e2-core] 9f 80 32 3f 03 00 1d 05 00 25 01 81 08 00 c0 00 00 00 04 00 85 82 02 02 01 84 02 00 6e 09 04 09 c4 fb 4a 09 04 09 af ff 4a 09 04 09 8c fa 4a 06 00 20 00 00 1b 0e ff 00 00 03 0f 00 00 00 03 0f 01 00 00
      22:03:49.072 [e2-core] doing version filtering
      22:03:49.073 [e2-core] 006e: 02 00 1d 05 00 00
      22:03:49.073 [e2-core] mask: ff ff ff 3f 00 00
      22:03:49.073 [e2-core] mode: 00 00 00 3e 00 00
      22:03:49.089 [e2-core] + 1/1 TID 00
      22:03:49.089 [e2-core] done!
      22:03:49.090 [e2-core] PATready
      22:03:49.090 [e2-core] use pmtpid 0039 for service_id 2ec3
      22:03:49.090 [e2-core] no version filtering
      22:03:49.090 [e2-core] 0039: 02 2e c3 00 00 00
      22:03:49.091 [e2-core] mask: ff ff ff 00 00 00
      22:03:49.091 [e2-core] mode: 00 00 00 00 00 00
      22:03:49.091 [e2-core] doing version filtering
      22:03:49.091 [e2-core] 0000: 00 00 00 13 00 00
      22:03:49.091 [e2-core] mask: ff 00 00 3f 00 00
      22:03:49.091 [e2-core] mode: 00 00 00 3e 00 00
      22:03:49.093 [e2-core] (2)fe event: status 1f, inversion off, m_tuning 3
      22:03:49.094 [e2-core] OURSTATE: ok
      22:03:49.094 [e2-core] [eDVBCAService] channel 0x14e39c0 running
      22:03:49.094 [e2-core] [eDVBLocalTimerHandler] channel 0x14e39c0 running
      22:03:49.094 [e2-core] no version filtering
      22:03:49.094 [e2-core] 0014: 70 00 00 00 00 00
      22:03:49.094 [e2-core] mask: fc 00 00 00 00 00
      22:03:49.094 [e2-core] mode: 00 00 00 00 00 00
      22:03:49.094 [e2-core] [eEPGCache] channel 0x14e39c0 running
      22:03:49.095 [e2-core] [eEPGCache] next update in 2 sec
      22:03:49.095 [e2-core] stop release channel timer
      22:03:49.095 [e2-core] no version filtering
      22:03:49.095 [e2-core] 0012: 4e 00 26 00 00 00
      22:03:49.095 [e2-core] mask: ff ff ff 00 00 00
      22:03:49.095 [e2-core] mode: 00 00 00 00 00 00
      22:03:49.096 [e2-core] ok ... now we start!!
      22:03:49.096 [e2-core] no version filtering
      22:03:49.096 [e2-core] 0000: 00 00 00 00 00 00
      22:03:49.096 [e2-core] mask: ff 00 00 00 00 00
      22:03:49.096 [e2-core] mode: 00 00 00 00 00 00
      22:03:49.097 [e2-core] eventNewProgramInfo 0 0
      22:03:49.097 [e2-core] [eDVBServiceFCCPlay::updateFCCDecoder][1:0:16:26:F:85:C00000:0:0:0:]
      22:03:49.097 [e2-core] have 1 video stream(s) (03ff), and 1 audio stream(s) (0400), and the pcr pid is 03ff, and the text pid is ffffffff (Cached)
      22:03:49.097 [e2-core] allocate demux
      22:03:49.097 [e2-core] [eFCCDecoder] alloc /dev/fcc2
      22:03:49.098 [e2-core] [eTSMPEGDecoder] FCC_START OK!
      22:03:49.100 [e2-core] allocate channel.. 0003:0085
      22:03:49.100 [e2-core] available channel.. 0411:0001
      22:03:49.100 [e2-core] available channel.. 0004:0085
      22:03:49.101 [e2-core] available channel.. 000f:0085
      22:03:49.103 [e2-core] [eDVBCAService] new channel 0x14d97c8!
      22:03:49.103 [e2-core] (3)tune
      22:03:49.103 [e2-core] RotorCmd ffffffff, lastRotorCmd ffffffff
      22:03:49.104 [e2-core] prepare_sat System 1 Freq 11719500 Pol 0 SR 27500000 INV 2 FEC 9 orbpos 192 system 1 modulation 1 pilot 2, rolloff 0
      22:03:49.104 [e2-core] tuning to 1119 mhz
      22:03:49.104 [e2-core] OURSTATE: tuning
      22:03:49.104 [e2-core] allocate Channel: res 0
      22:03:49.104 [e2-core] allocate demux
      22:03:49.104 [e2-core] resolve: resolve ${sysconfdir}/scan_tp_valid_check.py
      22:03:49.104 [e2-core] resolve: -> /etc/scan_tp_valid_check.py
      22:03:49.105 [e2-core] [SEC] set static current limiting
      22:03:49.105 [e2-core] [SEC] invalidate current switch params
      22:03:49.106 [e2-core] set sequence pos 3
      22:03:49.106 [e2-core] set sequence pos 3
      22:03:49.106 [e2-core] [SEC] update current switch params
      22:03:49.106 [e2-core] [SEC] startTuneTimeout 5000
      22:03:49.106 [e2-core] [SEC] setFrontend 1
      22:03:49.106 [e2-core] setting frontend 3
      22:03:49.106 [e2-core] [SEC] sleep 500ms
      22:03:49.120 [e2-core] (3)fe event: status 0, inversion off, m_tuning 1
      22:03:49.159 [e2-core] + 1/1 TID 00
      22:03:49.159 [e2-core] done!
      22:03:49.160 [e2-core] PATready
      22:03:49.160 [e2-core] use pmtpid 0063 for service_id 0026
      22:03:49.160 [e2-core] no version filtering
      22:03:49.160 [e2-core] 0063: 02 00 26 00 00 00
      22:03:49.161 [e2-core] mask: ff ff ff 00 00 00
      22:03:49.161 [e2-core] mode: 00 00 00 00 00 00
      22:03:49.161 [e2-core] doing version filtering
      22:03:49.161 [e2-core] 0000: 00 00 00 3b 00 00
      22:03:49.161 [e2-core] mask: ff 00 00 3f 00 00
      22:03:49.161 [e2-core] mode: 00 00 00 3e 00 00
      22:03:49.163 [e2-core] (3)fe event: status 7, inversion off, m_tuning 2
      22:03:49.179 [e2-core] + 1/1 TID 02
      22:03:49.179 [e2-core] done!
      22:03:49.180 [e2-core] eventNewProgramInfo 0 0
      22:03:49.180 [e2-core] [eDVBServiceFCCPlay::updateFCCDecoder][1:0:16:26:F:85:C00000:0:0:0:]
      22:03:49.180 [e2-core] have 1 video stream(s) (03ff), and 1 audio stream(s) (0400), and the pcr pid is 03ff, and the text pid is ffffffff
      22:03:49.180 [e2-core] [eDVBCAService] new service 1:0:16:26:F:85:C00000:0:0:0:
      22:03:49.180 [e2-core] [eDVBCAService] add demux 2 to slot 0 service 1:0:16:26:F:85:C00000:0:0:0:
      22:03:49.181 [e2-core] demux 2 mask 04 prevhash 00000000
      22:03:49.181 [e2-core] [eDVBCAService] send 63 bytes
      22:03:49.181 [e2-core] 9f 80 32 3b 03 00 26 31 00 2b 01 81 08 00 c0 00 00 00 0f 00 85 82 02 04 02 84 02 00 63 09 04 18 37 ff d0 09 04 09 c4 fb 27 09 04 09 8c fa 27 09 04 18 67 ff e0 1b 03 ff 00 00 03 04 00 00 00
      22:03:49.181 [e2-core] doing version filtering
      22:03:49.181 [e2-core] 0063: 02 00 26 31 00 00
      22:03:49.181 [e2-core] mask: ff ff ff 3f 00 00
      22:03:49.181 [e2-core] mode: 00 00 00 3e 00 00
      22:03:49.260 [e2-core] [SEC] set dynamic current limiting
      22:03:49.319 [e2-core] (3)fe event: status 1f, inversion off, m_tuning 3
      22:03:49.320 [e2-core] OURSTATE: ok
      22:03:49.320 [e2-core] [eDVBCAService] channel 0x14d97c8 running
      22:03:49.320 [e2-core] [eDVBLocalTimerHandler] channel 0x14d97c8 running
      22:03:49.320 [e2-core] no version filtering
      22:03:49.320 [e2-core] 0014: 70 00 00 00 00 00
      22:03:49.320 [e2-core] mask: fc 00 00 00 00 00
      22:03:49.320 [e2-core] mode: 00 00 00 00 00 00
      22:03:49.321 [e2-core] [eEPGCache] channel 0x14d97c8 running
      22:03:49.321 [e2-core] stop release channel timer
      22:03:49.321 [e2-core] [eEPGCache] next update in 2 sec
      22:03:49.321 [e2-core] no version filtering
      22:03:49.321 [e2-core] 0012: 4e 00 1c 00 00 00
      22:03:49.321 [e2-core] mask: ff ff ff 00 00 00
      22:03:49.321 [e2-core] mode: 00 00 00 00 00 00
      22:03:49.322 [e2-core] ok ... now we start!!
      22:03:49.322 [e2-core] no version filtering
      22:03:49.322 [e2-core] 0000: 00 00 00 00 00 00
      22:03:49.322 [e2-core] mask: ff 00 00 00 00 00
      22:03:49.322 [e2-core] mode: 00 00 00 00 00 00
      22:03:49.325 [e2-core] allocate channel.. 0002:0085
      22:03:49.325 [e2-core] available channel.. 0411:0001
      22:03:49.325 [e2-core] available channel.. 0004:0085
      22:03:49.325 [e2-core] available channel.. 000f:0085
      22:03:49.326 [e2-core] available channel.. 0003:0085
      22:03:49.326 [e2-core] opening frontend 4
      22:03:49.328 [e2-core] [eDVBCAService] new channel 0xb63a90!
      22:03:49.328 [e2-core] (4)tune
      22:03:49.329 [e2-core] RotorCmd ffffffff, lastRotorCmd ffffffff
      22:03:49.329 [e2-core] prepare_sat System 1 Freq 11758500 Pol 0 SR 27500000 INV 2 FEC 9 orbpos 192 system 1 modulation 1 pilot 2, rolloff 0
      22:03:49.329 [e2-core] tuning to 1158 mhz
      22:03:49.329 [e2-core] OURSTATE: tuning
      22:03:49.329 [e2-core] allocate Channel: res 0
      22:03:49.329 [e2-core] allocate demux
      22:03:49.329 [e2-core] resolve: resolve ${sysconfdir}/scan_tp_valid_check.py
      22:03:49.329 [e2-core] resolve: -> /etc/scan_tp_valid_check.py
      22:03:49.330 [e2-core] [SEC] set static current limiting
      22:03:49.331 [e2-core] [SEC] invalidate current switch params
      22:03:49.331 [e2-core] set sequence pos 3
      22:03:49.331 [e2-core] set sequence pos 3
      22:03:49.331 [e2-core] [SEC] update current switch params
      22:03:49.331 [e2-core] [SEC] startTuneTimeout 5000
      22:03:49.332 [e2-core] [SEC] setFrontend 1
      22:03:49.332 [e2-core] setting frontend 4
      22:03:49.332 [e2-core] [SEC] sleep 500ms
      22:03:49.349 [e2-core] [eDVBLocalTimerHandler] diff is -2
      22:03:49.349 [e2-core] [eDVBLocalTimerHandler] diff < 120 .. use Transponder Time
      22:03:49.459 [e2-core] [eDVBLocalTimerHandler] update RTC
      22:03:49.459 [e2-core] [eDVBLocalTimerHandler] time update to 22:03:47
      22:03:49.459 [e2-core] [eDVBLocalTimerHandler] m_time_difference is -2
      22:03:49.460 [e2-core] [eDVBLocalTimerHandler] set Linux Time
      22:03:47.460 [e2-core] [eDVBLocalTimerHandler] diff is 0
      22:03:47.460 [e2-core] [eDVBLocalTimerHandler] diff < 120 .. use Transponder Time
      22:03:47.460 [e2-core] [eDVBLocalTimerHandler] not changed
      22:03:47.461 [e2-core] [eDVBLocalTimerHandler] diff is 0
      22:03:47.461 [e2-core] [eDVBLocalTimerHandler] diff < 120 .. use Transponder Time
      22:03:47.461 [e2-core] [eDVBLocalTimerHandler] not changed
      22:03:47.461 [e2-core] (4)fe event: status 0, inversion off, m_tuning 1
      22:03:47.461 [e2-core] (4)fe event: status 7, inversion off, m_tuning 2
      22:03:49.469 [e2-core] ++ 2/2 TID 4e
      22:03:49.470 [e2-core] done!
      22:03:49.473 [e2-python] looking for Extended Data EventID: 26496
      22:03:49.474 [e2-python] Extended Data Event found
      22:03:49.474 [e2-python] But Extended Data is empty
      22:03:49.475 [e2-python] looking for Extended Data EventID: 26498
      22:03:49.476 [e2-python] Extended Data Event found
      22:03:49.476 [e2-python] Event has Extended Data: {"title":"Das perfekte Dinner","subtitle":"","airtime":1475354100,"categoryName":"Reportage","genre":"Doku-Soap","year":"2006","isNew":"","country":"D","ageRating":"","season":"","episode":"","channelid":"215","isLastEpisode":"","highlightCategory":"","image":"http:\/\/images.tvmovie.de\/220x142\/North\/9a93c1b0-7ab6-11e6-b11c-95652bbb374f-1.jpg","imagebase":"","showviewNumber":"","conclusion":"","isDolbyDigital":"","movieStarValue":"","ratings":"","leadText":"","search":"","id":"94443149"}
      22:03:49.489 [e2-core] doing version filtering
      22:03:49.489 [e2-core] 0012: 4e 2e c3 1d 00 00
      22:03:49.489 [e2-core] mask: ff ff ff 3f 00 00
      22:03:49.489 [e2-core] mode: 00 00 00 3e 00 00
      22:03:49.490 [e2-core] + 1/1 TID 02
      22:03:49.490 [e2-core] done!
      22:03:49.491 [e2-core] eventNewProgramInfo 0 0
      22:03:49.491 [e2-core] [eDVBServiceFCCPlay::updateFCCDecoder][1:0:1:2EC3:411:1:C00000:0:0:0:]
      22:03:49.491 [e2-core] have 1 video stream(s) (02bc), and 2 audio stream(s) (02c6, 02c7), and the pcr pid is 02bc, and the text pid is ffffffff
      22:03:49.491 [e2-core] disable teletext subtitles
      22:03:49.499 [e2-core] PES filter: DMX_SET_PES_FILTER - Invalid argument
      22:03:49.499 [e2-core] decoder state: play, vpid=700, apid=710
      22:03:49.499 [e2-core] VIDEO_SLOWMOTION(0) - ok
      22:03:49.499 [e2-core] VIDEO_FAST_FORWARD(0) - ok
      22:03:49.500 [e2-core] VIDEO_CONTINUE - ok
      22:03:49.500 [e2-core] AUDIO_CONTINUE - ok
      22:03:49.508 [e2-core] [eDVBCAService] new service 1:0:1:2EC3:411:1:C00000:0:0:0:
      22:03:49.508 [e2-core] [eDVBCAService] add demux 0 to slot 0 service 1:0:1:2EC3:411:1:C00000:0:0:0:
      22:03:49.508 [e2-core] '1:0:1:2EC3:411:1:C00000:0:0:0:' is in service list of slot 0... so use it
      22:03:49.509 [e2-core] demux 0 mask 01 prevhash 00000000
      22:03:49.509 [e2-core] [eDVBCAService] send 56 bytes
      22:03:49.509 [e2-core] 9f 80 32 34 03 2e c3 09 00 1f 01 81 08 00 c0 00 00 04 11 00 01 82 02 01 00 84 02 00 39 09 04 09 c4 e2 e8 09 04 09 8c e2 e9 1b 02 bc 00 00 03 02 c6 00 00 03 02 c7 00 00
      22:03:49.509 [e2-core] doing version filtering
      22:03:49.510 [e2-core] 0039: 02 2e c3 09 00 00
      22:03:49.510 [e2-core] mask: ff ff ff 3f 00 00
      22:03:49.510 [e2-core] mode: 00 00 00 3e 00 00
      22:03:49.515 [e2-core] + 1/1 TID 00
      22:03:49.515 [e2-core] done!
      22:03:49.515 [e2-core] PATready
      22:03:49.516 [e2-core] use pmtpid 0064 for service_id 001c
      22:03:49.516 [e2-core] no version filtering
      22:03:49.516 [e2-core] 0064: 02 00 1c 00 00 00
      22:03:49.516 [e2-core] mask: ff ff ff 00 00 00
      22:03:49.516 [e2-core] mode: 00 00 00 00 00 00
      22:03:49.516 [e2-core] doing version filtering
      22:03:49.516 [e2-core] 0000: 00 00 00 33 00 00
      22:03:49.516 [e2-core] mask: ff 00 00 3f 00 00
      22:03:49.516 [e2-core] mode: 00 00 00 3e 00 00
      22:03:49.518 [e2-core] [SEC] set dynamic current limiting
      22:03:49.557 [e2-core] (4)fe event: status 1f, inversion off, m_tuning 3
      22:03:49.557 [e2-core] OURSTATE: ok
      22:03:49.557 [e2-core] [eDVBCAService] channel 0xb63a90 running
      22:03:49.557 [e2-core] [eDVBLocalTimerHandler] channel 0xb63a90 running
      22:03:49.558 [e2-core] no version filtering
      22:03:49.558 [e2-core] 0014: 70 00 00 00 00 00
      22:03:49.558 [e2-core] mask: fc 00 00 00 00 00
      22:03:49.558 [e2-core] mode: 00 00 00 00 00 00
      22:03:49.558 [e2-core] [eEPGCache] channel 0xb63a90 running
      22:03:49.559 [e2-core] [eEPGCache] next update in 2 sec
      22:03:49.559 [e2-core] stop release channel timer
      22:03:49.559 [e2-core] no version filtering
      22:03:49.559 [e2-core] 0012: 4e 02 06 00 00 00
      22:03:49.560 [e2-core] mask: ff ff ff 00 00 00
      22:03:49.560 [e2-core] mode: 00 00 00 00 00 00
      22:03:49.560 [e2-core] ok ... now we start!!
      22:03:49.560 [e2-core] no version filtering
      22:03:49.560 [e2-core] 0000: 00 00 00 00 00 00
      22:03:49.561 [e2-core] mask: ff 00 00 00 00 00
      22:03:49.561 [e2-core] mode: 00 00 00 00 00 00
      22:03:49.579 [e2-core] + 1/1 TID 02
      22:03:49.580 [e2-core] done!
      22:03:49.580 [e2-core] eventNewProgramInfo 0 0
      22:03:49.580 [e2-core] [eDVBServiceFCCPlay::updateFCCDecoder][1:0:16:1C:3:85:C00000:0:0:0:]
      22:03:49.580 [e2-core] have 1 video stream(s) (04ff), and 2 audio stream(s) (0500, 0501), and the pcr pid is 04ff, and the text pid is 0020
      22:03:49.580 [e2-core] allocate demux
      22:03:49.581 [e2-core] [eFCCDecoder] alloc /dev/fcc3
      22:03:49.581 [e2-core] [eTSMPEGDecoder] FCC_START OK!
      22:03:49.582 [e2-core] [eDVBCAService] new service 1:0:16:1C:3:85:C00000:0:0:0:
      22:03:49.582 [e2-core] [eDVBCAService] add demux 3 to slot 0 service 1:0:16:1C:3:85:C00000:0:0:0:
      22:03:49.583 [e2-core] demux 3 mask 08 prevhash 00000000
      22:03:49.583 [e2-core] [eDVBCAService] send 72 bytes
      22:03:49.584 [e2-core] 9f 80 32 44 03 00 1c 07 00 25 01 81 08 00 c0 00 00 00 03 00 85 82 02 08 03 84 02 00 64 09 04 09 c4 fb 6e 09 04 09 8c fa 6e 09 04 09 af ff 6e 06 00 20 00 00 1b 04 ff 00 00 03 05 00 00 00 03 05 01 00 00 0b 09 8d 00 00
      22:03:49.584 [e2-core] doing version filtering
      22:03:49.584 [e2-core] 0064: 02 00 1c 07 00 00
      22:03:49.584 [e2-core] mask: ff ff ff 3f 00 00
      22:03:49.584 [e2-core] mode: 00 00 00 3e 00 00
      22:03:49.601 [e2-core] [SEC] set dynamic current limiting
      22:03:49.679 [e2-core] + 1/1 TID 00
      22:03:49.679 [e2-core] done!
      22:03:49.680 [e2-core] PATready
      22:03:49.680 [e2-core] use pmtpid 006b for service_id 0206
      22:03:49.680 [e2-core] no version filtering
      22:03:49.680 [e2-core] 006b: 02 02 06 00 00 00
      22:03:49.681 [e2-core] mask: ff ff ff 00 00 00
      22:03:49.681 [e2-core] mode: 00 00 00 00 00 00
      22:03:49.681 [e2-core] doing version filtering
      22:03:49.681 [e2-core] 0000: 00 00 00 01 00 00
      22:03:49.681 [e2-core] mask: ff 00 00 3f 00 00
      22:03:49.681 [e2-core] mode: 00 00 00 3e 00 00
      22:03:49.740 [e2-core] + 1/1 TID 02
      22:03:49.741 [e2-core] done!
      22:03:49.741 [e2-core] eventNewProgramInfo 0 0
      22:03:49.741 [e2-core] [eDVBServiceFCCPlay::updateFCCDecoder][1:0:16:206:2:85:C00000:0:0:0:]
      22:03:49.741 [e2-core] have 1 video stream(s) (0bff), and 1 audio stream(s) (0c00), and the pcr pid is 0bff, and the text pid is 0020
      22:03:49.742 [e2-core] allocate demux
      22:03:49.742 [e2-core] [eFCCDecoder] alloc /dev/fcc4
      22:03:49.742 [e2-core] [eTSMPEGDecoder] FCC_START OK!
      22:03:49.743 [e2-core] [eDVBCAService] new service 1:0:16:206:2:85:C00000:0:0:0:
      22:03:49.743 [e2-core] [eDVBCAService] add demux 4 to slot 0 service 1:0:16:206:2:85:C00000:0:0:0:
      22:03:49.743 [e2-core] demux 4 mask 10 prevhash 00000000
      22:03:49.744 [e2-core] [eDVBCAService] send 62 bytes
      22:03:49.744 [e2-core] 9f 80 32 3a 03 02 06 03 00 25 01 81 08 00 c0 00 00 00 02 00 85 82 02 10 04 84 02 00 6b 09 04 09 c4 fb 62 09 04 09 8c fa 62 09 04 09 af ff 62 06 00 20 00 00 1b 0b ff 00 00 03 0c 00 00 00
      22:03:49.744 [e2-core] doing version filtering
      22:03:49.744 [e2-core] 006b: 02 02 06 03 00 00
      22:03:49.744 [e2-core] mask: ff ff ff 3f 00 00
      22:03:49.745 [e2-core] mode: 00 00 00 3e 00 00
      22:03:49.819 [e2-core] +- 1/2 TID 4e
      22:03:49.840 [e2-core] [SEC] set dynamic current limiting
      22:03:49.880 [e2-core] -+ 1/2 TID 4e
      22:03:49.944 [e2-core] +- 1/2 TID 4e
      22:03:50.142 [e2-core] -+ 1/2 TID 4e
      22:03:50.184 [e2-core] sdt update done!
      22:03:50.224 [e2-core] sdt update done!
      22:03:50.289 [e2-core] sdt update done!
      22:03:50.395 [e2-core] sdt update done!
      22:03:50.655 [e2-core] [eEPGCache] start caching events(1475352230)
      22:03:50.789 [e2-core] ++ 2/2 TID 4e
      22:03:50.789 [e2-core] done!
      22:03:50.790 [e2-core] doing version filtering
      22:03:50.791 [e2-core] 0012: 4e 00 26 27 00 00
      22:03:50.791 [e2-core] mask: ff ff ff 3f 00 00
      22:03:50.791 [e2-core] mode: 00 00 00 3e 00 00
      22:03:50.792 [e2-core] ++ 2/2 TID 4e
      22:03:50.792 [e2-core] done!
      22:03:50.792 [e2-core] doing version filtering
      22:03:50.792 [e2-core] 0012: 4e 02 06 05 00 00
      22:03:50.793 [e2-core] mask: ff ff ff 3f 00 00
      22:03:50.793 [e2-core] mode: 00 00 00 3e 00 00
      22:03:50.810 [e2-core] ++ 2/2 TID 4e
      22:03:50.810 [e2-core] done!
      22:03:50.810 [e2-core] doing version filtering
      22:03:50.811 [e2-core] 0012: 4e 00 1d 1f 00 00
      22:03:50.811 [e2-core] mask: ff ff ff 3f 00 00
      22:03:50.811 [e2-core] mode: 00 00 00 3e 00 00
      22:03:50.954 [e2-core] [eEPGCache] start caching events(1475352230)
      22:03:51.009 [e2-core] ++ 2/2 TID 4e
      22:03:51.009 [e2-core] done!
      22:03:51.010 [e2-core] doing version filtering
      22:03:51.010 [e2-core] 0012: 4e 00 1c 3f 00 00
      22:03:51.010 [e2-core] mask: ff ff ff 3f 00 00
      22:03:51.011 [e2-core] mode: 00 00 00 3e 00 00
      22:03:51.085 [e2-core] [eEPGCache] start caching events(1475352231)
      22:03:51.294 [e2-core] VIDEO_GET_EVENT - ok
      22:03:51.311 [e2-core] [eEPGCache] start caching events(1475352231)
      22:03:51.459 [e2-core] close frontend 5
      22:03:51.559 [e2-core] [eEPGCache] start caching events(1475352231)
      22:03:51.565 [e2-core] sdt update done!
      22:03:52.330 [e2-python] playing service..
      22:03:52.334 [e2-python] looking for Extended Data EventID: 26496
      22:03:52.339 [e2-python] Extended Data Event found
      22:03:52.339 [e2-python] But Extended Data is empty
      22:03:52.340 [e2-python] looking for Extended Data EventID: 26498
      22:03:52.340 [e2-python] Extended Data Event found
      22:03:52.340 [e2-python] Event has Extended Data: {"title":"Das perfekte Dinner","subtitle":"","airtime":1475354100,"categoryName":"Reportage","genre":"Doku-Soap","year":"2006","isNew":"","country":"D","ageRating":"","season":"","episode":"","channelid":"215","isLastEpisode":"","highlightCategory":"","image":"http:\/\/images.tvmovie.de\/220x142\/North\/9a93c1b0-7ab6-11e6-b11c-95652bbb374f-1.jpg","imagebase":"","showviewNumber":"","conclusion":"","isDolbyDigital":"","movieStarValue":"","ratings":"","leadText":"","search":"","id":"94443149"}
      22:03:52.341 [e2-core] [eDVBServiceFCCPlay::changeFCCMode][1:0:1:2EC3:411:1:C00000:0:0:0:] disable FCC decoding.
      22:03:52.342 [e2-core] [eDVBCIInterfaces] remove last pmt handler for service 1:0:1:2EC3:411:1:C00000:0:0:0: send empty capmt
      22:03:52.343 [e2-core] (3) slot 0 usecount is now 0
      22:03:52.343 [e2-core] [eDVBServiceFCCPlay::FCCDecoderStop][1:0:1:2EC3:411:1:C00000:0:0:0:]
      22:03:52.345 [e2-core] decoder state: play, vpid=-1, apid=-1
      22:03:52.345 [e2-core] DEMUX_STOP - pcr - ok
      22:03:52.349 [e2-core] AUDIO_STOP - ok
      22:03:52.349 [e2-core] DEMUX_STOP - audio - ok
      22:03:52.349 [e2-core] AUDIO_CONTINUE - ok
      22:03:52.350 [e2-core] [eTSMPEGDecoder] FCC_DECODER_STOP OK!
      22:03:52.350 [e2-core] [eFCCServiceManager] stop FCC service sref : 1:0:16:1D:4:85:C00000:0:0:0:
      22:03:52.350 [e2-core] [eDVBCAService] free slot 0 demux 1 for service 1:0:16:1D:4:85:C00000:0:0:0:
      22:03:52.350 [e2-core] [eDVBCAService] free service 1:0:16:1D:4:85:C00000:0:0:0:
      22:03:52.354 [e2-core] [eFCCServiceManager] stop FCC service sref : 1:0:16:26:F:85:C00000:0:0:0:
      22:03:52.355 [e2-core] [eDVBCAService] free slot 0 demux 2 for service 1:0:16:26:F:85:C00000:0:0:0:
      22:03:52.355 [e2-core] [eDVBCAService] free service 1:0:16:26:F:85:C00000:0:0:0:
      22:03:52.356 [e2-core] [eFCCServiceManager] stop FCC service sref : 1:0:16:206:2:85:C00000:0:0:0:
      22:03:52.357 [e2-core] [eDVBCAService] free slot 0 demux 4 for service 1:0:16:206:2:85:C00000:0:0:0:
      22:03:52.357 [e2-core] [eDVBCAService] free service 1:0:16:206:2:85:C00000:0:0:0:
      22:03:52.415 [e2-core] [eFCCServiceManager] stop FCC service sref : 1:0:16:1C:3:85:C00000:0:0:0:
      22:03:52.416 [e2-core] [eDVBCAService] free slot 0 demux 3 for service 1:0:16:1C:3:85:C00000:0:0:0:
      22:03:52.416 [e2-core] [eDVBCAService] free service 1:0:16:1C:3:85:C00000:0:0:0:
      22:03:52.417 [e2-core] [eFCCServiceManager] stop FCC service sref : 1:0:1:2EC3:411:1:C00000:0:0:0:
      22:03:52.417 [e2-core] [eDVBCAService] free slot 0 demux 0 for service 1:0:1:2EC3:411:1:C00000:0:0:0:
      22:03:52.418 [e2-core] [eDVBCAService] free service 1:0:1:2EC3:411:1:C00000:0:0:0:
      22:03:52.423 [e2-core] decoder state: play, vpid=-1, apid=-1
      22:03:52.424 [e2-core] [eTSMPEGDecoder] FCC_STOP OK!
      22:03:52.424 [e2-core] [eFCCDecoder] close /dev/fcc0
      22:03:52.424 [e2-core] [eDVBCAService] remove channel 0xb65ec8
      22:03:52.425 [e2-core] [eDVBLocalTimerHandler] remove channel 0xb65ec8
      22:03:52.425 [e2-core] [eEPGCache] remove channel 0xb65ec8
      22:03:52.426 [e2-core] [eEPGCache] abort caching events !!
      22:03:52.433 [e2-core] decoder state: stop, vpid=-1, apid=-1
      22:03:52.434 [e2-core] [eTSMPEGDecoder] FCC_STOP OK!
      22:03:52.435 [e2-core] [eFCCDecoder] close /dev/fcc3
      22:03:52.435 [e2-core] [eDVBCAService] remove channel 0x14d97c8
      22:03:52.435 [e2-core] [eDVBLocalTimerHandler] remove channel 0x14d97c8
      22:03:52.435 [e2-core] [eEPGCache] remove channel 0x14d97c8
      22:03:52.438 [e2-core] [eEPGCache] abort caching events !!
      22:03:52.445 [e2-core] decoder state: stop, vpid=-1, apid=-1
      22:03:52.446 [e2-core] [eTSMPEGDecoder] FCC_STOP OK!
      22:03:52.446 [e2-core] [eFCCDecoder] close /dev/fcc4
      22:03:52.446 [e2-core] start release channel timer
      22:03:52.450 [e2-core] decoder state: stop, vpid=-1, apid=-1
      22:03:52.451 [e2-core] [eTSMPEGDecoder] FCC_STOP OK!
      22:03:52.452 [e2-core] [eFCCDecoder] close /dev/fcc2
      22:03:52.452 [e2-core] [eDVBCAService] remove channel 0x14e39c0
      22:03:52.452 [e2-core] [eDVBLocalTimerHandler] remove channel 0x14e39c0
      22:03:52.452 [e2-core] [eEPGCache] remove channel 0x14e39c0
      22:03:52.454 [e2-core] [eEPGCache] abort caching events !!
      22:03:52.460 [e2-core] decoder state: stop, vpid=-1, apid=-1
      22:03:52.461 [e2-core] [eTSMPEGDecoder] FCC_STOP OK!
      22:03:52.462 [e2-core] [eFCCDecoder] close /dev/fcc1
      22:03:52.462 [e2-core] [eDVBCAService] remove channel 0x1770580
      22:03:52.462 [e2-core] [eDVBLocalTimerHandler] remove channel 0x1770580
      22:03:52.462 [e2-core] [eEPGCache] remove channel 0x1770580
      22:03:52.463 [e2-core] [eEPGCache] abort caching events !!
      22:03:52.468 [e2-core] [eDVBCAService] remove channel 0xb63a90
      22:03:52.469 [e2-core] [eDVBLocalTimerHandler] remove channel 0xb63a90
      22:03:52.469 [e2-core] [eEPGCache] remove channel 0xb63a90
      22:03:52.470 [e2-core] [eEPGCache] abort caching events !!
      22:03:52.475 [e2-core] allocate channel.. 000c:0085
      22:03:52.477 [e2-core] [eDVBCAService] new channel 0xb65ec8!
      22:03:52.477 [e2-core] (0)tune
      22:03:52.477 [e2-core] RotorCmd ffffffff, lastRotorCmd ffffffff
      22:03:52.477 [e2-core] prepare_sat System 1 Freq 12304500 Pol 0 SR 27500000 INV 2 FEC 9 orbpos 192 system 1 modulation 1 pilot 2, rolloff 0
      22:03:52.477 [e2-core] tuning to 1704 mhz
      22:03:52.477 [e2-core] OURSTATE: tuning
      22:03:52.478 [e2-core] allocate Channel: res 0
      22:03:52.478 [e2-core] allocate demux
      22:03:52.478 [e2-core] resolve: resolve ${sysconfdir}/scan_tp_valid_check.py
      22:03:52.478 [e2-core] resolve: -> /etc/scan_tp_valid_check.py
      22:03:52.478 [e2-core] [eDVBServiceFCCPlay::changeFCCMode][1:0:19:69:C:85:C00000:0:0:0:] enable FCC decoding.
      22:03:52.478 [e2-core] 'SKY/00c00000' is in provider list of slot 0... so use it
      22:03:52.478 [e2-core] (1)CISlot 0, usecount now 1
      22:03:52.492 [e2-python] looking for Extended Data EventID: 18480
      22:03:52.492 [e2-python] Extended Data Event found
      22:03:52.493 [e2-python] But Extended Data is empty
      22:03:52.494 [e2-python] looking for Extended Data EventID: 18481
      22:03:52.494 [e2-python] Extended Data Event found
      22:03:52.495 [e2-python] But Extended Data is empty
      22:03:52.505 [e2-python] not pauseable.
      22:03:52.506 [e2-python] RemovePopup, id = ZapError
      22:03:52.508 [e2-core] [SEC] set static current limiting
      22:03:52.535 [e2-core] [SEC] invalidate current switch params
      22:03:52.535 [e2-core] set sequence pos 3
      22:03:52.535 [e2-core] [SEC] setTone 1
      22:03:52.536 [e2-core] [SEC] sleep 10ms
      22:03:52.549 [e2-core] [SEC] update current switch params
      22:03:52.549 [e2-core] [SEC] startTuneTimeout 5000
      22:03:52.549 [e2-core] [SEC] setFrontend 1
      22:03:52.549 [e2-core] setting frontend 0
      22:03:52.549 [e2-core] [SEC] sleep 500ms
      22:03:52.569 [e2-core] (0)fe event: status 0, inversion off, m_tuning 1
      22:03:52.569 [e2-core] (2)fe event: status 7, inversion off, m_tuning 3
      22:03:52.609 [e2-core] (0)fe event: status 7, inversion off, m_tuning 2
      22:03:52.769 [e2-core] (0)fe event: status 1f, inversion off, m_tuning 3
      22:03:52.769 [e2-core] OURSTATE: ok
      22:03:52.769 [e2-core] [eDVBCAService] channel 0xb65ec8 running
      22:03:52.769 [e2-core] [eDVBLocalTimerHandler] channel 0xb65ec8 running
      22:03:52.770 [e2-core] no version filtering
      22:03:52.770 [e2-core] 0014: 70 00 00 00 00 00
      22:03:52.770 [e2-core] mask: fc 00 00 00 00 00
      22:03:52.770 [e2-core] mode: 00 00 00 00 00 00
      22:03:52.770 [e2-core] [eEPGCache] channel 0xb65ec8 running
      22:03:52.771 [e2-core] [eEPGCache] next update in 2 sec
      22:03:52.771 [e2-core] stop release channel timer
      22:03:52.771 [e2-core] no version filtering
      22:03:52.771 [e2-core] 0012: 4e 00 69 00 00 00
      22:03:52.772 [e2-core] mask: ff ff ff 00 00 00
      22:03:52.772 [e2-core] mode: 00 00 00 00 00 00
      22:03:52.774 [e2-core] ok ... now we start!!
      22:03:52.774 [e2-core] no version filtering
      22:03:52.774 [e2-core] 0000: 00 00 00 00 00 00
      22:03:52.774 [e2-core] mask: ff 00 00 00 00 00
      22:03:52.774 [e2-core] mode: 00 00 00 00 00 00
      22:03:52.775 [e2-core] eventNewProgramInfo 0 0
      22:03:52.775 [e2-core] [eDVBServiceFCCPlay::updateFCCDecoder][1:0:19:69:C:85:C00000:0:0:0:]
      22:03:52.775 [e2-core] have 1 video stream(s) (00ff), and 1 audio stream(s) (0102), and the pcr pid is 00ff, and the text pid is 0021 (Cached)
      22:03:52.775 [e2-core] allocate demux
      22:03:52.775 [e2-core] [eFCCDecoder] alloc /dev/fcc0
      22:03:52.776 [e2-core] [eTSMPEGDecoder] FCC_START OK!
      22:03:52.776 [e2-core] disable teletext subtitles
      22:03:52.794 [e2-core] [eTSMPEGDecoder] FCC_DECODER_START OK!
      22:03:52.794 [e2-core] decoder state: play, vpid=255, apid=258
      22:03:52.795 [e2-core] DMX_SET_PES_FILTER(0xff) - pcr - ok
      22:03:52.795 [e2-core] DEMUX_START - pcr - ok
      22:03:52.795 [e2-core] DMX_SET_PES_FILTER(0x102) - audio - ok
      22:03:52.795 [e2-core] DEMUX_START - audio - ok
      22:03:52.795 [e2-core] AUDIO_SET_BYPASS(0) - ok
      22:03:52.795 [e2-core] AUDIO_PAUSE - ok
      22:03:52.800 [e2-core] AUDIO_PLAY - ok
      22:03:52.800 [e2-core] Video Device: /dev/dvb/adapter0/video0
      22:03:52.801 [e2-core] demux device: /dev/dvb/adapter0/demux0
      22:03:52.801 [e2-core] DMX_SET_PES_FILTER(0x21) - ttx - ok
      22:03:52.801 [e2-core] DEMUX_START - ttx - ok
      22:03:52.801 [e2-core] VIDEO_SLOWMOTION(0) - ok
      22:03:52.802 [e2-core] VIDEO_FAST_FORWARD(0) - ok
      22:03:52.802 [e2-core] VIDEO_CONTINUE - ok
      22:03:52.802 [e2-core] AUDIO_CONTINUE - ok
      22:03:52.825 [e2-python] not pauseable.
      22:03:52.836 [e2-core] allocate channel.. 0006:0085
      22:03:52.837 [e2-core] available channel.. 000c:0085
      22:03:52.840 [e2-core] [eDVBCAService] new channel 0x14e39c0!
      22:03:52.841 [e2-core] (2)tune
      22:03:52.841 [e2-core] RotorCmd ffffffff, lastRotorCmd ffffffff
      22:03:52.841 [e2-core] prepare_sat System 1 Freq 11914500 Pol 0 SR 27500000 INV 2 FEC 9 orbpos 192 system 1 modulation 1 pilot 2, rolloff 0
      22:03:52.841 [e2-core] tuning to 1314 mhz
      22:03:52.841 [e2-core] allocate Channel: res 0
      22:03:52.841 [e2-core] allocate demux
      22:03:52.841 [e2-core] resolve: resolve ${sysconfdir}/scan_tp_valid_check.py
      22:03:52.842 [e2-core] resolve: -> /etc/scan_tp_valid_check.py
      22:03:52.842 [e2-core] [SEC] set static current limiting
      22:03:52.842 [e2-core] [SEC] invalidate current switch params
      22:03:52.842 [e2-core] set sequence pos 3
      22:03:52.842 [e2-core] set sequence pos 3
      22:03:52.842 [e2-core] [SEC] update current switch params
      22:03:52.842 [e2-core] [SEC] startTuneTimeout 5000
      22:03:52.843 [e2-core] [SEC] setFrontend 1
      22:03:52.843 [e2-core] setting frontend 2
      22:03:52.843 [e2-core] [SEC] sleep 500ms
      22:03:52.859 [e2-core] + 1/1 TID 00
      22:03:52.859 [e2-core] done!
      22:03:52.860 [e2-core] PATready
      22:03:52.860 [e2-core] use pmtpid 0060 for service_id 0069
      22:03:52.860 [e2-core] no version filtering
      22:03:52.860 [e2-core] 0060: 02 00 69 00 00 00
      22:03:52.860 [e2-core] mask: ff ff ff 00 00 00
      22:03:52.861 [e2-core] mode: 00 00 00 00 00 00
      22:03:52.861 [e2-core] doing version filtering
      22:03:52.861 [e2-core] 0000: 00 00 00 2f 00 00
      22:03:52.861 [e2-core] mask: ff 00 00 3f 00 00
      22:03:52.862 [e2-core] mode: 00 00 00 3e 00 00
      22:03:52.863 [e2-core] (2)fe event: status 0, inversion off, m_tuning 1
      22:03:52.879 [e2-core] + 1/1 TID 02
      22:03:52.879 [e2-core] done!
      22:03:52.880 [e2-core] eventNewProgramInfo 0 0
      22:03:52.880 [e2-core] [eDVBServiceFCCPlay::updateFCCDecoder][1:0:19:69:C:85:C00000:0:0:0:]
      22:03:52.880 [e2-core] have 1 video stream(s) (00ff), and 2 audio stream(s) (0102, 0103), and the pcr pid is 00ff, and the text pid is 0021
      22:03:52.880 [e2-core] disable teletext subtitles
      22:03:52.881 [e2-core] decoder state: play, vpid=255, apid=258
      22:03:52.888 [e2-core] [eDVBCAService] new service 1:0:19:69:C:85:C00000:0:0:0:
      22:03:52.888 [e2-core] [eDVBCAService] add demux 0 to slot 0 service 1:0:19:69:C:85:C00000:0:0:0:
      22:03:52.888 [e2-core] 'SKY/00c00000' is in provider list of slot 0... so use it
      22:03:52.889 [e2-core] demux 0 mask 01 prevhash 00000000
      22:03:52.889 [e2-core] [eDVBCAService] send 67 bytes
      22:03:52.889 [e2-core] 9f 80 32 3f 03 00 69 23 00 25 01 81 08 00 c0 00 00 00 0c 00 85 82 02 01 00 84 02 00 60 09 04 09 c4 fb 0d 09 04 09 af ff 0d 09 04 09 8c fa 0d 06 00 21 00 00 1b 00 ff 00 00 06 01 02 00 00 06 01 03 00 00
      22:03:52.890 [e2-core] doing version filtering
      22:03:52.890 [e2-core] 0060: 02 00 69 23 00 00
      22:03:52.890 [e2-core] mask: ff ff ff 3f 00 00
      22:03:52.890 [e2-core] mode: 00 00 00 3e 00 00
      22:03:52.933 [e2-core] (2)fe event: status 7, inversion off, m_tuning 2
      22:03:53.049 [e2-core] (2)fe event: status 1f, inversion off, m_tuning 3
      22:03:53.049 [e2-core] OURSTATE: ok
      22:03:53.049 [e2-core] [eDVBCAService] channel 0x14e39c0 running
      22:03:53.049 [e2-core] [eDVBLocalTimerHandler] channel 0x14e39c0 running
      22:03:53.050 [e2-core] no version filtering
      22:03:53.050 [e2-core] 0014: 70 00 00 00 00 00
      22:03:53.050 [e2-core] mask: fc 00 00 00 00 00
      22:03:53.050 [e2-core] mode: 00 00 00 00 00 00
      22:03:53.050 [e2-core] [eEPGCache] channel 0x14e39c0 running
      22:03:53.050 [e2-core] stop release channel timer
      22:03:53.051 [e2-core] [eEPGCache] next update in 2 sec
      22:03:53.051 [e2-core] no version filtering
      22:03:53.051 [e2-core] 0012: 4e 01 0b 00 00 00
      22:03:53.051 [e2-core] mask: ff ff ff 00 00 00
      22:03:53.051 [e2-core] mode: 00 00 00 00 00 00
      22:03:53.051 [e2-core] ok ... now we start!!
      22:03:53.052 [e2-core] no version filtering
      22:03:53.052 [e2-core] 0000: 00 00 00 00 00 00
      22:03:53.052 [e2-core] mask: ff 00 00 00 00 00
      22:03:53.052 [e2-core] mode: 00 00 00 00 00 00
      22:03:53.052 [e2-core] eventNewProgramInfo 0 0
      22:03:53.052 [e2-core] [eDVBServiceFCCPlay::updateFCCDecoder][1:0:19:10B:6:85:C00000:0:0:0:]
      22:03:53.052 [e2-core] have 1 video stream(s) (07ff), and 1 audio stream(s) (0802), and the pcr pid is 07ff, and the text pid is 0020 (Cached)
      22:03:53.052 [e2-core] allocate demux
      22:03:53.053 [e2-core] [eFCCDecoder] alloc /dev/fcc1
      22:03:53.053 [e2-core] [eTSMPEGDecoder] FCC_START OK!
      22:03:53.054 [e2-core] [SEC] set dynamic current limiting
      22:03:53.055 [e2-core] allocate channel.. 0003:0085
      22:03:53.055 [e2-core] available channel.. 000c:0085
      22:03:53.056 [e2-core] available channel.. 0006:0085
      22:03:53.058 [e2-core] [eDVBCAService] new channel 0x1770580!
      22:03:53.058 [e2-core] (3)tune
      22:03:53.059 [e2-core] RotorCmd ffffffff, lastRotorCmd ffffffff
      22:03:53.059 [e2-core] prepare_sat System 1 Freq 11719500 Pol 0 SR 27500000 INV 2 FEC 9 orbpos 192 system 1 modulation 1 pilot 2, rolloff 0
      22:03:53.059 [e2-core] tuning to 1119 mhz
      22:03:53.059 [e2-core] OURSTATE: tuning
      22:03:53.059 [e2-core] allocate Channel: res 0
      22:03:53.059 [e2-core] allocate demux
      22:03:53.059 [e2-core] resolve: resolve ${sysconfdir}/scan_tp_valid_check.py
      22:03:53.059 [e2-core] resolve: -> /etc/scan_tp_valid_check.py
      22:03:53.061 [e2-core] [SEC] set static current limiting
      22:03:53.061 [e2-core] [SEC] invalidate current switch params
      22:03:53.061 [e2-core] set sequence pos 3
      22:03:53.061 [e2-core] set sequence pos 3
      22:03:53.061 [e2-core] [SEC] update current switch params
      22:03:53.061 [e2-core] [SEC] startTuneTimeout 5000
      22:03:53.062 [e2-core] [SEC] setFrontend 1
      22:03:53.062 [e2-core] setting frontend 3
      22:03:53.062 [e2-core] [SEC] sleep 500ms
      22:03:53.080 [e2-core] + 1/1 TID 00
      22:03:53.080 [e2-core] done!
      22:03:53.081 [e2-core] PATready
      22:03:53.081 [e2-core] no PAT entry found.. start delay
      22:03:53.081 [e2-core] doing version filtering
      22:03:53.081 [e2-core] 0000: 00 00 00 2f 00 00
      22:03:53.081 [e2-core] mask: ff 00 00 3f 00 00
      22:03:53.081 [e2-core] mode: 00 00 00 3e 00 00
      22:03:53.083 [e2-core] (3)fe event: status 0, inversion off, m_tuning 1
      22:03:53.119 [e2-core] (3)fe event: status 7, inversion off, m_tuning 2
      22:03:53.279 [e2-core] (3)fe event: status 1f, inversion off, m_tuning 3
      22:03:53.280 [e2-core] OURSTATE: ok
      22:03:53.284 [e2-core] [eDVBCAService] channel 0x1770580 running
      22:03:53.284 [e2-core] [eDVBLocalTimerHandler] channel 0x1770580 running
      22:03:53.284 [e2-core] no version filtering
      22:03:53.284 [e2-core] 0014: 70 00 00 00 00 00
      22:03:53.285 [e2-core] mask: fc 00 00 00 00 00
      22:03:53.285 [e2-core] mode: 00 00 00 00 00 00
      22:03:53.285 [e2-core] [eEPGCache] channel 0x1770580 running
      22:03:53.286 [e2-core] stop release channel timer
      22:03:53.286 [e2-core] [eEPGCache] next update in 2 sec
      22:03:53.286 [e2-core] no version filtering
      22:03:53.286 [e2-core] 0012: 4e 00 15 00 00 00
      22:03:53.286 [e2-core] mask: ff ff ff 00 00 00
      22:03:53.286 [e2-core] mode: 00 00 00 00 00 00
      22:03:53.287 [e2-core] ok ... now we start!!
      22:03:53.287 [e2-core] no version filtering
      22:03:53.287 [e2-core] 0000: 00 00 00 00 00 00
      22:03:53.287 [e2-core] mask: ff 00 00 00 00 00
      22:03:53.287 [e2-core] mode: 00 00 00 00 00 00
      22:03:53.290 [e2-core] allocate channel.. 000d:0085
      22:03:53.290 [e2-core] available channel.. 000c:0085
      22:03:53.290 [e2-core] available channel.. 0006:0085
      22:03:53.290 [e2-core] available channel.. 0003:0085
      22:03:53.293 [e2-core] [eDVBCAService] new channel 0x14d97c8!
      22:03:53.293 [e2-core] (4)tune
      22:03:53.293 [e2-core] RotorCmd ffffffff, lastRotorCmd ffffffff
      22:03:53.293 [e2-core] prepare_sat System 1 Freq 11992500 Pol 0 SR 27500000 INV 2 FEC 9 orbpos 192 system 1 modulation 1 pilot 2, rolloff 0
      22:03:53.293 [e2-core] tuning to 1392 mhz
      22:03:53.293 [e2-core] OURSTATE: tuning
      22:03:53.293 [e2-core] allocate Channel: res 0
      22:03:53.293 [e2-core] allocate demux
      22:03:53.294 [e2-core] resolve: resolve ${sysconfdir}/scan_tp_valid_check.py
      22:03:53.294 [e2-core] resolve: -> /etc/scan_tp_valid_check.py
      22:03:53.295 [e2-core] [SEC] set static current limiting
      22:03:53.296 [e2-core] [SEC] invalidate current switch params
      22:03:53.296 [e2-core] set sequence pos 3
      22:03:53.296 [e2-core] set sequence pos 3
      22:03:53.296 [e2-core] [SEC] update current switch params
      22:03:53.296 [e2-core] [SEC] startTuneTimeout 5000
      22:03:53.296 [e2-core] [SEC] setFrontend 1
      22:03:53.296 [e2-core] setting frontend 4
      22:03:53.296 [e2-core] [SEC] sleep 500ms
      22:03:53.310 [e2-core] (4)fe event: status 0, inversion off, m_tuning 1
      22:03:53.350 [e2-core] (4)fe event: status 7, inversion off, m_tuning 2
      22:03:53.350 [e2-core] [SEC] set dynamic current limiting
      22:03:53.410 [e2-core] + 1/1 TID 00
      22:03:53.410 [e2-core] done!
      22:03:53.411 [e2-core] PATready
      22:03:53.411 [e2-core] use pmtpid 0068 for service_id 0015
      22:03:53.411 [e2-core] no version filtering
      22:03:53.411 [e2-core] 0068: 02 00 15 00 00 00
      22:03:53.411 [e2-core] mask: ff ff ff 00 00 00
      22:03:53.411 [e2-core] mode: 00 00 00 00 00 00
      22:03:53.412 [e2-core] doing version filtering
      22:03:53.412 [e2-core] 0000: 00 00 00 33 00 00
      22:03:53.412 [e2-core] mask: ff 00 00 3f 00 00
      22:03:53.412 [e2-core] mode: 00 00 00 3e 00 00
      22:03:53.469 [e2-core] + 1/1 TID 02
      22:03:53.469 [e2-core] done!
      22:03:53.470 [e2-core] eventNewProgramInfo 0 0
      22:03:53.470 [e2-core] [eDVBServiceFCCPlay::updateFCCDecoder][1:0:16:15:3:85:C00000:0:0:0:]
      22:03:53.470 [e2-core] have 1 video stream(s) (08ff), and 1 audio stream(s) (0900), and the pcr pid is 08ff, and the text pid is 0020
      22:03:53.470 [e2-core] allocate demux
      22:03:53.470 [e2-core] [eFCCDecoder] alloc /dev/fcc2
      22:03:53.471 [e2-core] [eTSMPEGDecoder] FCC_START OK!
      22:03:53.472 [e2-core] [eDVBCAService] new service 1:0:16:15:3:85:C00000:0:0:0:
      22:03:53.472 [e2-core] [eDVBCAService] add demux 2 to slot 0 service 1:0:16:15:3:85:C00000:0:0:0:
      22:03:53.472 [e2-core] demux 2 mask 04 prevhash 00000000
      22:03:53.473 [e2-core] [eDVBCAService] send 62 bytes
      22:03:53.473 [e2-core] 9f 80 32 3a 03 00 15 05 00 25 01 81 08 00 c0 00 00 00 03 00 85 82 02 04 02 84 02 00 68 09 04 09 c4 fb 7e 09 04 09 8c fa 7e 09 04 09 af ff 7e 06 00 20 00 00 1b 08 ff 00 00 03 09 00 00 00
      22:03:53.473 [e2-core] doing version filtering
      22:03:53.473 [e2-core] 0068: 02 00 15 05 00 00
      22:03:53.473 [e2-core] mask: ff ff ff 3f 00 00
      22:03:53.473 [e2-core] mode: 00 00 00 3e 00 00
      22:03:53.509 [e2-core] (4)fe event: status 1f, inversion off, m_tuning 3
      22:03:53.509 [e2-core] OURSTATE: ok
      22:03:53.510 [e2-core] [eDVBCAService] channel 0x14d97c8 running
      22:03:53.510 [e2-core] [eDVBLocalTimerHandler] channel 0x14d97c8 running
      22:03:53.510 [e2-core] no version filtering
      22:03:53.510 [e2-core] 0014: 70 00 00 00 00 00
      22:03:53.510 [e2-core] mask: fc 00 00 00 00 00
      22:03:53.510 [e2-core] mode: 00 00 00 00 00 00
      22:03:53.510 [e2-core] [eEPGCache] channel 0x14d97c8 running
      22:03:53.511 [e2-core] [eEPGCache] next update in 2 sec
      22:03:53.511 [e2-core] stop release channel timer
      22:03:53.511 [e2-core] no version filtering
      22:03:53.511 [e2-core] 0012: 4e 01 15 00 00 00
      22:03:53.511 [e2-core] mask: ff ff ff 00 00 00
      22:03:53.511 [e2-core] mode: 00 00 00 00 00 00
      22:03:53.512 [e2-core] ok ... now we start!!
      22:03:53.512 [e2-core] no version filtering
      22:03:53.512 [e2-core] 0000: 00 00 00 00 00 00
      22:03:53.512 [e2-core] mask: ff 00 00 00 00 00
      22:03:53.512 [e2-core] mode: 00 00 00 00 00 00
      22:03:53.516 [e2-core] allocate channel.. 000e:0085
      22:03:53.516 [e2-core] available channel.. 000c:0085
      22:03:53.516 [e2-core] available channel.. 0006:0085
      22:03:53.517 [e2-core] available channel.. 0003:0085
      22:03:53.517 [e2-core] available channel.. 000d:0085
      22:03:53.517 [e2-core] opening frontend 5
      22:03:53.519 [e2-core] [eDVBCAService] new channel 0xb629d8!
      22:03:53.520 [e2-core] (5)tune
      22:03:53.520 [e2-core] RotorCmd ffffffff, lastRotorCmd ffffffff
      22:03:53.520 [e2-core] prepare_sat System 1 Freq 11875500 Pol 0 SR 27500000 INV 2 FEC 3 orbpos 192 system 1 modulation 2 pilot 2, rolloff 0
      22:03:53.520 [e2-core] tuning to 1275 mhz
      22:03:53.520 [e2-core] OURSTATE: tuning
      22:03:53.520 [e2-core] allocate Channel: res 0
      22:03:53.520 [e2-core] allocate demux
      22:03:53.520 [e2-core] resolve: resolve ${sysconfdir}/scan_tp_valid_check.py
      22:03:53.520 [e2-core] resolve: -> /etc/scan_tp_valid_check.py
      22:03:53.521 [e2-core] [SEC] set static current limiting
      22:03:53.521 [e2-core] [SEC] invalidate current switch params
      22:03:53.522 [e2-core] set sequence pos 3
      22:03:53.522 [e2-core] set sequence pos 3
      22:03:53.522 [e2-core] [SEC] update current switch params
      22:03:53.522 [e2-core] [SEC] startTuneTimeout 5000
      22:03:53.522 [e2-core] [SEC] setFrontend 1
      22:03:53.522 [e2-core] setting frontend 5
      22:03:53.523 [e2-core] [SEC] sleep 500ms
      22:03:53.539 [e2-core] (5)fe event: status 0, inversion off, m_tuning 1
      22:03:53.564 [e2-core] sdt update done!
      22:03:53.564 [e2-core] [SEC] set dynamic current limiting
      22:03:53.579 [e2-core] +- 1/2 TID 4e
      22:03:53.579 [e2-core] (5)fe event: status 7, inversion off, m_tuning 2
      22:03:53.619 [e2-core] + 1/1 TID 00
      22:03:53.619 [e2-core] done!
      22:03:53.620 [e2-core] PATready
      22:03:53.620 [e2-core] no PAT entry found.. start delay
      22:03:53.620 [e2-core] doing version filtering
      22:03:53.621 [e2-core] 0000: 00 00 00 0d 00 00
      22:03:53.621 [e2-core] mask: ff 00 00 3f 00 00
      22:03:53.621 [e2-core] mode: 00 00 00 3e 00 00
      22:03:53.639 [e2-core] (5)fe event: status 1f, inversion off, m_tuning 3
      22:03:53.639 [e2-core] OURSTATE: ok
      22:03:53.639 [e2-core] [eDVBCAService] channel 0xb629d8 running
      22:03:53.639 [e2-core] [eDVBLocalTimerHandler] channel 0xb629d8 running
      22:03:53.640 [e2-core] no version filtering
      22:03:53.640 [e2-core] 0014: 70 00 00 00 00 00
      22:03:53.640 [e2-core] mask: fc 00 00 00 00 00
      22:03:53.640 [e2-core] mode: 00 00 00 00 00 00
      22:03:53.640 [e2-core] [eEPGCache] channel 0xb629d8 running
      22:03:53.641 [e2-core] [eEPGCache] next update in 2 sec
      22:03:53.641 [e2-core] stop release channel timer
      22:03:53.641 [e2-core] no version filtering
      22:03:53.641 [e2-core] 0012: 4e 01 93 00 00 00
      22:03:53.641 [e2-core] mask: ff ff ff 00 00 00
      22:03:53.641 [e2-core] mode: 00 00 00 00 00 00
      22:03:53.642 [e2-core] ok ... now we start!!
      22:03:53.642 [e2-core] no version filtering
      22:03:53.642 [e2-core] 0000: 00 00 00 00 00 00
      22:03:53.642 [e2-core] mask: ff 00 00 00 00 00
      22:03:53.642 [e2-core] mode: 00 00 00 00 00 00
      22:03:53.741 [e2-core] + 1/1 TID 00
      22:03:53.741 [e2-core] done!
      22:03:53.742 [e2-core] PATready
      22:03:53.742 [e2-core] use pmtpid 0070 for service_id 0193
      22:03:53.742 [e2-core] no version filtering
      22:03:53.742 [e2-core] 0070: 02 01 93 00 00 00
      22:03:53.742 [e2-core] mask: ff ff ff 00 00 00
      22:03:53.742 [e2-core] mode: 00 00 00 00 00 00
      22:03:53.742 [e2-core] doing version filtering
      22:03:53.742 [e2-core] 0000: 00 00 00 11 00 00
      22:03:53.743 [e2-core] mask: ff 00 00 3f 00 00
      22:03:53.743 [e2-core] mode: 00 00 00 3e 00 00
      22:03:53.779 [e2-core] -+ 1/2 TID 4e
      22:03:53.779 [e2-core] + 1/1 TID 02
      22:03:53.779 [e2-core] done!
      22:03:53.780 [e2-core] eventNewProgramInfo 0 0
      22:03:53.780 [e2-core] [eDVBServiceFCCPlay::updateFCCDecoder][1:0:16:193:E:85:C00000:0:0:0:]
      22:03:53.780 [e2-core] have 1 video stream(s) (10ff), and 2 audio stream(s) (1100, 1101), and the pcr pid is 10ff, and the text pid is ffffffff
      22:03:53.780 [e2-core] allocate demux
      22:03:53.780 [e2-core] [eFCCDecoder] alloc /dev/fcc3
      22:03:53.781 [e2-core] [eTSMPEGDecoder] FCC_START OK!
      22:03:53.782 [e2-core] [eDVBCAService] new service 1:0:16:193:E:85:C00000:0:0:0:
      22:03:53.782 [e2-core] [eDVBCAService] add demux 4 to slot 0 service 1:0:16:193:E:85:C00000:0:0:0:
      22:03:53.782 [e2-core] demux 4 mask 10 prevhash 00000000
      22:03:53.782 [e2-core] [eDVBCAService] send 56 bytes
      22:03:53.783 [e2-core] 9f 80 32 34 03 01 93 09 00 1f 01 81 08 00 c0 00 00 00 0e 00 85 82 02 10 04 84 02 00 70 09 04 09 c4 fb 2d 09 04 09 8c fa 2d 1b 10 ff 00 00 03 11 00 00 00 03 11 01 00 00
      22:03:53.783 [e2-core] doing version filtering
      22:03:53.783 [e2-core] 0070: 02 01 93 09 00 00
      22:03:53.783 [e2-core] mask: ff ff ff 3f 00 00
      22:03:53.783 [e2-core] mode: 00 00 00 3e 00 00
      22:03:53.799 [e2-core] [SEC] set dynamic current limiting
      22:03:54.021 [e2-core] -+ 1/2 TID 4e
      22:03:54.040 [e2-core] [SEC] set dynamic current limiting
      22:03:54.100 [e2-core] DVB service failed to tune - error 3
      22:03:54.100 [e2-core] [eFCCServiceManager][1:0:19:10B:6:85:C00000:0:0:0:] set service to state failed.
      22:03:54.100 [e2-core] [eFCCServiceManager] stop FCC service sref : 1:0:19:10B:6:85:C00000:0:0:0:
      22:03:54.101 [e2-core] decoder state: stop, vpid=-1, apid=-1
      22:03:54.102 [e2-core] [eTSMPEGDecoder] FCC_STOP OK!
      22:03:54.103 [e2-core] [eFCCDecoder] close /dev/fcc1
      22:03:54.103 [e2-core] [eDVBCAService] remove channel 0x14e39c0
      22:03:54.104 [e2-core] [eDVBLocalTimerHandler] remove channel 0x14e39c0
      22:03:54.105 [e2-core] [eEPGCache] remove channel 0x14e39c0
      22:03:54.229 [e2-core] -+ 1/2 TID 4e
      22:03:54.330 [e2-core] +- 1/2 TID 4e
      22:03:54.520 [e2-core] ++ 2/2 TID 4e
      22:03:54.520 [e2-core] done!
      22:03:54.524 [e2-python] looking for Extended Data EventID: 18480
      22:03:54.525 [e2-python] Extended Data Event found
      22:03:54.525 [e2-python] But Extended Data is empty
      22:03:54.527 [e2-python] looking for Extended Data EventID: 18481
      22:03:54.527 [e2-python] Extended Data Event found
      22:03:54.527 [e2-python] But Extended Data is empty
      22:03:54.538 [e2-core] doing version filtering
      22:03:54.538 [e2-core] 0012: 4e 00 69 01 00 00
      22:03:54.538 [e2-core] mask: ff ff ff 3f 00 00
      22:03:54.539 [e2-core] mode: 00 00 00 3e 00 00
      22:03:54.639 [e2-core] DVB service failed to tune - error 3
      22:03:54.639 [e2-core] [eFCCServiceManager][1:0:19:115:D:85:C00000:0:0:0:] set service to state failed.
      22:03:54.640 [e2-core] [eFCCServiceManager] stop FCC service sref : 1:0:19:115:D:85:C00000:0:0:0:
      22:03:54.641 [e2-core] [eDVBCAService] remove channel 0x14d97c8
      22:03:54.641 [e2-core] [eDVBLocalTimerHandler] remove channel 0x14d97c8
      22:03:54.642 [e2-core] [eEPGCache] remove channel 0x14d97c8
      22:03:54.659 [e2-core] VIDEO_GET_EVENT - ok
      22:03:54.749 [e2-core] ++ 2/2 TID 4e
      22:03:54.749 [e2-core] done!
      22:03:54.750 [e2-core] doing version filtering
      22:03:54.750 [e2-core] 0012: 4e 00 15 11 00 00
      22:03:54.750 [e2-core] mask: ff ff ff 3f 00 00
      22:03:54.750 [e2-core] mode: 00 00 00 3e 00 00
      22:03:54.771 [e2-core] [eEPGCache] start caching events(1475352234)
      22:03:54.914 [e2-core] sdt update done!
      22:03:55.279 [e2-core] ++ 2/2 TID 4e
      22:03:55.279 [e2-core] done!
      22:03:55.280 [e2-core] doing version filtering
      22:03:55.280 [e2-core] 0012: 4e 01 93 0b 00 00
      22:03:55.280 [e2-core] mask: ff ff ff 3f 00 00
      22:03:55.280 [e2-core] mode: 00 00 00 3e 00 00
      22:03:55.286 [e2-core] [eEPGCache] start caching events(1475352235)
      22:03:55.487 [e2-core] close frontend 1
      22:03:55.589 [e2-core] [eDVBLocalTimerHandler] diff is -1
      22:03:55.589 [e2-core] [eDVBLocalTimerHandler] diff < 120 .. use Transponder Time
      22:03:55.641 [e2-core] [eEPGCache] start caching events(1475352235)
      22:03:55.699 [e2-core] [eDVBLocalTimerHandler] update RTC
      22:03:55.699 [e2-core] [eDVBLocalTimerHandler] time update to 22:03:54
      22:03:55.699 [e2-core] [eDVBLocalTimerHandler] m_time_difference is -1
      22:03:55.699 [e2-core] [eDVBLocalTimerHandler] set Linux Time
      22:03:54.700 [e2-core] [eDVBLocalTimerHandler] diff is 0
      22:03:54.701 [e2-core] [eDVBLocalTimerHandler] diff < 120 .. use Transponder Time
      22:03:54.701 [e2-core] [eDVBLocalTimerHandler] not changed
      22:03:54.701 [e2-core] [eDVBLocalTimerHandler] diff is 0
      22:03:54.702 [e2-core] [eDVBLocalTimerHandler] diff < 120 .. use Transponder Time
      22:03:54.702 [e2-core] [eDVBLocalTimerHandler] not changed
      22:03:55.714 [e2-core] sdt update done!
      22:03:57.109 [e2-core] close frontend 2
      22:03:57.649 [e2-core] close frontend 4
      22:03:59.291 [e2-core] [eEPGCache] update begin time --> 1475375700 for external source event with id 18488
      22:04:01.764 [e2-core] [eEPGCache] abort non avail schedule other reading
      22:04:01.772 [e2-core] [eEPGCache] abort non avail viasat reading
      22:04:01.773 [e2-core] [eEPGCache] abort non avail mhw reading
      22:04:01.776 [e2-core] [eEPGCache] nownext finished(1475352241)
      22:04:02.279 [e2-core] [eEPGCache] abort non avail schedule other reading
      22:04:02.281 [e2-core] [eEPGCache] abort non avail viasat reading
      22:04:02.281 [e2-core] [eEPGCache] abort non avail mhw reading
      22:04:02.286 [e2-core] [eEPGCache] nownext finished(1475352242)
      22:04:02.635 [e2-core] [eEPGCache] abort non avail schedule other reading
      22:04:02.637 [e2-core] [eEPGCache] abort non avail viasat reading
      22:04:02.638 [e2-core] [eEPGCache] abort non avail mhw reading
      22:04:02.638 [e2-core] [eEPGCache] nownext finished(1475352242)
      22:04:04.778 [e2-core] [eEPGCache] schedule finished(1475352244)
      22:04:04.780 [e2-core] [eEPGCache] stop caching events(1475352244)
      22:04:04.780 [e2-core] [eEPGCache] next update in 60 min
      22:04:12.779 [e2-core] no ancillary data in audio stream... abort radiotext pes parser
      22:04:24.959 [e2-python] next real activation is Mon Oct 3 09:39:40 2016
      22:04:27.758 [e2-core] +- 1/2 TID 4e
      22:04:28.718 [e2-core] ++ 2/2 TID 4e
      22:04:28.719 [e2-core] done!
      22:04:28.723 [e2-python] looking for Extended Data EventID: 18480
      22:04:28.723 [e2-python] Extended Data Event found
      22:04:28.723 [e2-python] But Extended Data is empty
      22:04:28.725 [e2-python] looking for Extended Data EventID: 18481
      22:04:28.725 [e2-python] Extended Data Event found
      22:04:28.725 [e2-python] But Extended Data is empty
      22:04:28.736 [e2-core] doing version filtering
      22:04:28.736 [e2-core] 0012: 4e 00 69 03 00 00
      22:04:28.736 [e2-core] mask: ff ff ff 3f 00 00
      22:04:28.736 [e2-core] mode: 00 00 00 3e 00 00
      22:06:04.011 [e2-python] next real activation is Mon Oct 3 09:39:40 2016
      22:07:44.019 [e2-python] next real activation is Mon Oct 3 09:39:40 2016
      22:09:24.009 [e2-python] next real activation is Mon Oct 3 09:39:40 2016
      22:11:04.009 [e2-python] next real activation is Mon Oct 3 09:39:40 2016
      22:12:44.019 [e2-python] next real activation is Mon Oct 3 09:39:40 2016
      22:14:24.009 [e2-python] next real activation is Mon Oct 3 09:39:40 2016
      22:16:04.009 [e2-python] next real activation is Mon Oct 3 09:39:40 2016
      22:17:44.019 [e2-python] next real activation is Mon Oct 3 09:39:40 2016
      22:19:24.019 [e2-python] next real activation is Mon Oct 3 09:39:40 2016
      22:21:04.009 [e2-python] next real activation is Mon Oct 3 09:39:40 2016
      22:22:44.019 [e2-python] next real activation is Mon Oct 3 09:39:40 2016
      22:24:24.019 [e2-python] next real activation is Mon Oct 3 09:39:40 2016
      22:26:04.019 [e2-python] next real activation is Mon Oct 3 09:39:40 2016
      22:27:44.009 [e2-python] next real activation is Mon Oct 3 09:39:40 2016
      22:29:24.009 [e2-python] next real activation is Mon Oct 3 09:39:40 2016
      22:30:02.068 [e2-core] child has terminated
      22:30:02.069 [e2-core] pipes closed
      22:30:12.038 [e2-core] child has terminated
      22:30:12.039 [e2-core] pipes closed
      22:30:12.058 [e2-core] child has terminated
      22:30:12.059 [e2-core] pipes closed
      22:31:04.009 [e2-python] next real activation is Mon Oct 3 09:39:40 2016
      22:32:44.019 [e2-python] next real activation is Mon Oct 3 09:39:40 2016
      22:33:59.369 [e2-core] main thread is non-idle! display spinner!

      Spoiler anzeigen
      22:39:39.068 [e2-core] [VTi] version: 9.0.3 --> build: 2016-07-28 (d75da0c) | vti-master
      22:39:39.203 [e2-core] + (1) Background File Eraser
      22:39:39.203 [e2-core] + (5) Tuxtxt
      22:39:39.203 [e2-core] + (8) graphics acceleration manager
      22:39:39.207 [e2-core] + (9) Font Render Class
      22:39:39.207 [e2-core] [FONT] initializing lib...
      22:39:39.212 [e2-core] [FONT] loading fonts...
      22:39:39.212 [e2-core] [FONT] Intializing font cache, using max. 4MB...
      22:39:39.212 [e2-core] + (9) gLCDDC
      22:39:39.213 [e2-core] found OLED display!
      22:39:39.214 [e2-core] lcd buffer 0xb5575008 614400 bytes, stride 1920
      22:39:39.214 [e2-core] + (9) GFBDC
      22:39:39.215 [e2-core] 21600k video mem
      22:39:39.215 [e2-core] [Animation] set animation mode 0
      22:39:39.215 [e2-core] SetMode : wanted: 1280x720x32, got 1920x1440x32
      22:39:39.225 [e2-core] - double buffering available!
      22:39:39.237 [e2-core] 10800kB available for acceleration surfaces.
      22:39:39.237 [e2-core] resolution: 1280 x 720 x 32 (stride: 7680)
      22:39:39.237 [e2-core] + (10) gRC
      22:39:39.238 [e2-core] RC thread created successfully
      22:39:39.238 [e2-core] + (15) eWindowStyleManager
      22:39:39.238 [e2-core] + (20) AVSwitch Driver
      22:39:39.238 [e2-core] + (20) misc options
      22:39:39.238 [e2-core] + (20) RC Input layer
      22:39:39.239 [e2-core] + (20) UHF Modulator
      22:39:39.239 [e2-core] couldnt open /dev/rfmod0!!!!
      22:39:39.239 [e2-core] + (20) Hdmi CEC driver
      22:39:39.239 [e2-core] + (20) DVB-CI UI
      22:39:39.242 [e2-core] + (21) Console RC Driver
      22:39:39.243 [e2-core] failed to open /dev/tty0
      22:39:39.243 [e2-core] + (21) input device driver
      22:39:39.243 [e2-core] Input device "dreambox advanced remote control (native)" is not a keyboard.
      22:39:39.243 [e2-core] Found 1 input devices!
      22:39:39.243 [e2-core] + (30) eActionMap
      22:39:39.243 [e2-core] + (35) CI Slots
      22:39:39.243 [e2-core] scanning for common interfaces..
      22:39:39.244 [e2-core] [VTi CI] 0
      22:39:39.245 [e2-core] setInputSource(4, 4) failed... dm8000 just have four inputs
      22:39:39.245 [e2-core] setInputSource(5, 5) failed... dm8000 just have four inputs
      22:39:39.245 [e2-core] setInputSource(6, 6) failed... dm8000 just have four inputs
      22:39:39.245 [e2-core] setInputSource(7, 7) failed... dm8000 just have four inputs
      22:39:39.315 [e2-core] before: 1
      22:39:39.315 [e2-core] after: 1
      22:39:39.315 [e2-core] setIoPrio best-effort level 7 ok
      22:39:39.315 [e2-core] before: 1
      22:39:39.315 [e2-core] after: 1
      22:39:39.316 [e2-core] setIoPrio idle level 6 ok
      22:39:39.316 [e2-core] done, found 2 common interface slots
      22:39:39.316 [e2-core] + (40) eServiceCenter
      22:39:39.318 [e2-core] settings instance.
      22:39:39.319 [e2-core] + (41) eServiceFactoryDVB
      22:39:39.321 [e2-core] + (41) eServiceFactoryFS
      22:39:39.321 [e2-core] + (41) eServiceFactoryMP3
      22:39:39.321 [e2-core] + (41) eServiceFactoryM2TS
      22:39:39.321 [e2-core] + (42) eVTiApp
      22:39:39.321 [e2-core] reached rl 70
      22:39:39.321 [e2-core] resolve: resolve ${sysconfdir}/enigma2/lamedb
      22:39:39.321 [e2-core] resolve: -> /etc/enigma2/lamedb
      22:39:39.321 [e2-core] ---- opening lame channel db
      22:39:39.322 [e2-core] reading services (version 4)
      22:39:39.353 [e2-core] loaded 1414 services
      22:39:39.355 [e2-core] scanning for frontends..
      22:39:39.356 [e2-core] opening frontend 0
      22:39:39.357 [e2-core] close frontend 0
      22:39:39.359 [e2-core] opening frontend 1
      22:39:39.360 [e2-core] close frontend 1
      22:39:39.362 [e2-core] opening frontend 2
      22:39:39.363 [e2-core] close frontend 2
      22:39:39.364 [e2-core] opening frontend 3
      22:39:39.366 [e2-core] close frontend 3
      22:39:39.367 [e2-core] opening frontend 4
      22:39:39.369 [e2-core] close frontend 4
      22:39:39.370 [e2-core] opening frontend 5
      22:39:39.371 [e2-core] close frontend 5
      22:39:39.373 [e2-core] opening frontend 6
      22:39:39.374 [e2-core] close frontend 6
      22:39:39.375 [e2-core] opening frontend 7
      22:39:39.377 [e2-core] close frontend 7
      22:39:39.379 [e2-core] found 1 adapter, 8 frontends(8 sim) and 15 demux, boxtype 4
      22:39:39.380 [e2-core] Use valid Linux Time :) (RTC?)
      22:39:39.380 [e2-core] [eEPGCache] Initialized EPGCache (wait for setCacheFile call now)
      22:39:39.380 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/pal.png
      22:39:39.380 [e2-core] resolve: -> /usr/share/enigma2/skin_default/pal.png
      22:39:39.389 [e2-core] Loading spinners...
      22:39:39.389 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait1.png
      22:39:39.389 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait1.png
      22:39:39.391 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait2.png
      22:39:39.391 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait2.png
      22:39:39.393 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait3.png
      22:39:39.393 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait3.png
      22:39:39.394 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait4.png
      22:39:39.394 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait4.png
      22:39:39.395 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait5.png
      22:39:39.395 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait5.png
      22:39:39.397 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait6.png
      22:39:39.397 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait6.png
      22:39:39.398 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait7.png
      22:39:39.398 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait7.png
      22:39:39.399 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait8.png
      22:39:39.399 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait8.png
      22:39:39.400 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait9.png
      22:39:39.400 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait9.png
      22:39:39.401 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait10.png
      22:39:39.401 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait10.png
      22:39:39.402 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait11.png
      22:39:39.402 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait11.png
      22:39:39.403 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait12.png
      22:39:39.403 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait12.png
      22:39:39.404 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait13.png
      22:39:39.404 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait13.png
      22:39:39.405 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait14.png
      22:39:39.405 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait14.png
      22:39:39.407 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait15.png
      22:39:39.407 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait15.png
      22:39:39.408 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait16.png
      22:39:39.408 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait16.png
      22:39:39.409 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait17.png
      22:39:39.409 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait17.png
      22:39:39.410 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait18.png
      22:39:39.410 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait18.png
      22:39:39.412 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait19.png
      22:39:39.412 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait19.png
      22:39:39.413 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait20.png
      22:39:39.413 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait20.png
      22:39:39.414 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait21.png
      22:39:39.414 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait21.png
      22:39:39.415 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait22.png
      22:39:39.416 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait22.png
      22:39:39.417 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait23.png
      22:39:39.417 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait23.png
      22:39:39.418 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait24.png
      22:39:39.418 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait24.png
      22:39:39.419 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait25.png
      22:39:39.419 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait25.png
      22:39:39.420 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait26.png
      22:39:39.420 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait26.png
      22:39:39.421 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait27.png
      22:39:39.421 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait27.png
      22:39:39.422 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait28.png
      22:39:39.422 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait28.png
      22:39:39.423 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait29.png
      22:39:39.423 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait29.png
      22:39:39.424 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait30.png
      22:39:39.424 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait30.png
      22:39:39.425 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait31.png
      22:39:39.425 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait31.png
      22:39:39.426 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait32.png
      22:39:39.427 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait32.png
      22:39:39.428 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait33.png
      22:39:39.428 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait33.png
      22:39:39.429 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait34.png
      22:39:39.429 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait34.png
      22:39:39.430 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait35.png
      22:39:39.431 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait35.png
      22:39:39.432 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait36.png
      22:39:39.432 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait36.png
      22:39:39.433 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait37.png
      22:39:39.433 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait37.png
      22:39:39.434 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait38.png
      22:39:39.434 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait38.png
      22:39:39.435 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait39.png
      22:39:39.435 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait39.png
      22:39:39.435 [e2-core] found 38 spinner!

      22:39:39.436 [e2-core] setIoPrio best-effort level 3 ok
      22:39:39.436 [e2-core] resolve: resolve ${libdir}/enigma2/python/mytest.py
      22:39:39.436 [e2-core] resolve: -> /usr/lib/enigma2/python/mytest.py
      22:39:39.514 [e2-core] resolve: resolve ${sysconfdir}/
      22:39:39.515 [e2-core] resolve: -> /etc/
      22:39:39.515 [e2-core] resolve: resolve ${sysconfdir}/
      22:39:39.515 [e2-core] resolve: -> /etc/
      22:39:39.515 [e2-core] resolve: resolve ${datadir}/fonts/
      22:39:39.515 [e2-core] resolve: -> /usr/share/fonts/
      22:39:39.515 [e2-core] resolve: resolve ${sysconfdir}/enigma2/
      22:39:39.515 [e2-core] resolve: -> /etc/enigma2/
      22:39:39.515 [e2-core] resolve: resolve ${libdir}/enigma2/python/Plugins/
      22:39:39.515 [e2-core] resolve: -> /usr/lib/enigma2/python/Plugins/
      22:39:39.515 [e2-core] resolve: resolve ${datadir}/enigma2/po/
      22:39:39.515 [e2-core] resolve: -> /usr/share/enigma2/po/
      22:39:39.515 [e2-core] resolve: resolve ${datadir}/enigma2/
      22:39:39.516 [e2-core] resolve: -> /usr/share/enigma2/
      22:39:39.516 [e2-core] resolve: resolve ${datadir}/enigma2/
      22:39:39.516 [e2-core] resolve: -> /usr/share/enigma2/
      22:39:39.516 [e2-core] resolve: resolve ${sysconfdir}/enigma2/playlist/
      22:39:39.516 [e2-core] resolve: -> /etc/enigma2/playlist/
      22:39:39.516 [e2-core] resolve: resolve ${datadir}/enigma2/defaults/
      22:39:39.516 [e2-core] resolve: -> /usr/share/enigma2/defaults/
      22:39:39.516 [e2-core] resolve: resolve ${datadir}/enigma2/dealer
      22:39:39.516 [e2-core] resolve: -> /usr/share/enigma2/dealer
      22:39:39.516 [e2-core] resolve: resolve ${datadir}/meta
      22:39:39.516 [e2-core] resolve: -> /usr/share/meta
      22:39:39.516 [e2-core] resolve: resolve ${datadir}/enigma2/defaults/
      22:39:39.516 [e2-core] resolve: -> /usr/share/enigma2/defaults/
      22:39:39.524 [e2-python] [dvbapp2] set os enivronment variable SSL_CERT_FILE= /etc/ssl/certs/ca-certificates.crt
      22:39:39.631 [e2-python] enumerating block devices...
      22:39:39.633 [e2-python] found block device 'sda': ok, removable=True, cdrom=False, partitions=['sda1']
      22:39:39.635 [e2-python] found block device 'sda1': error querying properties
      22:39:39.636 [e2-python] found block device 'loop0': blacklisted
      22:39:39.637 [e2-python] found block device 'loop1': blacklisted
      22:39:39.638 [e2-python] found block device 'loop2': blacklisted
      22:39:39.639 [e2-python] found block device 'loop3': blacklisted
      22:39:39.639 [e2-python] found block device 'loop4': blacklisted
      22:39:39.640 [e2-python] found block device 'loop5': blacklisted
      22:39:39.641 [e2-python] found block device 'loop6': blacklisted
      22:39:39.642 [e2-python] found block device 'loop7': blacklisted
      22:39:39.643 [e2-python] found block device 'mmcblk0boot0': blacklisted
      22:39:39.645 [e2-python] found block device 'mmcblk0boot1': blacklisted
      22:39:39.646 [e2-python] found block device 'mmcblk0': blacklisted
      22:39:39.647 [e2-python] found block device 'mtdblock0': blacklisted
      22:39:39.648 [e2-python] found block device 'mtdblock1': blacklisted
      22:39:39.650 [e2-python] found block device 'mtdblock2': blacklisted
      22:39:39.651 [e2-python] found block device 'mtdblock3': blacklisted
      22:39:39.652 [e2-python] found block device 'mtdblock4': blacklisted
      22:39:39.678 [e2-python] [VTi] loading vfd skin: vfd_skin/skin_vfd_vti_I.xml
      22:39:39.679 [e2-python] [VTi] not loading user defined colors for skin
      22:39:39.679 [e2-python] [VTi] not loading user defined header file for skin
      22:39:39.682 [e2-python] [VTi] loading modular skin file : Fluid/mySkin/skin_Menu_New.xml
      22:39:39.684 [e2-python] [VTi] loading modular skin file : Fluid/mySkin/skin_Movielist_big.xml
      22:39:39.694 [e2-python] [VTi] loading modular skin file : Fluid/mySkin/skin_SecondInfoBar_dark.xml
      22:39:39.697 [e2-python] [VTi] loading modular skin file : Fluid/mySkin/skin_TimerEditList_Big.xml
      22:39:39.858 [e2-python] Reading satellites.xml
      22:39:40.440 [e2-core] resolve: resolve ${datadir}/enigma2/unicable.xml
      22:39:40.440 [e2-core] resolve: -> /usr/share/enigma2/unicable.xml
      22:39:40.483 [e2-python] [InitNimManager] check multi type slot 0
      22:39:40.484 [e2-python] [InitNimManager] check multi type slot 1
      22:39:40.484 [e2-python] [InitNimManager] check multi type slot 2
      22:39:40.484 [e2-python] [InitNimManager] check multi type slot 3
      22:39:40.484 [e2-python] [InitNimManager] check multi type slot 4
      22:39:40.484 [e2-python] [InitNimManager] check multi type slot 5
      22:39:40.485 [e2-python] [InitNimManager] check multi type slot 6
      22:39:40.485 [e2-python] [InitNimManager] check multi type slot 7
      22:39:40.485 [e2-python] [Nimmanager] slot 0 create config satellite..
      22:39:40.490 [e2-python] [Nimmanager] slot 1 create config satellite..
      22:39:40.494 [e2-python] [Nimmanager] slot 2 create config satellite..
      22:39:40.502 [e2-python] [Nimmanager] slot 3 create config satellite..
      22:39:40.507 [e2-python] [Nimmanager] slot 4 create config satellite..
      22:39:40.512 [e2-python] [Nimmanager] slot 5 create config satellite..
      22:39:40.517 [e2-python] [Nimmanager] slot 6 create config satellite..
      22:39:40.523 [e2-python] [Nimmanager] slot 7 create config satellite..
      22:39:40.529 [e2-python] sec config cleared
      22:39:40.529 [e2-core] setSlotInfo for dvb frontend 0 to slotid 0, descr Vuplus DVB-S NIM(7376 FBC), need rotorworkaround No, enabled Yes, DVB-S2 Yes, DVB-T2 No
      22:39:40.529 [e2-core] setSlotInfo for dvb frontend 1 to slotid 1, descr Vuplus DVB-S NIM(7376 FBC), need rotorworkaround No, enabled Yes, DVB-S2 Yes, DVB-T2 No
      22:39:40.529 [e2-core] setSlotInfo for dvb frontend 2 to slotid 2, descr Vuplus DVB-S NIM(7376 FBC), need rotorworkaround No, enabled No, DVB-S2 Yes, DVB-T2 No
      22:39:40.529 [e2-core] setSlotInfo for dvb frontend 3 to slotid 3, descr Vuplus DVB-S NIM(7376 FBC), need rotorworkaround No, enabled No, DVB-S2 Yes, DVB-T2 No
      22:39:40.530 [e2-core] setSlotInfo for dvb frontend 4 to slotid 4, descr Vuplus DVB-S NIM(7376 FBC), need rotorworkaround No, enabled No, DVB-S2 Yes, DVB-T2 No
      22:39:40.530 [e2-core] setSlotInfo for dvb frontend 5 to slotid 5, descr Vuplus DVB-S NIM(7376 FBC), need rotorworkaround No, enabled No, DVB-S2 Yes, DVB-T2 No
      22:39:40.530 [e2-core] setSlotInfo for dvb frontend 6 to slotid 6, descr Vuplus DVB-S NIM(7376 FBC), need rotorworkaround No, enabled No, DVB-S2 Yes, DVB-T2 No
      22:39:40.530 [e2-core] setSlotInfo for dvb frontend 7 to slotid 7, descr Vuplus DVB-S NIM(7376 FBC), need rotorworkaround No, enabled No, DVB-S2 Yes, DVB-T2 No
      22:39:40.530 [e2-python] slot: 0 configmode: simple
      22:39:40.531 [e2-python] diseqcmode: single
      22:39:40.531 [e2-python] slot: 1 configmode: equal
      22:39:40.531 [e2-python] slot: 2 configmode: nothing
      22:39:40.531 [e2-python] slot: 3 configmode: nothing
      22:39:40.532 [e2-python] slot: 4 configmode: nothing
      22:39:40.532 [e2-python] slot: 5 configmode: nothing
      22:39:40.532 [e2-python] slot: 6 configmode: nothing
      22:39:40.532 [e2-python] slot: 7 configmode: nothing
      22:39:40.532 [e2-python] sec config completed
      22:39:40.559 [e2-core] resolve: resolve ${datadir}/enigma2/setup.xml
      22:39:40.560 [e2-core] resolve: -> /usr/share/enigma2/setup.xml
      22:39:41.616 [e2-core] main thread is non-idle! display spinner!
      22:39:42.754 [e2-python] Preferred tag editor set to None
      22:39:42.955 [e2-core] resolve: resolve ${sysconfdir}/enigma2/
      22:39:42.955 [e2-core] resolve: -> /etc/enigma2/
      22:39:42.959 [e2-core] loading bouquet... /etc/enigma2/bouquets.tv
      22:39:42.961 [e2-core] resolve: resolve ${sysconfdir}/enigma2/
      22:39:42.961 [e2-core] resolve: -> /etc/enigma2/
      22:39:42.962 [e2-core] loading bouquet... /etc/enigma2/userbouquet.73222.tv
      22:39:42.962 [e2-core] 21 entries in Bouquet userbouquet.73222.tv
      22:39:42.962 [e2-core] resolve: resolve ${sysconfdir}/enigma2/
      22:39:42.962 [e2-core] resolve: -> /etc/enigma2/
      22:39:42.962 [e2-core] loading bouquet... /etc/enigma2/userbouquet.dbec6.tv
      22:39:42.963 [e2-core] 21 entries in Bouquet userbouquet.dbec6.tv
      22:39:42.963 [e2-core] resolve: resolve ${sysconfdir}/enigma2/
      22:39:42.963 [e2-core] resolve: -> /etc/enigma2/
      22:39:42.963 [e2-core] loading bouquet... /etc/enigma2/userbouquet.24bf5.tv
      22:39:42.964 [e2-core] 44 entries in Bouquet userbouquet.24bf5.tv
      22:39:42.964 [e2-core] resolve: resolve ${sysconfdir}/enigma2/
      22:39:42.964 [e2-core] resolve: -> /etc/enigma2/
      22:39:42.964 [e2-core] loading bouquet... /etc/enigma2/userbouquet.b5b48.tv
      22:39:42.965 [e2-core] 10 entries in Bouquet userbouquet.b5b48.tv
      22:39:42.965 [e2-core] resolve: resolve ${sysconfdir}/enigma2/
      22:39:42.965 [e2-core] resolve: -> /etc/enigma2/
      22:39:42.965 [e2-core] loading bouquet... /etc/enigma2/userbouquet.favourites.tv
      22:39:42.965 [e2-core] 26 entries in Bouquet userbouquet.favourites.tv
      22:39:42.965 [e2-core] 5 entries in Bouquet bouquets.tv
      22:39:42.966 [e2-core] resolve: resolve ${sysconfdir}/enigma2/
      22:39:42.966 [e2-core] resolve: -> /etc/enigma2/
      22:39:42.966 [e2-core] loading bouquet... /etc/enigma2/bouquets.radio
      22:39:42.966 [e2-core] resolve: resolve ${sysconfdir}/enigma2/
      22:39:42.966 [e2-core] resolve: -> /etc/enigma2/
      22:39:42.966 [e2-core] loading bouquet... /etc/enigma2/userbouquet.favourites.radio
      22:39:42.967 [e2-core] 16 entries in Bouquet userbouquet.favourites.radio
      22:39:42.967 [e2-core] 1 entries in Bouquet bouquets.radio
      22:39:42.978 [e2-core] [eDVBLocalTimeHandler] enable sync local time with transponder time!
      22:39:43.322 [e2-core] [FONT] adding font /usr/share/fonts/nmsbd.ttf...OK (Display)
      22:39:43.323 [e2-core] SetMode : wanted: 1920x1080x32, got 1280x720x32
      22:39:43.341 [e2-core] - double buffering available!
      22:39:43.358 [e2-core] 5400kB available for acceleration surfaces.
      22:39:43.358 [e2-core] resolution: 1920 x 1080 x 32 (stride: 7680)
      22:39:43.364 [e2-core] [FONT] adding font /usr/share/enigma2/Fluid/fonts/TG/Regular.ttf...OK (Regular)
      22:39:43.364 [e2-core] [FONT] adding font /usr/share/enigma2/Fluid/fonts/TG/Regular.ttf...OK (RegularCap)
      22:39:43.367 [e2-core] [FONT] adding font /usr/share/enigma2/Fluid/fonts/TG/Bold.ttf...OK (Bold)
      22:39:43.367 [e2-core] [FONT] adding font /usr/share/enigma2/Fluid/fonts/TG/Bold.ttf...OK (BoldCap)
      22:39:43.368 [e2-core] [FONT] adding font /usr/share/enigma2/Fluid/fonts/TG/Bold.ttf...OK (Menu)
      22:39:43.368 [e2-core] [FONT] adding font /usr/share/enigma2/Fluid/fonts/TG/Bold.ttf...OK (ChannelName)
      22:39:43.371 [e2-core] [FONT] adding font /usr/share/enigma2/Fluid/fonts/TG/RegularCondensed.ttf...OK (EventName)
      22:39:43.374 [e2-core] [FONT] adding font /usr/share/enigma2/Fluid/fonts/TG/Light.ttf...OK (Light)
      22:39:43.380 [e2-core] [FONT] adding font /usr/share/enigma2/Fluid/fonts/arial.ttf...OK (Keyboard)
      22:39:43.382 [e2-core] [FONT] adding font /usr/share/enigma2/Fluid/fonts/meteocons.ttf...OK (Wetter)
      22:39:43.383 [e2-core] [FONT] adding font /usr/share/enigma2/Fluid/fonts/PVR_State.ttf...OK (PVR)
      22:39:43.384 [e2-core] [FONT] adding font /usr/share/enigma2/Fluid/fonts/VMCIcons.ttf...OK (VMCIcons)
      22:39:43.388 [e2-core] [FONT] adding font /usr/share/enigma2/Fluid/fonts/MDI.ttf...OK (MDI)
      22:39:43.393 [e2-core] [FONT] adding font /usr/share/enigma2/Fluid/fonts/fa.ttf...OK (FA)
      22:39:43.394 [e2-core] [FONT] adding font /usr/share/enigma2/Fluid/fonts/vmc.ttf...OK (VMCL)
      22:39:43.396 [e2-core] [FONT] adding font /usr/share/fonts/lcd.ttf...OK (LCD)
      22:39:43.398 [e2-core] [FONT] adding font /usr/share/fonts/tuxtxt.ttf...OK (Console)
      22:39:43.398 [e2-core] [FONT] adding font /usr/share/enigma2/Fluid/fonts/arial.ttf...OK (Sub)
      22:39:43.415 [e2-core] [FONT] adding font /usr/share/fonts/nmsbd.ttf...OK (VFD)
      22:39:43.418 [e2-python] [iInputDevices] getInputDevices <ERROR: ioctl(EVIOCGNAME): [Errno 22] Invalid argument >
      22:39:43.418 [e2-python] [iInputDevices] getInputDevices <ERROR: ioctl(EVIOCGNAME): [Errno 25] Inappropriate ioctl for device >
      22:39:43.418 [e2-python] [iInputDevices] getInputDevices <ERROR: ioctl(EVIOCGNAME): [Errno 25] Inappropriate ioctl for device >
      22:39:43.428 [e2-core] couldn't open /proc/stb/misc/12V_output
      22:39:43.428 [e2-core] resolve: resolve ${datadir}/enigma2/keymap.xml
      22:39:43.428 [e2-core] resolve: -> /usr/share/enigma2/keymap.xml
      22:39:43.547 [e2-core] resolve: resolve ${datadir}/keymaps/
      22:39:43.547 [e2-core] resolve: -> /usr/share/keymaps/
      22:39:43.548 [e2-core] resolve: resolve ${datadir}/keymaps/
      22:39:43.548 [e2-core] resolve: -> /usr/share/keymaps/
      22:39:43.550 [e2-core] resolve: resolve ${datadir}/keymaps/
      22:39:43.550 [e2-core] resolve: -> /usr/share/keymaps/
      22:39:43.554 [e2-python] Activating keymap: Keyboard English
      22:39:43.554 [e2-core] resolve: resolve ${datadir}/keymaps/
      22:39:43.554 [e2-core] resolve: -> /usr/share/keymaps/
      22:39:43.555 [e2-python] Activating language German
      22:39:43.651 [e2-python] language set to de_DE
      22:39:43.655 [e2-core] FIXME: request for unknown slot
      22:39:43.656 [e2-core] FIXME: request for unknown slot
      22:39:43.657 [e2-core] setLCDBrightness 102
      22:39:43.700 [e2-core] setLCDBrightness 255
      22:39:43.756 [e2-core] cannot open /proc/stb/avs/0/input_choices
      22:39:43.760 [e2-python] --> setting scaler_sharpness to: 00000000
      22:39:43.760 [e2-core] [eVTiApp] starting...
      22:39:43.761 [e2-core] before: 1
      22:39:43.761 [e2-core] after: 1
      22:39:43.761 [e2-core] [eVTiApp] connecting...
      22:39:43.785 [e2-core] [eVTiApp] connected in 0.02401 seconds
      22:39:43.811 [e2-python] [PiconManager] set language to de
      22:39:43.861 [e2-core] [eVTiApp] connected sucessfully
      22:39:44.034 [e2-python] [PiconManager] set language to de
      22:39:44.172 [e2-core] resolve: resolve ${datadir}/enigma2/
      22:39:44.173 [e2-core] resolve: -> /usr/share/enigma2/
      22:39:44.451 [e2-python] [LCD4linux] libusb found :) 2016-07-28-vti-master (d75da0c)
      22:39:44.472 [e2-python] [LCD4linux] dpflib-Error
      22:39:45.391 [e2-core] main thread is non-idle! display spinner!
      22:39:45.603 [e2-core] resolve: resolve ${datadir}/enigma2/setup.xml
      22:39:45.604 [e2-core] resolve: -> /usr/share/enigma2/setup.xml
      22:39:45.604 [e2-core] resolve: resolve ${libdir}
      22:39:45.604 [e2-core] resolve: -> /usr/lib
      22:39:45.887 [e2-core] resolve: resolve ${libdir}/enigma2/python/Plugins/SystemPlugins/TransCodingSetup/plugin.pyo
      22:39:45.887 [e2-core] resolve: -> /usr/lib/enigma2/python/Plugins/SystemPlugins/TransCodingSetup/plugin.pyo
      22:39:46.130 [e2-python] [FilebrowserVTi] set language to de
      22:39:46.137 [e2-python] [FilebrowserVTi] set language to de
      22:39:46.151 [e2-python] [FilebrowserVTi] set language to de
      22:39:46.156 [e2-python] [FilebrowserVTi] set language to de
      22:39:46.267 [e2-python] remove DVI-PC because it does not exist.
      22:39:46.267 [e2-python] remove Scart because it does not exist.
      22:39:46.268 [e2-python] remove YPbPr because it does not exist.
      22:39:46.270 [e2-python] set HDMI Colorspace : Edid(Auto)
      22:39:46.270 [e2-python] hotplug on DVI
      22:39:46.271 [e2-python] set Videomode DVI 1080p multi
      22:39:47.299 [e2-python] set aspect, policy, policy2, wss 16:9 panscan letterbox auto
      22:39:47.334 [e2-python] <ZappingModeSelection> set zapping mode : mute
      22:39:47.349 [e2-python] --> setting contrast to: 00008000
      22:39:47.350 [e2-python] --> setting saturation to: 00008000
      22:39:47.351 [e2-python] --> setting hue to: 00008000
      22:39:47.351 [e2-python] --> setting brightness to: 00008000
      22:39:47.351 [e2-python] --> setting block_noise_reduction to: 00000000
      22:39:47.352 [e2-python] --> setting mosquito_noise_reduction to: 00000000
      22:39:47.364 [e2-python] --> setting digital_contour_removal to: 00000000
      22:39:47.365 [e2-python] --> setting splitmode to: off
      22:39:47.479 [e2-python] --> setting sharpness to: 00000000
      22:39:47.479 [e2-python] --> setting auto_flesh to: 00000000
      22:39:47.518 [e2-python] --> setting green_boost to: 00000000
      22:39:47.519 [e2-python] --> setting blue_boost to: 00000000
      22:39:47.519 [e2-python] --> setting dynamic_contrast to: 00000000
      22:39:47.520 [e2-python] --> setting scaler_vertical_dejagging to: disable
      22:39:47.520 [e2-python] --> setting smooth to: disable
      22:39:47.538 [e2-python] --> applying pep values
      22:39:47.559 [e2-python] [UIPositionSetup] write dst_left : 20
      22:39:47.559 [e2-python] [UIPositionSetup] write dst_width : 680
      22:39:47.559 [e2-python] [UIPositionSetup] write dst_top : 20
      22:39:47.560 [e2-python] [UIPositionSetup] write dst_height : 536
      22:39:47.580 [e2-python] NFSMOUNT {'username': False, 'sharedir': 'media/usb/EPG', 'sharename': 'Wohnzimmer', 'active': 'True', 'ip': '192.168.178.10', 'hdd_replacement': 'False', 'password': False, 'isMounted': False, 'mounttype': 'nfs', 'options': 'rw,nolock,tcp'}
      22:39:47.580 [e2-python] [AutoMount.py] -getAutoMountPoints:self.automounts --> {'Wohnzimmer': {'username': False, 'sharedir': 'media/usb/EPG', 'sharename': 'Wohnzimmer', 'active': 'True', 'ip': '192.168.178.10', 'hdd_replacement': 'False', 'password': False, 'isMounted': False, 'mounttype': 'nfs', 'options': 'rw,nolock,tcp'}}
      22:39:47.580 [e2-python] [AutoMount.py] CheckMountPoint
      22:39:47.580 [e2-python] [AutoMount.py] activeMounts:---> 1
      22:39:47.581 [e2-python] [AutoMount.py] U/MOUNTCMD---> mount -t nfs -o rw,nolock,tcp,rsize=8192,wsize=8192 192.168.178.10:/media/usb/EPG /media/net/Wohnzimmer
      22:39:47.601 [e2-python] <RemoteControlCode> Write Remote Control Code : 2
      22:39:47.654 [e2-core] resolve: resolve ${datadir}/enigma2/
      22:39:47.654 [e2-core] resolve: -> /usr/share/enigma2/
      22:39:47.761 [e2-python] [DeviceManager2] Loading skin /usr/lib/enigma2/python/Plugins/SystemPlugins/DeviceManager2/skin.xml
      22:39:47.777 [e2-python] [MultiQuickButton] enabled: True
      22:39:47.778 [e2-python] [CI_Assignment] activating ci configs:
      22:39:47.778 [e2-core] resolve: resolve ${sysconfdir}/enigma2/ci
      22:39:47.778 [e2-core] resolve: -> /etc/enigma2/ci
      22:39:47.779 [e2-core] resolve: resolve ${sysconfdir}/enigma2/ci
      22:39:47.780 [e2-core] resolve: -> /etc/enigma2/ci
      22:39:47.780 [e2-python] [CI_Activate] activate CI0 with following settings:
      22:39:47.780 [e2-python] (['1:0:1:2EC3:411:1:C00000:0:0:0:'], [('SKY', 12582912L)], [])
      22:39:47.785 [e2-python] starting hotplug handler
      22:39:47.788 [e2-python] add device sda to bdpoll current state: medium inserted
      22:39:47.791 [e2-python] [TIMER] record time changed, start prepare is now: Mon Oct 3 09:39:40 2016
      22:39:47.791 [e2-python] sanitycheck
      22:39:47.791 [e2-python] check
      22:39:47.791 [e2-python] checkTimerlist
      22:39:47.792 [e2-python] recording service: 1:0:16:1D:4:85:C00000:0:0:0:
      22:39:47.792 [e2-core] record: 0
      22:39:47.793 [e2-python] recording service: 1:0:16:1D:4:85:C00000:0:0:0:
      22:39:47.793 [e2-core] record: 0
      22:39:47.794 [e2-python] recording service: 1:0:16:1D:4:85:C00000:0:0:0:
      22:39:47.794 [e2-core] record: 0
      22:39:47.794 [e2-python] recording service: 1:0:16:1D:4:85:C00000:0:0:0:
      22:39:47.794 [e2-core] record: 0
      22:39:47.795 [e2-python] recording service: 1:0:16:1D:4:85:C00000:0:0:0:
      22:39:47.795 [e2-core] record: 0
      22:39:47.795 [e2-python] recording service: 1:0:16:1D:4:85:C00000:0:0:0:
      22:39:47.796 [e2-core] record: 0
      22:39:47.796 [e2-python] recording service: 1:0:16:1D:4:85:C00000:0:0:0:
      22:39:47.796 [e2-core] record: 0
      22:39:47.797 [e2-python] recording service: 1:0:16:1D:4:85:C00000:0:0:0:
      22:39:47.797 [e2-core] record: 0
      22:39:47.797 [e2-python] recording service: 1:0:16:1D:4:85:C00000:0:0:0:
      22:39:47.797 [e2-core] record: 0
      22:39:47.798 [e2-python] recording service: 1:0:16:1D:4:85:C00000:0:0:0:
      22:39:47.798 [e2-core] record: 0
      22:39:47.798 [e2-python] [Timer] Record <RecordTimer.RecordTimerEntry object at 0x9eb08bd0>
      22:39:47.798 [e2-python] ProcessRepeated
      22:39:47.799 [e2-python] localrepeatedbegindate: Mon Oct 3 09:40:00 2016
      22:39:47.799 [e2-python] localbegin: Mon Oct 3 09:40:00 2016
      22:39:47.799 [e2-python] localend: Mon Oct 3 10:35:00 2016
      22:39:47.799 [e2-python] localnow: Sat Oct 1 22:39:48 2016
      22:39:47.799 [e2-python] Day: 0
      22:39:47.799 [e2-python] Day: 1
      22:39:47.799 [e2-python] Day: 2
      22:39:47.800 [e2-python] Day: 3
      22:39:47.800 [e2-python] Day: 4
      22:39:47.800 [e2-python] ProcessRepeated result
      22:39:47.800 [e2-python] Mon Oct 3 09:40:00 2016
      22:39:47.800 [e2-python] Mon Oct 3 10:35:00 2016
      22:39:47.800 [e2-python] next real activation is Mon Oct 3 09:39:40 2016
      22:39:47.867 [e2-python] Looking for embedded skin
      22:39:47.922 [e2-python] [MultiQuickButton] enabled: True
      22:39:48.087 [e2-python] [AutoShutDown] start....
      22:39:48.087 [e2-python] [Solo4kMiscControl] set /proc/stb/frontend/fbc/force_lnbon : off
      22:39:48.087 [e2-python] [Solo4kMiscControl] set /proc/stb/frontend/fbc/force_toneburst : disable
      22:39:48.088 [e2-python] [Solo4kMiscControl] set /proc/stb/tsmux/rmx_delay : 256
      22:39:48.093 [e2-core] [eEPGCache] disable Vu+ DVB EPG blacklist mode
      22:39:48.093 [e2-core] [eEPGCache] set Vu+ in EPG-server (default) mode
      22:39:48.093 [e2-core] [eEPGCache] setCacheFile read/write epg data from/to '/etc/enigma2/epg.dat'
      22:39:48.093 [e2-core] [eEPGCache] time updated.. start EPG Mainloop
      22:39:48.093 [e2-core] before: 1
      22:39:48.093 [e2-core] after: 1
      22:39:48.094 [e2-core] [eEPGCache] create epg.dat backup
      22:39:48.094 [e2-python] not showing fine-tuning wizard, config variable doesn't exist
      22:39:48.095 [e2-python] showtestcard is false
      22:39:48.098 [e2-python] Looking for embedded skin
      22:39:48.118 [e2-python] setValue 85
      22:39:48.119 [e2-core] Setvolume: 100 100 (raw)
      22:39:48.119 [e2-core] Setvolume: 0 0 (-1db)
      22:39:48.119 [e2-core] Setvolume: 85 85 (raw)
      22:39:48.120 [e2-core] Setvolume: 10 10 (-1db)
      22:39:48.511 [e2-core] [eEPGCache] service reference for epg query is not valid
      22:39:48.511 [e2-core] [eEPGCache] service reference for epg query is not valid
      22:39:48.554 [e2-python] warning, skin is missing element etitle in <class 'Screens.ChannelSelection.ChannelSelection'>
      22:39:48.592 [e2-python] warning, skin is missing element RassLogo in <class 'Screens.RdsDisplay.RdsInfoDisplay'>
      22:39:48.597 [e2-python] warning, skin is missing element UnhandledKeyPixmap in <class 'Screens.UnhandledKey.UnhandledKey'>
      22:39:48.627 [e2-python] RemovePopup, id = ZapError
      22:39:48.736 [e2-python] playing service..
      22:39:48.737 [e2-core] allocate channel.. 03fb:0001
      22:39:48.737 [e2-core] opening frontend 0
      22:39:48.742 [e2-core] [eDVBCAService] new channel 0x1ddc068!
      22:39:48.742 [e2-core] (0)tune
      22:39:48.742 [e2-core] RotorCmd ffffffff, lastRotorCmd ffffffff
      22:39:48.742 [e2-core] prepare_sat System 1 Freq 11493750 Pol 0 SR 22000000 INV 2 FEC 2 orbpos 192 system 1 modulation 2 pilot 2, rolloff 0
      22:39:48.742 [e2-core] tuning to 1743 mhz
      22:39:48.742 [e2-core] OURSTATE: tuning
      22:39:48.742 [e2-core] allocate Channel: res 0
      22:39:48.742 [e2-core] allocate demux
      22:39:48.742 [e2-core] resolve: resolve ${sysconfdir}/scan_tp_valid_check.py
      22:39:48.743 [e2-core] resolve: -> /etc/scan_tp_valid_check.py
      22:39:48.743 [e2-core] [eDVBServiceFCCPlay::changeFCCMode][1:0:19:283D:3FB:1:C00000:0:0:0:] enable FCC decoding.
      22:39:48.989 [e2-core] [eEPGCache] 60658 events read from /etc/enigma2/epg.dat
      22:39:48.997 [e2-python] looking for Extended Data EventID: 54039
      22:39:48.997 [e2-python] Extended Data Event found
      22:39:48.997 [e2-python] Event has Extended Data: {"title":"Spiel f\u00fcr dein Land","subtitle":"Der gro\u00dfe L\u00e4nderwettstreit","airtime":1475345700,"categoryName":"Unterhaltung","genre":"Quizshow","year":"2016","isNew":"","country":"D","ageRating":"","season":"","episode":"4","channelid":"1","isLastEpisode":"","highlightCategory":"Top Tipp","image":"http:\/\/images.tvmovie.de\/220x142\/North\/a229d040-870e-11e6-a937-991b0ab5d171-1.jpg","imagebase":"","showviewNumber":"","conclusion":"Deutschland gewann die Show bislang schon 2 Mal","isDolbyDigital":"","movieStarValue":"","ratings":"","leadText":"Drei Nationen k\u00e4mpfen um 50.000 Euro","search":"","id":"94709524"}
      22:39:49.001 [e2-core] [eEPGCache] create real epg.dat backup
      22:39:49.035 [e2-python] looking for Extended Data EventID: 54040
      22:39:49.035 [e2-python] Extended Data Event found
      22:39:49.035 [e2-python] Event has Extended Data: {"title":"Tagesthemen","subtitle":"Mit Wetter","airtime":1475356500,"categoryName":"Reportage","genre":"Nachrichtenmagazin","year":"2016","isNew":"","country":"D","ageRating":"","season":"","episode":"","channelid":"1","isLastEpisode":"","highlightCategory":"","image":"","imagebase":"","showviewNumber":"","conclusion":"","isDolbyDigital":"","movieStarValue":"","ratings":"","leadText":"","search":"","id":"94709434"}
      22:39:49.049 [e2-python] not pauseable.
      22:39:49.050 [e2-python] RemovePopup, id = ZapError
      22:39:49.052 [e2-core] [SEC] set static current limiting
      22:39:49.113 [e2-core] [SEC] invalidate current switch params
      22:39:49.113 [e2-core] [SEC] setVoltage 2
      22:39:49.114 [e2-core] [SEC] sleep 10ms
      22:39:49.114 [e2-core] child has terminated
      22:39:49.114 [e2-core] pipes closed
      22:39:49.115 [e2-core] child has terminated
      22:39:49.115 [e2-core] pipes closed
      22:39:49.127 [e2-core] child has terminated
      22:39:49.128 [e2-core] pipes closed
      22:39:49.129 [e2-core] child has terminated
      22:39:49.129 [e2-core] pipes closed
      22:39:49.130 [e2-core] child has terminated
      22:39:49.130 [e2-core] pipes closed
      22:39:49.130 [e2-python] [AutoMount.py] CheckMountPointFinished
      22:39:49.131 [e2-python] [AutoMount.py] result mount: RPC: Remote system error - Connection refused
      mount: mounting 192.168.178.10:/media/usb/EPG on /media/net/Wohnzimmer failed: Bad file descriptor
      22:39:49.131 [e2-python]
      22:39:49.131 [e2-python] [AutoMount.py] retval 0
      22:39:49.132 [e2-python] LEN 0
      22:39:49.132 [e2-python] PATH im CheckMountPointFinished /media/net/Wohnzimmer
      22:39:49.133 [e2-core] child has terminated
      22:39:49.133 [e2-core] pipes closed
      22:39:49.168 [e2-core] set sequence pos 3
      22:39:49.181 [e2-core] [SEC] update current switch params
      22:39:49.181 [e2-core] [SEC] startTuneTimeout 5000
      22:39:49.181 [e2-core] [SEC] setFrontend 1
      22:39:49.181 [e2-core] setting frontend 0
      22:39:49.181 [e2-core] [SEC] sleep 500ms
      22:39:49.187 [e2-core] child has terminated
      22:39:49.187 [e2-core] pipes closed
      22:39:49.187 [e2-python] 0.0.0.0
      22:39:49.188 [e2-python] 169.254
      22:39:49.188 [e2-python] 192.168
      22:39:49.189 [e2-core] child has terminated
      22:39:49.189 [e2-core] pipes closed
      22:39:49.195 [e2-python] nameservers: [[192, 168, 178, 1]]
      22:39:49.195 [e2-python] read configured interface: {'lo': {'dhcp': False}, 'eth0': {'dhcp': False}}
      22:39:49.196 [e2-python] self.ifaces after loading: {'wlan0': {'preup': False, 'predown': False, 'ip': [0, 0, 0, 0], 'up': False, 'dns-nameservers': False, 'mac': '7c:dd:90:a0:28:9a', 'dhcp': True, 'netmask': [0, 0, 0, 0], 'gateway': [0, 0, 0, 0]}, 'eth0': {'preup': False, 'predown': False, 'ip': [192, 168, 178, 10], 'up': True, 'dns-nameservers': '\tdns-nameservers 192.168.178.1\n', 'mac': '00:1d:ec:0b:dd:32', 'dhcp': False, 'netmask': [255, 255, 255, 0], 'gateway': [192, 168, 178, 1]}}
      22:39:49.198 [e2-python] AT plugin not found
      22:39:49.198 [e2-python] SerienRecorder plugin not found
      22:39:49.198 [e2-python] ER plugin not found
      22:39:49.199 [e2-core] resolve: resolve ${libdir}/enigma2/python/Plugins/Extensions/WebInterface/plugin.py
      22:39:49.199 [e2-core] resolve: -> /usr/lib/enigma2/python/Plugins/Extensions/WebInterface/plugin.py
      22:39:49.199 [e2-core] resolve: resolve ${libdir}/enigma2/python/Plugins/Extensions/WebInterface
      22:39:49.200 [e2-core] resolve: -> /usr/lib/enigma2/python/Plugins/Extensions/WebInterface
      22:39:49.200 [e2-core] resolve: resolve ${libdir}/enigma2/python/Plugins/Extensions/OpenWebif/pluginshook.src
      22:39:49.200 [e2-core] resolve: -> /usr/lib/enigma2/python/Plugins/Extensions/OpenWebif/pluginshook.src
      22:39:49.204 [e2-python] [OpenWebif] started on 80
      22:39:49.211 [e2-python] [OpenWebif] started on 443
      22:39:49.212 [e2-core] (0)fe event: status 0, inversion off, m_tuning 1
      22:39:49.230 [e2-core] (0)fe event: status 7, inversion off, m_tuning 2
      22:39:49.282 [e2-core] (0)fe event: status 1f, inversion off, m_tuning 3
      22:39:49.282 [e2-core] OURSTATE: ok
      22:39:49.282 [e2-core] [eDVBCAService] channel 0x1ddc068 running
      22:39:49.282 [e2-core] [eDVBLocalTimerHandler] channel 0x1ddc068 running
      22:39:49.282 [e2-core] no version filtering
      22:39:49.282 [e2-core] 0014: 70 00 00 00 00 00
      22:39:49.282 [e2-core] mask: fc 00 00 00 00 00
      22:39:49.282 [e2-core] mode: 00 00 00 00 00 00
      22:39:49.283 [e2-core] [eEPGCache] channel 0x1ddc068 running
      22:39:49.283 [e2-core] [eEPGCache] next update in 2 sec
      22:39:49.284 [e2-core] stop release channel timer
      22:39:49.284 [e2-core] no version filtering
      22:39:49.284 [e2-core] 0012: 4e 28 3d 00 00 00
      22:39:49.284 [e2-core] mask: ff ff ff 00 00 00
      22:39:49.284 [e2-core] mode: 00 00 00 00 00 00
      22:39:49.287 [e2-core] ok ... now we start!!
      22:39:49.287 [e2-core] no version filtering
      22:39:49.287 [e2-core] 0000: 00 00 00 00 00 00
      22:39:49.287 [e2-core] mask: ff 00 00 00 00 00
      22:39:49.287 [e2-core] mode: 00 00 00 00 00 00
      22:39:49.288 [e2-core] eventNewProgramInfo 0 0
      22:39:49.288 [e2-core] [eDVBServiceFCCPlay::updateFCCDecoder][1:0:19:283D:3FB:1:C00000:0:0:0:]
      22:39:49.288 [e2-core] have 1 video stream(s) (13ed), and 1 audio stream(s) (13f2), and the pcr pid is 13ed, and the text pid is 13f0 (Cached)
      22:39:49.288 [e2-core] allocate demux
      22:39:49.293 [e2-core] [eFCCDecoder] scanning for FCC device files..
      22:39:49.293 [e2-core] [eFCCDecoder] /dev/fcc0 found..
      22:39:49.294 [e2-core] [eFCCDecoder] /dev/fcc1 found..
      22:39:49.294 [e2-core] [eFCCDecoder] /dev/fcc2 found..
      22:39:49.294 [e2-core] [eFCCDecoder] /dev/fcc3 found..
      22:39:49.294 [e2-core] [eFCCDecoder] /dev/fcc4 found..
      22:39:49.294 [e2-core] [eFCCDecoder] /dev/fcc5 found..
      22:39:49.294 [e2-core] [eFCCDecoder] /dev/fcc6 found..
      22:39:49.294 [e2-core] [eFCCDecoder] alloc /dev/fcc0
      22:39:49.295 [e2-core] [eTSMPEGDecoder] FCC_START OK!
      22:39:49.295 [e2-core] disable teletext subtitles
      22:39:49.315 [e2-core] [eTSMPEGDecoder] FCC_DECODER_START OK!
      22:39:49.315 [e2-core] decoder state: play, vpid=5101, apid=5106
      22:39:49.315 [e2-core] DMX_SET_PES_FILTER(0x13ed) - pcr - ok
      22:39:49.315 [e2-core] DEMUX_START - pcr - ok
      22:39:49.315 [e2-core] DMX_SET_PES_FILTER(0x13f2) - audio - ok
      22:39:49.315 [e2-core] DEMUX_START - audio - ok
      22:39:49.316 [e2-core] AUDIO_SET_BYPASS(0) - ok
      22:39:49.316 [e2-core] AUDIO_PAUSE - ok
      22:39:49.317 [e2-core] AUDIO_PLAY - ok
      22:39:49.317 [e2-core] Video Device: /dev/dvb/adapter0/video0
      22:39:49.317 [e2-core] demux device: /dev/dvb/adapter0/demux0
      22:39:49.318 [e2-core] DMX_SET_PES_FILTER(0x13f0) - ttx - ok
      22:39:49.318 [e2-core] DEMUX_START - ttx - ok
      22:39:49.320 [e2-core] VIDEO_SLOWMOTION(0) - ok
      22:39:49.321 [e2-core] VIDEO_FAST_FORWARD(0) - ok
      22:39:49.321 [e2-core] VIDEO_CONTINUE - ok
      22:39:49.321 [e2-core] AUDIO_CONTINUE - ok
      22:39:49.321 [e2-core] AUDIO_CHANNEL_SELECT(0) - ok
      22:39:49.322 [e2-python] not pauseable.
      22:39:49.335 [e2-core] allocate channel.. 03f3:0001
      22:39:49.336 [e2-core] available channel.. 03fb:0001
      22:39:49.336 [e2-core] opening frontend 2
      22:39:49.341 [e2-core] [eDVBCAService] new channel 0x2ac4190!
      22:39:49.341 [e2-core] (2)tune
      22:39:49.341 [e2-core] RotorCmd ffffffff, lastRotorCmd ffffffff
      22:39:49.341 [e2-core] prepare_sat System 1 Freq 11361750 Pol 0 SR 22000000 INV 2 FEC 2 orbpos 192 system 1 modulation 2 pilot 2, rolloff 0
      22:39:49.341 [e2-core] tuning to 1611 mhz
      22:39:49.341 [e2-core] OURSTATE: tuning
      22:39:49.341 [e2-core] allocate Channel: res 0
      22:39:49.341 [e2-core] allocate demux
      22:39:49.342 [e2-core] resolve: resolve ${sysconfdir}/scan_tp_valid_check.py
      22:39:49.342 [e2-core] resolve: -> /etc/scan_tp_valid_check.py
      22:39:49.342 [e2-core] [SEC] set static current limiting
      22:39:49.342 [e2-core] [SEC] invalidate current switch params
      22:39:49.342 [e2-core] set sequence pos 3
      22:39:49.343 [e2-core] set sequence pos 3
      22:39:49.343 [e2-core] [SEC] update current switch params
      22:39:49.343 [e2-core] [SEC] startTuneTimeout 5000
      22:39:49.343 [e2-core] [SEC] setFrontend 1
      22:39:49.343 [e2-core] setting frontend 2
      22:39:49.343 [e2-core] [SEC] sleep 500ms
      22:39:49.344 [e2-core] + 1/1 TID 00
      22:39:49.344 [e2-core] done!
      22:39:49.345 [e2-core] PATready
      22:39:49.345 [e2-core] use pmtpid 13ec for service_id 283d
      22:39:49.345 [e2-core] no version filtering
      22:39:49.345 [e2-core] 13ec: 02 28 3d 00 00 00
      22:39:49.346 [e2-core] mask: ff ff ff 00 00 00
      22:39:49.346 [e2-core] mode: 00 00 00 00 00 00
      22:39:49.346 [e2-core] doing version filtering
      22:39:49.346 [e2-core] 0000: 00 00 00 05 00 00
      22:39:49.346 [e2-core] mask: ff 00 00 3f 00 00
      22:39:49.346 [e2-core] mode: 00 00 00 3e 00 00
      22:39:49.347 [e2-core] VIDEO_GET_EVENT - ok
      22:39:49.348 [e2-core] (2)fe event: status 0, inversion off, m_tuning 1
      22:39:49.364 [e2-core] -+ 1/2 TID 4e
      22:39:49.376 [e2-core] [eDVBLocalTimerHandler] diff is 4
      22:39:49.376 [e2-core] [eDVBLocalTimerHandler] diff < 120 .. use Transponder Time
      22:39:49.480 [e2-core] [eDVBLocalTimerHandler] update RTC
      22:39:49.480 [e2-core] [eDVBLocalTimerHandler] time update to 22:39:53
      22:39:49.480 [e2-core] [eDVBLocalTimerHandler] m_time_difference is 4
      22:39:49.480 [e2-core] [eDVBLocalTimerHandler] set Linux Time
      22:39:53.483 [e2-core] + 1/1 TID 02
      22:39:53.483 [e2-core] done!
      22:39:53.484 [e2-core] eventNewProgramInfo 0 0
      22:39:53.484 [e2-core] [eDVBServiceFCCPlay::updateFCCDecoder][1:0:19:283D:3FB:1:C00000:0:0:0:]
      22:39:53.484 [e2-core] no version filtering
      22:39:53.484 [e2-core] 0492: 74 00 00 00 00 00
      22:39:53.484 [e2-core] mask: ff 00 00 00 00 00
      22:39:53.485 [e2-core] mode: 00 00 00 00 00 00
      22:39:53.485 [e2-core] dvb subtitle PID 13f1 with wrong subtitling type (24)... force 0x10!!
      22:39:53.485 [e2-core] Rds PID 13f4 detected ? ! ?
      22:39:53.486 [e2-core] 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
      22:39:53.486 [e2-core] disable teletext subtitles
      22:39:53.486 [e2-core] decoder state: play, vpid=5101, apid=5106
      22:39:53.489 [e2-core] no version filtering
      22:39:53.489 [e2-core] 0492: 74 00 00 00 00 00
      22:39:53.489 [e2-core] mask: ff 00 00 00 00 00
      22:39:53.489 [e2-core] mode: 00 00 00 00 00 00
      22:39:53.490 [e2-core] dvb subtitle PID 13f1 with wrong subtitling type (24)... force 0x10!!
      22:39:53.490 [e2-core] Rds PID 13f4 detected ? ! ?
      22:39:53.496 [e2-core] [eDVBCAService] new service 1:0:19:283D:3FB:1:C00000:0:0:0:
      22:39:53.496 [e2-core] [eDVBCAService] add demux 0 to slot 0 service 1:0:19:283D:3FB:1:C00000:0:0:0:
      22:39:53.496 [e2-core] demux 0 mask 01 prevhash 00000000
      22:39:53.497 [e2-core] [eDVBCAService] send 84 bytes
      22:39:53.497 [e2-core] 9f 80 32 50 03 28 3d 07 00 13 01 81 08 00 c0 00 00 03 fb 00 01 82 02 01 00 84 02 13 ec 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
      22:39:53.498 [e2-core] doing version filtering
      22:39:53.498 [e2-core] 13ec: 02 28 3d 07 00 00
      22:39:53.498 [e2-core] mask: ff ff ff 3f 00 00
      22:39:53.498 [e2-core] mode: 00 00 00 3e 00 00
      22:39:53.499 [e2-core] (2)fe event: status 7, inversion off, m_tuning 2
      22:39:53.499 [e2-core] (2)fe event: status 1f, inversion off, m_tuning 3
      22:39:53.499 [e2-core] OURSTATE: ok
      22:39:53.499 [e2-core] [eDVBCAService] channel 0x2ac4190 running
      22:39:53.499 [e2-core] [eDVBLocalTimerHandler] channel 0x2ac4190 running
      22:39:53.499 [e2-core] no version filtering
      22:39:53.500 [e2-core] 0014: 70 00 00 00 00 00
      22:39:53.500 [e2-core] mask: fc 00 00 00 00 00
      22:39:53.500 [e2-core] mode: 00 00 00 00 00 00
      22:39:53.500 [e2-core] [eEPGCache] channel 0x2ac4190 running
      22:39:53.500 [e2-core] [eEPGCache] next update in 2 sec
      22:39:53.500 [e2-core] stop release channel timer
      22:39:53.501 [e2-core] no version filtering
      22:39:53.501 [e2-core] 0012: 4e 2b 66 00 00 00
      22:39:53.501 [e2-core] mask: ff ff ff 00 00 00
      22:39:53.501 [e2-core] mode: 00 00 00 00 00 00
      22:39:53.501 [e2-core] ok ... now we start!!
      22:39:53.502 [e2-core] no version filtering
      22:39:53.502 [e2-core] 0000: 00 00 00 00 00 00
      22:39:53.502 [e2-core] mask: ff 00 00 00 00 00
      22:39:53.502 [e2-core] mode: 00 00 00 00 00 00
      22:39:53.502 [e2-core] eventNewProgramInfo 0 0
      22:39:53.502 [e2-core] [eDVBServiceFCCPlay::updateFCCDecoder][1:0:19:2B66:3F3:1:C00000:0:0:0:]
      22:39:53.502 [e2-core] have 1 video stream(s) (17de), and 1 audio stream(s) (17ea), and the pcr pid is 17de, and the text pid is 17f2 (Cached)
      22:39:53.502 [e2-core] allocate demux
      22:39:53.503 [e2-core] [eFCCDecoder] alloc /dev/fcc1
      22:39:53.503 [e2-core] [eTSMPEGDecoder] FCC_START OK!
      22:39:53.508 [e2-core] allocate channel.. 000e:0085
      22:39:53.509 [e2-core] available channel.. 03fb:0001
      22:39:53.509 [e2-core] available channel.. 03f3:0001
      22:39:53.510 [e2-core] opening frontend 1
      22:39:53.514 [e2-core] [eDVBCAService] new channel 0x2a4bad8!
      22:39:53.515 [e2-core] (1)tune
      22:39:53.515 [e2-core] RotorCmd ffffffff, lastRotorCmd ffffffff
      22:39:53.515 [e2-core] prepare_sat System 1 Freq 11875500 Pol 0 SR 27500000 INV 2 FEC 3 orbpos 192 system 1 modulation 2 pilot 2, rolloff 0
      22:39:53.515 [e2-core] tuning to 1275 mhz
      22:39:53.515 [e2-core] OURSTATE: tuning
      22:39:53.515 [e2-core] allocate Channel: res 0
      22:39:53.516 [e2-core] allocate demux
      22:39:53.516 [e2-core] resolve: resolve ${sysconfdir}/scan_tp_valid_check.py
      22:39:53.516 [e2-core] resolve: -> /etc/scan_tp_valid_check.py
      22:39:53.516 [e2-core] [SEC] set static current limiting
      22:39:53.517 [e2-core] [SEC] invalidate current switch params
      22:39:53.517 [e2-core] [SEC] setVoltage 2
      22:39:53.517 [e2-core] [SEC] sleep 10ms
      22:39:53.536 [e2-core] [SEC] setTone 1
      22:39:53.537 [e2-core] [SEC] sleep 10ms
      22:39:53.541 [e2-core] + 1/1 TID 00
      22:39:53.541 [e2-core] done!
      22:39:53.542 [e2-core] PATready
      22:39:53.542 [e2-core] use pmtpid 17d4 for service_id 2b66
      22:39:53.542 [e2-core] no version filtering
      22:39:53.542 [e2-core] 17d4: 02 2b 66 00 00 00
      22:39:53.542 [e2-core] mask: ff ff ff 00 00 00
      22:39:53.542 [e2-core] mode: 00 00 00 00 00 00
      22:39:53.543 [e2-core] doing version filtering
      22:39:53.543 [e2-core] 0000: 00 00 00 01 00 00
      22:39:53.543 [e2-core] mask: ff 00 00 3f 00 00
      22:39:53.543 [e2-core] mode: 00 00 00 3e 00 00
      22:39:53.547 [e2-core] [SEC] update current switch params
      22:39:53.548 [e2-core] [SEC] startTuneTimeout 5000
      22:39:53.548 [e2-core] [SEC] setFrontend 1
      22:39:53.548 [e2-core] setting frontend 1
      22:39:53.548 [e2-core] [SEC] sleep 500ms
      22:39:53.601 [e2-core] (1)fe event: status 0, inversion off, m_tuning 1
      22:39:53.601 [e2-core] + 1/1 TID 02
      22:39:53.602 [e2-core] done!
      22:39:53.602 [e2-core] eventNewProgramInfo 0 0
      22:39:53.602 [e2-core] [eDVBServiceFCCPlay::updateFCCDecoder][1:0:19:2B66:3F3:1:C00000:0:0:0:]
      22:39:53.603 [e2-core] dvb subtitle PID 17f3 with wrong subtitling type (24)... force 0x10!!
      22:39:53.603 [e2-core] no version filtering
      22:39:53.603 [e2-core] 181a: 74 00 00 00 00 00
      22:39:53.603 [e2-core] mask: ff 00 00 00 00 00
      22:39:53.603 [e2-core] mode: 00 00 00 00 00 00
      22:39:53.604 [e2-core] have 1 video stream(s) (17de), and 4 audio stream(s) (17e8, 17e9, 17ea, 17eb), and the pcr pid is 17de, and the text pid is 17f2
      22:39:53.604 [e2-core] [eDVBCAService] new service 1:0:19:2B66:3F3:1:C00000:0:0:0:
      22:39:53.604 [e2-core] [eDVBCAService] add demux 1 to slot 0 service 1:0:19:2B66:3F3:1:C00000:0:0:0:
      22:39:53.604 [e2-core] demux 1 mask 02 prevhash 00000000
      22:39:53.605 [e2-core] [eDVBCAService] send 74 bytes
      22:39:53.605 [e2-core] 9f 80 32 46 03 2b 66 03 00 13 01 81 08 00 c0 00 00 03 f3 00 01 82 02 02 01 84 02 17 d4 1b 17 de 00 00 03 17 e8 00 00 03 17 e9 00 00 06 17 ea 00 00 03 17 eb 00 00 06 17 f2 00 00 06 17 f3 00 00 06 17 f4 00 00 05 18 1a 00 00
      22:39:53.606 [e2-core] doing version filtering
      22:39:53.606 [e2-core] 17d4: 02 2b 66 03 00 00
      22:39:53.606 [e2-core] mask: ff ff ff 3f 00 00
      22:39:53.606 [e2-core] mode: 00 00 00 3e 00 00
      22:39:53.612 [e2-core] sdt update done!
      22:39:53.650 [e2-core] (1)fe event: status 7, inversion off, m_tuning 2
      22:39:53.682 [e2-core] [SEC] set dynamic current limiting
      22:39:53.701 [e2-core] (1)fe event: status 1f, inversion off, m_tuning 3
      22:39:53.702 [e2-core] OURSTATE: ok
      22:39:53.702 [e2-core] [eDVBCAService] channel 0x2a4bad8 running
      22:39:53.702 [e2-core] [eDVBLocalTimerHandler] channel 0x2a4bad8 running
      22:39:53.702 [e2-core] no version filtering
      22:39:53.702 [e2-core] 0014: 70 00 00 00 00 00
      22:39:53.702 [e2-core] mask: fc 00 00 00 00 00
      22:39:53.702 [e2-core] mode: 00 00 00 00 00 00
      22:39:53.703 [e2-core] [eEPGCache] channel 0x2a4bad8 running
      22:39:53.703 [e2-core] [eEPGCache] next update in 2 sec
      22:39:53.703 [e2-core] stop release channel timer
      22:39:53.703 [e2-core] no version filtering
      22:39:53.703 [e2-core] 0012: 4e 01 04 00 00 00
      22:39:53.703 [e2-core] mask: ff ff ff 00 00 00
      22:39:53.704 [e2-core] mode: 00 00 00 00 00 00
      22:39:53.704 [e2-core] ok ... now we start!!
      22:39:53.704 [e2-core] no version filtering
      22:39:53.705 [e2-core] 0000: 00 00 00 00 00 00
      22:39:53.705 [e2-core] mask: ff 00 00 00 00 00
      22:39:53.705 [e2-core] mode: 00 00 00 00 00 00
      22:39:53.707 [e2-core] allocate channel.. 0425:0001
      22:39:53.707 [e2-core] available channel.. 03fb:0001
      22:39:53.707 [e2-core] available channel.. 03f3:0001
      22:39:53.708 [e2-core] available channel.. 000e:0085
      22:39:53.708 [e2-core] opening frontend 3
      22:39:53.711 [e2-core] [eDVBCAService] new channel 0x2a5b120!
      22:39:53.711 [e2-core] (3)tune
      22:39:53.711 [e2-core] RotorCmd ffffffff, lastRotorCmd ffffffff
      22:39:53.712 [e2-core] prepare_sat System 1 Freq 10891250 Pol 0 SR 22000000 INV 2 FEC 2 orbpos 192 system 1 modulation 2 pilot 2, rolloff 0
      22:39:53.712 [e2-core] tuning to 1141 mhz
      22:39:53.712 [e2-core] OURSTATE: tuning
      22:39:53.712 [e2-core] allocate Channel: res 0
      22:39:53.712 [e2-core] allocate demux
      22:39:53.712 [e2-core] resolve: resolve ${sysconfdir}/scan_tp_valid_check.py
      22:39:53.713 [e2-core] resolve: -> /etc/scan_tp_valid_check.py
      22:39:53.715 [e2-core] [SEC] set static current limiting
      22:39:53.715 [e2-core] [SEC] invalidate current switch params
      22:39:53.716 [e2-core] set sequence pos 3
      22:39:53.716 [e2-core] set sequence pos 3
      22:39:53.716 [e2-core] [SEC] update current switch params
      22:39:53.716 [e2-core] [SEC] startTuneTimeout 5000
      22:39:53.716 [e2-core] [SEC] setFrontend 1
      22:39:53.716 [e2-core] setting frontend 3
      22:39:53.716 [e2-core] [SEC] sleep 500ms
      22:39:53.718 [e2-core] (3)fe event: status 0, inversion off, m_tuning 1
      22:39:53.755 [e2-core] [eDVBLocalTimerHandler] diff is 1
      22:39:53.756 [e2-core] [eDVBLocalTimerHandler] diff < 120 .. use Transponder Time
      22:39:53.860 [e2-core] [eDVBLocalTimerHandler] update RTC
      22:39:53.860 [e2-core] [eDVBLocalTimerHandler] time update to 22:39:54
      22:39:53.860 [e2-core] [eDVBLocalTimerHandler] m_time_difference is 1
      22:39:53.860 [e2-core] [eDVBLocalTimerHandler] set Linux Time
      22:39:54.862 [e2-core] [SEC] set dynamic current limiting
      22:39:54.880 [e2-core] +- 1/2 TID 4e
      22:39:54.880 [e2-core] + 1/1 TID 00
      22:39:54.881 [e2-core] done!
      22:39:54.881 [e2-core] PATready
      22:39:54.881 [e2-core] no PAT entry found.. start delay
      22:39:54.881 [e2-core] doing version filtering
      22:39:54.881 [e2-core] 0000: 00 00 00 11 00 00
      22:39:54.881 [e2-core] mask: ff 00 00 3f 00 00
      22:39:54.881 [e2-core] mode: 00 00 00 3e 00 00
      22:39:54.882 [e2-core] (3)fe event: status 7, inversion off, m_tuning 2
      22:39:54.883 [e2-core] (3)fe event: status 1f, inversion off, m_tuning 3
      22:39:54.883 [e2-core] OURSTATE: ok
      22:39:54.883 [e2-core] [eDVBCAService] channel 0x2a5b120 running
      22:39:54.883 [e2-core] [eDVBLocalTimerHandler] channel 0x2a5b120 running
      22:39:54.883 [e2-core] no version filtering
      22:39:54.883 [e2-core] 0014: 70 00 00 00 00 00
      22:39:54.883 [e2-core] mask: fc 00 00 00 00 00
      22:39:54.883 [e2-core] mode: 00 00 00 00 00 00
      22:39:54.883 [e2-core] [eEPGCache] channel 0x2a5b120 running
      22:39:54.884 [e2-core] [eEPGCache] next update in 2 sec
      22:39:54.884 [e2-core] stop release channel timer
      22:39:54.884 [e2-core] no version filtering
      22:39:54.884 [e2-core] 0012: 4e 28 73 00 00 00
      22:39:54.884 [e2-core] mask: ff ff ff 00 00 00
      22:39:54.885 [e2-core] mode: 00 00 00 00 00 00
      22:39:54.885 [e2-core] ok ... now we start!!
      22:39:54.885 [e2-core] no version filtering
      22:39:54.885 [e2-core] 0000: 00 00 00 00 00 00
      22:39:54.885 [e2-core] mask: ff 00 00 00 00 00
      22:39:54.885 [e2-core] mode: 00 00 00 00 00 00
      22:39:54.886 [e2-core] eventNewProgramInfo 0 0
      22:39:54.886 [e2-core] [eDVBServiceFCCPlay::updateFCCDecoder][1:0:19:2873:425:1:C00000:0:0:0:]
      22:39:54.886 [e2-core] have 1 video stream(s) (14e7), and 1 audio stream(s) (14ec), and the pcr pid is 14e7, and the text pid is 14ea (Cached)
      22:39:54.886 [e2-core] allocate demux
      22:39:54.886 [e2-core] [eFCCDecoder] alloc /dev/fcc2
      22:39:54.887 [e2-core] [eTSMPEGDecoder] FCC_START OK!
      22:39:54.889 [e2-core] allocate channel.. 000a:0085
      22:39:54.890 [e2-core] available channel.. 03fb:0001
      22:39:54.890 [e2-core] available channel.. 03f3:0001
      22:39:54.890 [e2-core] available channel.. 000e:0085
      22:39:54.890 [e2-core] available channel.. 0425:0001
      22:39:54.890 [e2-core] opening frontend 4
      22:39:54.893 [e2-core] [eDVBCAService] new channel 0x2a65f98!
      22:39:54.894 [e2-core] (4)tune
      22:39:54.894 [e2-core] RotorCmd ffffffff, lastRotorCmd ffffffff
      22:39:54.894 [e2-core] prepare_sat System 1 Freq 11332250 Pol 0 SR 22000000 INV 2 FEC 3 orbpos 192 system 1 modulation 2 pilot 2, rolloff 0
      22:39:54.894 [e2-core] tuning to 1582 mhz
      22:39:54.894 [e2-core] OURSTATE: tuning
      22:39:54.894 [e2-core] allocate Channel: res 0
      22:39:54.894 [e2-core] allocate demux
      22:39:54.894 [e2-core] resolve: resolve ${sysconfdir}/scan_tp_valid_check.py
      22:39:54.894 [e2-core] resolve: -> /etc/scan_tp_valid_check.py
      22:39:54.895 [e2-core] [SEC] set static current limiting
      22:39:54.896 [e2-core] [SEC] invalidate current switch params
      22:39:54.896 [e2-core] set sequence pos 3
      22:39:54.896 [e2-core] set sequence pos 3
      22:39:54.896 [e2-core] [SEC] update current switch params
      22:39:54.896 [e2-core] [SEC] startTuneTimeout 5000
      22:39:54.896 [e2-core] [SEC] setFrontend 1
      22:39:54.897 [e2-core] setting frontend 4
      22:39:54.897 [e2-core] [SEC] sleep 500ms
      22:39:54.910 [e2-core] (4)fe event: status 0, inversion off, m_tuning 1
      22:39:54.950 [e2-core] + 1/1 TID 74
      22:39:54.950 [e2-core] done!
      22:39:54.950 [e2-core] AITready
      22:39:54.951 [e2-core] Section Length : 436, Total Section Length : 439
      22:39:54.951 [e2-core] found applicaions ids >> pid : 181a, orgid : 17, appid : 1
      22:39:54.951 [e2-core] Save Data Len : [439]
      22:39:54.951 [e2-core] found applicaions ids >> pid : 181a, orgid : 17, appid : 2
      22:39:54.951 [e2-core] found applicaions ids >> pid : 181a, orgid : 17, appid : 7
      22:39:54.951 [e2-core] found applicaions ids >> pid : 181a, orgid : 17, appid : 6
      22:39:54.951 [e2-core] found applicaions ids >> pid : 181a, orgid : 17, appid : 4
      22:39:54.951 [e2-core] Found : control[1], name[ZDF start], url[index.php]
      22:39:54.951 [e2-core] Found : control[2], name[ZDF mediathek], url[ZDF mediathek HbbTV]
      22:39:54.951 [e2-core] Found : control[2], name[ZDF nachrichten], url[index.php]
      22:39:54.952 [e2-core] Found : control[2], name[ZDF programm], url[index.php]
      22:39:54.952 [e2-core] Found : control[2], name[ZDF Olympia], url[index.php?zdf=1]
      22:39:54.952 [e2-core] (4)fe event: status 7, inversion off, m_tuning 2
      22:39:55.010 [e2-core] (4)fe event: status 1f, inversion off, m_tuning 3
      22:39:55.010 [e2-core] OURSTATE: ok
      22:39:55.011 [e2-core] [eDVBCAService] channel 0x2a65f98 running
      22:39:55.011 [e2-core] [eDVBLocalTimerHandler] channel 0x2a65f98 running
      22:39:55.011 [e2-core] no version filtering
      22:39:55.011 [e2-core] 0014: 70 00 00 00 00 00
      22:39:55.011 [e2-core] mask: fc 00 00 00 00 00
      22:39:55.011 [e2-core] mode: 00 00 00 00 00 00
      22:39:55.011 [e2-core] [eEPGCache] channel 0x2a65f98 running
      22:39:55.012 [e2-core] [eEPGCache] next update in 2 sec
      22:39:55.012 [e2-core] stop release channel timer
      22:39:55.012 [e2-core] no version filtering
      22:39:55.012 [e2-core] 0012: 4e 01 54 00 00 00
      22:39:55.012 [e2-core] mask: ff ff ff 00 00 00
      22:39:55.012 [e2-core] mode: 00 00 00 00 00 00
      22:39:55.013 [e2-core] ok ... now we start!!
      22:39:55.013 [e2-core] no version filtering
      22:39:55.013 [e2-core] 0000: 00 00 00 00 00 00
      22:39:55.013 [e2-core] mask: ff 00 00 00 00 00
      22:39:55.013 [e2-core] mode: 00 00 00 00 00 00
      22:39:55.030 [e2-core] +- 1/2 TID 4e
      22:39:55.030 [e2-core] + 1/1 TID 00
      22:39:55.030 [e2-core] done!
      22:39:55.031 [e2-core] PATready
      22:39:55.031 [e2-core] use pmtpid 14e6 for service_id 2873
      22:39:55.031 [e2-core] no version filtering
      22:39:55.031 [e2-core] 14e6: 02 28 73 00 00 00
      22:39:55.031 [e2-core] mask: ff ff ff 00 00 00
      22:39:55.031 [e2-core] mode: 00 00 00 00 00 00
      22:39:55.031 [e2-core] doing version filtering
      22:39:55.031 [e2-core] 0000: 00 00 00 05 00 00
      22:39:55.031 [e2-core] mask: ff 00 00 3f 00 00
      22:39:55.032 [e2-core] mode: 00 00 00 3e 00 00
      22:39:55.050 [e2-core] +- 1/2 TID 4e
      22:39:55.050 [e2-core] + 1/1 TID 00
      22:39:55.050 [e2-core] done!
      22:39:55.051 [e2-core] PATready
      22:39:55.051 [e2-core] no PAT entry found.. start delay
      22:39:55.051 [e2-core] doing version filtering
      22:39:55.051 [e2-core] 0000: 00 00 00 27 00 00
      22:39:55.051 [e2-core] mask: ff 00 00 3f 00 00
      22:39:55.051 [e2-core] mode: 00 00 00 3e 00 00
      22:39:55.053 [e2-core] [SEC] set dynamic current limiting
      22:39:55.150 [e2-core] + 1/1 TID 02
      22:39:55.150 [e2-core] done!
      22:39:55.150 [e2-core] eventNewProgramInfo 0 0
      22:39:55.150 [e2-core] [eDVBServiceFCCPlay::updateFCCDecoder][1:0:19:2873:425:1:C00000:0:0:0:]
      22:39:55.150 [e2-core] no version filtering
      22:39:55.151 [e2-core] 08de: 74 00 00 00 00 00
      22:39:55.151 [e2-core] mask: ff 00 00 00 00 00
      22:39:55.151 [e2-core] mode: 00 00 00 00 00 00
      22:39:55.151 [e2-core] dvb subtitle PID 14eb with wrong subtitling type (24)... force 0x10!!
      22:39:55.151 [e2-core] have 1 video stream(s) (14e7), and 3 audio stream(s) (14e8, 14e9, 14ec), and the pcr pid is 14e7, and the text pid is 14ea
      22:39:55.152 [e2-core] [eDVBCAService] new service 1:0:19:2873:425:1:C00000:0:0:0:
      22:39:55.152 [e2-core] [eDVBCAService] add demux 3 to slot 0 service 1:0:19:2873:425:1:C00000:0:0:0:
      22:39:55.152 [e2-core] demux 3 mask 08 prevhash 00000000
      22:39:55.152 [e2-core] [eDVBCAService] send 74 bytes
      22:39:55.152 [e2-core] 9f 80 32 46 03 28 73 05 00 13 01 81 08 00 c0 00 00 04 25 00 01 82 02 08 03 84 02 14 e6 1b 14 e7 00 00 03 14 e8 00 00 03 14 e9 00 00 06 14 ea 00 00 06 14 ec 00 00 0b 08 7b 00 00 05 08 de 00 00 0c 08 e4 00 00 06 14 eb 00 00
      22:39:55.153 [e2-core] doing version filtering
      22:39:55.153 [e2-core] 14e6: 02 28 73 05 00 00
      22:39:55.153 [e2-core] mask: ff ff ff 3f 00 00
      22:39:55.153 [e2-core] mode: 00 00 00 3e 00 00
      22:39:55.230 [e2-core] ++ 2/2 TID 4e
      22:39:55.230 [e2-core] done!
      22:39:55.230 [e2-core] doing version filtering
      22:39:55.231 [e2-core] 0012: 4e 2b 66 2f 00 00
      22:39:55.231 [e2-core] mask: ff ff ff 3f 00 00
      22:39:55.231 [e2-core] mode: 00 00 00 3e 00 00
      22:39:55.232 [e2-core] [SEC] set dynamic current limiting
      22:39:55.290 [e2-core] [eDVBLocalTimerHandler] diff is -1
      22:39:55.290 [e2-core] [eDVBLocalTimerHandler] diff < 120 .. use Transponder Time
      22:39:55.400 [e2-core] [eDVBLocalTimerHandler] update RTC
      22:39:55.400 [e2-core] [eDVBLocalTimerHandler] time update to 22:39:54
      22:39:55.400 [e2-core] [eDVBLocalTimerHandler] m_time_difference is -1
      22:39:55.400 [e2-core] [eDVBLocalTimerHandler] set Linux Time
      22:39:55.409 [e2-core] [SEC] set dynamic current limiting
      22:39:55.431 [e2-core] ++ 2/2 TID 4e
      22:39:55.431 [e2-core] done!
      22:39:55.432 [e2-core] doing version filtering
      22:39:55.432 [e2-core] 0012: 4e 28 73 0f 00 00
      22:39:55.432 [e2-core] mask: ff ff ff 3f 00 00
      22:39:55.432 [e2-core] mode: 00 00 00 3e 00 00
      22:39:55.494 [e2-core] sdt update done!
      22:39:55.859 [e2-core] +- 1/2 TID 4e
      22:39:55.879 [e2-core] DVB service failed to tune - error 3
      22:39:55.880 [e2-core] [eFCCServiceManager][1:0:19:104:E:85:C00000:0:0:0:] set service to state failed.
      22:39:55.880 [e2-core] [eFCCServiceManager] stop FCC service sref : 1:0:19:104:E:85:C00000:0:0:0:
      22:39:55.881 [e2-core] [eDVBCAService] remove channel 0x2a4bad8
      22:39:55.881 [e2-core] [eDVBLocalTimerHandler] remove channel 0x2a4bad8
      22:39:55.882 [e2-core] [eEPGCache] remove channel 0x2a4bad8
      22:39:56.005 [e2-core] sdt update done!
      22:39:56.059 [e2-core] DVB service failed to tune - error 3
      22:39:56.060 [e2-core] [eFCCServiceManager][1:0:19:154:A:85:C00000:0:0:0:] set service to state failed.
      22:39:56.060 [e2-core] [eFCCServiceManager] stop FCC service sref : 1:0:19:154:A:85:C00000:0:0:0:
      22:39:56.061 [e2-core] start release channel timer
      22:39:56.240 [e2-core] + 1/1 TID 74
      22:39:56.240 [e2-core] done!
      22:39:56.240 [e2-core] AITready
      22:39:56.240 [e2-core] Section Length : 867, Total Section Length : 870
      22:39:56.240 [e2-core] found applicaions ids >> pid : ffffffff, orgid : 19, appid : 1
      22:39:56.241 [e2-core] Save Data Len : [870]
      22:39:56.241 [e2-core] no version filtering
      22:39:56.241 [e2-core] 087b: 3c 00 00 00 00 00
      22:39:56.241 [e2-core] mask: ff 00 00 00 00 00
      22:39:56.241 [e2-core] mode: 00 00 00 00 00 00
      22:39:56.242 [e2-core] found applicaions ids >> pid : ffffffff, orgid : 19, appid : 2
      22:39:56.242 [e2-core] found applicaions ids >> pid : ffffffff, orgid : 19, appid : 5
      22:39:56.242 [e2-core] found applicaions ids >> pid : ffffffff, orgid : 19, appid : 54
      22:39:56.242 [e2-core] found applicaions ids >> pid : ffffffff, orgid : 19, appid : 20
      22:39:56.242 [e2-core] found applicaions ids >> pid : ffffffff, orgid : 19, appid : 27
      22:39:56.242 [e2-core] found applicaions ids >> pid : ffffffff, orgid : 19, appid : 35
      22:39:56.242 [e2-core] found applicaions ids >> pid : ffffffff, orgid : 19, appid : 3
      22:39:56.242 [e2-core] found applicaions ids >> pid : ffffffff, orgid : 19, appid : 56
      22:39:56.242 [e2-core] Found : control[1], name[HBBTV-Start-DSMCC+Web], url[index.html]
      22:39:56.242 [e2-core] Found : control[2], name[EPG], url[index.php]
      22:39:56.243 [e2-core] Found : control[2], name[Tagesschau], url[tagesschau.de/hbbtv]
      22:39:56.243 [e2-core] Found : control[2], name[HR Mediathek], url[?devicegroup=hbbtv&client=hr]
      22:39:56.243 [e2-core] Found : control[2], name[Mediathek DasErste], url[index.php]
      22:39:56.243 [e2-core] Found : control[2], name[HBBTV NDR-Mediathek], url[NDR HbbTV Mediathek]
      22:39:56.243 [e2-core] Found : control[2], name[BR-Mediathek], url[BR Mediathek für HbbTV]
      22:39:56.243 [e2-core] Found : control[2], name[HBBTV ARD-Mediathek], url[?devicegroup=hbbtv]
      22:39:56.243 [e2-core] Found : control[2], name[HbbTV SR Mediathek], url[index.php]
      22:39:56.275 [e2-core] [eEPGCache] start caching events(1475354396)
      22:39:56.491 [e2-core] [eEPGCache] start caching events(1475354396)
      22:39:56.874 [e2-core] [eEPGCache] start caching events(1475354396)
      22:39:57.003 [e2-core] [eEPGCache] start caching events(1475354397)
      22:39:57.290 [e2-core] Sky NDS CI Plus Modul-+ 1/2 TID 4e
      22:39:57.370 [e2-core] VIDEO_GET_EVENT - ok
      22:39:57.390 [e2-core] VIDEO_GET_EVENT - ok
      22:39:57.391 [e2-python] [AutoFramerate] got framerate: 50000
      22:39:57.428 [e2-python] [AutoFramerate] set resolution/framerate: 1080p50
      22:39:57.450 [e2-core] VIDEO_GET_EVENT - ok
      22:39:57.470 [e2-core] -+ 1/2 TID 74
      22:39:57.630 [e2-core] [eDVBLocalTimerHandler] diff is -2
      22:39:57.630 [e2-core] [eDVBLocalTimerHandler] diff < 120 .. use Transponder Time
      22:39:57.740 [e2-core] [eDVBLocalTimerHandler] update RTC
      22:39:57.740 [e2-core] [eDVBLocalTimerHandler] time update to 22:39:55
      22:39:57.740 [e2-core] [eDVBLocalTimerHandler] m_time_difference is -2
      22:39:57.740 [e2-core] [eDVBLocalTimerHandler] set Linux Time
      22:39:57.839 [e2-core] -------+ 1/8 TID 3c
      22:39:57.844 [e2-core] [eEPGCache] update begin time --> 1475352300 for external source event with id 18481
      22:39:57.989 [e2-core] ++ 2/2 TID 4e
      22:39:57.990 [e2-core] done!
      22:39:57.995 [e2-python] looking for Extended Data EventID: 54039
      22:39:57.996 [e2-python] Extended Data Event found
      22:39:57.996 [e2-python] Event has Extended Data: {"title":"Spiel f\u00fcr dein Land","subtitle":"Der gro\u00dfe L\u00e4nderwettstreit","airtime":1475345700,"categoryName":"Unterhaltung","genre":"Quizshow","year":"2016","isNew":"","country":"D","ageRating":"","season":"","episode":"4","channelid":"1","isLastEpisode":"","highlightCategory":"Top Tipp","image":"http:\/\/images.tvmovie.de\/220x142\/North\/a229d040-870e-11e6-a937-991b0ab5d171-1.jpg","imagebase":"","showviewNumber":"","conclusion":"Deutschland gewann die Show bislang schon 2 Mal","isDolbyDigital":"","movieStarValue":"","ratings":"","leadText":"Drei Nationen k\u00e4mpfen um 50.000 Euro","search":"","id":"94709524"}
      22:39:58.006 [e2-python] looking for Extended Data EventID: 54040
      22:39:58.007 [e2-python] Extended Data Event found
      22:39:58.007 [e2-python] Event has Extended Data: {"title":"Tagesthemen","subtitle":"Mit Wetter","airtime":1475356500,"categoryName":"Reportage","genre":"Nachrichtenmagazin","year":"2016","isNew":"","country":"D","ageRating":"","season":"","episode":"","channelid":"1","isLastEpisode":"","highlightCategory":"","image":"","imagebase":"","showviewNumber":"","conclusion":"","isDolbyDigital":"","movieStarValue":"","ratings":"","leadText":"","search":"","id":"94709434"}
      22:39:58.019 [e2-core] doing version filtering
      22:39:58.020 [e2-core] 0012: 4e 28 3d 2b 00 00
      22:39:58.020 [e2-core] mask: ff ff ff 3f 00 00
      22:39:58.020 [e2-core] mode: 00 00 00 3e 00 00
      22:39:58.319 [e2-core] kaputt max(3) < ssize(8) || nr(2) >= max(3)
      22:39:58.360 [e2-core] ++ 2/2 TID 74
      22:39:58.360 [e2-core] done!
      22:39:58.360 [e2-core] AITready
      22:39:58.360 [e2-core] Section Length : 1018, Total Section Length : 1021
      22:39:58.360 [e2-core] found applicaions ids >> pid : ffffffff, orgid : 19, appid : 1
      22:39:58.361 [e2-core] last_section_number 1 > section_number 0
      22:39:58.361 [e2-core] Save Data Len : [1021]
      22:39:58.361 [e2-core] no version filtering
      22:39:58.361 [e2-core] 1434: 3c 00 00 00 00 00
      22:39:58.361 [e2-core] mask: ff 00 00 00 00 00
      22:39:58.361 [e2-core] mode: 00 00 00 00 00 00
      22:39:58.362 [e2-core] found applicaions ids >> pid : ffffffff, orgid : 19, appid : 2
      22:39:58.362 [e2-core] found applicaions ids >> pid : ffffffff, orgid : 19, appid : 4
      22:39:58.362 [e2-core] no version filtering
      22:39:58.362 [e2-core] 1434: 3c 00 00 00 00 00
      22:39:58.362 [e2-core] mask: ff 00 00 00 00 00
      22:39:58.362 [e2-core] mode: 00 00 00 00 00 00
      22:39:58.363 [e2-core] found applicaions ids >> pid : ffffffff, orgid : 19, appid : 5
      22:39:58.363 [e2-core] found applicaions ids >> pid : ffffffff, orgid : 19, appid : 20
      22:39:58.363 [e2-core] found applicaions ids >> pid : ffffffff, orgid : 19, appid : 27
      22:39:58.363 [e2-core] found applicaions ids >> pid : ffffffff, orgid : 19, appid : 3
      22:39:58.364 [e2-core] found applicaions ids >> pid : ffffffff, orgid : 19, appid : 35
      22:39:58.364 [e2-core] found applicaions ids >> pid : ffffffff, orgid : 19, appid : 42
      22:39:58.364 [e2-core] found applicaions ids >> pid : ffffffff, orgid : 19, appid : 56
      22:39:58.364 [e2-core] found applicaions ids >> pid : ffffffff, orgid : 19, appid : 66
      22:39:58.364 [e2-core] Section Length : 111, Total Section Length : 114
      22:39:58.364 [e2-core] found applicaions ids >> pid : ffffffff, orgid : 19, appid : 50
      22:39:58.364 [e2-core] Found : control[1], name[HBBTV-Start-DSMCC+Web], url[index.html]
      22:39:58.364 [e2-core] Found : control[2], name[EPG], url[index.php]
      22:39:58.364 [e2-core] Found : control[2], name[ARD-Text-DSMCC], url[index.html]
      22:39:58.364 [e2-core] Found : control[2], name[Tagesschau], url[tagesschau.de/hbbtv]
      22:39:58.365 [e2-core] Found : control[2], name[Mediathek DasErste], url[index.php]
      22:39:58.365 [e2-core] Found : control[2], name[HBBTV NDR-Mediathek], url[NDR HbbTV Mediathek]
      22:39:58.365 [e2-core] Found : control[2], name[HBBTV ARD-Mediathek], url[?devicegroup=hbbtv]
      22:39:58.365 [e2-core] Found : control[2], name[BR-Mediathek], url[BR Mediathek für HbbTV]
      22:39:58.365 [e2-core] Found : control[2], name[HBBTV Tatort], url[index.php]
      22:39:58.365 [e2-core] Found : control[2], name[HbbTV SR Mediathek], url[index.php]
      22:39:58.365 [e2-core] Found : control[2], name[HBBTV Das Erste Check Eins], url[Check eins Mediathek für HbbTV]
      22:39:58.365 [e2-core] Found : control[2], name[Donnerstagskrimi], url[donnerstagskrimi.php]
      22:39:58.370 [e2-python] Name : HBBTV-Start-DSMCC+Web
      22:39:58.370 [e2-python] URL : index.html
      22:39:58.371 [e2-python] OrgID : 19
      22:39:58.371 [e2-python] AppID : 1
      22:39:58.371 [e2-python] Control Code : 1
      22:39:58.371 [e2-python] Profile Code : 0
      22:39:58.371 [e2-python]
      22:39:58.371 [e2-python] Name : EPG
      22:39:58.372 [e2-python] URL : index.php
      22:39:58.372 [e2-python] OrgID : 19
      22:39:58.373 [e2-python] AppID : 2
      22:39:58.373 [e2-python] Control Code : 2
      22:39:58.373 [e2-python] Profile Code : 0
      22:39:58.373 [e2-python]
      22:39:58.373 [e2-python] Name : ARD-Text-DSMCC
      22:39:58.373 [e2-python] URL : index.html
      22:39:58.373 [e2-python] OrgID : 19
      22:39:58.374 [e2-python] AppID : 4
      22:39:58.374 [e2-python] Control Code : 2
      22:39:58.374 [e2-python] Profile Code : 0
      22:39:58.374 [e2-python]
      22:39:58.374 [e2-python] Name : Tagesschau
      22:39:58.375 [e2-python] URL : tagesschau.de/hbbtv
      22:39:58.375 [e2-python] OrgID : 19
      22:39:58.375 [e2-python] AppID : 5
      22:39:58.375 [e2-python] Control Code : 2
      22:39:58.376 [e2-python] Profile Code : 0
      22:39:58.376 [e2-python]
      22:39:58.376 [e2-python] Name : Mediathek DasErste
      22:39:58.376 [e2-python] URL : index.php
      22:39:58.376 [e2-python] OrgID : 19
      22:39:58.376 [e2-python] AppID : 20
      22:39:58.376 [e2-python] Control Code : 2
      22:39:58.377 [e2-python] Profile Code : 0
      22:39:58.377 [e2-python]
      22:39:58.377 [e2-python] Name : HBBTV NDR-Mediathek
      22:39:58.377 [e2-python] URL : NDR HbbTV Mediathek
      22:39:58.377 [e2-python] OrgID : 19
      22:39:58.378 [e2-python] AppID : 27
      22:39:58.378 [e2-python] Control Code : 2
      22:39:58.378 [e2-python] Profile Code : 0
      22:39:58.378 [e2-python]
      22:39:58.378 [e2-python] Name : HBBTV ARD-Mediathek
      22:39:58.378 [e2-python] URL : ?devicegroup=hbbtv
      22:39:58.379 [e2-python] OrgID : 19
      22:39:58.379 [e2-python] AppID : 3
      22:39:58.379 [e2-python] Control Code : 2
      22:39:58.379 [e2-python] Profile Code : 0
      22:39:58.379 [e2-python]
      22:39:58.380 [e2-python] Name : BR-Mediathek
      22:39:58.380 [e2-python] URL : BR Mediathek für HbbTV
      22:39:58.380 [e2-python] OrgID : 19
      22:39:58.380 [e2-python] AppID : 35
      22:39:58.380 [e2-python] Control Code : 2
      22:39:58.381 [e2-python] Profile Code : 0
      22:39:58.381 [e2-python]
      22:39:58.381 [e2-python] Name : HBBTV Tatort
      22:39:58.381 [e2-python] URL : index.php
      22:39:58.381 [e2-python] OrgID : 19
      22:39:58.381 [e2-python] AppID : 42
      22:39:58.382 [e2-python] Control Code : 2
      22:39:58.382 [e2-python] Profile Code : 0
      22:39:58.382 [e2-python]
      22:39:58.382 [e2-python] Name : HbbTV SR Mediathek
      22:39:58.382 [e2-python] URL : index.php
      22:39:58.382 [e2-python] OrgID : 19
      22:39:58.383 [e2-python] AppID : 56
      22:39:58.383 [e2-python] Control Code : 2
      22:39:58.383 [e2-python] Profile Code : 0
      22:39:58.383 [e2-python]
      22:39:58.383 [e2-python] Name : HBBTV Das Erste Check Eins
      22:39:58.383 [e2-python] URL : Check eins Mediathek für HbbTV
      22:39:58.384 [e2-python] OrgID : 19
      22:39:58.384 [e2-python] AppID : 66
      22:39:58.384 [e2-python] Control Code : 2
      22:39:58.384 [e2-python] Profile Code : 0
      22:39:58.384 [e2-python]
      22:39:58.384 [e2-python] Name : Donnerstagskrimi
      22:39:58.385 [e2-python] URL : donnerstagskrimi.php
      22:39:58.385 [e2-python] OrgID : 19
      22:39:58.385 [e2-python] AppID : 50
      22:39:58.385 [e2-python] Control Code : 2
      22:39:58.385 [e2-python] Profile Code : 0
      22:39:58.385 [e2-python]
      22:39:58.386 [e2-python] (1, 'HBBTV-Start-DSMCC+Web', 'http://itv.ard.de/ardstart/index.html', 19, 1, 0)
      22:39:58.554 [e2-core] sdt update done!
      22:39:58.620 [e2-core] --+ 1/3 TID 3c
      22:39:58.860 [e2-core] --++ 2/4 TID 3c
      22:39:58.879 [e2-core] close frontend 1
      22:39:59.060 [e2-core] release cached channel (timer timeout)
      22:39:59.060 [e2-core] [eDVBCAService] remove channel 0x2a65f98
      22:39:59.060 [e2-core] [eDVBLocalTimerHandler] remove channel 0x2a65f98
      22:39:59.060 [e2-core] [eEPGCache] remove channel 0x2a65f98
      22:39:59.061 [e2-core] [eEPGCache] abort caching events !!
      22:39:59.064 [e2-core] stop release channel timer
      22:39:59.139 [e2-core] --++ 2/4 TID 3c
      22:39:59.299 [e2-core] kaputt max(2) < ssize(4) || nr(1) >= max(2)
      22:39:59.439 [e2-core] kaputt max(5) < ssize(8) || nr(4) >= max(5)
      22:39:59.451 [e2-core] [eEPGCache] update begin time --> 1475352900 for external source event with id 17545
      22:39:59.452 [e2-core] [eEPGCache] [ID: 17545] short event description --> keep existing data
      22:39:59.520 [e2-core] kaputt max(3) < ssize(4) || nr(2) >= max(3)
      22:39:59.679 [e2-core] kaputt max(3) < ssize(4) || nr(2) >= max(3)
      22:39:59.739 [e2-core] kaputt max(2) < ssize(8) || nr(1) >= max(2)
      22:39:59.879 [e2-core] kaputt max(3) < ssize(4) || nr(2) >= max(3)
      22:40:00.019 [e2-core] eDVBCICAManagerSession::setCAIDs casCount = 1
      22:40:00.020 [e2-core] Slot 0 plugged
      22:40:00.139 [e2-core] --++ 2/4 TID 3c
      22:40:00.439 [e2-core] --++ 2/4 TID 3c
      22:40:00.720 [e2-core] --++ 2/4 TID 3c
      22:40:00.919 [e2-core] kaputt max(3) < ssize(4) || nr(2) >= max(3)
      22:40:00.943 [e2-core] [eEPGCache] update begin time --> 1475354640 for external source event with id 17546
      22:40:00.944 [e2-core] [eEPGCache] [ID: 17546] short event description --> keep existing data
      22:40:01.059 [e2-core] timeout 1434!
      22:40:01.060 [e2-core] OCready
      22:40:02.079 [e2-core] close frontend 4
      22:40:02.539 [e2-core] -------+----+ 2/13 TID 3c
      22:40:02.920 [e2-core] kaputt max(2) < ssize(13) || nr(1) >= max(2)
      22:40:02.920 [e2-core] child has terminated
      22:40:02.920 [e2-core] pipes closed
      22:40:03.271 [e2-core] [eEPGCache] abort non avail schedule other reading
      22:40:03.272 [e2-core] [eEPGCache] abort non avail viasat reading
      22:40:03.274 [e2-core] [eEPGCache] abort non avail mhw reading
      22:40:03.484 [e2-core] [eEPGCache] abort non avail schedule other reading
      22:40:03.486 [e2-core] [eEPGCache] abort non avail viasat reading
      22:40:03.487 [e2-core] [eEPGCache] abort non avail mhw reading
      22:40:03.867 [e2-core] [eEPGCache] abort non avail schedule other reading
      22:40:03.869 [e2-core] [eEPGCache] abort non avail viasat reading
      22:40:03.870 [e2-core] [eEPGCache] abort non avail mhw reading
      22:40:04.569 [e2-core] kaputt max(8) < ssize(13) || nr(7) >= max(8)
      22:40:05.049 [e2-core] kaputt max(3) < ssize(13) || nr(2) >= max(3)
      22:40:05.056 [e2-core] [eEPGCache] nownext finished(1475354405)
      22:40:05.372 [e2-core] [eEPGCache] nownext finished(1475354405)
      22:40:06.200 [e2-core] kaputt max(5) < ssize(13) || nr(4) >= max(5)
      22:40:06.449 [e2-core] kaputt max(2) < ssize(13) || nr(1) >= max(2)
      22:40:06.908 [e2-core] [eEPGCache] nownext finished(1475354406)
      22:40:08.164 [e2-core] reserved 27
      22:40:09.269 [e2-core] -------+----+ 2/13 TID 3c
      22:40:09.639 [e2-core] timeout 087b!
      22:40:09.640 [e2-core] OCready
      22:40:11.882 [e2-core] [eEPGCache] schedule finished(1475354411)
      22:40:11.883 [e2-core] [eEPGCache] stop caching events(1475354411)
      22:40:11.883 [e2-core] [eEPGCache] next update in 60 min
      22:40:12.027 [e2-core] [eEPGCache] update begin time --> 1476568200 for external source event with id 54567
      22:40:12.027 [e2-core] [eEPGCache] update begin time --> 1476573900 for external source event with id 54569
      22:40:12.748 [e2-core] [eEPGCache] update begin time --> 1476586380 for external source event with id 54573
      22:40:12.749 [e2-core] [eEPGCache] [ID: 54573] short event description --> keep existing data
      22:40:12.749 [e2-core] [eEPGCache] update begin time --> 1476586500 for external source event with id 54574
      22:40:12.749 [e2-core] [eEPGCache] [ID: 54574] short event description --> keep existing data
      22:40:14.290 [e2-core] no ancillary data in audio stream... abort radiotext pes parser
      22:40:54.170 [e2-core] child has terminated
      22:40:54.170 [e2-core] pipes closed
      22:40:54.929 [e2-core] child has terminated
      22:40:54.930 [e2-core] pipes closed
      22:41:31.980 [e2-python] next real activation is Mon Oct 3 09:39:40 2016
      22:41:33.284 [e2-core] [eEPGCache] schedule finished(1475354493)
      22:41:33.285 [e2-core] [eEPGCache] stop caching events(1475354493)
      22:41:33.285 [e2-core] [eEPGCache] next update in 60 min
      22:41:33.871 [e2-core] [eEPGCache] schedule finished(1475354493)
      22:41:33.872 [e2-core] [eEPGCache] stop caching events(1475354493)
      22:41:33.872 [e2-core] [eEPGCache] next update in 60 min


      Edit2:
      Kann mir bitte jemand helfen


      Edit by NaseDC: Bitte für Ergänzungen den Bearbeiten-Button nutzen! Pushen von Threds ist nicht gerne gesehen.

      Edit3:
      Box ist gerade auf Sky Sport Bundesliga 1 HD wieder abgestürzt! (Bild steht und Spinner dreht sich)
      Wer kann mir bitte weiterhelfen?
      Gruß Markus

      Dieser Beitrag wurde bereits 3 mal editiert, zuletzt von NaseDC ()

    • Was ist daran so schwer zu verstehen , wenn man schreibt:

      Edit by NaseDC: Bitte für Ergänzungen den Bearbeiten-Button nutzen! Pushen von Threds ist nicht gerne gesehen.


      Wenn jemand helfen kann wird er dieses tun!
      _______________________________________________________
      LG Nase
      Receiver
      Duo 4Kse DVB-S2x (45308X FBC) / DVB-T2 (BCM3466) ; Samsung HM321H intern ; Synology 218+ ; Inverto Unicable II IDLU-UWT110-CUO1O-32P Multischalter 5/32
      Uno 4K SE DVB-S2 (45208 FBC) ; TOSHIBA MQ01ABD0 extern ; Synology 218+ ; Inverto Unicable II IDLU-UWT110-CUO1O-32P Multischalter 5/32
      Uno 4K DVB-S2 (45208 FBC) ; Synology 218 ; Inverto Unicable II IDLU-UWT110-CUO1O-32P Multischalter 5/32 ; Inverto Pro Wideband IDLP-WDB01-OOPRO-OPP
      Zero 4K DVB-S2x (SI2166) / HMP-Combo DVB C/T2 Hybrid ; Synology 218+ ; Selfsat H30D2 / Maximum UHF 200


      Der Fortschritt lebt vom Austausch des Wissens. (Albert Einstein)
      Wende dein Gesicht der Sonne zu, dann fallen die Schatten hinter dich. (aus Uganda)

    • Wetteraktualisierung ist deaktiviert und sonst läuft auch nichts im Hintergrund.
      Box stürzt ständig ab.
      Kann man an den log Dateien aus Post 3 was erkennen?
      Gruß Markus

    • Nutzt du EPGShare?
      Dein EPG wird sehr häufig upgedated, alle 60 min. ist vielleicht übertrieben denke ich.

      Kann es nicht genau sehen, aber ein Versuch ist es Wert.

      Edit:
      Entsteht mit dem Spinner und Reboot ein Crashlog? Dieser wäre auch sehr hilfreich.
      _______________________________________________________
      LG Nase
      Receiver
      Duo 4Kse DVB-S2x (45308X FBC) / DVB-T2 (BCM3466) ; Samsung HM321H intern ; Synology 218+ ; Inverto Unicable II IDLU-UWT110-CUO1O-32P Multischalter 5/32
      Uno 4K SE DVB-S2 (45208 FBC) ; TOSHIBA MQ01ABD0 extern ; Synology 218+ ; Inverto Unicable II IDLU-UWT110-CUO1O-32P Multischalter 5/32
      Uno 4K DVB-S2 (45208 FBC) ; Synology 218 ; Inverto Unicable II IDLU-UWT110-CUO1O-32P Multischalter 5/32 ; Inverto Pro Wideband IDLP-WDB01-OOPRO-OPP
      Zero 4K DVB-S2x (SI2166) / HMP-Combo DVB C/T2 Hybrid ; Synology 218+ ; Selfsat H30D2 / Maximum UHF 200


      Der Fortschritt lebt vom Austausch des Wissens. (Albert Einstein)
      Wende dein Gesicht der Sonne zu, dann fallen die Schatten hinter dich. (aus Uganda)

      Dieser Beitrag wurde bereits 1 mal editiert, zuletzt von NaseDC ()

    • Nein Spinner dreht sich und Bild bleibt stehen.
      Crashlog oder Reboot gibt es keinen.
      Der Ordner media/hdd ist leer.
      Habe epg share vorhin deinstalliert.
      Stürzt leider trotzdem ab.
      Habe eben noch das Plugin exteventinfohandler deinstalliert .
      Kann es daran gelegen haben?
      Gruß Markus

      Dieser Beitrag wurde bereits 4 mal editiert, zuletzt von Markus1973 ()

    • Welcher Skin is aktiv ?
      ----------------------------------------------------------------------------------------------------------------------------------------------------------------
      KAPIERVORGANG beendet.

      Zubehör : Philips 46PFL-9705 / 37PFL-9604, Samsung HT-E6759W, Samsung SPF 107H-105P-87H, Qnap TS-253A, Harmony 650, Fritzbox 7490, Cisco WAP4410N, Netgear M4100-D12G, TPLink HS100/HS110/LB110

    • Jetzt Metrix fhd, vorher Fluid.
      Abstürze hatte ich bei beiden

      Gerade wieder auf Sky Sport Bundesliga 1 HD Spinner gehabt und dann blieb das Bild stehen.
      Kann es an den commoninterface Einstellungen oder Oscam 1.2.0 rev 11233 liegen?
      Habe die V14 im Ci+ Modul von Sky drin.
      Habe den Provider Sky zugewiesen nicht die caid.
      Gruß Markus

      Dieser Beitrag wurde bereits 2 mal editiert, zuletzt von Markus1973 ()

    • Danke habe ich gemacht.
      Wollte danach Neustarten und wieder der Spinner und Bild steht.
      Gruß Markus

      Dieser Beitrag wurde bereits 1 mal editiert, zuletzt von Markus1973 ()

    • Wie sehen die Einstellungen und Common-Interface-Zuweisungen aus ?
      ----------------------------------------------------------------------------------------------------------------------------------------------------------------
      KAPIERVORGANG beendet.

      Zubehör : Philips 46PFL-9705 / 37PFL-9604, Samsung HT-E6759W, Samsung SPF 107H-105P-87H, Qnap TS-253A, Harmony 650, Fritzbox 7490, Cisco WAP4410N, Netgear M4100-D12G, TPLink HS100/HS110/LB110

    • Ci Meldungen anzeigen nein
      Unterstützung für mehrere Kanäle nein
      Unterstützung für hohe Datenraten ja
      PIN dauerhaft speichern ja

      Zuweisungen Provider Sky und RTL Living Keine Caid zugewiesen.
      Gruß Markus

      Dieser Beitrag wurde bereits 1 mal editiert, zuletzt von Markus1973 ()

    • Lass mal die Meldungen anzeigen .
      ----------------------------------------------------------------------------------------------------------------------------------------------------------------
      KAPIERVORGANG beendet.

      Zubehör : Philips 46PFL-9705 / 37PFL-9604, Samsung HT-E6759W, Samsung SPF 107H-105P-87H, Qnap TS-253A, Harmony 650, Fritzbox 7490, Cisco WAP4410N, Netgear M4100-D12G, TPLink HS100/HS110/LB110

    • Habe ich gemacht.

      Habe die Box seit Donnerstag.
      Hatte vorher die Solo SE V2 und damit ging alles ohne Probleme.

      Habe bei der Solo 4K VTI 9.0.3 geflasht und dann die Einstellungen von der Solo SE V2 eingespielt.

      Kann es damit was zu tun haben?
      Gruß Markus

      Dieser Beitrag wurde bereits 1 mal editiert, zuletzt von Markus1973 ()

    • Danke habe ich gemacht.

      Habe die Box neu geflasht und komplett neu eingerichtet, aber sie stürzt immer wieder mal ab.
      Werde die Box heute Austauschen und hoffen das das Problem dann gelöst ist.
      Habe sie ja erst am 29.09. bekommen.
      Gruß Markus

    • Habe mal ein Bildschirmfoto von VTI INFO gemacht.
      Vielleicht ist da ein Fehler drin.
      vuplus-support.org/wbb4/index.…d2ed3d8772386c9ce7910fdcf

      Edit:
      Habe die Funktion (Schneller Kanalwechsel FCC) deaktiviert und seit ca. 11:00 Uhr keinen Absturz mehr.
      Gruß Markus

      Dieser Beitrag wurde bereits 2 mal editiert, zuletzt von Markus1973 ()

    • Moin
      Hatte ein ähnliches Problem mit meiner Solo 4K, bei mir blieb das Bild stehen und der Ton lief weiter, auch wurde ab und an das Bild schwarz und der Ton lief weiter.
      Habe Black Hole derzeit zum testen am laufen, keinerlei Probleme mehr, wobei ich sagen muss VTi gefällt mir besser, war aber katastrophal.
      Wenn man was aufgenommen hatte und wollte es sich dann anschauen und nach kurzer Zeit steht das Bild und der Ton lüppt weiter, also selbst diue Aufnahme war versaut, hatte die Aufnahme versucht über meine DUo2 zu schauen in dem ich die Daten übers Netzwerk kopiert hatte, gleiches Problem.
      Manchmal half es auf einen anderen Kanal zu wechseln manchmal musste ich die Box über die FB auschalten und ab und an ging es nur noch über den Netzschalter.
      Hatte die Probleme mit einem Sky CI und einem AlphaCrypt Light Ver.2.2, aber auch wenn kein CI Modul eingesteckt war und die Probleme traten auf allen Sendern ob HD oder SD ob FreeToAir oder Sky auf.
      Allerdings habe ich auf der Duo2 keinerlei der Probleme die ich auf der Solo 4K beschrieben habe, ob mit oder ohne CI Modul und egal welcher Sender.

      Dieser Beitrag wurde bereits 1 mal editiert, zuletzt von ToMicPa68 ()