-- Logs begin at Fri 2017-01-06 12:59:49 CET. --
Jan 06 13:03:38 dm900 enigma2[186]: [SEC] delayed close frontend
Jan 06 13:03:38 dm900 enigma2[186]: close frontend 2
Jan 06 13:03:38 dm900 enigma2[186]: (2)setVoltage 0V
Jan 06 13:03:38 dm900 enigma2[186]: [SEC] unlock
Jan 06 13:03:38 dm900 enigma2[186]: thread joined 0
Jan 06 13:03:38 dm900 enigma2[186]: thread joined 0
Jan 06 13:03:38 dm900 systemd[1]: enigma2.service: Main process exited, code=exited, status=143/n/a
Jan 06 13:03:39 dm900 systemd[1]: Stopped enigma2.
Jan 06 13:03:39 dm900 systemd[1]: enigma2.service: Unit entered failed state.
Jan 06 13:03:39 dm900 systemd[1]: enigma2.service: Failed with result 'exit-code'.
-- Logs begin at Fri 2017-01-06 12:59:49 CET. --
Jan 06 13:04:40 dm900 enigma2[365]: language set to de_DE
Jan 06 13:04:40 dm900 enigma2[365]: libpng warning: iCCP: known incorrect sRGB profile
Jan 06 13:04:40 dm900 enigma2[365]: [WebInterface] set language to  de
Jan 06 13:04:40 dm900 enigma2[365]: [WebInterface] set language to  de
Jan 06 13:04:41 dm900 enigma2[365]: [AudioSync] set language to  de
Jan 06 13:04:41 dm900 enigma2[365]: [AudioSync] set language to  de
Jan 06 13:04:41 dm900 enigma2[365]: [TeleText] set language to [de]
Jan 06 13:04:41 dm900 enigma2[365]: [TeleText] set language to [de]
Jan 06 13:04:41 dm900 enigma2[365]: [TeleText] fallback to default translation for bilinear
Jan 06 13:04:41 dm900 enigma2[365]: [TeleText] plugins
Jan 06 13:04:41 dm900 enigma2[365]: [WebInterface] fallback to default translation for Webinterface
Jan 06 13:04:41 dm900 enigma2[365]: I/  [MediaCore.registerBrowser] :: b={'params': [], 'class': <class 'Plugins.Extensions.MediaCenter.MediaBrowserUPnP.MediaBrowserUPnP'>, 'name': 'DLNA/UPnP'}
Jan 06 13:04:41 dm900 enigma2[365]: I/  [MediaCore.registerBrowser] :: b={'params': [], 'class': <class 'Plugins.Extensions.MediaCenter.MediaBrowserFile.MediaBrowserFile'>, 'name': 'Dateisystem'}
Jan 06 13:04:41 dm900 enigma2[365]: I/  [MediaCore.registerBrowser] :: b={'params': [], 'class': <class 'Plugins.Extensions.MediaCenter.MediaBrowserDB.MediaBrowserDB'>, 'name': 'Mediendatenbank'}
Jan 06 13:04:41 dm900 enigma2[365]: I/  [MediaCore.registerBrowser] :: b={'params': [], 'class': <class 'Plugins.Extensions.MediaCenter.MediaBrowserDB.MediaBrowserDB'>, 'name': 'Mediendatenbank'}
Jan 06 13:04:41 dm900 enigma2[365]: I/  [MediaCore.registerBrowser] :: b={'params': [], 'class': <class 'Plugins.Extensions.MediaCenter.MediaBrowserSearch.MediaBrowserSearch'>, 'name': 'Suche'}
Jan 06 13:04:41 dm900 enigma2[365]: gPixmap: Failed to access '': No such file or directory
Jan 06 13:04:41 dm900 enigma2[365]: gPixmap: Failed to access '/usr/lib/enigma2/python/Plugins/Extensions/MediaCenter/plugin.png': No such file or directory
Jan 06 13:04:41 dm900 enigma2[365]: It's now  Fr 06 Jan 2017 13:04:41 CET
Jan 06 13:04:41 dm900 enigma2[365]: [timer.py] next activation: 1483704381 (in 99721 ms)
Jan 06 13:04:41 dm900 enigma2[365]: [SetPasswd] set language to  de
Jan 06 13:04:41 dm900 enigma2[365]: [SetPasswd] set language to  de
Jan 06 13:04:41 dm900 enigma2[365]: /usr/share/enigma2/
Jan 06 13:04:41 dm900 enigma2[365]: [ResourceManager] adding: software_manager
Jan 06 13:04:41 dm900 enigma2[365]: [ResourceManager] adding: software_manager_upgrade
Jan 06 13:04:41 dm900 enigma2[365]: I/  [ClientConfig.reload] :: parsing: #This file is managed by your dreambox! All comments will be lost on next save using the UI!
Jan 06 13:04:41 dm900 enigma2[365]: I/  [ClientConfig.reload] :: parsing: 0=tuner_type:DVB-S,ipaddr:192.168.88.198,vtuner_type:satip_client
Jan 06 13:04:41 dm900 enigma2[365]: I/  [ClientConfig.reload] :: parsing: 1=tuner_type:DVB-S,ipaddr:192.168.88.198,vtuner_type:satip_client
Jan 06 13:04:41 dm900 enigma2[365]: I/  [ClientConfig.reload] :: {0: TunerEntry~{'tuner_type': 'DVB-S', 'ipaddr': '192.168.88.198', 'vtuner_type': 'satip_client'}, 1: TunerEntry~{'tuner_type': 'DVB-S', 'ipaddr': '192.168.88.198', 'vtuner_type': 'satip_client'}}
Jan 06 13:04:41 dm900 enigma2[365]: [TeleText] autostart(0, {})
Jan 06 13:04:41 dm900 enigma2[365]: [CrashlogAutoSubmit] - autostart
Jan 06 13:04:41 dm900 enigma2[365]: getModeList for port DVI-PC
Jan 06 13:04:41 dm900 enigma2[365]: getModeList for port DVI
Jan 06 13:04:41 dm900 enigma2[365]: getModeList for port DVI-PC
Jan 06 13:04:41 dm900 enigma2[365]: hotplug on dvi
Jan 06 13:04:41 dm900 enigma2[365]: -> setting aspect, policy, policy2, wss 16:9 panscan letterbox auto
Jan 06 13:04:41 dm900 enigma2[365]: -> setting aspect, policy, policy2, wss 16:9 panscan letterbox auto
Jan 06 13:04:41 dm900 enigma2[365]: -> setting aspect, policy, policy2, wss 16:9 panscan letterbox auto
Jan 06 13:04:41 dm900 enigma2[365]: setMode - port: DVI mode: 2160p rate: multi
Jan 06 13:04:41 dm900 enigma2[365]: -> setting aspect, policy, policy2, wss 16:9 panscan letterbox auto
Jan 06 13:04:41 dm900 enigma2[365]: starting hotplug handler
Jan 06 13:04:41 dm900 enigma2[365]: [ResourceManager] adding: Hotplug
Jan 06 13:04:41 dm900 enigma2[365]: [CI_Assignment] activating ci configs:
Jan 06 13:04:41 dm900 enigma2[365]: [CI_Activate] FOUND 1 CI Slots
Jan 06 13:04:41 dm900 enigma2[365]: [CI_Activate_Config_CI0] no config file found
Jan 06 13:04:41 dm900 enigma2[365]: [CI_Activate_Config_CI0] error parsing xml...
Jan 06 13:04:41 dm900 enigma2[365]: couldn't open /proc/stb/misc/12V_output
Jan 06 13:04:41 dm900 enigma2[365]: [WebInterface] set language to  de
Jan 06 13:04:41 dm900 enigma2[365]: [WebInterface] set language to  de
Jan 06 13:04:41 dm900 enigma2[365]: [AudioSync] set language to  de
Jan 06 13:04:41 dm900 enigma2[365]: [AudioSync] set language to  de
Jan 06 13:04:41 dm900 enigma2[365]: [TeleText] set language to [de]
Jan 06 13:04:41 dm900 enigma2[365]: [TeleText] set language to [de]
Jan 06 13:04:41 dm900 enigma2[365]: [SetPasswd] set language to  de
Jan 06 13:04:41 dm900 enigma2[365]: [SetPasswd] set language to  de
Jan 06 13:04:41 dm900 enigma2[365]: profile: RFMod: 69
Jan 06 13:04:41 dm900 enigma2[365]: profile: Init:CI: 70
Jan 06 13:04:41 dm900 enigma2[365]: profile: Init:Session: 71
Jan 06 13:04:41 dm900 enigma2[365]: It's now  Fr 06 Jan 2017 13:04:41 CET
Jan 06 13:04:41 dm900 enigma2[365]: [timer.py] next activation: 1483704381 (in 99210 ms)
Jan 06 13:04:41 dm900 enigma2[365]: It's now  Fr 06 Jan 2017 13:04:41 CET
Jan 06 13:04:41 dm900 enigma2[365]: [timer.py] next activation: 1483704381 (in 99206 ms)
Jan 06 13:04:41 dm900 enigma2[365]: I/  [isUpdateRequired] :: /usr/sbin/flash-fsbl
Jan 06 13:04:42 dm900 enigma2[365]: I/  [FSBLCheckerDM900.isUpdateRequired] :: Current FSBL checksum is: ceeae388827fc2e76ebd1203eac7f408c71e72640477e44275b96a9f9fd5374a
Jan 06 13:04:42 dm900 enigma2[365]: I/  [FSBLUpdateHandler.check] :: No FSBL update required!
Jan 06 13:04:42 dm900 enigma2[365]: [TeleText] ----- sessionstart(<__main__.Session instance at 0x98f4ee68>) -----
Jan 06 13:04:42 dm900 enigma2[365]: [TeleText] [favorites] reading
Jan 06 13:04:42 dm900 enigma2[365]: Looking for embedded skin
Jan 06 13:04:42 dm900 enigma2[365]: [TeleText] __layoutFinished
Jan 06 13:04:42 dm900 enigma2[365]: [BARRYALLEN] autostart
Jan 06 13:04:42 dm900 enigma2[365]: [CrashlogAutoSubmit] - autostart
Jan 06 13:04:42 dm900 enigma2[365]: W/  [WatchDog.start] :: Streamserver Watchdog is starting!
Jan 06 13:04:42 dm900 enigma2[365]: [Toplevel.importExternalModules] Imported external module: EPGRefresh
Jan 06 13:04:42 dm900 enigma2[365]: [Toplevel.importExternalModules] Imported external module: Example
Jan 06 13:04:42 dm900 enigma2[365]: [HTTPRootResource}.__init__
Jan 06 13:04:42 dm900 enigma2[365]: [Webinterface] started on :::80 auth=False ssl=False
Jan 06 13:04:42 dm900 enigma2[365]: [WebInterface.registerBonjourService] No module named Bonjour.Bonjour
Jan 06 13:04:42 dm900 enigma2[365]: [HTTPRootResource}.__init__
Jan 06 13:04:42 dm900 enigma2[365]: [Webinterface] started on :::443 auth=True ssl=True
Jan 06 13:04:42 dm900 enigma2[365]: [WebInterface.registerBonjourService] No module named Bonjour.Bonjour
Jan 06 13:04:42 dm900 enigma2[365]: [eCec] current powerstate = 0
Jan 06 13:04:42 dm900 enigma2[365]: [eWindowAnimationmanger] adding _-disabled-_
Jan 06 13:04:42 dm900 enigma2[365]: [eWindowAnimationManager::setWidgetDefault] fade duration=400
Jan 06 13:04:42 dm900 enigma2[365]: [eWindowAnimationManager] Default widget animation set to ''
Jan 06 13:04:42 dm900 enigma2[365]: [eWindowAnimationmanger] adding simple_fade
Jan 06 13:04:42 dm900 enigma2[365]: [eWindowAnimationManager] Default animation set to 'simple_fade'
Jan 06 13:04:42 dm900 enigma2[365]: [eWindowAnimationmanger] adding quick_fade
Jan 06 13:04:42 dm900 enigma2[365]: [eWindowAnimationmanger] adding slide_left_to_right
Jan 06 13:04:42 dm900 enigma2[365]: [eWindowAnimationmanger] adding slide_right_to_left
Jan 06 13:04:42 dm900 enigma2[365]: [eWindowAnimationmanger] adding slide_top_to_bottom
Jan 06 13:04:42 dm900 enigma2[365]: [eWindowAnimationmanger] adding zoom_and_fade
Jan 06 13:04:42 dm900 enigma2[365]: [eWindowAnimationmanger] adding grow_left_shrink_top
Jan 06 13:04:42 dm900 enigma2[365]: [eWindowAnimationmanger] adding slide_zoom_left_to_right
Jan 06 13:04:42 dm900 enigma2[365]: [eWindowAnimationmanger] adding slide_zoom_right_to_left
Jan 06 13:04:42 dm900 enigma2[365]: [eWindowAnimationmanger] adding wizard_previous
Jan 06 13:04:42 dm900 enigma2[365]: [eWindowAnimationmanger] adding wizard_next
Jan 06 13:04:42 dm900 enigma2[365]: profile: wizards: 94
Jan 06 13:04:42 dm900 enigma2[365]: [EPGC] set outdated epg timespan to 0 hours...
Jan 06 13:04:42 dm900 enigma2[365]: [EPGC] set cache timespan to 28 days!
Jan 06 13:04:42 dm900 enigma2[365]: [EPGC] setCacheFile read/write epg data from/to '/etc/enigma2/epg.db'
Jan 06 13:04:42 dm900 enigma2[365]: [EPGC] time updated.. start EPG Mainloop
Jan 06 13:04:42 dm900 enigma2[365]: before: 1
Jan 06 13:04:42 dm900 enigma2[365]: after: 1
Jan 06 13:04:42 dm900 enigma2[365]: [EPGC] data thread started
Jan 06 13:04:42 dm900 enigma2[365]: I/  [ServiceList.__init__] :: {'serviceItemHeightLarge': 68, 'progressBarWidth': 52, 'piconWidthBig': 100, 'textOffset': 10, 'endMargin': 5, 'piconOffset': 8, 'beginMargin': 5, 'piconWidth': 50, 'progressBarHeight': 8, 'progressBarMargin': 8, 'serviceNumberWidth': 50, 'serviceItemHeight': 34, 'serviceInfoHeightAdd': 6}
Jan 06 13:04:42 dm900 enigma2[365]: I/  [TemplatedListFonts.__init__] :: Bigger: 24, Regular
Jan 06 13:04:42 dm900 enigma2[365]: I/  [TemplatedListFonts.__init__] :: Big: 22, Regular
Jan 06 13:04:42 dm900 enigma2[365]: I/  [TemplatedListFonts.__init__] :: Medium: 20, Regular
Jan 06 13:04:42 dm900 enigma2[365]: I/  [TemplatedListFonts.__init__] :: Small: 18, Regular
Jan 06 13:04:42 dm900 enigma2[365]: I/  [TemplatedListFonts.__init__] :: Smaller: 14, Regular
Jan 06 13:04:42 dm900 enigma2[365]: [EPGC] Loading database into memory
Jan 06 13:04:42 dm900 enigma2[365]: gPixmap: Failed to access '/usr/share/enigma2/ico_dvb_s-fs8.png': No such file or directory
Jan 06 13:04:42 dm900 enigma2[365]: gPixmap: Failed to access '/usr/share/enigma2/ico_dvb_c-fs8.png': No such file or directory
Jan 06 13:04:42 dm900 enigma2[365]: gPixmap: Failed to access '/usr/share/enigma2/ico_dvb_t-fs8.png': No such file or directory
Jan 06 13:04:42 dm900 enigma2[365]: gPixmap: Failed to access '/usr/share/enigma2/ico_service_group-fs8.png': No such file or directory
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: reused converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: warning, skin is missing element RassLogo in <class 'Screens.RdsDisplay.RdsInfoDisplay'>
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: reused converter!
Jan 06 13:04:42 dm900 enigma2[365]: RemovePopup, id = ZapError
Jan 06 13:04:42 dm900 enigma2[365]: [HbbTV] connecting callbacks
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: reused converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: reused converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: reused converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: reused converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: reused converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: reused converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: reused converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: reused converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: reused converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: reused converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: reused converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: reused converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: reused converter!
Jan 06 13:04:42 dm900 enigma2[365]: reused converter!
Jan 06 13:04:42 dm900 enigma2[365]: reused converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: reused converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: reused converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: reused converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: reused converter!
Jan 06 13:04:42 dm900 enigma2[365]: create buffer for widget 880 x 90
Jan 06 13:04:42 dm900 enigma2[365]: reused converter!
Jan 06 13:04:42 dm900 enigma2[365]: reused converter!
Jan 06 13:04:42 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:42 dm900 enigma2[365]: libpng warning: iCCP: known incorrect sRGB profile
Jan 06 13:04:42 dm900 enigma2[365]: create buffer for widget 1280 x 150
Jan 06 13:04:42 dm900 enigma2[365]: profile: Init:VolumeControl: 99
Jan 06 13:04:42 dm900 enigma2[365]: setValue 100
Jan 06 13:04:42 dm900 enigma2[365]: cannot open /proc/stb/audio/j1_mute(No such file or directory)
Jan 06 13:04:42 dm900 enigma2[365]: Setvolume: 100 100 (raw)
Jan 06 13:04:42 dm900 enigma2[365]: Setvolume: 0 0 (-1db)
Jan 06 13:04:42 dm900 enigma2[365]: Setvolume: 100 100 (raw)
Jan 06 13:04:42 dm900 enigma2[365]: Setvolume: 0 0 (-1db)
Jan 06 13:04:42 dm900 enigma2[365]: profile: Init:PowerKey: 99
Jan 06 13:04:42 dm900 enigma2[365]: No skin to read...
Jan 06 13:04:42 dm900 enigma2[365]: profile: RunReactor: 100
Jan 06 13:04:42 dm900 enigma2[365]: delaying playService request until the ChannelSelection is finally initialized
Jan 06 13:04:42 dm900 enigma2[365]: deferred playService ... ChannelSelection is finally initialized now
Jan 06 13:04:42 dm900 enigma2[365]: playing 1:0:1:2EF4:441:1:C00000:0:0:0:
Jan 06 13:04:42 dm900 enigma2[365]: realpath /etc/enigma2/virtsubmapping.txt: No such file or directory
Jan 06 13:04:42 dm900 enigma2[365]: can't open /etc/enigma2/virtsubmapping.txt: No such file or directory
Jan 06 13:04:42 dm900 enigma2[365]: [TeleText] service started
Jan 06 13:04:42 dm900 enigma2[365]: not pauseable.
Jan 06 13:04:42 dm900 enigma2[365]: RemovePopup, id = ZapError
Jan 06 13:04:42 dm900 enigma2[365]: allocate channel.. 0441:0001:00c00000
Jan 06 13:04:42 dm900 enigma2[365]: opening frontend 2
Jan 06 13:04:42 dm900 enigma2[365]: [eDVBCAService] new channel 0x2a14f18!
Jan 06 13:04:42 dm900 enigma2[365]: (2)tune
Jan 06 13:04:42 dm900 enigma2[365]: RotorCmd ffffffff, lastRotorCmd ffffffff
Jan 06 13:04:42 dm900 enigma2[365]: prepare_sat System 0 Freq 12187500 Pol 0 SR 27500000 INV 2 FEC 3 orbpos 192 system 0 modulation 1 pilot 2, rolloff 0
Jan 06 13:04:42 dm900 enigma2[365]: tuning to 1587 mhz
Jan 06 13:04:42 dm900 enigma2[365]: OURSTATE: tuning
Jan 06 13:04:42 dm900 enigma2[365]: allocate Channel: res 0
Jan 06 13:04:42 dm900 enigma2[365]: allocate demux
Jan 06 13:04:42 dm900 enigma2[365]: have 1 video stream(s) (00a6), and 1 audio stream(s) (0080), and the pcr pid is 00a6, and the text pid is 0044
Jan 06 13:04:42 dm900 enigma2[365]: allocate demux
Jan 06 13:04:42 dm900 enigma2[365]: disable teletext subtitles page ffffffffffffffff (und)
Jan 06 13:04:42 dm900 enigma2[365]: decoder state: play, vpid=166, apid=128
Jan 06 13:04:42 dm900 enigma2[365]: DMX_SET_PES_FILTER(0xa6) - pcr - ok
Jan 06 13:04:42 dm900 enigma2[365]: DEMUX_START - pcr - [SEC] lock 0
Jan 06 13:04:42 dm900 enigma2[365]: [SEC] invalidate current switch params
Jan 06 13:04:42 dm900 enigma2[365]: [SEC] setVoltage 2
Jan 06 13:04:42 dm900 enigma2[365]: (2)setVoltage 18V
Jan 06 13:04:42 dm900 enigma2[365]: [SEC] sleep 10ms
Jan 06 13:04:42 dm900 enigma2[365]: ok
Jan 06 13:04:42 dm900 enigma2[365]: DMX_SET_PES_FILTER(0x80) - audio - ok
Jan 06 13:04:42 dm900 enigma2[365]: DEMUX_START - audio - ok
Jan 06 13:04:42 dm900 enigma2[365]: AUDIO_SET_BYPASS(1) - ok
Jan 06 13:04:42 dm900 enigma2[365]: AUDIO_PAUSE - ok
Jan 06 13:04:42 dm900 enigma2[365]: AUDIO_PLAY - ok
Jan 06 13:04:42 dm900 enigma2[365]: Video Device: /dev/dvb/adapter0/video0
Jan 06 13:04:42 dm900 enigma2[365]: demux device: /dev/dvb/adapter0/demux5
Jan 06 13:04:42 dm900 enigma2[365]: VIDEO_SET_STREAMTYPE 0 - ok
Jan 06 13:04:42 dm900 enigma2[365]: DMX_SET_PES_FILTER(0xa6) - video - ok
Jan 06 13:04:42 dm900 enigma2[365]: DEMUX_START - video - ok
Jan 06 13:04:42 dm900 enigma2[365]: VIDEO_FREEZE - ok
Jan 06 13:04:42 dm900 enigma2[365]: VIDEO_PLAY - [SEC] setTone 1
Jan 06 13:04:42 dm900 enigma2[365]: (2)setTone On
Jan 06 13:04:42 dm900 enigma2[365]: [SEC] sleep 10ms
Jan 06 13:04:42 dm900 enigma2[365]: ok
Jan 06 13:04:42 dm900 enigma2[365]: DMX_SET_PES_FILTER(0x44) - ttx - ok
Jan 06 13:04:42 dm900 enigma2[365]: DEMUX_START - ttx - ok
Jan 06 13:04:42 dm900 enigma2[365]: VIDEO_SLOWMOTION(0) - ok
Jan 06 13:04:42 dm900 enigma2[365]: VIDEO_FAST_FORWARD(0) - ok
Jan 06 13:04:42 dm900 enigma2[365]: VIDEO_CONTINUE - ok
Jan 06 13:04:42 dm900 enigma2[365]: AUDIO_CONTINUE - ok
Jan 06 13:04:42 dm900 enigma2[365]: AUDIO_CHANNEL_SELECT(0) - ok
Jan 06 13:04:42 dm900 enigma2[365]: not pauseable.
Jan 06 13:04:42 dm900 enigma2[365]: [HbbTV].aitInvalidated
Jan 06 13:04:42 dm900 enigma2[365]: [SEC] update current switch params
Jan 06 13:04:42 dm900 enigma2[365]: [SEC] startTuneTimeout 5000
Jan 06 13:04:42 dm900 enigma2[365]: [SEC] setFrontend 1
Jan 06 13:04:42 dm900 enigma2[365]: (2)setting frontend
Jan 06 13:04:42 dm900 enigma2[365]: [SEC] unlock
Jan 06 13:04:42 dm900 enigma2[365]: [SEC] sleep 500ms
Jan 06 13:04:43 dm900 enigma2[365]: [eCec] attached: hdmi attached
Jan 06 13:04:43 dm900 enigma2[365]: [eCec] attached: hdmi cec address acknowledged
Jan 06 13:04:43 dm900 enigma2[365]: [eCec] my physical: 1.0.0.0  logical 3
Jan 06 13:04:43 dm900 enigma2[365]: I/  [Cec.ready] :: READY to power on!
Jan 06 13:04:43 dm900 enigma2[365]: [eCec] current powerstate = 0
Jan 06 13:04:43 dm900 enigma2[365]: [Cec] power on
Jan 06 13:04:43 dm900 enigma2[365]: child has terminated
Jan 06 13:04:43 dm900 enigma2[365]: pipes closed
Jan 06 13:04:43 dm900 enigma2[365]: Harddisk.py: failed to read /sys/devices/rdb.4/f03e3400.spi/spi_master/spi32766/spi32766.0/mtd/mtd0/mtdblock0/partition
Jan 06 13:04:43 dm900 enigma2[365]: ignoring event for /devices/rdb.4/f03e3400.spi/spi_master/spi32766/spi32766.0/mtd/mtd0/mtdblock0 (blacklisted)
Jan 06 13:04:43 dm900 enigma2[365]: Harddisk.py: failed to read /sys/devices/rdb.4/f03e3400.spi/spi_master/spi32766/spi32766.0/mtd/mtd2/mtdblock2/partition
Jan 06 13:04:43 dm900 enigma2[365]: ignoring event for /devices/rdb.4/f03e3400.spi/spi_master/spi32766/spi32766.0/mtd/mtd2/mtdblock2 (blacklisted)
Jan 06 13:04:43 dm900 enigma2[365]: Harddisk.py: failed to read /sys/devices/rdb.4/f03e3400.spi/spi_master/spi32766/spi32766.0/mtd/mtd3/mtdblock3/partition
Jan 06 13:04:43 dm900 enigma2[365]: ignoring event for /devices/rdb.4/f03e3400.spi/spi_master/spi32766/spi32766.0/mtd/mtd3/mtdblock3 (blacklisted)
Jan 06 13:04:43 dm900 enigma2[365]: Harddisk.py: failed to read /sys/devices/rdb.4/f03e3400.spi/spi_master/spi32766/spi32766.0/mtd/mtd4/mtdblock4/partition
Jan 06 13:04:43 dm900 enigma2[365]: ignoring event for /devices/rdb.4/f03e3400.spi/spi_master/spi32766/spi32766.0/mtd/mtd4/mtdblock4 (blacklisted)
Jan 06 13:04:43 dm900 enigma2[365]: Harddisk.py: failed to read /sys/devices/rdb.4/f03e3400.spi/spi_master/spi32766/spi32766.0/mtd/mtd1/mtdblock1/partition
Jan 06 13:04:43 dm900 enigma2[365]: ignoring event for /devices/rdb.4/f03e3400.spi/spi_master/spi32766/spi32766.0/mtd/mtd1/mtdblock1 (blacklisted)
Jan 06 13:04:43 dm900 enigma2[365]: Harddisk.py: failed to read /sys/devices/rdb.4/f03e0000.sdhci/mmc_host/mmc0/mmc0:0007/block/mmcblk1/partition
Jan 06 13:04:43 dm900 enigma2[365]: ignoring event for /devices/rdb.4/f03e0000.sdhci/mmc_host/mmc0/mmc0:0007/block/mmcblk1 (blacklisted)
Jan 06 13:04:43 dm900 enigma2[365]: Harddisk.py: failed to read /sys/devices/virtual/block/loop1/partition
Jan 06 13:04:43 dm900 enigma2[365]: ignoring event for /devices/virtual/block/loop1 (blacklisted)
Jan 06 13:04:43 dm900 enigma2[365]: Harddisk.py: failed to read /sys/devices/virtual/block/loop0/partition
Jan 06 13:04:43 dm900 enigma2[365]: ignoring event for /devices/virtual/block/loop0 (blacklisted)
Jan 06 13:04:43 dm900 enigma2[365]: Harddisk.py: failed to read /sys/devices/rdb.4/f03e0200.sdhci/mmc_host/mmc1/mmc1:0001/block/mmcblk0/partition
Jan 06 13:04:43 dm900 enigma2[365]: ignoring event for /devices/rdb.4/f03e0200.sdhci/mmc_host/mmc1/mmc1:0001/block/mmcblk0 (blacklisted)
Jan 06 13:04:43 dm900 enigma2[365]: Harddisk.py: failed to read /sys/devices/virtual/block/loop8/partition
Jan 06 13:04:43 dm900 enigma2[365]: ignoring event for /devices/virtual/block/loop8 (blacklisted)
Jan 06 13:04:43 dm900 enigma2[365]: ignoring event for /devices/rdb.4/f03e0200.sdhci/mmc_host/mmc1/mmc1:0001/block/mmcblk0/mmcblk0p1 (blacklisted)
Jan 06 13:04:43 dm900 enigma2[365]: Harddisk.py: failed to read /sys/devices/rdb.4/f03e0200.sdhci/mmc_host/mmc1/mmc1:0001/block/mmcblk0/mmcblk0rpmb/partition
Jan 06 13:04:43 dm900 enigma2[365]: ignoring event for /devices/rdb.4/f03e0200.sdhci/mmc_host/mmc1/mmc1:0001/block/mmcblk0/mmcblk0rpmb (blacklisted)
Jan 06 13:04:43 dm900 enigma2[365]: Harddisk.py: failed to read /sys/devices/rdb.4/f03e0200.sdhci/mmc_host/mmc1/mmc1:0001/block/mmcblk0/mmcblk0boot1/partition
Jan 06 13:04:43 dm900 enigma2[365]: ignoring event for /devices/rdb.4/f03e0200.sdhci/mmc_host/mmc1/mmc1:0001/block/mmcblk0/mmcblk0boot1 (blacklisted)
Jan 06 13:04:43 dm900 enigma2[365]: Harddisk.py: failed to read /sys/devices/rdb.4/f03e0200.sdhci/mmc_host/mmc1/mmc1:0001/block/mmcblk0/mmcblk0boot0/partition
Jan 06 13:04:43 dm900 enigma2[365]: ignoring event for /devices/rdb.4/f03e0200.sdhci/mmc_host/mmc1/mmc1:0001/block/mmcblk0/mmcblk0boot0 (blacklisted)
Jan 06 13:04:43 dm900 enigma2[365]: ignoring event for /devices/rdb.4/f03e0000.sdhci/mmc_host/mmc0/mmc0:0007/block/mmcblk1/mmcblk1p1 (blacklisted)
Jan 06 13:04:43 dm900 enigma2[365]: Harddisk.py: failed to read /sys/devices/platform/brcmstb-ahci.0/ata1/host0/target0:0:0/0:0:0:0/block/sda/partition
Jan 06 13:04:43 dm900 enigma2[365]: found block device 'sda':
Jan 06 13:04:43 dm900 enigma2[365]: Harddisk.py: New disk: sda
Jan 06 13:04:43 dm900 enigma2[365]: [ePopen] command: ('hdparm', 'hdparm', '-S0', '/dev/sda')
Jan 06 13:04:43 dm900 enigma2[365]: calling Notifier for device 'sda', reason 'add_delayed'
Jan 06 13:04:43 dm900 enigma2[365]: ignoring event for /devices/rdb.4/f03e0200.sdhci/mmc_host/mmc1/mmc1:0001/block/mmcblk0/mmcblk0p2 (blacklisted)
Jan 06 13:04:43 dm900 enigma2[365]: found block device 'sda1':
Jan 06 13:04:43 dm900 enigma2[365]: Harddisk.py: failed to read /sys/devices/rdb.4/f0470500.ehci_v2/usb4/4-1/4-1:1.0/host2/target2:0:0/2:0:0:0/block/sdb/partition
Jan 06 13:04:43 dm900 enigma2[365]: found block device 'sdb':
Jan 06 13:04:43 dm900 enigma2[365]: Harddisk.py: New disk: sdb
Jan 06 13:04:43 dm900 enigma2[365]: calling Notifier for device 'sdb', reason 'add_delayed'
Jan 06 13:04:43 dm900 enigma2[365]: ignoring event for /devices/rdb.4/f03e0200.sdhci/mmc_host/mmc1/mmc1:0001/block/mmcblk0/mmcblk0p3 (blacklisted)
Jan 06 13:04:43 dm900 enigma2[365]: found block device 'sdb1':
Jan 06 13:04:43 dm900 enigma2[365]: [addDevicePartition] device:'sdb1' with UUID:'ccbc99e4-3226-4a5a-9b04-a8be60d13255'
Jan 06 13:04:43 dm900 enigma2[365]: [setupConfigEntries] new device add for 'sdb1' with uuid:'ccbc99e4-3226-4a5a-9b04-a8be60d13255'
Jan 06 13:04:43 dm900 enigma2[365]: mountpoint /autofs/sdb1/
Jan 06 13:04:43 dm900 enigma2[365]: description DataTraveler 2.0
Jan 06 13:04:43 dm900 enigma2[365]: force_mounted True
Jan 06 13:04:43 dm900 enigma2[365]: scanning ('DataTraveler 2.0', '/autofs/sdb1/', <__main__.Session instance at 0x98f4ee68>)
Jan 06 13:04:43 dm900 enigma2[365]: scanner: [<Scanner Pictures>, <Scanner Dpkg>, <Scanner MediaCenter Movies>, <Scanner MediaCenter Music>]
Jan 06 13:04:43 dm900 enigma2[365]: create buffer for widget 782 x 175
Jan 06 13:04:43 dm900 enigma2[365]: calling Notifier for device 'sdb1', reason 'add_delayed'
Jan 06 13:04:43 dm900 enigma2[365]: HDDDetectedCB: main infobar is not execing... so we ignore hotplug event!
Jan 06 13:04:43 dm900 enigma2[365]: poll: unhandled POLLERR/HUP/NVAL for fd 99(16)
Jan 06 13:04:43 dm900 enigma2[365]: VIDEO_GET_EVENT - ok
Jan 06 13:04:43 dm900 enigma2[365]: I/  [ManagedControlPoint.doStart] :: starting now!
Jan 06 13:04:43 dm900 enigma2[365]: [eCec] attached: hdmi attached
Jan 06 13:04:43 dm900 enigma2[365]: [eCec] attached: hdmi cec address acknowledged
Jan 06 13:04:43 dm900 enigma2[365]: [eCec] my physical: 1.0.0.0  logical 3
Jan 06 13:04:43 dm900 enigma2[365]: (2)fe event: status 0, freq 1587500, inversion off, m_tuning 1 F
Jan 06 13:04:43 dm900 enigma2[365]: child has terminated
Jan 06 13:04:43 dm900 enigma2[365]: pipes closed
Jan 06 13:04:43 dm900 enigma2[365]: VIDEO_GET_EVENT - ok
Jan 06 13:04:43 dm900 enigma2[365]: poll: unhandled POLLERR/HUP/NVAL for fd 115(16)
Jan 06 13:04:43 dm900 enigma2[365]: [eCec] handle message 0 -> 3 : 8f
Jan 06 13:04:43 dm900 enigma2[365]: [eCec] Give Device Power Status
Jan 06 13:04:43 dm900 enigma2[365]: [eCec] Adding new Device with logical address 0
Jan 06 13:04:43 dm900 enigma2[365]: VIDEO_GET_EVENT - ok
Jan 06 13:04:43 dm900 enigma2[365]: unhandled DVBAPI Video Event 32
Jan 06 13:04:43 dm900 enigma2[365]: [eCec] handle message 0 -> 3 : 46
Jan 06 13:04:43 dm900 enigma2[365]: [eCec] Give OSD Name
Jan 06 13:04:43 dm900 enigma2[365]: [eCec] handle message 0 -> 3 : 46
Jan 06 13:04:43 dm900 enigma2[365]: [eCec] Give OSD Name
Jan 06 13:04:43 dm900 enigma2[365]: (2)fe event: status 10, freq 16, inversion off, m_tuning 1 N
Jan 06 13:04:43 dm900 enigma2[365]: OURSTATE: ok
Jan 06 13:04:43 dm900 enigma2[365]: [eDVBCAService] channel 0x2a14f18 running
Jan 06 13:04:43 dm900 enigma2[365]: [eDVBLocalTimeHandler] channel 0x2a14f18 running
Jan 06 13:04:43 dm900 enigma2[365]: no version filtering
Jan 06 13:04:43 dm900 enigma2[365]: 0014:  70 00 00 00 00 00
Jan 06 13:04:43 dm900 enigma2[365]: mask:  fc 00 00 00 00 00
Jan 06 13:04:43 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:04:43 dm900 enigma2[365]: [EPGC] channel 0x2a14f18 running
Jan 06 13:04:43 dm900 enigma2[365]: stop release channel timer
Jan 06 13:04:43 dm900 enigma2[365]: no version filtering
Jan 06 13:04:43 dm900 enigma2[365]: 0012:  4e 2e f4 00 00 00
Jan 06 13:04:43 dm900 enigma2[365]: mask:  ff ff ff 00 00 00
Jan 06 13:04:43 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:04:43 dm900 enigma2[365]: ok ... now we start!!
Jan 06 13:04:43 dm900 enigma2[365]: no version filtering
Jan 06 13:04:43 dm900 enigma2[365]: 0000:  00 00 00 00 00 00
Jan 06 13:04:43 dm900 enigma2[365]: mask:  ff 00 00 00 00 00
Jan 06 13:04:43 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:04:44 dm900 enigma2[365]: [eCec] handle message 0 -> 3 : 46
Jan 06 13:04:44 dm900 enigma2[365]: [eCec] Give OSD Name
Jan 06 13:04:44 dm900 enigma2[365]: [eCec] handle message 0 -> 3 : 8c
Jan 06 13:04:44 dm900 enigma2[365]: [eCec] Give Device Vendor ID
Jan 06 13:04:44 dm900 enigma2[365]: [eCec] send 3 -> 0 : 04
Jan 06 13:04:44 dm900 enigma2[365]: I/  [PlayerImpl.getVolume] :: <no detail>
Jan 06 13:04:44 dm900 enigma2[365]: I/  [PlayerImpl.getMute] :: <no detail>
Jan 06 13:04:44 dm900 enigma2[365]: I/  [PlayerImpl.getVolume] :: <no detail>
Jan 06 13:04:44 dm900 enigma2[365]: I/  [PlayerImpl.getMute] :: <no detail>
Jan 06 13:04:44 dm900 enigma2[365]: [eCec] checking new devices
Jan 06 13:04:44 dm900 enigma2[365]: [eCec] send 3 -> f : 82 10 00
Jan 06 13:04:44 dm900 enigma2[365]: [CrashlogAutoSubmit] gotMXServer:  82.149.226.184
Jan 06 13:04:44 dm900 enigma2[365]: [CrashlogAutoSubmit] - mxServerFound --> 82.149.226.184
Jan 06 13:04:44 dm900 enigma2[365]: [CrashlogAutoSubmit] - found crashlog:  enigma2_crash_1483693914.log
Jan 06 13:04:44 dm900 enigma2[365]: [CrashlogAutoSubmit] - found crashlog:  enigma2_crash_1483198164.log
Jan 06 13:04:44 dm900 enigma2[365]: [CrashlogAutoSubmit] - found crashlog:  enigma2_crash_1483693549.log
Jan 06 13:04:44 dm900 enigma2[365]: [CrashlogAutoSubmit] - found crashlog:  enigma2_crash_1483693484.log
Jan 06 13:04:44 dm900 enigma2[365]: [CrashlogAutoSubmit] - found crashlog:  enigma2_crash_1483650932.log
Jan 06 13:04:44 dm900 enigma2[365]: [CrashlogAutoSubmit] - found crashlog:  enigma2_crash_1483675020.log
Jan 06 13:04:44 dm900 enigma2[365]: [eCec] send 3 -> 5 : 70 10 00
Jan 06 13:04:44 dm900 enigma2[365]: + 1/1 TID 00
Jan 06 13:04:44 dm900 enigma2[365]: done!
Jan 06 13:04:44 dm900 enigma2[365]: PATready
Jan 06 13:04:44 dm900 enigma2[365]: use pmtpid 002e for service_id 2ef4
Jan 06 13:04:44 dm900 enigma2[365]: no version filtering
Jan 06 13:04:44 dm900 enigma2[365]: 002e:  02 2e f4 00 00 00
Jan 06 13:04:44 dm900 enigma2[365]: mask:  ff ff ff 00 00 00
Jan 06 13:04:44 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:04:44 dm900 enigma2[365]: doing version filtering
Jan 06 13:04:44 dm900 enigma2[365]: 0000:  00 00 00 0b 00 00
Jan 06 13:04:44 dm900 enigma2[365]: mask:  ff 00 00 3f 00 00
Jan 06 13:04:44 dm900 enigma2[365]: mode:  00 00 00 3e 00 00
Jan 06 13:04:44 dm900 enigma2[365]: before: 1
Jan 06 13:04:44 dm900 enigma2[365]: after: 1
Jan 06 13:04:44 dm900 enigma2[365]: [EPGC] db thread started
Jan 06 13:04:44 dm900 enigma2[365]: [EPGC] cleanupOutdated
Jan 06 13:04:44 dm900 enigma2[365]: [eCec] send 3 -> 0 : 83
Jan 06 13:04:44 dm900 enigma2[365]: VIDEO_GET_EVENT - ok
Jan 06 13:04:44 dm900 enigma2[365]: VIDEO_GET_EVENT - ok
Jan 06 13:04:44 dm900 enigma2[365]: unhandled DVBAPI Video Event 32
Jan 06 13:04:44 dm900 enigma2[365]: [eCec] send 3 -> f : 84 10 00 03
Jan 06 13:04:44 dm900 enigma2[365]: I/  [ManagedControlPoint._onMediaDeviceDectected] :: New Device found: dLAN 500 WiFi (WLANAccessPointDevice)
Jan 06 13:04:44 dm900 enigma2[365]: [eCec] send 3 -> f : 7d
Jan 06 13:04:44 dm900 enigma2[365]: I/  [ManagedControlPoint._onMediaDeviceDectected] :: New Device found: FRITZ!Box Fon WLAN 7390 (fritzbox)
Jan 06 13:04:44 dm900 enigma2[365]: I/  [ManagedControlPoint._onMediaDeviceDectected] :: New Device found: InternetGatewayDeviceV2 - FRITZ!Box Fon WLAN 7390 (InternetGatewayDevice)
Jan 06 13:04:44 dm900 enigma2[365]: [eCec] handle message 0 -> f : 84 00 00 00
Jan 06 13:04:44 dm900 enigma2[365]: [eCec] Report Physical Address 0.0.0.0
Jan 06 13:04:44 dm900 enigma2[365]: [eCec] device type 0 (TV)
Jan 06 13:04:44 dm900 enigma2[365]: + 1/1 TID 02
Jan 06 13:04:44 dm900 enigma2[365]: done!
Jan 06 13:04:44 dm900 enigma2[365]: [eFileWatch] Now watching /tmp
Jan 06 13:04:44 dm900 enigma2[365]: [eFileWatch] Now watching /var/run
Jan 06 13:04:44 dm900 enigma2[365]: [eDVBCAService] new service 1:0:1:2EF4:441:1:C00000:0:0:0:
Jan 06 13:04:44 dm900 enigma2[365]: [eDVBCAService] add demux 5 to slot 0 service 1:0:1:2EF4:441:1:C00000:0:0:0:
Jan 06 13:04:44 dm900 enigma2[365]: HBBTV broadcast data on pid 010f
Jan 06 13:04:44 dm900 enigma2[365]: [eDVBCAService] demux 5 mask 20
Jan 06 13:04:44 dm900 enigma2[365]: [eDVBCAServiceConn] send 68 bytes to '/tmp/camd.socket'
Jan 06 13:04:44 dm900 enigma2[365]: 9f 80 32 40 03 2e f4 21 00 17 01 81 08 00 c0 00 00 04 41 00 01 82 02 20 05 84 02 00 2e 85 02 02 43 02 00 a6 00 00 03 00 80 00 00 05 00 45 00 00 06 00 44 00 00 06 00 4b 00 00 0b 01 0f 00 00 0c 01 10 00 00
Jan 06 13:04:44 dm900 enigma2[365]: [eDVBCIInterfaces] addPMTHandler 1:0:1:2EF4:441:1:C00000:0:0:0:
Jan 06 13:04:44 dm900 enigma2[365]: [eDVBCIInterfaces] gotPMT
Jan 06 13:04:44 dm900 enigma2[365]: eventNewProgramInfo 0 0
Jan 06 13:04:44 dm900 enigma2[365]: start ait on pid 0045
Jan 06 13:04:44 dm900 enigma2[365]: no version filtering
Jan 06 13:04:44 dm900 enigma2[365]: 0045:  74 00 00 00 00 00
Jan 06 13:04:44 dm900 enigma2[365]: mask:  ff 00 00 00 00 00
Jan 06 13:04:44 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:04:44 dm900 enigma2[365]: have 1 video stream(s) (00a6), and 1 audio stream(s) (0080), and the pcr pid is 00a6, and the text pid is 0044
Jan 06 13:04:44 dm900 enigma2[365]: decoder state: play, vpid=166, apid=128
Jan 06 13:04:44 dm900 enigma2[365]: HBBTV broadcast data on pid 010f
Jan 06 13:04:44 dm900 enigma2[365]: [TeleText] serviceInfoChanged
Jan 06 13:04:44 dm900 enigma2[365]: [TeleText] TXT PID 68 DEMUX 5
Jan 06 13:04:44 dm900 enigma2[365]: [TeleText] send array('B', [1, 0, 68, 5])
Jan 06 13:04:44 dm900 enigma2[365]: doing version filtering
Jan 06 13:04:44 dm900 enigma2[365]: 002e:  02 2e f4 21 00 00
Jan 06 13:04:44 dm900 enigma2[365]: mask:  ff ff ff 3f 00 00
Jan 06 13:04:44 dm900 enigma2[365]: mode:  00 00 00 3e 00 00
Jan 06 13:04:44 dm900 enigma2[365]: I/  [ManagedControlPoint._onMediaDeviceDectected] :: New Device found: FritzBox UPnP/1.0 AVM (fritzbox)
Jan 06 13:04:44 dm900 enigma2[365]: I/  [ManagedControlPoint._onMediaDeviceDectected] :: New Device found: FRITZ!Box 7490 (InternetGatewayDevice)
Jan 06 13:04:44 dm900 enigma2[365]: I/  [ManagedControlPoint._onMediaDeviceDectected] :: New Device found: AVM FRITZ!Mediaserver (MediaServer)
Jan 06 13:04:44 dm900 enigma2[365]: I/  [ManagedControlPoint._onMediaDeviceDectected] :: New Device found: WANDevice - FRITZ!Box Fon WLAN 7390 (WANDevice)
Jan 06 13:04:44 dm900 enigma2[365]: [DLNA] MediaServer Detected: AVM FRITZ!Mediaserver (MediaServer)
Jan 06 13:04:44 dm900 enigma2[365]: I/  [ManagedControlPoint._onMediaDeviceDectected] :: New Device found: WANConnectionDevice - FRITZ!Box Fon WLAN 7390 (WANConnectionDevice)
Jan 06 13:04:44 dm900 enigma2[365]: [eCec] send 3 -> 0 : 83
Jan 06 13:04:44 dm900 enigma2[365]: +- 1/2 TID 4e
Jan 06 13:04:45 dm900 enigma2[365]: I/  [ManagedControlPoint._onMediaDeviceDectected] :: New Device found: FRITZ!Box 7490 (l2tpv3)
Jan 06 13:04:45 dm900 enigma2[365]: I/  [ManagedControlPoint._onMediaDeviceDectected] :: New Device found: InternetGatewayDeviceV2 - FRITZ!Box 7490 (InternetGatewayDevice)
Jan 06 13:04:45 dm900 enigma2[365]: I/  [ManagedControlPoint._onMediaDeviceDectected] :: New Device found: FRITZ!Box Fon WLAN 7390 (InternetGatewayDevice)
Jan 06 13:04:45 dm900 enigma2[365]: I/  [ManagedControlPoint._onMediaDeviceDectected] :: New Device found: WANDevice - FRITZ!Box 7490 (WANDevice)
Jan 06 13:04:45 dm900 enigma2[365]: I/  [ManagedControlPoint._onMediaDeviceDectected] :: New Device found: WANConnectionDevice - FRITZ!Box 7490 (WANConnectionDevice)
Jan 06 13:04:45 dm900 enigma2[365]: I/  [ManagedControlPoint._onMediaDeviceDectected] :: New Device found: AVM FRITZ!Mediaserver (MediaServer)
Jan 06 13:04:45 dm900 enigma2[365]: I/  [ManagedControlPoint._onMediaDeviceDectected] :: New Device found: WANDevice - FRITZ!Box 7490 (WANDevice)
Jan 06 13:04:45 dm900 enigma2[365]: [DLNA] MediaServer Detected: AVM FRITZ!Mediaserver (MediaServer)
Jan 06 13:04:45 dm900 enigma2[365]: I/  [ManagedControlPoint._onMediaDeviceDectected] :: New Device found: WANConnectionDevice - FRITZ!Box 7490 (WANConnectionDevice)
Jan 06 13:04:45 dm900 enigma2[365]: I/  [ManagedControlPoint._onMediaDeviceDectected] :: New Device found: WANDevice - FRITZ!Box Fon WLAN 7390 (WANDevice)
Jan 06 13:04:45 dm900 enigma2[365]: I/  [ManagedControlPoint._onMediaDeviceDectected] :: New Device found: WANConnectionDevice - FRITZ!Box Fon WLAN 7390 (WANConnectionDevice)
Jan 06 13:04:45 dm900 enigma2[365]: [eCec] handle message 0 -> f : 84 00 00 00
Jan 06 13:04:45 dm900 enigma2[365]: [eCec] Report Physical Address 0.0.0.0
Jan 06 13:04:45 dm900 enigma2[365]: [eCec] device type 0 (TV)
Jan 06 13:04:45 dm900 enigma2[365]: VIDEO_GET_EVENT - ok
Jan 06 13:04:45 dm900 enigma2[365]: poll: unhandled POLLERR/HUP/NVAL for fd 132(24)
Jan 06 13:04:45 dm900 enigma2[365]: poll: unhandled POLLERR/HUP/NVAL for fd 132(28)
Jan 06 13:04:45 dm900 enigma2[365]: I/  [ManagedControlPoint._onMediaDeviceDectected] :: New Dreambox found: dm900 WebInterface (Dreambox - http://192.168.88.89)
Jan 06 13:04:45 dm900 enigma2[365]: [eCec] send 3 -> 0 : 90 00
Jan 06 13:04:45 dm900 enigma2[365]: I/  [ManagedControlPoint._onMediaDeviceDectected] :: New Device found: KD-49X8005C (Basic)
Jan 06 13:04:45 dm900 enigma2[365]: I/  [ManagedControlPoint._onMediaDeviceDectected] :: New SAT>IP Server found: Digibit Twin (SatIPServer - DVBS2-2)
Jan 06 13:04:45 dm900 enigma2[365]: [eCec] send 3 -> 0 : 47 64 6d 39 30 30
Jan 06 13:04:45 dm900 enigma2[365]: I/  [ManagedControlPoint._onMediaDeviceDectected] :: New Device found: dm900 (MediaRenderer)
Jan 06 13:04:45 dm900 enigma2[365]: [DLNA] MediaRenderer detected: dm900 (MediaRenderer, uuid:949cf276-1a3b-45a5-ac18-0b45b934facd)
Jan 06 13:04:45 dm900 enigma2[365]: [eCec] send 3 -> 0 : 47 64 6d 39 30 30
Jan 06 13:04:45 dm900 enigma2[365]: I/  [ManagedControlPoint._onMediaDeviceDectected] :: New Device found: KD-49X8005C (dial)
Jan 06 13:04:45 dm900 enigma2[365]: I/  [ManagedControlPoint._onMediaDeviceDectected] :: New Device found: KD-49X8005C (MediaRenderer)
Jan 06 13:04:45 dm900 enigma2[365]: [eCec] handle message 0 -> 3 : 8c
Jan 06 13:04:45 dm900 enigma2[365]: [eCec] Give Device Vendor ID
Jan 06 13:04:45 dm900 enigma2[365]: [DLNA] MediaRenderer detected: KD-49X8005C (MediaRenderer, uuid:23456789-1234-1010-8000-ac9b0a76f481)
Jan 06 13:04:45 dm900 enigma2[365]: [DLNA] MediaRenderer detected: dm900 (MediaRenderer, uuid:949cf276-1a3b-45a5-ac18-0b45b934facd)
Jan 06 13:04:45 dm900 enigma2[365]: I/  [ManagedControlPoint._onMediaDeviceDectected] :: New Device found: dm900 Mediaserver (MediaServer)
Jan 06 13:04:45 dm900 enigma2[365]: + 1/1 TID 74
Jan 06 13:04:45 dm900 enigma2[365]: done!
Jan 06 13:04:45 dm900 enigma2[365]: [eHbbtv] aitChanged pid=0x45
Jan 06 13:04:45 dm900 enigma2[365]: [eOipfApplication] Profile 0000, Version 1.1.1
Jan 06 13:04:45 dm900 enigma2[365]: [eOipfApplication] deu:RTL2 Startleiste
Jan 06 13:04:45 dm900 enigma2[365]: [eHbbtv] New Application: RTL2 Startleiste (orgid=26, appid=700, urlBase=http://www.rtl2.de/, initalPath=hbbtvp, controlCode=1, visibility=2)
Jan 06 13:04:45 dm900 enigma2[365]: [eHbbtv] Resolving Application Locator: dvb://current.ait/1a.2bc
Jan 06 13:04:45 dm900 enigma2[365]: [eHbbtv] We have 1 app(s) for service 1.1089.12020
Jan 06 13:04:45 dm900 enigma2[365]: [eHbbtv] 'dvb://current.ait/1a.2bc' resolved to 'http://www.rtl2.de/hbbtvp'
Jan 06 13:04:45 dm900 enigma2[365]: [HbbTV].readButtonApplicationReady, appid=1a.2bc
Jan 06 13:04:45 dm900 enigma2[365]: doing version filtering
Jan 06 13:04:45 dm900 enigma2[365]: 0045:  74 00 00 03 00 00
Jan 06 13:04:45 dm900 enigma2[365]: mask:  ff 00 00 3f 00 00
Jan 06 13:04:45 dm900 enigma2[365]: mode:  00 00 00 3e 00 00
Jan 06 13:04:45 dm900 enigma2[365]: [eCec] send 3 -> 0 : 47 64 6d 39 30 30
Jan 06 13:04:45 dm900 enigma2[365]: [DLNA] MediaServer Detected: dm900 Mediaserver (MediaServer)
Jan 06 13:04:45 dm900 enigma2[365]: I/  [ManagedControlPoint._onMediaDeviceDectected] :: New Device found: HomePlug AV Wireless AP (WFADevice)
Jan 06 13:04:46 dm900 enigma2[365]: sdt update done!
Jan 06 13:04:46 dm900 enigma2[365]: [eCec] send 3 -> f : 87 00 09 34
Jan 06 13:04:46 dm900 enigma2[365]: I/  [ManagedControlPoint._onMediaDeviceDectected] :: New Device found: KD-49X8005C (Basic)
Jan 06 13:04:46 dm900 enigma2[365]: [eCec] send 3 -> 0 : 8c
Jan 06 13:04:46 dm900 enigma2[365]: [eCec] send 3 -> 0 : 46
Jan 06 13:04:46 dm900 enigma2[365]: [eCec] send 3 -> f : 85
Jan 06 13:04:46 dm900 enigma2[365]: [eCec] send 3 -> 0 : 8f
Jan 06 13:04:46 dm900 enigma2[365]: ++ 2/2 TID 4e
Jan 06 13:04:46 dm900 enigma2[365]: done!
Jan 06 13:04:46 dm900 enigma2[365]: doing version filtering
Jan 06 13:04:46 dm900 enigma2[365]: 0012:  4e 2e f4 1f 00 00
Jan 06 13:04:46 dm900 enigma2[365]: mask:  ff ff ff 3f 00 00
Jan 06 13:04:46 dm900 enigma2[365]: mode:  00 00 00 3e 00 00
Jan 06 13:04:46 dm900 enigma2[365]: [eDVBLocalTimeHandler] Receiver time is 'Fri Jan  6 13:04:46 2017'
Jan 06 13:04:46 dm900 enigma2[365]: [eDVBLocalTimeHandler] Transponder time is 'Fri Jan  6 13:04:46 2017'
Jan 06 13:04:46 dm900 enigma2[365]: [eDVBLocalTimeHandler] diff is 0
Jan 06 13:04:46 dm900 enigma2[365]: [eDVBLocalTimeHandler] diff < 120 .. use Transponder Time
Jan 06 13:04:46 dm900 enigma2[365]: [eDVBLocalTimeHandler] not changed
Jan 06 13:04:46 dm900 enigma2[365]: [eCec] send 3 -> f : 85
Jan 06 13:04:46 dm900 enigma2[365]: [eCec] send 3 -> 0 : 8f
Jan 06 13:04:46 dm900 enigma2[365]: [eCec] send 3 -> f : 87 00 09 34
Jan 06 13:04:46 dm900 enigma2[365]: [eCec] handle message 0 -> f : 87 08 00 46
Jan 06 13:04:46 dm900 enigma2[365]: [eCec] Device Vendor ID 080046 (Sony)
Jan 06 13:04:46 dm900 enigma2[365]: [eCecDevice] no vendor handler required!
Jan 06 13:04:46 dm900 enigma2[365]: [eCec] --- KNOWN CEC DEVICES ---
Jan 06 13:04:46 dm900 enigma2[365]: [eCec] |- 0 (): 080046 (Sony), power=15
Jan 06 13:04:46 dm900 enigma2[365]: [eCec] --- KNOWN CEC DEVICES ---
Jan 06 13:04:47 dm900 enigma2[365]: [eCec] handle message 0 -> 3 : 47 54 56
Jan 06 13:04:47 dm900 enigma2[365]: [eCec] Set OSD Name: TV
Jan 06 13:04:47 dm900 enigma2[365]: [eCec] --- KNOWN CEC DEVICES ---
Jan 06 13:04:47 dm900 enigma2[365]: [eCec] |- 0 (TV): 080046 (Sony), power=15
Jan 06 13:04:47 dm900 enigma2[365]: [eCec] --- KNOWN CEC DEVICES ---
Jan 06 13:04:47 dm900 enigma2[365]: [eCec] handle message 0 -> 3 : 90 00
Jan 06 13:04:47 dm900 enigma2[365]: [eCec] Report power status: On
Jan 06 13:04:47 dm900 enigma2[365]: [eCec] --- KNOWN CEC DEVICES ---
Jan 06 13:04:47 dm900 enigma2[365]: [eCec] |- 0 (TV): 080046 (Sony), power=0
Jan 06 13:04:47 dm900 enigma2[365]: [eCec] --- KNOWN CEC DEVICES ---
Jan 06 13:04:47 dm900 enigma2[365]: [eCec] handle message 0 -> 3 : 90 00
Jan 06 13:04:47 dm900 enigma2[365]: [eCec] Report power status: On
Jan 06 13:04:47 dm900 enigma2[365]: [eCec] --- KNOWN CEC DEVICES ---
Jan 06 13:04:47 dm900 enigma2[365]: [eCec] |- 0 (TV): 080046 (Sony), power=0
Jan 06 13:04:47 dm900 enigma2[365]: [eCec] --- KNOWN CEC DEVICES ---
Jan 06 13:04:47 dm900 enigma2[365]: [eCec] checking if we're the active source
Jan 06 13:04:47 dm900 enigma2[365]: [eCec] send 3 -> f : 82 10 00
Jan 06 13:04:47 dm900 enigma2[365]: action ->  MsgBoxActions cancel
Jan 06 13:04:47 dm900 enigma2[365]: [NotificationQueue::popNotification] domain default deferred_callable: False
Jan 06 13:04:47 dm900 enigma2[365]: I/  [TemplatedListFonts.__init__] :: Bigger: 24, Regular
Jan 06 13:04:47 dm900 enigma2[365]: I/  [TemplatedListFonts.__init__] :: Big: 22, Regular
Jan 06 13:04:47 dm900 enigma2[365]: I/  [TemplatedListFonts.__init__] :: Medium: 20, Regular
Jan 06 13:04:47 dm900 enigma2[365]: I/  [TemplatedListFonts.__init__] :: Small: 18, Regular
Jan 06 13:04:47 dm900 enigma2[365]: I/  [TemplatedListFonts.__init__] :: Smaller: 14, Regular
Jan 06 13:04:47 dm900 enigma2[365]: create buffer for widget 650 x 354
Jan 06 13:04:48 dm900 enigma2[365]: I/  [ManagedControlPoint._onMediaDeviceDectected] :: New Device found: NAS (NAS)
Jan 06 13:04:48 dm900 enigma2[365]: I/  [ManagedControlPoint._onMediaDeviceDectected] :: New Device found: Gerrit's Fire TV stick (dial)
Jan 06 13:04:49 dm900 enigma2[365]: action ->  WizardActions back
Jan 06 13:04:49 dm900 enigma2[365]: [CrashlogAutoSubmit] - handleAnswer -->  None
Jan 06 13:04:53 dm900 enigma2[365]: action ->  InfobarMenuActions mainMenu
Jan 06 13:04:53 dm900 enigma2[365]: loading mainmenu XML...
Jan 06 13:04:53 dm900 enigma2[365]: TimerEdit TimerEditList
Jan 06 13:04:53 dm900 enigma2[365]: PluginBrowser PluginBrowser
Jan 06 13:04:53 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:53 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:53 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:53 dm900 enigma2[365]: allocating new converter!
Jan 06 13:04:53 dm900 enigma2[365]: create buffer for widget 720 x 570
Jan 06 13:04:57 dm900 enigma2[365]: action ->  OkCancelActions cancel
Jan 06 13:05:02 dm900 enigma2[365]: no ancillary data in audio stream... abort radiotext pes parser
Jan 06 13:05:08 dm900 enigma2[365]: [eCec] handle message 0 -> 3 : 8f
Jan 06 13:05:08 dm900 enigma2[365]: [eCec] Give Device Power Status
Jan 06 13:05:08 dm900 enigma2[365]: [eCec] send 3 -> 0 : 90 00
Jan 06 13:05:15 dm900 enigma2[365]: action ->  InfobarChannelSelection zapDown
Jan 06 13:05:15 dm900 enigma2[365]: playing 1:0:1:445D:453:1:C00000:0:0:0:
Jan 06 13:05:15 dm900 enigma2[365]: [eDVBCAService] free slot 0 demux 5 for service 1:0:1:2EF4:441:1:C00000:0:0:0:
Jan 06 13:05:15 dm900 enigma2[365]: [eDVBCAService] free service 1:0:1:2EF4:441:1:C00000:0:0:0:
Jan 06 13:05:15 dm900 enigma2[365]: [TeleText] service stopped
Jan 06 13:05:15 dm900 enigma2[365]: [TeleText] send array('B', [1, 0, 0, 0])
Jan 06 13:05:15 dm900 enigma2[365]: disable dvb subtitles
Jan 06 13:05:15 dm900 enigma2[365]: disable teletext subtitles page ffffffffffffffff (und)
Jan 06 13:05:15 dm900 enigma2[365]: decoder state: play, vpid=-1, apid=-1
Jan 06 13:05:15 dm900 enigma2[365]: DEMUX_STOP - pcr - ok
Jan 06 13:05:15 dm900 enigma2[365]: DEMUX_STOP - video - ok
Jan 06 13:05:15 dm900 enigma2[365]: VIDEO_STOP - ok
Jan 06 13:05:15 dm900 enigma2[365]: AUDIO_STOP - ok
Jan 06 13:05:15 dm900 enigma2[365]: DEMUX_STOP - audio - ok
Jan 06 13:05:15 dm900 enigma2[365]: AUDIO_CONTINUE - ok
Jan 06 13:05:15 dm900 enigma2[365]: DEMUX_STOP - ttx - ok
Jan 06 13:05:15 dm900 enigma2[365]: start release channel timer
Jan 06 13:05:15 dm900 enigma2[365]: [TeleText] service started
Jan 06 13:05:15 dm900 enigma2[365]: create buffer for widget 1280 x 150
Jan 06 13:05:15 dm900 enigma2[365]: not pauseable.
Jan 06 13:05:15 dm900 enigma2[365]: RemovePopup, id = ZapError
Jan 06 13:05:15 dm900 enigma2[365]: [eDVBCAService] remove channel 0x2a14f18
Jan 06 13:05:15 dm900 enigma2[365]: [eDVBCAService] write leave transponder to '/tmp/camd.socket' ok
Jan 06 13:05:15 dm900 enigma2[365]: [eDVBLocalTimeHandler] remove channel 0x2a14f18
Jan 06 13:05:15 dm900 enigma2[365]: [EPGC] remove channel 0x2a14f18
Jan 06 13:05:15 dm900 enigma2[365]: (2) preClose
Jan 06 13:05:15 dm900 enigma2[365]: allocate channel.. 0453:0001:00c00000
Jan 06 13:05:15 dm900 enigma2[365]: [eDVBCAService] new channel 0x2a14f18!
Jan 06 13:05:15 dm900 enigma2[365]: (2)tune
Jan 06 13:05:15 dm900 enigma2[365]: RotorCmd ffffffff, lastRotorCmd ffffffff
Jan 06 13:05:15 dm900 enigma2[365]: prepare_sat System 0 Freq 12544750 Pol 0 SR 22000000 INV 2 FEC 4 orbpos 192 system 0 modulation 1 pilot 2, rolloff 0
Jan 06 13:05:15 dm900 enigma2[365]: tuning to 1944 mhz
Jan 06 13:05:15 dm900 enigma2[365]: OURSTATE: tuning
Jan 06 13:05:15 dm900 enigma2[365]: allocate Channel: res 0
Jan 06 13:05:15 dm900 enigma2[365]: allocate demux[SEC] lock 0
Jan 06 13:05:15 dm900 enigma2[365]: [SEC] invalidate current switch params
Jan 06 13:05:15 dm900 enigma2[365]: [SEC] update current switch params
Jan 06 13:05:15 dm900 enigma2[365]: getting program info failed.[SEC] startTuneTimeout 5000
Jan 06 13:05:15 dm900 enigma2[365]: allocate demux
Jan 06 13:05:15 dm900 enigma2[365]: [SEC] setFrontend 1
Jan 06 13:05:15 dm900 enigma2[365]: (2)setting frontend
Jan 06 13:05:15 dm900 enigma2[365]: disable teletext subtitles page ffffffffffffffff (und)
Jan 06 13:05:15 dm900 enigma2[365]: PES filter: DMX_SET_PES_FILTER - Invalid argument
Jan 06 13:05:15 dm900 enigma2[365]: decoder state: play, vpid=-1, apid=-1
Jan 06 13:05:15 dm900 enigma2[365]: [HbbTV].aitInvalidated
Jan 06 13:05:15 dm900 enigma2[365]: [SEC] unlock
Jan 06 13:05:15 dm900 enigma2[365]: [SEC] sleep 500ms
Jan 06 13:05:15 dm900 enigma2[365]: (2)fe event: status 0, freq 1944750, inversion off, m_tuning 1 F
Jan 06 13:05:16 dm900 enigma2[365]: (2)fe event: status 10, freq 16, inversion off, m_tuning 1 N
Jan 06 13:05:16 dm900 enigma2[365]: OURSTATE: ok
Jan 06 13:05:16 dm900 enigma2[365]: [eDVBCAService] channel 0x2a14f18 running
Jan 06 13:05:16 dm900 enigma2[365]: [eDVBLocalTimeHandler] channel 0x2a14f18 running
Jan 06 13:05:16 dm900 enigma2[365]: no version filtering
Jan 06 13:05:16 dm900 enigma2[365]: 0014:  70 00 00 00 00 00
Jan 06 13:05:16 dm900 enigma2[365]: mask:  fc 00 00 00 00 00
Jan 06 13:05:16 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:05:16 dm900 enigma2[365]: [EPGC] channel 0x2a14f18 running
Jan 06 13:05:16 dm900 enigma2[365]: stop release channel timer
Jan 06 13:05:16 dm900 enigma2[365]: no version filtering
Jan 06 13:05:16 dm900 enigma2[365]: 0012:  4e 44 5d 00 00 00
Jan 06 13:05:16 dm900 enigma2[365]: mask:  ff ff ff 00 00 00
Jan 06 13:05:16 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:05:16 dm900 enigma2[365]: ok ... now we start!!
Jan 06 13:05:16 dm900 enigma2[365]: no version filtering
Jan 06 13:05:16 dm900 enigma2[365]: 0000:  00 00 00 00 00 00
Jan 06 13:05:16 dm900 enigma2[365]: mask:  ff 00 00 00 00 00
Jan 06 13:05:16 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:05:16 dm900 enigma2[365]: [EPGC] next update in 2 sec
Jan 06 13:05:16 dm900 enigma2[365]: + 1/1 TID 00
Jan 06 13:05:16 dm900 enigma2[365]: done!
Jan 06 13:05:16 dm900 enigma2[365]: PATready
Jan 06 13:05:16 dm900 enigma2[365]: use pmtpid 0061 for service_id 445d
Jan 06 13:05:16 dm900 enigma2[365]: no version filtering
Jan 06 13:05:16 dm900 enigma2[365]: 0061:  02 44 5d 00 00 00
Jan 06 13:05:16 dm900 enigma2[365]: mask:  ff ff ff 00 00 00
Jan 06 13:05:16 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:05:16 dm900 enigma2[365]: doing version filtering
Jan 06 13:05:16 dm900 enigma2[365]: 0000:  00 00 00 33 00 00
Jan 06 13:05:16 dm900 enigma2[365]: mask:  ff 00 00 3f 00 00
Jan 06 13:05:16 dm900 enigma2[365]: mode:  00 00 00 3e 00 00
Jan 06 13:05:16 dm900 enigma2[365]: + 1/1 TID 02
Jan 06 13:05:16 dm900 enigma2[365]: done!
Jan 06 13:05:16 dm900 enigma2[365]: [eDVBCAService] new service 1:0:1:445D:453:1:C00000:0:0:0:
Jan 06 13:05:16 dm900 enigma2[365]: [eDVBCAService] add demux 5 to slot 0 service 1:0:1:445D:453:1:C00000:0:0:0:
Jan 06 13:05:16 dm900 enigma2[365]: HBBTV broadcast data on pid 0106
Jan 06 13:05:16 dm900 enigma2[365]: [eDVBCAService] demux 5 mask 20
Jan 06 13:05:16 dm900 enigma2[365]: [eDVBCAServiceConn] send 68 bytes to '/tmp/camd.socket'
Jan 06 13:05:16 dm900 enigma2[365]: 9f 80 32 40 03 44 5d 11 00 17 01 81 08 00 c0 00 00 04 53 00 01 82 02 20 05 84 02 00 61 85 02 02 43 06 00 21 00 00 0b 01 06 00 00 0c 01 07 00 00 02 01 ff 00 00 03 02 00 00 00 06 02 03 00 00 05 02 05 00 00
Jan 06 13:05:16 dm900 enigma2[365]: [eDVBCIInterfaces] addPMTHandler 1:0:1:445D:453:1:C00000:0:0:0:
Jan 06 13:05:16 dm900 enigma2[365]: [eDVBCIInterfaces] gotPMT
Jan 06 13:05:16 dm900 enigma2[365]: eventNewProgramInfo 0 0
Jan 06 13:05:16 dm900 enigma2[365]: start ait on pid 0205
Jan 06 13:05:16 dm900 enigma2[365]: no version filtering
Jan 06 13:05:16 dm900 enigma2[365]: 0205:  74 00 00 00 00 00
Jan 06 13:05:16 dm900 enigma2[365]: mask:  ff 00 00 00 00 00
Jan 06 13:05:16 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:05:16 dm900 enigma2[365]: have 1 video stream(s) (01ff), and 2 audio stream(s) (0200, 0203), and the pcr pid is 01ff, and the text pid is 0021
Jan 06 13:05:16 dm900 enigma2[365]: decoder state: play, vpid=511, apid=512
Jan 06 13:05:16 dm900 enigma2[365]: DMX_SET_PES_FILTER(0x1ff) - pcr - ok
Jan 06 13:05:16 dm900 enigma2[365]: DEMUX_START - pcr - ok
Jan 06 13:05:16 dm900 enigma2[365]: DMX_SET_PES_FILTER(0x200) - audio - ok
Jan 06 13:05:16 dm900 enigma2[365]: DEMUX_START - audio - ok
Jan 06 13:05:16 dm900 enigma2[365]: AUDIO_SET_BYPASS(1) - ok
Jan 06 13:05:16 dm900 enigma2[365]: AUDIO_PAUSE - ok
Jan 06 13:05:16 dm900 enigma2[365]: AUDIO_PLAY - ok
Jan 06 13:05:16 dm900 enigma2[365]: Video Device: /dev/dvb/adapter0/video0
Jan 06 13:05:16 dm900 enigma2[365]: demux device: /dev/dvb/adapter0/demux5
Jan 06 13:05:16 dm900 enigma2[365]: VIDEO_SET_STREAMTYPE 0 - ok
Jan 06 13:05:16 dm900 enigma2[365]: DMX_SET_PES_FILTER(0x1ff) - video - ok
Jan 06 13:05:16 dm900 enigma2[365]: DEMUX_START - video - ok
Jan 06 13:05:16 dm900 enigma2[365]: VIDEO_FREEZE - ok
Jan 06 13:05:16 dm900 enigma2[365]: VIDEO_PLAY - ok
Jan 06 13:05:16 dm900 enigma2[365]: DMX_SET_PES_FILTER(0x21) - ttx - ok
Jan 06 13:05:16 dm900 enigma2[365]: DEMUX_START - ttx - ok
Jan 06 13:05:16 dm900 enigma2[365]: VIDEO_SLOWMOTION(0) - ok
Jan 06 13:05:16 dm900 enigma2[365]: VIDEO_FAST_FORWARD(0) - ok
Jan 06 13:05:16 dm900 enigma2[365]: VIDEO_CONTINUE - ok
Jan 06 13:05:16 dm900 enigma2[365]: AUDIO_CONTINUE - ok
Jan 06 13:05:16 dm900 enigma2[365]: not pauseable.
Jan 06 13:05:16 dm900 enigma2[365]: HBBTV broadcast data on pid 0106
Jan 06 13:05:16 dm900 enigma2[365]: [TeleText] serviceInfoChanged
Jan 06 13:05:16 dm900 enigma2[365]: [TeleText] TXT PID 33 DEMUX 5
Jan 06 13:05:16 dm900 enigma2[365]: [TeleText] send array('B', [1, 0, 33, 5])
Jan 06 13:05:16 dm900 enigma2[365]: doing version filtering
Jan 06 13:05:16 dm900 enigma2[365]: 0061:  02 44 5d 11 00 00
Jan 06 13:05:16 dm900 enigma2[365]: mask:  ff ff ff 3f 00 00
Jan 06 13:05:16 dm900 enigma2[365]: mode:  00 00 00 3e 00 00
Jan 06 13:05:16 dm900 enigma2[365]: sdt update done!
Jan 06 13:05:16 dm900 enigma2[365]: +- 1/2 TID 4e
Jan 06 13:05:17 dm900 enigma2[365]: VIDEO_GET_EVENT - ok
Jan 06 13:05:17 dm900 enigma2[365]: unhandled DVBAPI Video Event 32
Jan 06 13:05:17 dm900 enigma2[365]: action ->  InfobarChannelSelection zapDown
Jan 06 13:05:17 dm900 enigma2[365]: playing 1:0:1:445E:453:1:C00000:0:0:0:
Jan 06 13:05:17 dm900 enigma2[365]: [eDVBCAService] free slot 0 demux 5 for service 1:0:1:445D:453:1:C00000:0:0:0:
Jan 06 13:05:17 dm900 enigma2[365]: [eDVBCAService] free service 1:0:1:445D:453:1:C00000:0:0:0:
Jan 06 13:05:17 dm900 enigma2[365]: [TeleText] service stopped
Jan 06 13:05:17 dm900 enigma2[365]: [TeleText] send array('B', [1, 0, 0, 0])
Jan 06 13:05:17 dm900 enigma2[365]: disable dvb subtitles
Jan 06 13:05:17 dm900 enigma2[365]: disable teletext subtitles page ffffffffffffffff (und)
Jan 06 13:05:17 dm900 enigma2[365]: decoder state: play, vpid=-1, apid=-1
Jan 06 13:05:17 dm900 enigma2[365]: DEMUX_STOP - pcr - ok
Jan 06 13:05:17 dm900 enigma2[365]: DEMUX_STOP - video - ok
Jan 06 13:05:17 dm900 enigma2[365]: VIDEO_STOP - ok
Jan 06 13:05:17 dm900 enigma2[365]: AUDIO_STOP - ok
Jan 06 13:05:17 dm900 enigma2[365]: DEMUX_STOP - audio - ok
Jan 06 13:05:17 dm900 enigma2[365]: AUDIO_CONTINUE - ok
Jan 06 13:05:17 dm900 enigma2[365]: DEMUX_STOP - ttx - ok
Jan 06 13:05:17 dm900 enigma2[365]: start release channel timer
Jan 06 13:05:17 dm900 enigma2[365]: [TeleText] service started
Jan 06 13:05:17 dm900 enigma2[365]: not pauseable.
Jan 06 13:05:17 dm900 enigma2[365]: RemovePopup, id = ZapError
Jan 06 13:05:17 dm900 enigma2[365]: use cached_channel
Jan 06 13:05:17 dm900 enigma2[365]: stop release channel timer
Jan 06 13:05:17 dm900 enigma2[365]: allocate Channel: res 0
Jan 06 13:05:17 dm900 enigma2[365]: no version filtering
Jan 06 13:05:17 dm900 enigma2[365]: 0012:  4e 44 5e 00 00 00
Jan 06 13:05:17 dm900 enigma2[365]: mask:  ff ff ff 00 00 00
Jan 06 13:05:17 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:05:17 dm900 enigma2[365]: ok ... now we start!!
Jan 06 13:05:17 dm900 enigma2[365]: no version filtering
Jan 06 13:05:17 dm900 enigma2[365]: 0000:  00 00 00 00 00 00
Jan 06 13:05:17 dm900 enigma2[365]: mask:  ff 00 00 00 00 00
Jan 06 13:05:17 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:05:17 dm900 enigma2[365]: getting program info failed.
Jan 06 13:05:17 dm900 enigma2[365]: disable teletext subtitles page ffffffffffffffff (und)
Jan 06 13:05:17 dm900 enigma2[365]: PES filter: DMX_SET_PES_FILTER - Invalid argument
Jan 06 13:05:17 dm900 enigma2[365]: decoder state: play, vpid=-1, apid=-1
Jan 06 13:05:17 dm900 enigma2[365]: [HbbTV].aitInvalidated
Jan 06 13:05:17 dm900 enigma2[365]: + 1/1 TID 00
Jan 06 13:05:17 dm900 enigma2[365]: done!
Jan 06 13:05:17 dm900 enigma2[365]: PATready
Jan 06 13:05:17 dm900 enigma2[365]: use pmtpid 0062 for service_id 445e
Jan 06 13:05:17 dm900 enigma2[365]: no version filtering
Jan 06 13:05:17 dm900 enigma2[365]: 0062:  02 44 5e 00 00 00
Jan 06 13:05:17 dm900 enigma2[365]: mask:  ff ff ff 00 00 00
Jan 06 13:05:17 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:05:17 dm900 enigma2[365]: doing version filtering
Jan 06 13:05:17 dm900 enigma2[365]: 0000:  00 00 00 33 00 00
Jan 06 13:05:17 dm900 enigma2[365]: mask:  ff 00 00 3f 00 00
Jan 06 13:05:17 dm900 enigma2[365]: mode:  00 00 00 3e 00 00
Jan 06 13:05:17 dm900 enigma2[365]: + 1/1 TID 02
Jan 06 13:05:17 dm900 enigma2[365]: done!
Jan 06 13:05:17 dm900 enigma2[365]: [eDVBCAService] new service 1:0:1:445E:453:1:C00000:0:0:0:
Jan 06 13:05:17 dm900 enigma2[365]: [eDVBCAService] add demux 5 to slot 0 service 1:0:1:445E:453:1:C00000:0:0:0:
Jan 06 13:05:17 dm900 enigma2[365]: HBBTV broadcast data on pid 0106
Jan 06 13:05:17 dm900 enigma2[365]: [eDVBCAService] demux 5 mask 20
Jan 06 13:05:17 dm900 enigma2[365]: [eDVBCAServiceConn] send 63 bytes to '/tmp/camd.socket'
Jan 06 13:05:17 dm900 enigma2[365]: 9f 80 32 3b 03 44 5e 11 00 17 01 81 08 00 c0 00 00 04 53 00 01 82 02 20 05 84 02 00 62 85 02 02 43 06 00 22 00 00 0b 01 06 00 00 0c 01 07 00 00 02 02 ff 00 00 03 03 00 00 00 05 03 05 00 00
Jan 06 13:05:17 dm900 enigma2[365]: [eDVBCIInterfaces] addPMTHandler 1:0:1:445E:453:1:C00000:0:0:0:
Jan 06 13:05:17 dm900 enigma2[365]: [eDVBCIInterfaces] gotPMT
Jan 06 13:05:17 dm900 enigma2[365]: eventNewProgramInfo 0 0
Jan 06 13:05:17 dm900 enigma2[365]: start ait on pid 0305
Jan 06 13:05:17 dm900 enigma2[365]: no version filtering
Jan 06 13:05:17 dm900 enigma2[365]: 0305:  74 00 00 00 00 00
Jan 06 13:05:17 dm900 enigma2[365]: mask:  ff 00 00 00 00 00
Jan 06 13:05:17 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:05:17 dm900 enigma2[365]: have 1 video stream(s) (02ff), and 1 audio stream(s) (0300), and the pcr pid is 02ff, and the text pid is 0022
Jan 06 13:05:17 dm900 enigma2[365]: decoder state: play, vpid=767, apid=768
Jan 06 13:05:17 dm900 enigma2[365]: DMX_SET_PES_FILTER(0x2ff) - pcr - ok
Jan 06 13:05:17 dm900 enigma2[365]: DEMUX_START - pcr - ok
Jan 06 13:05:17 dm900 enigma2[365]: DMX_SET_PES_FILTER(0x300) - audio - ok
Jan 06 13:05:17 dm900 enigma2[365]: DEMUX_START - audio - ok
Jan 06 13:05:17 dm900 enigma2[365]: AUDIO_SET_BYPASS(1) - ok
Jan 06 13:05:17 dm900 enigma2[365]: AUDIO_PAUSE - ok
Jan 06 13:05:17 dm900 enigma2[365]: AUDIO_PLAY - ok
Jan 06 13:05:17 dm900 enigma2[365]: Video Device: /dev/dvb/adapter0/video0
Jan 06 13:05:17 dm900 enigma2[365]: demux device: /dev/dvb/adapter0/demux5
Jan 06 13:05:17 dm900 enigma2[365]: VIDEO_SET_STREAMTYPE 0 - ok
Jan 06 13:05:17 dm900 enigma2[365]: DMX_SET_PES_FILTER(0x2ff) - video - ok
Jan 06 13:05:17 dm900 enigma2[365]: DEMUX_START - video - ok
Jan 06 13:05:17 dm900 enigma2[365]: VIDEO_FREEZE - ok
Jan 06 13:05:17 dm900 enigma2[365]: VIDEO_PLAY - ok
Jan 06 13:05:17 dm900 enigma2[365]: DMX_SET_PES_FILTER(0x22) - ttx - ok
Jan 06 13:05:17 dm900 enigma2[365]: DEMUX_START - ttx - ok
Jan 06 13:05:17 dm900 enigma2[365]: VIDEO_SLOWMOTION(0) - ok
Jan 06 13:05:17 dm900 enigma2[365]: VIDEO_FAST_FORWARD(0) - ok
Jan 06 13:05:17 dm900 enigma2[365]: VIDEO_CONTINUE - ok
Jan 06 13:05:17 dm900 enigma2[365]: AUDIO_CONTINUE - ok
Jan 06 13:05:17 dm900 enigma2[365]: not pauseable.
Jan 06 13:05:17 dm900 enigma2[365]: HBBTV broadcast data on pid 0106
Jan 06 13:05:17 dm900 enigma2[365]: [TeleText] serviceInfoChanged
Jan 06 13:05:17 dm900 enigma2[365]: [TeleText] TXT PID 34 DEMUX 5
Jan 06 13:05:17 dm900 enigma2[365]: [TeleText] send array('B', [1, 0, 34, 5])
Jan 06 13:05:17 dm900 enigma2[365]: doing version filtering
Jan 06 13:05:17 dm900 enigma2[365]: 0062:  02 44 5e 11 00 00
Jan 06 13:05:17 dm900 enigma2[365]: mask:  ff ff ff 3f 00 00
Jan 06 13:05:17 dm900 enigma2[365]: mode:  00 00 00 3e 00 00
Jan 06 13:05:17 dm900 enigma2[365]: -+ 1/2 TID 4e
Jan 06 13:05:18 dm900 enigma2[365]: [EPGC] start caching events(1483704318)
Jan 06 13:05:18 dm900 enigma2[365]: [eDVBLocalTimeHandler] Receiver time is 'Fri Jan  6 13:05:18 2017'
Jan 06 13:05:18 dm900 enigma2[365]: [eDVBLocalTimeHandler] Transponder time is 'Fri Jan  6 13:05:18 2017'
Jan 06 13:05:18 dm900 enigma2[365]: [eDVBLocalTimeHandler] diff is 0
Jan 06 13:05:18 dm900 enigma2[365]: [eDVBLocalTimeHandler] diff < 120 .. use Transponder Time
Jan 06 13:05:18 dm900 enigma2[365]: [eDVBLocalTimeHandler] not changed
Jan 06 13:05:18 dm900 enigma2[365]: ++ 2/2 TID 4e
Jan 06 13:05:18 dm900 enigma2[365]: done!
Jan 06 13:05:18 dm900 enigma2[365]: doing version filtering
Jan 06 13:05:18 dm900 enigma2[365]: 0012:  4e 44 5e 15 00 00
Jan 06 13:05:18 dm900 enigma2[365]: mask:  ff ff ff 3f 00 00
Jan 06 13:05:18 dm900 enigma2[365]: mode:  00 00 00 3e 00 00
Jan 06 13:05:18 dm900 enigma2[365]: VIDEO_GET_EVENT - ok
Jan 06 13:05:18 dm900 enigma2[365]: unhandled DVBAPI Video Event 32
Jan 06 13:05:19 dm900 enigma2[365]: + 1/1 TID 74
Jan 06 13:05:19 dm900 enigma2[365]: done!
Jan 06 13:05:19 dm900 enigma2[365]: [eHbbtv] aitChanged pid=0x305
Jan 06 13:05:19 dm900 enigma2[365]: [eOipfApplication] Profile 0000, Version 1.1.1
Jan 06 13:05:19 dm900 enigma2[365]: [eOipfApplication] deu:kabel eins
Jan 06 13:05:19 dm900 enigma2[365]: [eHbbtv] New Application: kabel eins (orgid=96, appid=3, urlBase=http://hbbtv.redbutton.de/service/, initalPath=redbutton.php?brand=k1de, controlCode=1, visibility=2)
Jan 06 13:05:19 dm900 enigma2[365]: [eHbbtv] Resolving Application Locator: dvb://current.ait/60.3
Jan 06 13:05:19 dm900 enigma2[365]: [eHbbtv] We have 1 app(s) for service 1.1107.17502
Jan 06 13:05:19 dm900 enigma2[365]: [eHbbtv] 'dvb://current.ait/60.3' resolved to 'http://hbbtv.redbutton.de/service/redbutton.php?brand=k1de'
Jan 06 13:05:19 dm900 enigma2[365]: [HbbTV].readButtonApplicationReady, appid=60.3
Jan 06 13:05:19 dm900 enigma2[365]: doing version filtering
Jan 06 13:05:19 dm900 enigma2[365]: 0305:  74 00 00 09 00 00
Jan 06 13:05:19 dm900 enigma2[365]: mask:  ff 00 00 3f 00 00
Jan 06 13:05:19 dm900 enigma2[365]: mode:  00 00 00 3e 00 00
Jan 06 13:05:19 dm900 enigma2[365]: action ->  InfobarChannelSelection zapDown
Jan 06 13:05:19 dm900 enigma2[365]: playing 1:0:1:33:21:85:C00000:0:0:0:
Jan 06 13:05:19 dm900 enigma2[365]: [eDVBCAService] free slot 0 demux 5 for service 1:0:1:445E:453:1:C00000:0:0:0:
Jan 06 13:05:19 dm900 enigma2[365]: [eDVBCAService] free service 1:0:1:445E:453:1:C00000:0:0:0:
Jan 06 13:05:19 dm900 enigma2[365]: [TeleText] service stopped
Jan 06 13:05:19 dm900 enigma2[365]: [TeleText] send array('B', [1, 0, 0, 0])
Jan 06 13:05:19 dm900 enigma2[365]: disable dvb subtitles
Jan 06 13:05:19 dm900 enigma2[365]: disable teletext subtitles page ffffffffffffffff (und)
Jan 06 13:05:19 dm900 enigma2[365]: decoder state: play, vpid=-1, apid=-1
Jan 06 13:05:19 dm900 enigma2[365]: DEMUX_STOP - pcr - ok
Jan 06 13:05:19 dm900 enigma2[365]: DEMUX_STOP - video - ok
Jan 06 13:05:19 dm900 enigma2[365]: VIDEO_STOP - ok
Jan 06 13:05:19 dm900 enigma2[365]: AUDIO_STOP - ok
Jan 06 13:05:20 dm900 enigma2[365]: DEMUX_STOP - audio - ok
Jan 06 13:05:20 dm900 enigma2[365]: AUDIO_CONTINUE - ok
Jan 06 13:05:20 dm900 enigma2[365]: DEMUX_STOP - ttx - ok
Jan 06 13:05:20 dm900 enigma2[365]: start release channel timer
Jan 06 13:05:20 dm900 enigma2[365]: [TeleText] service started
Jan 06 13:05:20 dm900 enigma2[365]: not pauseable.
Jan 06 13:05:20 dm900 enigma2[365]: RemovePopup, id = ZapError
Jan 06 13:05:20 dm900 enigma2[365]: [eDVBCAService] remove channel 0x2a14f18
Jan 06 13:05:20 dm900 enigma2[365]: [eDVBCAService] write leave transponder to '/tmp/camd.socket' ok
Jan 06 13:05:20 dm900 enigma2[365]: [eDVBLocalTimeHandler] remove channel 0x2a14f18
Jan 06 13:05:20 dm900 enigma2[365]: [EPGC] remove channel 0x2a14f18
Jan 06 13:05:20 dm900 enigma2[365]: [EPGC] abort caching events !!
Jan 06 13:05:20 dm900 enigma2[365]: (2) preClose
Jan 06 13:05:20 dm900 enigma2[365]: allocate channel.. 0021:0085:00c00000
Jan 06 13:05:20 dm900 enigma2[365]: [eDVBCAService] new channel 0x2a5d650!
Jan 06 13:05:20 dm900 enigma2[365]: (2)tune
Jan 06 13:05:20 dm900 enigma2[365]: RotorCmd ffffffff, lastRotorCmd ffffffff
Jan 06 13:05:20 dm900 enigma2[365]: prepare_sat System 0 Freq 12480000 Pol 1 SR 27500000 INV 2 FEC 3 orbpos 192 system 0 modulation 1 pilot 2, rolloff 0
Jan 06 13:05:20 dm900 enigma2[365]: tuning to 1880 mhz
Jan 06 13:05:20 dm900 enigma2[365]: OURSTATE: tuning
Jan 06 13:05:20 dm900 enigma2[365]: [SEC] lock 0
Jan 06 13:05:20 dm900 enigma2[365]: [SEC] invalidate current switch params
Jan 06 13:05:20 dm900 enigma2[365]: [SEC] setVoltage 1
Jan 06 13:05:20 dm900 enigma2[365]: (2)setVoltage 13V
Jan 06 13:05:20 dm900 enigma2[365]: [SEC] sleep 10ms
Jan 06 13:05:20 dm900 enigma2[365]: allocate Channel: res 0
Jan 06 13:05:20 dm900 enigma2[365]: allocate demux
Jan 06 13:05:20 dm900 enigma2[365]: getting program info failed.
Jan 06 13:05:20 dm900 enigma2[365]: allocate demux
Jan 06 13:05:20 dm900 enigma2[365]: disable teletext subtitles page ffffffffffffffff (und)
Jan 06 13:05:20 dm900 enigma2[365]: PES filter: DMX_SET_PES_FILTER - Invalid argument
Jan 06 13:05:20 dm900 enigma2[365]: decoder state: play, vpid=-1, apid=-1
Jan 06 13:05:20 dm900 enigma2[365]: [HbbTV].aitInvalidated
Jan 06 13:05:20 dm900 enigma2[365]: [SEC] update current switch params
Jan 06 13:05:20 dm900 enigma2[365]: [SEC] startTuneTimeout 5000
Jan 06 13:05:20 dm900 enigma2[365]: [SEC] setFrontend 1
Jan 06 13:05:20 dm900 enigma2[365]: (2)setting frontend
Jan 06 13:05:20 dm900 enigma2[365]: [SEC] unlock
Jan 06 13:05:20 dm900 enigma2[365]: [SEC] sleep 500ms
Jan 06 13:05:20 dm900 enigma2[365]: (2)fe event: status 0, freq 1880000, inversion off, m_tuning 1 F
Jan 06 13:05:20 dm900 enigma2[365]: [EPGC] cleanup invalid data
Jan 06 13:05:21 dm900 enigma2[365]: (2)fe event: status 10, freq 16, inversion off, m_tuning 1 N
Jan 06 13:05:21 dm900 enigma2[365]: OURSTATE: ok
Jan 06 13:05:21 dm900 enigma2[365]: [eDVBCAService] channel 0x2a5d650 running
Jan 06 13:05:21 dm900 enigma2[365]: [eDVBLocalTimeHandler] channel 0x2a5d650 running
Jan 06 13:05:21 dm900 enigma2[365]: no version filtering
Jan 06 13:05:21 dm900 enigma2[365]: 0014:  70 00 00 00 00 00
Jan 06 13:05:21 dm900 enigma2[365]: mask:  fc 00 00 00 00 00
Jan 06 13:05:21 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:05:21 dm900 enigma2[365]: [EPGC] channel 0x2a5d650 running
Jan 06 13:05:21 dm900 enigma2[365]: stop release channel timer
Jan 06 13:05:21 dm900 enigma2[365]: [EPGC] next update in 2 sec
Jan 06 13:05:21 dm900 enigma2[365]: no version filtering
Jan 06 13:05:21 dm900 enigma2[365]: 0012:  4e 00 33 00 00 00
Jan 06 13:05:21 dm900 enigma2[365]: mask:  ff ff ff 00 00 00
Jan 06 13:05:21 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:05:21 dm900 enigma2[365]: ok ... now we start!!
Jan 06 13:05:21 dm900 enigma2[365]: no version filtering
Jan 06 13:05:21 dm900 enigma2[365]: 0000:  00 00 00 00 00 00
Jan 06 13:05:21 dm900 enigma2[365]: mask:  ff 00 00 00 00 00
Jan 06 13:05:21 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:05:21 dm900 enigma2[365]: + 1/1 TID 00
Jan 06 13:05:21 dm900 enigma2[365]: done!
Jan 06 13:05:21 dm900 enigma2[365]: PATready
Jan 06 13:05:21 dm900 enigma2[365]: use pmtpid 0063 for service_id 0033
Jan 06 13:05:21 dm900 enigma2[365]: no version filtering
Jan 06 13:05:21 dm900 enigma2[365]: 0063:  02 00 33 00 00 00
Jan 06 13:05:21 dm900 enigma2[365]: mask:  ff ff ff 00 00 00
Jan 06 13:05:21 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:05:21 dm900 enigma2[365]: doing version filtering
Jan 06 13:05:21 dm900 enigma2[365]: 0000:  00 00 00 21 00 00
Jan 06 13:05:21 dm900 enigma2[365]: mask:  ff 00 00 3f 00 00
Jan 06 13:05:21 dm900 enigma2[365]: mode:  00 00 00 3e 00 00
Jan 06 13:05:21 dm900 enigma2[365]: + 1/1 TID 02
Jan 06 13:05:21 dm900 enigma2[365]: done!
Jan 06 13:05:21 dm900 enigma2[365]: [eDVBCAService] new service 1:0:1:33:21:85:C00000:0:0:0:
Jan 06 13:05:21 dm900 enigma2[365]: [eDVBCAService] add demux 5 to slot 0 service 1:0:1:33:21:85:C00000:0:0:0:
Jan 06 13:05:21 dm900 enigma2[365]: [eDVBCAService] demux 5 mask 20
Jan 06 13:05:21 dm900 enigma2[365]: [eDVBCAServiceConn] send 53 bytes to '/tmp/camd.socket'
Jan 06 13:05:21 dm900 enigma2[365]: 9f 80 32 31 03 00 33 07 00 17 01 81 08 00 c0 00 00 00 21 00 85 82 02 20 05 84 02 00 63 85 02 02 43 06 00 26 00 00 02 05 ff 00 00 03 06 00 00 00 05 06 05 00 00
Jan 06 13:05:21 dm900 enigma2[365]: [eDVBCIInterfaces] addPMTHandler 1:0:1:33:21:85:C00000:0:0:0:
Jan 06 13:05:21 dm900 enigma2[365]: [eDVBCIInterfaces] gotPMT
Jan 06 13:05:21 dm900 enigma2[365]: eventNewProgramInfo 0 0
Jan 06 13:05:21 dm900 enigma2[365]: start ait on pid 0605
Jan 06 13:05:21 dm900 enigma2[365]: no version filtering
Jan 06 13:05:21 dm900 enigma2[365]: 0605:  74 00 00 00 00 00
Jan 06 13:05:21 dm900 enigma2[365]: mask:  ff 00 00 00 00 00
Jan 06 13:05:21 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:05:21 dm900 enigma2[365]: have 1 video stream(s) (05ff), and 1 audio stream(s) (0600), and the pcr pid is 05ff, and the text pid is 0026
Jan 06 13:05:21 dm900 enigma2[365]: decoder state: play, vpid=1535, apid=1536
Jan 06 13:05:21 dm900 enigma2[365]: DMX_SET_PES_FILTER(0x5ff) - pcr - ok
Jan 06 13:05:21 dm900 enigma2[365]: DEMUX_START - pcr - ok
Jan 06 13:05:21 dm900 enigma2[365]: DMX_SET_PES_FILTER(0x600) - audio - ok
Jan 06 13:05:21 dm900 enigma2[365]: DEMUX_START - audio - ok
Jan 06 13:05:21 dm900 enigma2[365]: AUDIO_SET_BYPASS(1) - ok
Jan 06 13:05:21 dm900 enigma2[365]: AUDIO_PAUSE - ok
Jan 06 13:05:21 dm900 enigma2[365]: AUDIO_PLAY - ok
Jan 06 13:05:21 dm900 enigma2[365]: Video Device: /dev/dvb/adapter0/video0
Jan 06 13:05:21 dm900 enigma2[365]: demux device: /dev/dvb/adapter0/demux5
Jan 06 13:05:21 dm900 enigma2[365]: VIDEO_SET_STREAMTYPE 0 - ok
Jan 06 13:05:21 dm900 enigma2[365]: DMX_SET_PES_FILTER(0x5ff) - video - ok
Jan 06 13:05:21 dm900 enigma2[365]: DEMUX_START - video - ok
Jan 06 13:05:21 dm900 enigma2[365]: VIDEO_FREEZE - ok
Jan 06 13:05:21 dm900 enigma2[365]: VIDEO_PLAY - ok
Jan 06 13:05:21 dm900 enigma2[365]: DMX_SET_PES_FILTER(0x26) - ttx - ok
Jan 06 13:05:21 dm900 enigma2[365]: DEMUX_START - ttx - ok
Jan 06 13:05:21 dm900 enigma2[365]: VIDEO_SLOWMOTION(0) - ok
Jan 06 13:05:21 dm900 enigma2[365]: VIDEO_FAST_FORWARD(0) - ok
Jan 06 13:05:21 dm900 enigma2[365]: VIDEO_CONTINUE - ok
Jan 06 13:05:21 dm900 enigma2[365]: AUDIO_CONTINUE - ok
Jan 06 13:05:21 dm900 enigma2[365]: not pauseable.
Jan 06 13:05:21 dm900 enigma2[365]: [TeleText] serviceInfoChanged
Jan 06 13:05:21 dm900 enigma2[365]: [TeleText] TXT PID 38 DEMUX 5
Jan 06 13:05:21 dm900 enigma2[365]: [TeleText] send array('B', [1, 0, 38, 5])
Jan 06 13:05:21 dm900 enigma2[365]: doing version filtering
Jan 06 13:05:21 dm900 enigma2[365]: 0063:  02 00 33 07 00 00
Jan 06 13:05:21 dm900 enigma2[365]: mask:  ff ff ff 3f 00 00
Jan 06 13:05:21 dm900 enigma2[365]: mode:  00 00 00 3e 00 00
Jan 06 13:05:21 dm900 enigma2[365]: sdt update done!
Jan 06 13:05:21 dm900 enigma2[365]: -+ 1/2 TID 4e
Jan 06 13:05:21 dm900 enigma2[365]: [eDVBLocalTimeHandler] Receiver time is 'Fri Jan  6 13:05:22 2017'
Jan 06 13:05:21 dm900 enigma2[365]: [eDVBLocalTimeHandler] Transponder time is 'Fri Jan  6 13:05:21 2017'
Jan 06 13:05:21 dm900 enigma2[365]: [eDVBLocalTimeHandler] diff is -1
Jan 06 13:05:21 dm900 enigma2[365]: [eDVBLocalTimeHandler] diff < 120 .. use Transponder Time
Jan 06 13:05:21 dm900 enigma2[365]: [eDVBLocalTimeHandler] update RTC
Jan 06 13:05:21 dm900 enigma2[365]: [eDVBLocalTimeHandler] time_difference is -1
Jan 06 13:05:21 dm900 enigma2[365]: [eDVBLocalTimeHandler] update Linux Time
Jan 06 13:05:21 dm900 enigma2[365]: VIDEO_GET_EVENT - ok
Jan 06 13:05:21 dm900 enigma2[365]: unhandled DVBAPI Video Event 32
Jan 06 13:05:21 dm900 enigma2[365]: + 1/1 TID 74
Jan 06 13:05:21 dm900 enigma2[365]: done!
Jan 06 13:05:21 dm900 enigma2[365]: [eHbbtv] aitChanged pid=0x605
Jan 06 13:05:21 dm900 enigma2[365]: [eOipfApplication] Profile 0000, Version 1.1.1
Jan 06 13:05:21 dm900 enigma2[365]: [eOipfApplication] deu:TELE5 HD
Jan 06 13:05:21 dm900 enigma2[365]: [eHbbtv] New Application: TELE5 HD (orgid=33, appid=33, urlBase=http://cdn.hbbtv.smartclip.net/, initalPath=loader.html?channel=tele5.hbbtv.x.de.smartclip, controlCode=1, visibility=2)
Jan 06 13:05:21 dm900 enigma2[365]: [eHbbtv] Resolving Application Locator: dvb://current.ait/21.21
Jan 06 13:05:21 dm900 enigma2[365]: [eHbbtv] We have 1 app(s) for service 133.33.51
Jan 06 13:05:21 dm900 enigma2[365]: [eHbbtv] 'dvb://current.ait/21.21' resolved to 'http://cdn.hbbtv.smartclip.net/loader.html?channel=tele5.hbbtv.x.de.smartclip'
Jan 06 13:05:21 dm900 enigma2[365]: [HbbTV].readButtonApplicationReady, appid=21.21
Jan 06 13:05:21 dm900 enigma2[365]: doing version filtering
Jan 06 13:05:21 dm900 enigma2[365]: 0605:  74 00 00 0d 00 00
Jan 06 13:05:21 dm900 enigma2[365]: mask:  ff 00 00 3f 00 00
Jan 06 13:05:21 dm900 enigma2[365]: mode:  00 00 00 3e 00 00
Jan 06 13:05:21 dm900 enigma2[365]: ++ 2/2 TID 4e
Jan 06 13:05:21 dm900 enigma2[365]: done!
Jan 06 13:05:21 dm900 enigma2[365]: doing version filtering
Jan 06 13:05:21 dm900 enigma2[365]: 0012:  4e 00 33 1d 00 00
Jan 06 13:05:21 dm900 enigma2[365]: mask:  ff ff ff 3f 00 00
Jan 06 13:05:21 dm900 enigma2[365]: mode:  00 00 00 3e 00 00
Jan 06 13:05:21 dm900 enigma2[365]: action ->  InfobarChannelSelection zapDown
Jan 06 13:05:21 dm900 enigma2[365]: playing 1:0:1:2F1C:441:1:C00000:0:0:0:
Jan 06 13:05:21 dm900 enigma2[365]: [eDVBCAService] free slot 0 demux 5 for service 1:0:1:33:21:85:C00000:0:0:0:
Jan 06 13:05:21 dm900 enigma2[365]: [eDVBCAService] free service 1:0:1:33:21:85:C00000:0:0:0:
Jan 06 13:05:21 dm900 enigma2[365]: [TeleText] service stopped
Jan 06 13:05:21 dm900 enigma2[365]: [TeleText] send array('B', [1, 0, 0, 0])
Jan 06 13:05:21 dm900 enigma2[365]: disable dvb subtitles
Jan 06 13:05:21 dm900 enigma2[365]: disable teletext subtitles page ffffffffffffffff (und)
Jan 06 13:05:21 dm900 enigma2[365]: decoder state: play, vpid=-1, apid=-1
Jan 06 13:05:21 dm900 enigma2[365]: DEMUX_STOP - pcr - ok
Jan 06 13:05:21 dm900 enigma2[365]: DEMUX_STOP - video - ok
Jan 06 13:05:21 dm900 enigma2[365]: VIDEO_STOP - ok
Jan 06 13:05:21 dm900 enigma2[365]: AUDIO_STOP - ok
Jan 06 13:05:21 dm900 enigma2[365]: DEMUX_STOP - audio - ok
Jan 06 13:05:21 dm900 enigma2[365]: AUDIO_CONTINUE - ok
Jan 06 13:05:21 dm900 enigma2[365]: DEMUX_STOP - ttx - ok
Jan 06 13:05:21 dm900 enigma2[365]: start release channel timer
Jan 06 13:05:21 dm900 enigma2[365]: [TeleText] service started
Jan 06 13:05:21 dm900 enigma2[365]: not pauseable.
Jan 06 13:05:21 dm900 enigma2[365]: RemovePopup, id = ZapError
Jan 06 13:05:21 dm900 enigma2[365]: [eDVBCAService] remove channel 0x2a5d650
Jan 06 13:05:21 dm900 enigma2[365]: [eDVBCAService] write leave transponder to '/tmp/camd.socket' ok
Jan 06 13:05:21 dm900 enigma2[365]: [eDVBLocalTimeHandler] remove channel 0x2a5d650
Jan 06 13:05:21 dm900 enigma2[365]: [EPGC] remove channel 0x2a5d650
Jan 06 13:05:21 dm900 enigma2[365]: (2) preClose
Jan 06 13:05:21 dm900 enigma2[365]: allocate channel.. 0441:0001:00c00000
Jan 06 13:05:21 dm900 enigma2[365]: [eDVBCAService] new channel 0x2a5d650!
Jan 06 13:05:21 dm900 enigma2[365]: (2)tune
Jan 06 13:05:21 dm900 enigma2[365]: RotorCmd ffffffff, lastRotorCmd ffffffff
Jan 06 13:05:21 dm900 enigma2[365]: prepare_sat System 0 Freq 12187500 Pol 0 SR 27500000 INV 2 FEC 3 orbpos 192 system 0 modulation 1 pilot 2, rolloff 0
Jan 06 13:05:21 dm900 enigma2[365]: tuning to 1587 mhz
Jan 06 13:05:21 dm900 enigma2[365]: OURSTATE: tuning
Jan 06 13:05:21 dm900 enigma2[365]: allocate Channel: res 0
Jan 06 13:05:21 dm900 enigma2[365]: [SEC] lock 0
Jan 06 13:05:21 dm900 enigma2[365]: allocate demux
Jan 06 13:05:21 dm900 enigma2[365]: [SEC] invalidate current switch params
Jan 06 13:05:21 dm900 enigma2[365]: [SEC] setVoltage 2
Jan 06 13:05:21 dm900 enigma2[365]: (2)setVoltage 18V
Jan 06 13:05:21 dm900 enigma2[365]: getting program info failed.
Jan 06 13:05:21 dm900 enigma2[365]: allocate demux
Jan 06 13:05:21 dm900 enigma2[365]: [SEC] sleep 10ms
Jan 06 13:05:21 dm900 enigma2[365]: disable teletext subtitles page ffffffffffffffff (und)
Jan 06 13:05:21 dm900 enigma2[365]: PES filter: DMX_SET_PES_FILTER - Invalid argument
Jan 06 13:05:21 dm900 enigma2[365]: decoder state: play, vpid=-1, apid=-1
Jan 06 13:05:21 dm900 enigma2[365]: [HbbTV].aitInvalidated
Jan 06 13:05:21 dm900 enigma2[365]: [SEC] update current switch params
Jan 06 13:05:21 dm900 enigma2[365]: [SEC] startTuneTimeout 5000
Jan 06 13:05:21 dm900 enigma2[365]: [SEC] setFrontend 1
Jan 06 13:05:21 dm900 enigma2[365]: (2)setting frontend
Jan 06 13:05:21 dm900 enigma2[365]: [SEC] unlock
Jan 06 13:05:21 dm900 enigma2[365]: [SEC] sleep 500ms
Jan 06 13:05:21 dm900 enigma2[365]: (2)fe event: status 0, freq 1587500, inversion off, m_tuning 1 F
Jan 06 13:05:22 dm900 enigma2[365]: action ->  InfobarChannelSelection zapDown
Jan 06 13:05:22 dm900 enigma2[365]: playing 1:0:19:2B7A:3F3:1:C00000:0:0:0:
Jan 06 13:05:22 dm900 enigma2[365]: [TeleText] service stopped
Jan 06 13:05:22 dm900 enigma2[365]: [TeleText] send array('B', [1, 0, 0, 0])
Jan 06 13:05:22 dm900 enigma2[365]: disable dvb subtitles
Jan 06 13:05:22 dm900 enigma2[365]: disable teletext subtitles page ffffffffffffffff (und)
Jan 06 13:05:22 dm900 enigma2[365]: decoder state: play, vpid=-1, apid=-1
Jan 06 13:05:22 dm900 enigma2[365]: start release channel timer
Jan 06 13:05:22 dm900 enigma2[365]: [TeleText] service started
Jan 06 13:05:22 dm900 enigma2[365]: not pauseable.
Jan 06 13:05:22 dm900 enigma2[365]: RemovePopup, id = ZapError
Jan 06 13:05:22 dm900 enigma2[365]: [eDVBCAService] remove channel 0x2a5d650
Jan 06 13:05:22 dm900 enigma2[365]: [eDVBCAService] write leave transponder to '/tmp/camd.socket' ok
Jan 06 13:05:22 dm900 enigma2[365]: [eDVBLocalTimeHandler] remove channel 0x2a5d650
Jan 06 13:05:22 dm900 enigma2[365]: [EPGC] remove channel 0x2a5d650
Jan 06 13:05:22 dm900 enigma2[365]: (2) preClose
Jan 06 13:05:22 dm900 enigma2[365]: allocate channel.. 03f3:0001:00c00000
Jan 06 13:05:22 dm900 enigma2[365]: [eDVBCAService] new channel 0x2a5d650!
Jan 06 13:05:22 dm900 enigma2[365]: (2)tune
Jan 06 13:05:22 dm900 enigma2[365]: RotorCmd ffffffff, lastRotorCmd ffffffff
Jan 06 13:05:22 dm900 enigma2[365]: prepare_sat System 1 Freq 11361750 Pol 0 SR 22000000 INV 2 FEC 2 orbpos 192 system 1 modulation 2 pilot 2, rolloff 0
Jan 06 13:05:22 dm900 enigma2[365]: tuning to 1611 mhz
Jan 06 13:05:22 dm900 enigma2[365]: OURSTATE: tuning
Jan 06 13:05:22 dm900 enigma2[365]: allocate Channel: res 0
Jan 06 13:05:22 dm900 enigma2[365]: [SEC] lock 0
Jan 06 13:05:22 dm900 enigma2[365]: allocate demux
Jan 06 13:05:22 dm900 enigma2[365]: [SEC] invalidate current switch params
Jan 06 13:05:22 dm900 enigma2[365]: [SEC] setTone 0
Jan 06 13:05:22 dm900 enigma2[365]: (2)setTone Off
Jan 06 13:05:22 dm900 enigma2[365]: getting program info failed.
Jan 06 13:05:22 dm900 enigma2[365]: allocate demux
Jan 06 13:05:22 dm900 enigma2[365]: [SEC] sleep 10ms
Jan 06 13:05:22 dm900 enigma2[365]: disable teletext subtitles page ffffffffffffffff (und)
Jan 06 13:05:22 dm900 enigma2[365]: PES filter: DMX_SET_PES_FILTER - Invalid argument
Jan 06 13:05:22 dm900 enigma2[365]: decoder state: play, vpid=-1, apid=-1
Jan 06 13:05:22 dm900 enigma2[365]: [HbbTV].aitInvalidated
Jan 06 13:05:22 dm900 enigma2[365]: [SEC] update current switch params
Jan 06 13:05:22 dm900 enigma2[365]: [SEC] startTuneTimeout 5000
Jan 06 13:05:22 dm900 enigma2[365]: [SEC] setFrontend 1
Jan 06 13:05:22 dm900 enigma2[365]: (2)setting frontend
Jan 06 13:05:22 dm900 enigma2[365]: [SEC] unlock
Jan 06 13:05:22 dm900 enigma2[365]: [SEC] sleep 500ms
Jan 06 13:05:22 dm900 enigma2[365]: (2)fe event: status 0, freq 1611750, inversion off, m_tuning 1 F
Jan 06 13:05:23 dm900 enigma2[365]: (2)fe event: status 10, freq 16, inversion off, m_tuning 1 N
Jan 06 13:05:23 dm900 enigma2[365]: OURSTATE: ok
Jan 06 13:05:23 dm900 enigma2[365]: [eDVBCAService] channel 0x2a5d650 running
Jan 06 13:05:23 dm900 enigma2[365]: [eDVBLocalTimeHandler] channel 0x2a5d650 running
Jan 06 13:05:23 dm900 enigma2[365]: no version filtering
Jan 06 13:05:23 dm900 enigma2[365]: 0014:  70 00 00 00 00 00
Jan 06 13:05:23 dm900 enigma2[365]: mask:  fc 00 00 00 00 00
Jan 06 13:05:23 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:05:23 dm900 enigma2[365]: [EPGC] channel 0x2a5d650 running
Jan 06 13:05:23 dm900 enigma2[365]: stop release channel timer
Jan 06 13:05:23 dm900 enigma2[365]: [EPGC] next update in 2 sec
Jan 06 13:05:23 dm900 enigma2[365]: no version filtering
Jan 06 13:05:23 dm900 enigma2[365]: 0012:  4e 2b 7a 00 00 00
Jan 06 13:05:23 dm900 enigma2[365]: mask:  ff ff ff 00 00 00
Jan 06 13:05:23 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:05:23 dm900 enigma2[365]: ok ... now we start!!
Jan 06 13:05:23 dm900 enigma2[365]: no version filtering
Jan 06 13:05:23 dm900 enigma2[365]: 0000:  00 00 00 00 00 00
Jan 06 13:05:23 dm900 enigma2[365]: mask:  ff 00 00 00 00 00
Jan 06 13:05:23 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:05:24 dm900 enigma2[365]: + 1/1 TID 00
Jan 06 13:05:24 dm900 enigma2[365]: done!
Jan 06 13:05:24 dm900 enigma2[365]: PATready
Jan 06 13:05:24 dm900 enigma2[365]: use pmtpid 189c for service_id 2b7a
Jan 06 13:05:24 dm900 enigma2[365]: no version filtering
Jan 06 13:05:24 dm900 enigma2[365]: 189c:  02 2b 7a 00 00 00
Jan 06 13:05:24 dm900 enigma2[365]: mask:  ff ff ff 00 00 00
Jan 06 13:05:24 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:05:24 dm900 enigma2[365]: doing version filtering
Jan 06 13:05:24 dm900 enigma2[365]: 0000:  00 00 00 03 00 00
Jan 06 13:05:24 dm900 enigma2[365]: mask:  ff 00 00 3f 00 00
Jan 06 13:05:24 dm900 enigma2[365]: mode:  00 00 00 3e 00 00
Jan 06 13:05:24 dm900 enigma2[365]: + 1/1 TID 02
Jan 06 13:05:24 dm900 enigma2[365]: done!
Jan 06 13:05:24 dm900 enigma2[365]: [eDVBCAService] new service 1:0:19:2B7A:3F3:1:C00000:0:0:0:
Jan 06 13:05:24 dm900 enigma2[365]: [eDVBCAService] add demux 5 to slot 0 service 1:0:19:2B7A:3F3:1:C00000:0:0:0:
Jan 06 13:05:24 dm900 enigma2[365]: dvb subtitle  PID 18bb with wrong subtitling type (24)... force 0x10!!
Jan 06 13:05:24 dm900 enigma2[365]: [eDVBCAService] demux 5 mask 20
Jan 06 13:05:24 dm900 enigma2[365]: [eDVBCAServiceConn] send 73 bytes to '/tmp/camd.socket'
Jan 06 13:05:24 dm900 enigma2[365]: 9f 80 32 45 03 2b 7a 05 00 17 01 81 08 00 c0 00 00 03 f3 00 01 82 02 20 05 84 02 18 9c 85 02 02 43 1b 18 a6 00 00 03 18 b0 00 00 03 18 b1 00 00 06 18 b2 00 00 03 18 b3 00 00 06 18 ba 00 00 06 18 bb 00 00 05 18 1a 00 00
Jan 06 13:05:24 dm900 enigma2[365]: [eDVBCIInterfaces] addPMTHandler 1:0:19:2B7A:3F3:1:C00000:0:0:0:
Jan 06 13:05:24 dm900 enigma2[365]: [eDVBCIInterfaces] gotPMT
Jan 06 13:05:24 dm900 enigma2[365]: eventNewProgramInfo 0 0
Jan 06 13:05:24 dm900 enigma2[365]: start ait on pid 181a
Jan 06 13:05:24 dm900 enigma2[365]: no version filtering
Jan 06 13:05:24 dm900 enigma2[365]: 181a:  74 00 00 00 00 00
Jan 06 13:05:24 dm900 enigma2[365]: mask:  ff 00 00 00 00 00
Jan 06 13:05:24 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:05:24 dm900 enigma2[365]: have 1 video stream(s) (18a6), and 4 audio stream(s) (18b0, 18b1, 18b2, 18b3), and the pcr pid is 18a6, and the text pid is 18ba
Jan 06 13:05:24 dm900 enigma2[365]: decoder state: play, vpid=6310, apid=6320
Jan 06 13:05:24 dm900 enigma2[365]: DMX_SET_PES_FILTER(0x18a6) - pcr - ok
Jan 06 13:05:24 dm900 enigma2[365]: DEMUX_START - pcr - ok
Jan 06 13:05:24 dm900 enigma2[365]: DMX_SET_PES_FILTER(0x18b0) - audio - ok
Jan 06 13:05:24 dm900 enigma2[365]: DEMUX_START - audio - ok
Jan 06 13:05:24 dm900 enigma2[365]: AUDIO_SET_BYPASS(1) - ok
Jan 06 13:05:24 dm900 enigma2[365]: AUDIO_PAUSE - ok
Jan 06 13:05:24 dm900 enigma2[365]: AUDIO_PLAY - ok
Jan 06 13:05:24 dm900 enigma2[365]: Video Device: /dev/dvb/adapter0/video0
Jan 06 13:05:24 dm900 enigma2[365]: demux device: /dev/dvb/adapter0/demux5
Jan 06 13:05:24 dm900 enigma2[365]: VIDEO_SET_STREAMTYPE 1 - ok
Jan 06 13:05:24 dm900 enigma2[365]: DMX_SET_PES_FILTER(0x18a6) - video - ok
Jan 06 13:05:24 dm900 enigma2[365]: DEMUX_START - video - ok
Jan 06 13:05:24 dm900 enigma2[365]: VIDEO_FREEZE - ok
Jan 06 13:05:24 dm900 enigma2[365]: VIDEO_PLAY - ok
Jan 06 13:05:24 dm900 enigma2[365]: DMX_SET_PES_FILTER(0x18ba) - ttx - ok
Jan 06 13:05:24 dm900 enigma2[365]: DEMUX_START - ttx - ok
Jan 06 13:05:24 dm900 enigma2[365]: VIDEO_SLOWMOTION(0) - ok
Jan 06 13:05:24 dm900 enigma2[365]: VIDEO_FAST_FORWARD(0) - ok
Jan 06 13:05:24 dm900 enigma2[365]: VIDEO_CONTINUE - ok
Jan 06 13:05:24 dm900 enigma2[365]: AUDIO_CONTINUE - ok
Jan 06 13:05:24 dm900 enigma2[365]: not pauseable.
Jan 06 13:05:24 dm900 enigma2[365]: dvb subtitle  PID 18bb with wrong subtitling type (24)... force 0x10!!
Jan 06 13:05:24 dm900 enigma2[365]: [TeleText] serviceInfoChanged
Jan 06 13:05:24 dm900 enigma2[365]: [TeleText] TXT PID 6330 DEMUX 5
Jan 06 13:05:24 dm900 enigma2[365]: [TeleText] send array('B', [1, 24, 186, 5])
Jan 06 13:05:24 dm900 enigma2[365]: doing version filtering
Jan 06 13:05:24 dm900 enigma2[365]: 189c:  02 2b 7a 05 00 00
Jan 06 13:05:24 dm900 enigma2[365]: mask:  ff ff ff 3f 00 00
Jan 06 13:05:24 dm900 enigma2[365]: mode:  00 00 00 3e 00 00
Jan 06 13:05:24 dm900 enigma2[365]: sdt update done!
Jan 06 13:05:24 dm900 enigma2[365]: -+ 1/2 TID 4e
Jan 06 13:05:24 dm900 enigma2[365]: ++ 2/2 TID 4e
Jan 06 13:05:24 dm900 enigma2[365]: done!
Jan 06 13:05:24 dm900 enigma2[365]: doing version filtering
Jan 06 13:05:24 dm900 enigma2[365]: 0012:  4e 2b 7a 15 00 00
Jan 06 13:05:24 dm900 enigma2[365]: mask:  ff ff ff 3f 00 00
Jan 06 13:05:24 dm900 enigma2[365]: mode:  00 00 00 3e 00 00
Jan 06 13:05:25 dm900 enigma2[365]: VIDEO_GET_EVENT - ok
Jan 06 13:05:25 dm900 enigma2[365]: VIDEO_GET_EVENT - ok
Jan 06 13:05:25 dm900 enigma2[365]: VIDEO_GET_EVENT - ok
Jan 06 13:05:25 dm900 enigma2[365]: unhandled DVBAPI Video Event 32
Jan 06 13:05:25 dm900 enigma2[365]: + 1/1 TID 74
Jan 06 13:05:25 dm900 enigma2[365]: done!
Jan 06 13:05:25 dm900 enigma2[365]: [eHbbtv] aitChanged pid=0x181a
Jan 06 13:05:25 dm900 enigma2[365]: [eOipfApplication] Profile 0000, Version 1.1.1
Jan 06 13:05:25 dm900 enigma2[365]: [eOipfApplication] deu:ZDF start
Jan 06 13:05:25 dm900 enigma2[365]: [eHbbtv] New Application: ZDF start (orgid=17, appid=1, urlBase=http://hbbtv.zdf.de/zdfstart/, initalPath=index.php, controlCode=1, visibility=2)
Jan 06 13:05:25 dm900 enigma2[365]: [eHbbtv] Resolving Application Locator: dvb://current.ait/11.1
Jan 06 13:05:25 dm900 enigma2[365]: [eHbbtv] We have 1 app(s) for service 1.1011.11130
Jan 06 13:05:25 dm900 enigma2[365]: [eHbbtv] 'dvb://current.ait/11.1' resolved to 'http://hbbtv.zdf.de/zdfstart/index.php'
Jan 06 13:05:25 dm900 enigma2[365]: [eOipfApplication] Profile 0000, Version 1.1.1
Jan 06 13:05:25 dm900 enigma2[365]: [eOipfApplication] deu:ZDF programm
Jan 06 13:05:25 dm900 enigma2[365]: [eHbbtv] New Application: ZDF programm (orgid=17, appid=6, urlBase=http://hbbtv.zdf.de/zdfepg/, initalPath=index.php, controlCode=2, visibility=2)
Jan 06 13:05:25 dm900 enigma2[365]: [eHbbtv] Resolving Application Locator: dvb://current.ait/11.6
Jan 06 13:05:25 dm900 enigma2[365]: [eHbbtv] We have 2 app(s) for service 1.1011.11130
Jan 06 13:05:25 dm900 enigma2[365]: [eHbbtv] 'dvb://current.ait/11.6' resolved to 'http://hbbtv.zdf.de/zdfepg/index.php'
Jan 06 13:05:25 dm900 enigma2[365]: [eOipfApplication] Profile 0000, Version 1.1.1
Jan 06 13:05:25 dm900 enigma2[365]: [eOipfApplication] deu:ZDF mediathek
Jan 06 13:05:25 dm900 enigma2[365]: [eHbbtv] New Application: ZDF mediathek (orgid=17, appid=2, urlBase=http://hbbtv.zdf.de/zdfm3/, initalPath=index.php, controlCode=2, visibility=2)
Jan 06 13:05:25 dm900 enigma2[365]: [eHbbtv] Resolving Application Locator: dvb://current.ait/11.2
Jan 06 13:05:25 dm900 enigma2[365]: [eHbbtv] We have 3 app(s) for service 1.1011.11130
Jan 06 13:05:25 dm900 enigma2[365]: [eHbbtv] 'dvb://current.ait/11.2' resolved to 'http://hbbtv.zdf.de/zdfm3/index.php'
Jan 06 13:05:25 dm900 enigma2[365]: [eOipfApplication] Profile 0000, Version 1.1.1
Jan 06 13:05:25 dm900 enigma2[365]: [eOipfApplication] eng:ZDF nachrichten
Jan 06 13:05:25 dm900 enigma2[365]: [eHbbtv] New Application: ZDF nachrichten (orgid=17, appid=7, urlBase=http://hbbtv.zdf.de/zdfnews/, initalPath=index.php, controlCode=2, visibility=2)
Jan 06 13:05:25 dm900 enigma2[365]: [eHbbtv] Resolving Application Locator: dvb://current.ait/11.7
Jan 06 13:05:25 dm900 enigma2[365]: [eHbbtv] We have 4 app(s) for service 1.1011.11130
Jan 06 13:05:25 dm900 enigma2[365]: [eHbbtv] 'dvb://current.ait/11.7' resolved to 'http://hbbtv.zdf.de/zdfnews/index.php'
Jan 06 13:05:25 dm900 enigma2[365]: [eOipfApplication] Profile 0000, Version 1.1.1
Jan 06 13:05:25 dm900 enigma2[365]: [eOipfApplication] deu:ZDFtivi
Jan 06 13:05:25 dm900 enigma2[365]: [eHbbtv] New Application: ZDFtivi (orgid=17, appid=8, urlBase=http://hbbtv.zdf.de/zdftivi/, initalPath=index.php, controlCode=2, visibility=2)
Jan 06 13:05:25 dm900 enigma2[365]: [eHbbtv] Resolving Application Locator: dvb://current.ait/11.8
Jan 06 13:05:25 dm900 enigma2[365]: [eHbbtv] We have 5 app(s) for service 1.1011.11130
Jan 06 13:05:25 dm900 enigma2[365]: [eHbbtv] 'dvb://current.ait/11.8' resolved to 'http://hbbtv.zdf.de/zdftivi/index.php'
Jan 06 13:05:25 dm900 enigma2[365]: [HbbTV].readButtonApplicationReady, appid=11.1
Jan 06 13:05:25 dm900 enigma2[365]: doing version filtering
Jan 06 13:05:25 dm900 enigma2[365]: 181a:  74 00 00 0d 00 00
Jan 06 13:05:25 dm900 enigma2[365]: mask:  ff 00 00 3f 00 00
Jan 06 13:05:25 dm900 enigma2[365]: mode:  00 00 00 3e 00 00
Jan 06 13:05:25 dm900 enigma2[365]: [EPGC] start caching events(1483704325)
Jan 06 13:05:25 dm900 enigma2[365]: VIDEO_GET_EVENT - ok
Jan 06 13:05:26 dm900 enigma2[365]: action ->  InfobarTimeshiftActions timeshiftStop
Jan 06 13:05:26 dm900 enigma2[365]: action ->  InfobarActions showTv
Jan 06 13:05:26 dm900 enigma2[365]: reused converter!
Jan 06 13:05:26 dm900 enigma2[365]: reused converter!
Jan 06 13:05:26 dm900 enigma2[365]: reused converter!
Jan 06 13:05:26 dm900 enigma2[365]: create buffer for widget 1200 x 660
Jan 06 13:05:20 dm900 enigma2[365]: [eDVBLocalTimeHandler] Receiver time is 'Fri Jan  6 13:05:26 2017'
Jan 06 13:05:20 dm900 enigma2[365]: [eDVBLocalTimeHandler] Transponder time is 'Fri Jan  6 13:05:20 2017'
Jan 06 13:05:20 dm900 enigma2[365]: [eDVBLocalTimeHandler] diff is -6
Jan 06 13:05:20 dm900 enigma2[365]: [eDVBLocalTimeHandler] diff < 120 .. use Transponder Time
Jan 06 13:05:20 dm900 enigma2[365]: [eDVBLocalTimeHandler] update RTC
Jan 06 13:05:20 dm900 enigma2[365]: [eDVBLocalTimeHandler] time_difference is -6
Jan 06 13:05:20 dm900 enigma2[365]: [eDVBLocalTimeHandler] update Linux Time
Jan 06 13:05:21 dm900 enigma2[365]: action ->  ChannelSelectBaseActions selectServiceUp
Jan 06 13:05:21 dm900 enigma2[365]: unknown action ChannelSelectBaseActions/selectServiceUp! typo in keymap?
Jan 06 13:05:21 dm900 enigma2[365]: action ->  WizardActions up
Jan 06 13:05:21 dm900 enigma2[365]: unknown action WizardActions/up! typo in keymap?
Jan 06 13:05:21 dm900 enigma2[365]: action ->  ChannelSelectBaseActions selectServiceUp
Jan 06 13:05:21 dm900 enigma2[365]: unknown action ChannelSelectBaseActions/selectServiceUp! typo in keymap?
Jan 06 13:05:21 dm900 enigma2[365]: action ->  WizardActions up
Jan 06 13:05:21 dm900 enigma2[365]: unknown action WizardActions/up! typo in keymap?
Jan 06 13:05:21 dm900 enigma2[365]: action ->  ChannelSelectBaseActions selectServiceUp
Jan 06 13:05:21 dm900 enigma2[365]: unknown action ChannelSelectBaseActions/selectServiceUp! typo in keymap?
Jan 06 13:05:21 dm900 enigma2[365]: action ->  WizardActions up
Jan 06 13:05:21 dm900 enigma2[365]: unknown action WizardActions/up! typo in keymap?
Jan 06 13:05:22 dm900 enigma2[365]: action ->  ChannelSelectBaseActions selectServiceUp
Jan 06 13:05:22 dm900 enigma2[365]: unknown action ChannelSelectBaseActions/selectServiceUp! typo in keymap?
Jan 06 13:05:22 dm900 enigma2[365]: action ->  WizardActions up
Jan 06 13:05:22 dm900 enigma2[365]: unknown action WizardActions/up! typo in keymap?
Jan 06 13:05:22 dm900 enigma2[365]: action ->  ChannelSelectBaseActions selectServiceUp
Jan 06 13:05:22 dm900 enigma2[365]: unknown action ChannelSelectBaseActions/selectServiceUp! typo in keymap?
Jan 06 13:05:22 dm900 enigma2[365]: action ->  WizardActions up
Jan 06 13:05:22 dm900 enigma2[365]: unknown action WizardActions/up! typo in keymap?
Jan 06 13:05:22 dm900 enigma2[365]: action ->  ChannelSelectBaseActions selectServiceUp
Jan 06 13:05:22 dm900 enigma2[365]: unknown action ChannelSelectBaseActions/selectServiceUp! typo in keymap?
Jan 06 13:05:22 dm900 enigma2[365]: action ->  WizardActions up
Jan 06 13:05:22 dm900 enigma2[365]: unknown action WizardActions/up! typo in keymap?
Jan 06 13:05:23 dm900 enigma2[365]: action ->  ChannelSelectBaseActions selectServiceUp
Jan 06 13:05:23 dm900 enigma2[365]: unknown action ChannelSelectBaseActions/selectServiceUp! typo in keymap?
Jan 06 13:05:23 dm900 enigma2[365]: action ->  WizardActions up
Jan 06 13:05:23 dm900 enigma2[365]: unknown action WizardActions/up! typo in keymap?
Jan 06 13:05:23 dm900 enigma2[365]: action ->  ChannelSelectBaseActions selectServiceUp
Jan 06 13:05:23 dm900 enigma2[365]: unknown action ChannelSelectBaseActions/selectServiceUp! typo in keymap?
Jan 06 13:05:23 dm900 enigma2[365]: action ->  WizardActions up
Jan 06 13:05:23 dm900 enigma2[365]: unknown action WizardActions/up! typo in keymap?
Jan 06 13:05:23 dm900 enigma2[365]: action ->  ChannelSelectBaseActions selectServiceUp
Jan 06 13:05:23 dm900 enigma2[365]: unknown action ChannelSelectBaseActions/selectServiceUp! typo in keymap?
Jan 06 13:05:23 dm900 enigma2[365]: action ->  WizardActions up
Jan 06 13:05:23 dm900 enigma2[365]: unknown action WizardActions/up! typo in keymap?
Jan 06 13:05:23 dm900 enigma2[365]: action ->  ChannelSelectBaseActions selectServiceUp
Jan 06 13:05:23 dm900 enigma2[365]: unknown action ChannelSelectBaseActions/selectServiceUp! typo in keymap?
Jan 06 13:05:23 dm900 enigma2[365]: action ->  WizardActions up
Jan 06 13:05:23 dm900 enigma2[365]: unknown action WizardActions/up! typo in keymap?
Jan 06 13:05:24 dm900 enigma2[365]: action ->  OkCancelActions ok
Jan 06 13:05:24 dm900 enigma2[365]: playing 1:0:19:283D:3FB:1:C00000:0:0:0:
Jan 06 13:05:24 dm900 enigma2[365]: [eDVBCAService] free slot 0 demux 5 for service 1:0:19:2B7A:3F3:1:C00000:0:0:0:
Jan 06 13:05:24 dm900 enigma2[365]: [eDVBCAService] free service 1:0:19:2B7A:3F3:1:C00000:0:0:0:
Jan 06 13:05:24 dm900 enigma2[365]: [TeleText] service stopped
Jan 06 13:05:24 dm900 enigma2[365]: [TeleText] send array('B', [1, 0, 0, 0])
Jan 06 13:05:24 dm900 enigma2[365]: disable dvb subtitles
Jan 06 13:05:24 dm900 enigma2[365]: disable teletext subtitles page ffffffffffffffff (und)
Jan 06 13:05:24 dm900 enigma2[365]: decoder state: play, vpid=-1, apid=-1
Jan 06 13:05:24 dm900 enigma2[365]: DEMUX_STOP - pcr - ok
Jan 06 13:05:24 dm900 enigma2[365]: DEMUX_STOP - video - ok
Jan 06 13:05:24 dm900 enigma2[365]: VIDEO_STOP - ok
Jan 06 13:05:24 dm900 enigma2[365]: AUDIO_STOP - ok
Jan 06 13:05:24 dm900 enigma2[365]: DEMUX_STOP - audio - ok
Jan 06 13:05:24 dm900 enigma2[365]: AUDIO_CONTINUE - ok
Jan 06 13:05:24 dm900 enigma2[365]: DEMUX_STOP - ttx - ok
Jan 06 13:05:24 dm900 enigma2[365]: start release channel timer
Jan 06 13:05:24 dm900 enigma2[365]: [TeleText] service started
Jan 06 13:05:24 dm900 enigma2[365]: not pauseable.
Jan 06 13:05:24 dm900 enigma2[365]: RemovePopup, id = ZapError
Jan 06 13:05:24 dm900 enigma2[365]: [eDVBCAService] remove channel 0x2a5d650
Jan 06 13:05:24 dm900 enigma2[365]: [eDVBCAService] write leave transponder to '/tmp/camd.socket' ok
Jan 06 13:05:24 dm900 enigma2[365]: [eDVBLocalTimeHandler] remove channel 0x2a5d650
Jan 06 13:05:24 dm900 enigma2[365]: [EPGC] remove channel 0x2a5d650
Jan 06 13:05:24 dm900 enigma2[365]: [EPGC] abort caching events !!
Jan 06 13:05:24 dm900 enigma2[365]: (2) preClose
Jan 06 13:05:24 dm900 enigma2[365]: allocate channel.. 03fb:0001:00c00000
Jan 06 13:05:24 dm900 enigma2[365]: [eDVBCAService] new channel 0x2a5d650!
Jan 06 13:05:24 dm900 enigma2[365]: (2)tune
Jan 06 13:05:24 dm900 enigma2[365]: RotorCmd ffffffff, lastRotorCmd ffffffff
Jan 06 13:05:24 dm900 enigma2[365]: prepare_sat System 1 Freq 11493750 Pol 0 SR 22000000 INV 2 FEC 2 orbpos 192 system 1 modulation 2 pilot 2, rolloff 0
Jan 06 13:05:24 dm900 enigma2[365]: tuning to 1743 mhz
Jan 06 13:05:24 dm900 enigma2[365]: OURSTATE: tuning
Jan 06 13:05:24 dm900 enigma2[365]: allocate Channel: res 0
Jan 06 13:05:24 dm900 enigma2[365]: allocate demux
Jan 06 13:05:24 dm900 enigma2[365]: have 1 video stream(s) (13ed), and 1 audio stream(s) (13ee), and the pcr pid is 13ed, and the text pid is 13f0
Jan 06 13:05:24 dm900 enigma2[365]: allocate demux
Jan 06 13:05:24 dm900 enigma2[365]: disable teletext subtitles page ffffffffffffffff (und)
Jan 06 13:05:24 dm900 enigma2[365]: decoder state: play, vpid=5101, apid=5102
Jan 06 13:05:24 dm900 enigma2[365]: DMX_SET_PES_FILTER(0x13ed) - pcr - ok
Jan 06 13:05:24 dm900 enigma2[365]: DEMUX_START - pcr - ok
Jan 06 13:05:24 dm900 enigma2[365]: DMX_SET_PES_FILTER(0x13ee) - audio - ok
Jan 06 13:05:24 dm900 enigma2[365]: DEMUX_START - audio - ok
Jan 06 13:05:24 dm900 enigma2[365]: AUDIO_SET_BYPASS(1) - ok
Jan 06 13:05:24 dm900 enigma2[365]: AUDIO_PAUSE - ok
Jan 06 13:05:24 dm900 enigma2[365]: AUDIO_PLAY - [SEC] lock 0
Jan 06 13:05:24 dm900 enigma2[365]: [SEC] invalidate current switch params
Jan 06 13:05:24 dm900 enigma2[365]: [SEC] update current switch params
Jan 06 13:05:24 dm900 enigma2[365]: [SEC] startTuneTimeout 5000
Jan 06 13:05:24 dm900 enigma2[365]: [SEC] setFrontend 1
Jan 06 13:05:24 dm900 enigma2[365]: (2)setting frontend
Jan 06 13:05:24 dm900 enigma2[365]: ok
Jan 06 13:05:24 dm900 enigma2[365]: Video Device: /dev/dvb/adapter0/video0
Jan 06 13:05:24 dm900 enigma2[365]: demux device: /dev/dvb/adapter0/demux5
Jan 06 13:05:24 dm900 enigma2[365]: VIDEO_SET_STREAMTYPE 1 - ok
Jan 06 13:05:24 dm900 enigma2[365]: DMX_SET_PES_FILTER(0x13ed) - video - ok
Jan 06 13:05:24 dm900 enigma2[365]: DEMUX_START - video - ok
Jan 06 13:05:24 dm900 enigma2[365]: VIDEO_FREEZE - ok
Jan 06 13:05:24 dm900 enigma2[365]: VIDEO_PLAY - ok
Jan 06 13:05:24 dm900 enigma2[365]: DMX_SET_PES_FILTER(0x13f0) - ttx - ok
Jan 06 13:05:24 dm900 enigma2[365]: DEMUX_START - ttx - ok
Jan 06 13:05:24 dm900 enigma2[365]: VIDEO_SLOWMOTION(0) - ok
Jan 06 13:05:24 dm900 enigma2[365]: VIDEO_FAST_FORWARD(0) - ok
Jan 06 13:05:24 dm900 enigma2[365]: VIDEO_CONTINUE - ok
Jan 06 13:05:24 dm900 enigma2[365]: AUDIO_CONTINUE - ok
Jan 06 13:05:24 dm900 enigma2[365]: not pauseable.
Jan 06 13:05:24 dm900 enigma2[365]: [HbbTV].aitInvalidated
Jan 06 13:05:24 dm900 enigma2[365]: [SEC] unlock
Jan 06 13:05:24 dm900 enigma2[365]: [SEC] sleep 500ms
Jan 06 13:05:24 dm900 enigma2[365]: create buffer for widget 1280 x 150
Jan 06 13:05:24 dm900 enigma2[365]: (2)fe event: status 0, freq 1743750, inversion off, m_tuning 1 F
Jan 06 13:05:25 dm900 enigma2[365]: [EPGC] cleanup invalid data
Jan 06 13:05:25 dm900 enigma2[365]: (2)fe event: status 10, freq 16, inversion off, m_tuning 1 N
Jan 06 13:05:25 dm900 enigma2[365]: OURSTATE: ok
Jan 06 13:05:25 dm900 enigma2[365]: [eDVBCAService] channel 0x2a5d650 running
Jan 06 13:05:25 dm900 enigma2[365]: [eDVBLocalTimeHandler] channel 0x2a5d650 running
Jan 06 13:05:25 dm900 enigma2[365]: no version filtering
Jan 06 13:05:25 dm900 enigma2[365]: 0014:  70 00 00 00 00 00
Jan 06 13:05:25 dm900 enigma2[365]: mask:  fc 00 00 00 00 00
Jan 06 13:05:25 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:05:25 dm900 enigma2[365]: [EPGC] channel 0x2a5d650 running
Jan 06 13:05:25 dm900 enigma2[365]: stop release channel timer
Jan 06 13:05:25 dm900 enigma2[365]: no version filtering
Jan 06 13:05:25 dm900 enigma2[365]: 0012:  4e 28 3d 00 00 00
Jan 06 13:05:25 dm900 enigma2[365]: mask:  ff ff ff 00 00 00
Jan 06 13:05:25 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:05:25 dm900 enigma2[365]: [EPGC] next update in 2 sec
Jan 06 13:05:25 dm900 enigma2[365]: ok ... now we start!!
Jan 06 13:05:25 dm900 enigma2[365]: no version filtering
Jan 06 13:05:25 dm900 enigma2[365]: 0000:  00 00 00 00 00 00
Jan 06 13:05:25 dm900 enigma2[365]: mask:  ff 00 00 00 00 00
Jan 06 13:05:25 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:05:25 dm900 enigma2[365]: + 1/1 TID 00
Jan 06 13:05:25 dm900 enigma2[365]: done!
Jan 06 13:05:25 dm900 enigma2[365]: PATready
Jan 06 13:05:25 dm900 enigma2[365]: use pmtpid 13ec for service_id 283d
Jan 06 13:05:25 dm900 enigma2[365]: no version filtering
Jan 06 13:05:25 dm900 enigma2[365]: 13ec:  02 28 3d 00 00 00
Jan 06 13:05:25 dm900 enigma2[365]: mask:  ff ff ff 00 00 00
Jan 06 13:05:25 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:05:25 dm900 enigma2[365]: doing version filtering
Jan 06 13:05:25 dm900 enigma2[365]: 0000:  00 00 00 05 00 00
Jan 06 13:05:25 dm900 enigma2[365]: mask:  ff 00 00 3f 00 00
Jan 06 13:05:25 dm900 enigma2[365]: mode:  00 00 00 3e 00 00
Jan 06 13:05:25 dm900 enigma2[365]: +- 1/2 TID 4e
Jan 06 13:05:26 dm900 enigma2[365]: [eDVBLocalTimeHandler] Receiver time is 'Fri Jan  6 13:05:26 2017'
Jan 06 13:05:33 dm900 enigma2[365]: [eDVBLocalTimeHandler] Transponder time is 'Fri Jan  6 13:05:33 2017'
Jan 06 13:05:33 dm900 enigma2[365]: [eDVBLocalTimeHandler] diff is 7
Jan 06 13:05:33 dm900 enigma2[365]: [eDVBLocalTimeHandler] diff < 120 .. use Transponder Time
Jan 06 13:05:33 dm900 enigma2[365]: [eDVBLocalTimeHandler] update RTC
Jan 06 13:05:33 dm900 enigma2[365]: [eDVBLocalTimeHandler] time_difference is 7
Jan 06 13:05:33 dm900 enigma2[365]: [eDVBLocalTimeHandler] update Linux Time
Jan 06 13:05:33 dm900 enigma2[365]: + 1/1 TID 02
Jan 06 13:05:33 dm900 enigma2[365]: done!
Jan 06 13:05:33 dm900 enigma2[365]: [eDVBCAService] new service 1:0:19:283D:3FB:1:C00000:0:0:0:
Jan 06 13:05:33 dm900 enigma2[365]: [eDVBCAService] add demux 5 to slot 0 service 1:0:19:283D:3FB:1:C00000:0:0:0:
Jan 06 13:05:33 dm900 enigma2[365]: HBBTV broadcast data on pid 087b
Jan 06 13:05:33 dm900 enigma2[365]: dvb subtitle  PID 13f1 with wrong subtitling type (24)... force 0x10!!
Jan 06 13:05:33 dm900 enigma2[365]: Rds PID 13f4 detected ? ! ?
Jan 06 13:05:33 dm900 enigma2[365]: HBBTV broadcast data on pid 1434
Jan 06 13:05:33 dm900 enigma2[365]: [eDVBCAService] demux 5 mask 20
Jan 06 13:05:33 dm900 enigma2[365]: [eDVBCAServiceConn] send 88 bytes to '/tmp/camd.socket'
Jan 06 13:05:33 dm900 enigma2[365]: 9f 80 32 54 03 28 3d 07 00 17 01 81 08 00 c0 00 00 03 fb 00 01 82 02 20 05 84 02 13 ec 85 02 02 43 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
Jan 06 13:05:33 dm900 enigma2[365]: [eDVBCIInterfaces] addPMTHandler 1:0:19:283D:3FB:1:C00000:0:0:0:
Jan 06 13:05:33 dm900 enigma2[365]: [eDVBCIInterfaces] gotPMT
Jan 06 13:05:33 dm900 enigma2[365]: eventNewProgramInfo 0 0
Jan 06 13:05:33 dm900 enigma2[365]: start ait on pid 0492
Jan 06 13:05:33 dm900 enigma2[365]: no version filtering
Jan 06 13:05:33 dm900 enigma2[365]: 0492:  74 00 00 00 00 00
Jan 06 13:05:33 dm900 enigma2[365]: mask:  ff 00 00 00 00 00
Jan 06 13:05:33 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:05:33 dm900 enigma2[365]: 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
Jan 06 13:05:33 dm900 enigma2[365]: decoder state: play, vpid=5101, apid=5102
Jan 06 13:05:33 dm900 enigma2[365]: HBBTV broadcast data on pid 087b
Jan 06 13:05:33 dm900 enigma2[365]: dvb subtitle  PID 13f1 with wrong subtitling type (24)... force 0x10!!
Jan 06 13:05:33 dm900 enigma2[365]: Rds PID 13f4 detected ? ! ?
Jan 06 13:05:33 dm900 enigma2[365]: HBBTV broadcast data on pid 1434
Jan 06 13:05:33 dm900 enigma2[365]: [TeleText] serviceInfoChanged
Jan 06 13:05:33 dm900 enigma2[365]: [TeleText] TXT PID 5104 DEMUX 5
Jan 06 13:05:33 dm900 enigma2[365]: [TeleText] send array('B', [1, 19, 240, 5])
Jan 06 13:05:33 dm900 enigma2[365]: doing version filtering
Jan 06 13:05:33 dm900 enigma2[365]: 13ec:  02 28 3d 07 00 00
Jan 06 13:05:33 dm900 enigma2[365]: mask:  ff ff ff 3f 00 00
Jan 06 13:05:33 dm900 enigma2[365]: mode:  00 00 00 3e 00 00
Jan 06 13:05:33 dm900 enigma2[365]: VIDEO_GET_EVENT - ok
Jan 06 13:05:33 dm900 enigma2[365]: unhandled DVBAPI Video Event 32
Jan 06 13:05:33 dm900 enigma2[365]: ++ 2/2 TID 4e
Jan 06 13:05:33 dm900 enigma2[365]: done!
Jan 06 13:05:33 dm900 enigma2[365]: doing version filtering
Jan 06 13:05:33 dm900 enigma2[365]: 0012:  4e 28 3d 2b 00 00
Jan 06 13:05:33 dm900 enigma2[365]: mask:  ff ff ff 3f 00 00
Jan 06 13:05:33 dm900 enigma2[365]: mode:  00 00 00 3e 00 00
Jan 06 13:05:34 dm900 enigma2[365]: action ->  InfobarChannelSelection zapDown
Jan 06 13:05:34 dm900 enigma2[365]: playing 1:0:19:2B66:3F3:1:C00000:0:0:0:
Jan 06 13:05:34 dm900 enigma2[365]: [eDVBCAService] free slot 0 demux 5 for service 1:0:19:283D:3FB:1:C00000:0:0:0:
Jan 06 13:05:34 dm900 enigma2[365]: [eDVBCAService] free service 1:0:19:283D:3FB:1:C00000:0:0:0:
Jan 06 13:05:34 dm900 enigma2[365]: [TeleText] service stopped
Jan 06 13:05:34 dm900 enigma2[365]: [TeleText] send array('B', [1, 0, 0, 0])
Jan 06 13:05:34 dm900 enigma2[365]: disable dvb subtitles
Jan 06 13:05:34 dm900 enigma2[365]: disable teletext subtitles page ffffffffffffffff (und)
Jan 06 13:05:34 dm900 enigma2[365]: decoder state: play, vpid=-1, apid=-1
Jan 06 13:05:34 dm900 enigma2[365]: DEMUX_STOP - pcr - ok
Jan 06 13:05:34 dm900 enigma2[365]: DEMUX_STOP - video - ok
Jan 06 13:05:34 dm900 enigma2[365]: VIDEO_STOP - ok
Jan 06 13:05:34 dm900 enigma2[365]: AUDIO_STOP - ok
Jan 06 13:05:34 dm900 enigma2[365]: DEMUX_STOP - audio - ok
Jan 06 13:05:34 dm900 enigma2[365]: AUDIO_CONTINUE - ok
Jan 06 13:05:34 dm900 enigma2[365]: DEMUX_STOP - ttx - ok
Jan 06 13:05:34 dm900 enigma2[365]: start release channel timer
Jan 06 13:05:34 dm900 enigma2[365]: [TeleText] service started
Jan 06 13:05:34 dm900 enigma2[365]: not pauseable.
Jan 06 13:05:34 dm900 enigma2[365]: RemovePopup, id = ZapError
Jan 06 13:05:34 dm900 enigma2[365]: [eDVBCAService] remove channel 0x2a5d650
Jan 06 13:05:34 dm900 enigma2[365]: [eDVBCAService] write leave transponder to '/tmp/camd.socket' ok
Jan 06 13:05:34 dm900 enigma2[365]: [eDVBLocalTimeHandler] remove channel 0x2a5d650
Jan 06 13:05:34 dm900 enigma2[365]: [EPGC] remove channel 0x2a5d650
Jan 06 13:05:34 dm900 enigma2[365]: (2) preClose
Jan 06 13:05:34 dm900 enigma2[365]: allocate channel.. 03f3:0001:00c00000
Jan 06 13:05:34 dm900 enigma2[365]: [eDVBCAService] new channel 0x2a5d650!
Jan 06 13:05:34 dm900 enigma2[365]: (2)tune
Jan 06 13:05:34 dm900 enigma2[365]: RotorCmd ffffffff, lastRotorCmd ffffffff
Jan 06 13:05:34 dm900 enigma2[365]: prepare_sat System 1 Freq 11361750 Pol 0 SR 22000000 INV 2 FEC 2 orbpos 192 system 1 modulation 2 pilot 2, rolloff 0
Jan 06 13:05:34 dm900 enigma2[365]: tuning to 1611 mhz
Jan 06 13:05:34 dm900 enigma2[365]: OURSTATE: tuning
Jan 06 13:05:34 dm900 enigma2[365]: [SEC] lock 0
Jan 06 13:05:34 dm900 enigma2[365]: [SEC] invalidate current switch params
Jan 06 13:05:34 dm900 enigma2[365]: [SEC] update current switch params
Jan 06 13:05:34 dm900 enigma2[365]: [SEC] startTuneTimeout 5000
Jan 06 13:05:34 dm900 enigma2[365]: [SEC] setFrontend 1
Jan 06 13:05:34 dm900 enigma2[365]: (2)setting frontend
Jan 06 13:05:34 dm900 enigma2[365]: allocate Channel: res 0
Jan 06 13:05:34 dm900 enigma2[365]: allocate demux
Jan 06 13:05:34 dm900 enigma2[365]: have 1 video stream(s) (17de), and 1 audio stream(s) (17e8), and the pcr pid is 17de, and the text pid is 17f2
Jan 06 13:05:34 dm900 enigma2[365]: allocate demux
Jan 06 13:05:34 dm900 enigma2[365]: disable teletext subtitles page ffffffffffffffff (und)
Jan 06 13:05:34 dm900 enigma2[365]: decoder state: play, vpid=6110, apid=6120
Jan 06 13:05:34 dm900 enigma2[365]: DMX_SET_PES_FILTER(0x17de) - pcr - ok
Jan 06 13:05:34 dm900 enigma2[365]: DEMUX_START - pcr - ok
Jan 06 13:05:34 dm900 enigma2[365]: DMX_SET_PES_FILTER(0x17e8) - audio - ok
Jan 06 13:05:34 dm900 enigma2[365]: DEMUX_START - audio - ok
Jan 06 13:05:34 dm900 enigma2[365]: AUDIO_SET_BYPASS(1) - ok
Jan 06 13:05:34 dm900 enigma2[365]: AUDIO_PAUSE - ok
Jan 06 13:05:34 dm900 enigma2[365]: AUDIO_PLAY - ok
Jan 06 13:05:34 dm900 enigma2[365]: Video Device: /dev/dvb/adapter0/video0
Jan 06 13:05:34 dm900 enigma2[365]: demux device: /dev/dvb/adapter0/demux5
Jan 06 13:05:34 dm900 enigma2[365]: VIDEO_SET_STREAMTYPE 1 - ok
Jan 06 13:05:34 dm900 enigma2[365]: DMX_SET_PES_FILTER(0x17de) - video - ok
Jan 06 13:05:34 dm900 enigma2[365]: DEMUX_START - video - ok
Jan 06 13:05:34 dm900 enigma2[365]: VIDEO_FREEZE - ok
Jan 06 13:05:34 dm900 enigma2[365]: VIDEO_PLAY - [SEC] unlock
Jan 06 13:05:34 dm900 enigma2[365]: [SEC] sleep 500ms
Jan 06 13:05:34 dm900 enigma2[365]: ok
Jan 06 13:05:34 dm900 enigma2[365]: DMX_SET_PES_FILTER(0x17f2) - ttx - ok
Jan 06 13:05:34 dm900 enigma2[365]: DEMUX_START - ttx - ok
Jan 06 13:05:34 dm900 enigma2[365]: VIDEO_SLOWMOTION(0) - ok
Jan 06 13:05:34 dm900 enigma2[365]: VIDEO_FAST_FORWARD(0) - ok
Jan 06 13:05:34 dm900 enigma2[365]: VIDEO_CONTINUE - ok
Jan 06 13:05:34 dm900 enigma2[365]: AUDIO_CONTINUE - ok
Jan 06 13:05:34 dm900 enigma2[365]: not pauseable.
Jan 06 13:05:34 dm900 enigma2[365]: [HbbTV].aitInvalidated
Jan 06 13:05:34 dm900 enigma2[365]: (2)fe event: status 0, freq 1611750, inversion off, m_tuning 1 F
Jan 06 13:05:35 dm900 enigma2[365]: (2)fe event: status 10, freq 16, inversion off, m_tuning 1 N
Jan 06 13:05:35 dm900 enigma2[365]: OURSTATE: ok
Jan 06 13:05:35 dm900 enigma2[365]: [eDVBCAService] channel 0x2a5d650 running
Jan 06 13:05:35 dm900 enigma2[365]: [eDVBLocalTimeHandler] channel 0x2a5d650 running
Jan 06 13:05:35 dm900 enigma2[365]: no version filtering
Jan 06 13:05:35 dm900 enigma2[365]: 0014:  70 00 00 00 00 00
Jan 06 13:05:35 dm900 enigma2[365]: mask:  fc 00 00 00 00 00
Jan 06 13:05:35 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:05:35 dm900 enigma2[365]: [EPGC] channel 0x2a5d650 running
Jan 06 13:05:35 dm900 enigma2[365]: stop release channel timer
Jan 06 13:05:35 dm900 enigma2[365]: [EPGC] next update in 2 sec
Jan 06 13:05:35 dm900 enigma2[365]: no version filtering
Jan 06 13:05:35 dm900 enigma2[365]: 0012:  4e 2b 66 00 00 00
Jan 06 13:05:35 dm900 enigma2[365]: mask:  ff ff ff 00 00 00
Jan 06 13:05:35 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:05:35 dm900 enigma2[365]: ok ... now we start!!
Jan 06 13:05:35 dm900 enigma2[365]: no version filtering
Jan 06 13:05:35 dm900 enigma2[365]: 0000:  00 00 00 00 00 00
Jan 06 13:05:35 dm900 enigma2[365]: mask:  ff 00 00 00 00 00
Jan 06 13:05:35 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:05:35 dm900 enigma2[365]: + 1/1 TID 00
Jan 06 13:05:35 dm900 enigma2[365]: done!
Jan 06 13:05:35 dm900 enigma2[365]: PATready
Jan 06 13:05:35 dm900 enigma2[365]: no PAT entry found.. start delay
Jan 06 13:05:35 dm900 enigma2[365]: doing version filtering
Jan 06 13:05:35 dm900 enigma2[365]: 0000:  00 00 00 05 00 00
Jan 06 13:05:35 dm900 enigma2[365]: mask:  ff 00 00 3f 00 00
Jan 06 13:05:35 dm900 enigma2[365]: mode:  00 00 00 3e 00 00
Jan 06 13:05:35 dm900 enigma2[365]: [eDVBLocalTimeHandler] Receiver time is 'Fri Jan  6 13:05:35 2017'
Jan 06 13:05:35 dm900 enigma2[365]: [eDVBLocalTimeHandler] Transponder time is 'Fri Jan  6 13:05:36 2017'
Jan 06 13:05:35 dm900 enigma2[365]: [eDVBLocalTimeHandler] diff is 1
Jan 06 13:05:35 dm900 enigma2[365]: [eDVBLocalTimeHandler] diff < 120 .. use Transponder Time
Jan 06 13:05:36 dm900 enigma2[365]: [eDVBLocalTimeHandler] update RTC
Jan 06 13:05:36 dm900 enigma2[365]: [eDVBLocalTimeHandler] time_difference is 1
Jan 06 13:05:36 dm900 enigma2[365]: [eDVBLocalTimeHandler] update Linux Time
Jan 06 13:05:36 dm900 enigma2[365]: + 1/1 TID 00
Jan 06 13:05:36 dm900 enigma2[365]: done!
Jan 06 13:05:36 dm900 enigma2[365]: PATready
Jan 06 13:05:36 dm900 enigma2[365]: use pmtpid 17d4 for service_id 2b66
Jan 06 13:05:36 dm900 enigma2[365]: no version filtering
Jan 06 13:05:36 dm900 enigma2[365]: 17d4:  02 2b 66 00 00 00
Jan 06 13:05:36 dm900 enigma2[365]: mask:  ff ff ff 00 00 00
Jan 06 13:05:36 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:05:36 dm900 enigma2[365]: doing version filtering
Jan 06 13:05:36 dm900 enigma2[365]: 0000:  00 00 00 03 00 00
Jan 06 13:05:36 dm900 enigma2[365]: mask:  ff 00 00 3f 00 00
Jan 06 13:05:36 dm900 enigma2[365]: mode:  00 00 00 3e 00 00
Jan 06 13:05:36 dm900 enigma2[365]: ignore sdt update data.... incorrect transponder tuned!!!
Jan 06 13:05:36 dm900 enigma2[365]: + 1/1 TID 00
Jan 06 13:05:36 dm900 enigma2[365]: done!
Jan 06 13:05:36 dm900 enigma2[365]: PATready
Jan 06 13:05:36 dm900 enigma2[365]: no PAT entry found.. start delay
Jan 06 13:05:36 dm900 enigma2[365]: Seen two consecutive table version changes within 500ms. This seems broken, so auto update for pid 0000, table 00 is now disabled!!
Jan 06 13:05:36 dm900 enigma2[365]: + 1/1 TID 02
Jan 06 13:05:36 dm900 enigma2[365]: done!
Jan 06 13:05:36 dm900 enigma2[365]: [eDVBCAService] new service 1:0:19:2B66:3F3:1:C00000:0:0:0:
Jan 06 13:05:36 dm900 enigma2[365]: [eDVBCAService] add demux 5 to slot 0 service 1:0:19:2B66:3F3:1:C00000:0:0:0:
Jan 06 13:05:36 dm900 enigma2[365]: dvb subtitle  PID 17f3 with wrong subtitling type (24)... force 0x10!!
Jan 06 13:05:36 dm900 enigma2[365]: [eDVBCAService] demux 5 mask 20
Jan 06 13:05:36 dm900 enigma2[365]: [eDVBCAServiceConn] send 78 bytes to '/tmp/camd.socket'
Jan 06 13:05:36 dm900 enigma2[365]: 9f 80 32 4a 03 2b 66 03 00 17 01 81 08 00 c0 00 00 03 f3 00 01 82 02 20 05 84 02 17 d4 85 02 02 43 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
Jan 06 13:05:36 dm900 enigma2[365]: [eDVBCIInterfaces] addPMTHandler 1:0:19:2B66:3F3:1:C00000:0:0:0:
Jan 06 13:05:36 dm900 enigma2[365]: [eDVBCIInterfaces] gotPMT
Jan 06 13:05:36 dm900 enigma2[365]: eventNewProgramInfo 0 0
Jan 06 13:05:36 dm900 enigma2[365]: start ait on pid 181a
Jan 06 13:05:36 dm900 enigma2[365]: no version filtering
Jan 06 13:05:36 dm900 enigma2[365]: 181a:  74 00 00 00 00 00
Jan 06 13:05:36 dm900 enigma2[365]: mask:  ff 00 00 00 00 00
Jan 06 13:05:36 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:05:36 dm900 enigma2[365]: 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
Jan 06 13:05:36 dm900 enigma2[365]: decoder state: play, vpid=6110, apid=6120
Jan 06 13:05:36 dm900 enigma2[365]: dvb subtitle  PID 17f3 with wrong subtitling type (24)... force 0x10!!
Jan 06 13:05:36 dm900 enigma2[365]: [TeleText] serviceInfoChanged
Jan 06 13:05:36 dm900 enigma2[365]: [TeleText] TXT PID 6130 DEMUX 5
Jan 06 13:05:36 dm900 enigma2[365]: [TeleText] send array('B', [1, 23, 242, 5])
Jan 06 13:05:36 dm900 enigma2[365]: doing version filtering
Jan 06 13:05:36 dm900 enigma2[365]: 17d4:  02 2b 66 03 00 00
Jan 06 13:05:36 dm900 enigma2[365]: mask:  ff ff ff 3f 00 00
Jan 06 13:05:36 dm900 enigma2[365]: mode:  00 00 00 3e 00 00
Jan 06 13:05:36 dm900 enigma2[365]: VIDEO_GET_EVENT - ok
Jan 06 13:05:36 dm900 enigma2[365]: unhandled DVBAPI Video Event 32
Jan 06 13:05:37 dm900 enigma2[365]: -+ 1/2 TID 4e
Jan 06 13:05:37 dm900 enigma2[365]: + 1/1 TID 74
Jan 06 13:05:37 dm900 enigma2[365]: done!
Jan 06 13:05:37 dm900 enigma2[365]: [eHbbtv] aitChanged pid=0x181a
Jan 06 13:05:37 dm900 enigma2[365]: [eOipfApplication] Profile 0000, Version 1.1.1
Jan 06 13:05:37 dm900 enigma2[365]: [eOipfApplication] deu:ZDF start
Jan 06 13:05:37 dm900 enigma2[365]: [eHbbtv] New Application: ZDF start (orgid=17, appid=1, urlBase=http://hbbtv.zdf.de/zdfstart/, initalPath=index.php, controlCode=1, visibility=2)
Jan 06 13:05:37 dm900 enigma2[365]: [eHbbtv] Resolving Application Locator: dvb://current.ait/11.1
Jan 06 13:05:37 dm900 enigma2[365]: [eHbbtv] We have 1 app(s) for service 1.1011.11110
Jan 06 13:05:37 dm900 enigma2[365]: [eHbbtv] 'dvb://current.ait/11.1' resolved to 'http://hbbtv.zdf.de/zdfstart/index.php'
Jan 06 13:05:37 dm900 enigma2[365]: [eOipfApplication] Profile 0000, Version 1.1.1
Jan 06 13:05:37 dm900 enigma2[365]: [eOipfApplication] deu:ZDF programm
Jan 06 13:05:37 dm900 enigma2[365]: [eHbbtv] New Application: ZDF programm (orgid=17, appid=6, urlBase=http://hbbtv.zdf.de/zdfepg/, initalPath=index.php, controlCode=2, visibility=2)
Jan 06 13:05:37 dm900 enigma2[365]: [eHbbtv] Resolving Application Locator: dvb://current.ait/11.6
Jan 06 13:05:37 dm900 enigma2[365]: [eHbbtv] We have 2 app(s) for service 1.1011.11110
Jan 06 13:05:37 dm900 enigma2[365]: [eHbbtv] 'dvb://current.ait/11.6' resolved to 'http://hbbtv.zdf.de/zdfepg/index.php'
Jan 06 13:05:37 dm900 enigma2[365]: [eOipfApplication] Profile 0000, Version 1.1.1
Jan 06 13:05:37 dm900 enigma2[365]: [eOipfApplication] deu:ZDF mediathek
Jan 06 13:05:37 dm900 enigma2[365]: [eHbbtv] New Application: ZDF mediathek (orgid=17, appid=2, urlBase=http://hbbtv.zdf.de/zdfm3/, initalPath=index.php, controlCode=2, visibility=2)
Jan 06 13:05:37 dm900 enigma2[365]: [eHbbtv] Resolving Application Locator: dvb://current.ait/11.2
Jan 06 13:05:37 dm900 enigma2[365]: [eHbbtv] We have 3 app(s) for service 1.1011.11110
Jan 06 13:05:37 dm900 enigma2[365]: [eHbbtv] 'dvb://current.ait/11.2' resolved to 'http://hbbtv.zdf.de/zdfm3/index.php'
Jan 06 13:05:37 dm900 enigma2[365]: [eOipfApplication] Profile 0000, Version 1.1.1
Jan 06 13:05:37 dm900 enigma2[365]: [eOipfApplication] eng:ZDF nachrichten
Jan 06 13:05:37 dm900 enigma2[365]: [eHbbtv] New Application: ZDF nachrichten (orgid=17, appid=7, urlBase=http://hbbtv.zdf.de/zdfnews/, initalPath=index.php, controlCode=2, visibility=2)
Jan 06 13:05:37 dm900 enigma2[365]: [eHbbtv] Resolving Application Locator: dvb://current.ait/11.7
Jan 06 13:05:37 dm900 enigma2[365]: [eHbbtv] We have 4 app(s) for service 1.1011.11110
Jan 06 13:05:37 dm900 enigma2[365]: [eHbbtv] 'dvb://current.ait/11.7' resolved to 'http://hbbtv.zdf.de/zdfnews/index.php'
Jan 06 13:05:37 dm900 enigma2[365]: [eOipfApplication] Profile 0000, Version 1.1.1
Jan 06 13:05:37 dm900 enigma2[365]: [eOipfApplication] deu:ZDFtivi
Jan 06 13:05:37 dm900 enigma2[365]: [eHbbtv] New Application: ZDFtivi (orgid=17, appid=8, urlBase=http://hbbtv.zdf.de/zdftivi/, initalPath=index.php, controlCode=2, visibility=2)
Jan 06 13:05:37 dm900 enigma2[365]: [eHbbtv] Resolving Application Locator: dvb://current.ait/11.8
Jan 06 13:05:37 dm900 enigma2[365]: [eHbbtv] We have 5 app(s) for service 1.1011.11110
Jan 06 13:05:37 dm900 enigma2[365]: [eHbbtv] 'dvb://current.ait/11.8' resolved to 'http://hbbtv.zdf.de/zdftivi/index.php'
Jan 06 13:05:37 dm900 enigma2[365]: [HbbTV].readButtonApplicationReady, appid=11.1
Jan 06 13:05:37 dm900 enigma2[365]: doing version filtering
Jan 06 13:05:37 dm900 enigma2[365]: 181a:  74 00 00 0d 00 00
Jan 06 13:05:37 dm900 enigma2[365]: mask:  ff 00 00 3f 00 00
Jan 06 13:05:37 dm900 enigma2[365]: mode:  00 00 00 3e 00 00
Jan 06 13:05:37 dm900 enigma2[365]: action ->  InfobarChannelSelection zapDown
Jan 06 13:05:37 dm900 enigma2[365]: playing 1:0:19:2873:425:1:C00000:0:0:0:
Jan 06 13:05:37 dm900 enigma2[365]: [eDVBCAService] free slot 0 demux 5 for service 1:0:19:2B66:3F3:1:C00000:0:0:0:
Jan 06 13:05:37 dm900 enigma2[365]: [eDVBCAService] free service 1:0:19:2B66:3F3:1:C00000:0:0:0:
Jan 06 13:05:37 dm900 enigma2[365]: [TeleText] service stopped
Jan 06 13:05:37 dm900 enigma2[365]: [TeleText] send array('B', [1, 0, 0, 0])
Jan 06 13:05:37 dm900 enigma2[365]: disable dvb subtitles
Jan 06 13:05:37 dm900 enigma2[365]: disable teletext subtitles page ffffffffffffffff (und)
Jan 06 13:05:37 dm900 enigma2[365]: decoder state: play, vpid=-1, apid=-1
Jan 06 13:05:37 dm900 enigma2[365]: DEMUX_STOP - pcr - ok
Jan 06 13:05:37 dm900 enigma2[365]: DEMUX_STOP - video - ok
Jan 06 13:05:37 dm900 enigma2[365]: VIDEO_STOP - ok
Jan 06 13:05:37 dm900 enigma2[365]: AUDIO_STOP - ok
Jan 06 13:05:37 dm900 enigma2[365]: DEMUX_STOP - audio - ok
Jan 06 13:05:37 dm900 enigma2[365]: AUDIO_CONTINUE - ok
Jan 06 13:05:37 dm900 enigma2[365]: DEMUX_STOP - ttx - ok
Jan 06 13:05:37 dm900 enigma2[365]: start release channel timer
Jan 06 13:05:37 dm900 enigma2[365]: [TeleText] service started
Jan 06 13:05:37 dm900 enigma2[365]: not pauseable.
Jan 06 13:05:37 dm900 enigma2[365]: RemovePopup, id = ZapError
Jan 06 13:05:37 dm900 enigma2[365]: [eDVBCAService] remove channel 0x2a5d650
Jan 06 13:05:37 dm900 enigma2[365]: [eDVBCAService] write leave transponder to '/tmp/camd.socket' ok
Jan 06 13:05:37 dm900 enigma2[365]: [eDVBLocalTimeHandler] remove channel 0x2a5d650
Jan 06 13:05:37 dm900 enigma2[365]: [EPGC] remove channel 0x2a5d650
Jan 06 13:05:37 dm900 enigma2[365]: (2) preClose
Jan 06 13:05:37 dm900 enigma2[365]: allocate channel.. 0425:0001:00c00000
Jan 06 13:05:37 dm900 enigma2[365]: [eDVBCAService] new channel 0x2a5d650!
Jan 06 13:05:37 dm900 enigma2[365]: (2)tune
Jan 06 13:05:37 dm900 enigma2[365]: RotorCmd ffffffff, lastRotorCmd ffffffff
Jan 06 13:05:37 dm900 enigma2[365]: prepare_sat System 1 Freq 10891250 Pol 0 SR 22000000 INV 2 FEC 2 orbpos 192 system 1 modulation 2 pilot 2, rolloff 0
Jan 06 13:05:37 dm900 enigma2[365]: tuning to 1141 mhz
Jan 06 13:05:37 dm900 enigma2[365]: OURSTATE: tuning
Jan 06 13:05:37 dm900 enigma2[365]: allocate Channel: res 0
Jan 06 13:05:37 dm900 enigma2[365]: [SEC] lock 0
Jan 06 13:05:37 dm900 enigma2[365]: allocate demux
Jan 06 13:05:37 dm900 enigma2[365]: [SEC] invalidate current switch params
Jan 06 13:05:37 dm900 enigma2[365]: [SEC] update current switch params
Jan 06 13:05:37 dm900 enigma2[365]: have 1 video stream(s) (14e7), and 1 audio stream(s) (14e8), and the pcr pid is 14e7, and the text pid is 14ea
Jan 06 13:05:37 dm900 enigma2[365]: allocate demux
Jan 06 13:05:37 dm900 enigma2[365]: [SEC] startTuneTimeout 5000
Jan 06 13:05:37 dm900 enigma2[365]: disable teletext subtitles page ffffffffffffffff (und)
Jan 06 13:05:37 dm900 enigma2[365]: [SEC] setFrontend 1
Jan 06 13:05:37 dm900 enigma2[365]: (2)setting frontend
Jan 06 13:05:37 dm900 enigma2[365]: decoder state: play, vpid=5351, apid=5352
Jan 06 13:05:37 dm900 enigma2[365]: DMX_SET_PES_FILTER(0x14e7) - pcr - ok
Jan 06 13:05:37 dm900 enigma2[365]: DEMUX_START - pcr - ok
Jan 06 13:05:37 dm900 enigma2[365]: DMX_SET_PES_FILTER(0x14e8) - audio - ok
Jan 06 13:05:37 dm900 enigma2[365]: DEMUX_START - audio - ok
Jan 06 13:05:37 dm900 enigma2[365]: AUDIO_SET_BYPASS(1) - ok
Jan 06 13:05:37 dm900 enigma2[365]: AUDIO_PAUSE - ok
Jan 06 13:05:37 dm900 enigma2[365]: AUDIO_PLAY - ok
Jan 06 13:05:37 dm900 enigma2[365]: Video Device: /dev/dvb/adapter0/video0
Jan 06 13:05:37 dm900 enigma2[365]: demux device: /dev/dvb/adapter0/demux5
Jan 06 13:05:37 dm900 enigma2[365]: VIDEO_SET_STREAMTYPE 1 - ok
Jan 06 13:05:37 dm900 enigma2[365]: DMX_SET_PES_FILTER(0x14e7) - video - ok
Jan 06 13:05:37 dm900 enigma2[365]: DEMUX_START - video - ok
Jan 06 13:05:37 dm900 enigma2[365]: VIDEO_FREEZE - ok
Jan 06 13:05:37 dm900 enigma2[365]: VIDEO_PLAY - ok
Jan 06 13:05:37 dm900 enigma2[365]: DMX_SET_PES_FILTER(0x14ea) - ttx - ok
Jan 06 13:05:37 dm900 enigma2[365]: DEMUX_START - ttx - ok
Jan 06 13:05:37 dm900 enigma2[365]: VIDEO_SLOWMOTION(0) - ok
Jan 06 13:05:37 dm900 enigma2[365]: VIDEO_FAST_FORWARD(0) - ok
Jan 06 13:05:37 dm900 enigma2[365]: VIDEO_CONTINUE - ok
Jan 06 13:05:37 dm900 enigma2[365]: AUDIO_CONTINUE - ok
Jan 06 13:05:37 dm900 enigma2[365]: not pauseable.
Jan 06 13:05:37 dm900 enigma2[365]: [SEC] unlock
Jan 06 13:05:37 dm900 enigma2[365]: [SEC] sleep 500ms
Jan 06 13:05:37 dm900 enigma2[365]: [HbbTV].aitInvalidated
Jan 06 13:05:37 dm900 enigma2[365]: (2)fe event: status 0, freq 1141250, inversion off, m_tuning 1 F
Jan 06 13:05:38 dm900 enigma2[365]: (2)fe event: status 10, freq 16, inversion off, m_tuning 1 N
Jan 06 13:05:38 dm900 enigma2[365]: OURSTATE: ok
Jan 06 13:05:38 dm900 enigma2[365]: [eDVBCAService] channel 0x2a5d650 running
Jan 06 13:05:38 dm900 enigma2[365]: [eDVBLocalTimeHandler] channel 0x2a5d650 running
Jan 06 13:05:38 dm900 enigma2[365]: no version filtering
Jan 06 13:05:38 dm900 enigma2[365]: 0014:  70 00 00 00 00 00
Jan 06 13:05:38 dm900 enigma2[365]: mask:  fc 00 00 00 00 00
Jan 06 13:05:38 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:05:38 dm900 enigma2[365]: [EPGC] channel 0x2a5d650 running
Jan 06 13:05:38 dm900 enigma2[365]: stop release channel timer
Jan 06 13:05:38 dm900 enigma2[365]: no version filtering
Jan 06 13:05:38 dm900 enigma2[365]: 0012:  4e 28 73 00 00 00
Jan 06 13:05:38 dm900 enigma2[365]: mask:  ff ff ff 00 00 00
Jan 06 13:05:38 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:05:38 dm900 enigma2[365]: ok ... now we start!!
Jan 06 13:05:38 dm900 enigma2[365]: no version filtering
Jan 06 13:05:38 dm900 enigma2[365]: 0000:  00 00 00 00 00 00
Jan 06 13:05:38 dm900 enigma2[365]: mask:  ff 00 00 00 00 00
Jan 06 13:05:38 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:05:38 dm900 enigma2[365]: [EPGC] next update in 2 sec
Jan 06 13:05:38 dm900 enigma2[365]: + 1/1 TID 00
Jan 06 13:05:38 dm900 enigma2[365]: done!
Jan 06 13:05:38 dm900 enigma2[365]: PATready
Jan 06 13:05:38 dm900 enigma2[365]: no PAT entry found.. start delay
Jan 06 13:05:38 dm900 enigma2[365]: doing version filtering
Jan 06 13:05:38 dm900 enigma2[365]: 0000:  00 00 00 05 00 00
Jan 06 13:05:38 dm900 enigma2[365]: mask:  ff 00 00 3f 00 00
Jan 06 13:05:38 dm900 enigma2[365]: mode:  00 00 00 3e 00 00
Jan 06 13:05:39 dm900 enigma2[365]: [eDVBLocalTimeHandler] Receiver time is 'Fri Jan  6 13:05:39 2017'
Jan 06 13:05:39 dm900 enigma2[365]: [eDVBLocalTimeHandler] Transponder time is 'Fri Jan  6 13:05:38 2017'
Jan 06 13:05:39 dm900 enigma2[365]: [eDVBLocalTimeHandler] diff is -1
Jan 06 13:05:39 dm900 enigma2[365]: [eDVBLocalTimeHandler] diff < 120 .. use Transponder Time
Jan 06 13:05:38 dm900 enigma2[365]: [eDVBLocalTimeHandler] update RTC
Jan 06 13:05:38 dm900 enigma2[365]: [eDVBLocalTimeHandler] time_difference is -1
Jan 06 13:05:38 dm900 enigma2[365]: [eDVBLocalTimeHandler] update Linux Time
Jan 06 13:05:38 dm900 enigma2[365]: DVB service failed to tune - error 3
Jan 06 13:05:38 dm900 enigma2[365]: RemovePopup, id = ZapError
Jan 06 13:05:38 dm900 enigma2[365]: AddPopup, id = ZapError domain = ZapError
Jan 06 13:05:38 dm900 enigma2[365]: [NotificationQueue::popNotification] domain ZapError deferred_callable: False
Jan 06 13:05:38 dm900 enigma2[365]: create buffer for widget 600 x 200
Jan 06 13:05:38 dm900 enigma2[365]: ignore sdt update data.... incorrect transponder tuned!!!
Jan 06 13:05:39 dm900 enigma2[365]: VIDEO_GET_EVENT - ok
Jan 06 13:05:39 dm900 enigma2[365]: unhandled DVBAPI Video Event 32
Jan 06 13:05:39 dm900 enigma2[365]: [EPGC] start caching events(1483704339)
Jan 06 13:05:39 dm900 enigma2[365]: +- 1/2 TID 4e
Jan 06 13:05:40 dm900 enigma2[365]: action ->  InfobarChannelSelection zapDown
Jan 06 13:05:40 dm900 enigma2[365]: playing 1:0:1:2EE3:441:1:C00000:0:0:0:
Jan 06 13:05:40 dm900 enigma2[365]: [TeleText] service stopped
Jan 06 13:05:40 dm900 enigma2[365]: [TeleText] send array('B', [1, 0, 0, 0])
Jan 06 13:05:40 dm900 enigma2[365]: disable dvb subtitles
Jan 06 13:05:40 dm900 enigma2[365]: disable teletext subtitles page ffffffffffffffff (und)
Jan 06 13:05:40 dm900 enigma2[365]: decoder state: play, vpid=-1, apid=-1
Jan 06 13:05:40 dm900 enigma2[365]: DEMUX_STOP - pcr - ok
Jan 06 13:05:40 dm900 enigma2[365]: DEMUX_STOP - video - ok
Jan 06 13:05:40 dm900 enigma2[365]: VIDEO_STOP - ok
Jan 06 13:05:40 dm900 enigma2[365]: AUDIO_STOP - ok
Jan 06 13:05:40 dm900 enigma2[365]: DEMUX_STOP - audio - ok
Jan 06 13:05:40 dm900 enigma2[365]: AUDIO_CONTINUE - ok
Jan 06 13:05:40 dm900 enigma2[365]: DEMUX_STOP - ttx - ok
Jan 06 13:05:40 dm900 enigma2[365]: start release channel timer
Jan 06 13:05:40 dm900 enigma2[365]: [TeleText] service started
Jan 06 13:05:40 dm900 enigma2[365]: not pauseable.
Jan 06 13:05:40 dm900 enigma2[365]: RemovePopup, id = ZapError
Jan 06 13:05:40 dm900 enigma2[365]: (found in current notifications)
Jan 06 13:05:40 dm900 enigma2[365]: [eDVBCAService] remove channel 0x2a5d650
Jan 06 13:05:40 dm900 enigma2[365]: [eDVBCAService] write leave transponder to '/tmp/camd.socket' ok
Jan 06 13:05:40 dm900 enigma2[365]: [eDVBLocalTimeHandler] remove channel 0x2a5d650
Jan 06 13:05:40 dm900 enigma2[365]: [EPGC] remove channel 0x2a5d650
Jan 06 13:05:40 dm900 enigma2[365]: [EPGC] abort caching events !!
Jan 06 13:05:40 dm900 enigma2[365]: (2) preClose
Jan 06 13:05:40 dm900 enigma2[365]: allocate channel.. 0441:0001:00c00000
Jan 06 13:05:40 dm900 enigma2[365]: [eDVBCAService] new channel 0x2a5d650!
Jan 06 13:05:40 dm900 enigma2[365]: (2)tune
Jan 06 13:05:40 dm900 enigma2[365]: RotorCmd ffffffff, lastRotorCmd ffffffff
Jan 06 13:05:40 dm900 enigma2[365]: prepare_sat System 0 Freq 12187500 Pol 0 SR 27500000 INV 2 FEC 3 orbpos 192 system 0 modulation 1 pilot 2, rolloff 0
Jan 06 13:05:40 dm900 enigma2[365]: tuning to 1587 mhz
Jan 06 13:05:40 dm900 enigma2[365]: OURSTATE: tuning
Jan 06 13:05:40 dm900 enigma2[365]: allocate Channel: res 0
Jan 06 13:05:40 dm900 enigma2[365]: allocate demux
Jan 06 13:05:40 dm900 enigma2[365]: have 1 video stream(s) (00a3), and 1 audio stream(s) (0068), and the pcr pid is 00a3, and the text pid is 0069
Jan 06 13:05:40 dm900 enigma2[365]: allocate demux
Jan 06 13:05:40 dm900 enigma2[365]: disable teletext subtitles page ffffffffffffffff (und)
Jan 06 13:05:40 dm900 enigma2[365]: decoder state: play, vpid=163, apid=104
Jan 06 13:05:40 dm900 enigma2[365]: DMX_SET_PES_FILTER(0xa3) - pcr - ok
Jan 06 13:05:40 dm900 enigma2[365]: DEMUX_START - pcr - ok
Jan 06 13:05:40 dm900 enigma2[365]: DMX_SET_PES_FILTER(0x68) - audio - ok
Jan 06 13:05:40 dm900 enigma2[365]: DEMUX_START - audio - ok
Jan 06 13:05:40 dm900 enigma2[365]: AUDIO_SET_BYPASS(1) - [SEC] lock 0
Jan 06 13:05:40 dm900 enigma2[365]: [SEC] invalidate current switch params
Jan 06 13:05:40 dm900 enigma2[365]: [SEC] setTone 1
Jan 06 13:05:40 dm900 enigma2[365]: (2)setTone On
Jan 06 13:05:40 dm900 enigma2[365]: [SEC] sleep 10ms
Jan 06 13:05:40 dm900 enigma2[365]: ok
Jan 06 13:05:40 dm900 enigma2[365]: AUDIO_PAUSE - ok
Jan 06 13:05:40 dm900 enigma2[365]: AUDIO_PLAY - ok
Jan 06 13:05:40 dm900 enigma2[365]: Video Device: /dev/dvb/adapter0/video0
Jan 06 13:05:40 dm900 enigma2[365]: demux device: /dev/dvb/adapter0/demux5
Jan 06 13:05:40 dm900 enigma2[365]: VIDEO_SET_STREAMTYPE 0 - ok
Jan 06 13:05:40 dm900 enigma2[365]: DMX_SET_PES_FILTER(0xa3) - video - ok
Jan 06 13:05:40 dm900 enigma2[365]: DEMUX_START - video - ok
Jan 06 13:05:40 dm900 enigma2[365]: VIDEO_FREEZE - ok
Jan 06 13:05:40 dm900 enigma2[365]: VIDEO_PLAY - [SEC] update current switch params
Jan 06 13:05:40 dm900 enigma2[365]: [SEC] startTuneTimeout 5000
Jan 06 13:05:40 dm900 enigma2[365]: [SEC] setFrontend 1
Jan 06 13:05:40 dm900 enigma2[365]: (2)setting frontend
Jan 06 13:05:40 dm900 enigma2[365]: ok
Jan 06 13:05:40 dm900 enigma2[365]: DMX_SET_PES_FILTER(0x69) - ttx - ok
Jan 06 13:05:40 dm900 enigma2[365]: DEMUX_START - ttx - ok
Jan 06 13:05:40 dm900 enigma2[365]: VIDEO_SLOWMOTION(0) - ok
Jan 06 13:05:40 dm900 enigma2[365]: VIDEO_FAST_FORWARD(0) - ok
Jan 06 13:05:40 dm900 enigma2[365]: VIDEO_CONTINUE - ok
Jan 06 13:05:40 dm900 enigma2[365]: AUDIO_CONTINUE - ok
Jan 06 13:05:40 dm900 enigma2[365]: not pauseable.
Jan 06 13:05:40 dm900 enigma2[365]: [HbbTV].aitInvalidated
Jan 06 13:05:40 dm900 enigma2[365]: [SEC] unlock
Jan 06 13:05:40 dm900 enigma2[365]: [SEC] sleep 500ms
Jan 06 13:05:40 dm900 enigma2[365]: (2)fe event: status 0, freq 1587500, inversion off, m_tuning 1 F
Jan 06 13:05:40 dm900 enigma2[365]: [EPGC] cleanup invalid data
Jan 06 13:05:41 dm900 enigma2[365]: (2)fe event: status 10, freq 16, inversion off, m_tuning 1 N
Jan 06 13:05:41 dm900 enigma2[365]: OURSTATE: ok
Jan 06 13:05:41 dm900 enigma2[365]: [eDVBCAService] channel 0x2a5d650 running
Jan 06 13:05:41 dm900 enigma2[365]: [eDVBLocalTimeHandler] channel 0x2a5d650 running
Jan 06 13:05:41 dm900 enigma2[365]: no version filtering
Jan 06 13:05:41 dm900 enigma2[365]: 0014:  70 00 00 00 00 00
Jan 06 13:05:41 dm900 enigma2[365]: mask:  fc 00 00 00 00 00
Jan 06 13:05:41 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:05:41 dm900 enigma2[365]: [EPGC] channel 0x2a5d650 running
Jan 06 13:05:41 dm900 enigma2[365]: stop release channel timer
Jan 06 13:05:41 dm900 enigma2[365]: [EPGC] next update in 2 sec
Jan 06 13:05:41 dm900 enigma2[365]: no version filtering
Jan 06 13:05:41 dm900 enigma2[365]: 0012:  4e 2e e3 00 00 00
Jan 06 13:05:41 dm900 enigma2[365]: mask:  ff ff ff 00 00 00
Jan 06 13:05:41 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:05:41 dm900 enigma2[365]: ok ... now we start!!
Jan 06 13:05:41 dm900 enigma2[365]: no version filtering
Jan 06 13:05:41 dm900 enigma2[365]: 0000:  00 00 00 00 00 00
Jan 06 13:05:41 dm900 enigma2[365]: mask:  ff 00 00 00 00 00
Jan 06 13:05:41 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:05:41 dm900 enigma2[365]: + 1/1 TID 00
Jan 06 13:05:41 dm900 enigma2[365]: done!
Jan 06 13:05:41 dm900 enigma2[365]: PATready
Jan 06 13:05:41 dm900 enigma2[365]: no PAT entry found.. start delay
Jan 06 13:05:41 dm900 enigma2[365]: doing version filtering
Jan 06 13:05:41 dm900 enigma2[365]: 0000:  00 00 00 05 00 00
Jan 06 13:05:41 dm900 enigma2[365]: mask:  ff 00 00 3f 00 00
Jan 06 13:05:41 dm900 enigma2[365]: mode:  00 00 00 3e 00 00
Jan 06 13:05:42 dm900 enigma2[365]: -+ 1/2 TID 4e
Jan 06 13:05:42 dm900 enigma2[365]: [eDVBLocalTimeHandler] Receiver time is 'Fri Jan  6 13:05:42 2017'
Jan 06 13:05:42 dm900 enigma2[365]: [eDVBLocalTimeHandler] Transponder time is 'Fri Jan  6 13:05:42 2017'
Jan 06 13:05:42 dm900 enigma2[365]: [eDVBLocalTimeHandler] diff is 0
Jan 06 13:05:42 dm900 enigma2[365]: [eDVBLocalTimeHandler] diff < 120 .. use Transponder Time
Jan 06 13:05:42 dm900 enigma2[365]: [eDVBLocalTimeHandler] not changed
Jan 06 13:05:42 dm900 enigma2[365]: + 1/1 TID 00
Jan 06 13:05:42 dm900 enigma2[365]: done!
Jan 06 13:05:42 dm900 enigma2[365]: PATready
Jan 06 13:05:42 dm900 enigma2[365]: use pmtpid 002c for service_id 2ee3
Jan 06 13:05:42 dm900 enigma2[365]: no version filtering
Jan 06 13:05:42 dm900 enigma2[365]: 002c:  02 2e e3 00 00 00
Jan 06 13:05:42 dm900 enigma2[365]: mask:  ff ff ff 00 00 00
Jan 06 13:05:42 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:05:42 dm900 enigma2[365]: doing version filtering
Jan 06 13:05:42 dm900 enigma2[365]: 0000:  00 00 00 0b 00 00
Jan 06 13:05:42 dm900 enigma2[365]: mask:  ff 00 00 3f 00 00
Jan 06 13:05:42 dm900 enigma2[365]: mode:  00 00 00 3e 00 00
Jan 06 13:05:42 dm900 enigma2[365]: ignore sdt update data.... incorrect transponder tuned!!!
Jan 06 13:05:42 dm900 enigma2[365]: + 1/1 TID 00
Jan 06 13:05:42 dm900 enigma2[365]: done!
Jan 06 13:05:42 dm900 enigma2[365]: PATready
Jan 06 13:05:42 dm900 enigma2[365]: no PAT entry found.. start delay
Jan 06 13:05:42 dm900 enigma2[365]: doing version filtering
Jan 06 13:05:42 dm900 enigma2[365]: 0000:  00 00 00 05 00 00
Jan 06 13:05:42 dm900 enigma2[365]: mask:  ff 00 00 3f 00 00
Jan 06 13:05:42 dm900 enigma2[365]: mode:  00 00 00 3e 00 00
Jan 06 13:05:42 dm900 enigma2[365]: VIDEO_GET_EVENT - ok
Jan 06 13:05:42 dm900 enigma2[365]: VIDEO_GET_EVENT - ok
Jan 06 13:05:42 dm900 enigma2[365]: VIDEO_GET_EVENT - ok
Jan 06 13:05:42 dm900 enigma2[365]: VIDEO_GET_EVENT - ok
Jan 06 13:05:42 dm900 enigma2[365]: unhandled DVBAPI Video Event 32
Jan 06 13:05:42 dm900 enigma2[365]: + 1/1 TID 00
Jan 06 13:05:42 dm900 enigma2[365]: done!
Jan 06 13:05:42 dm900 enigma2[365]: PATready
Jan 06 13:05:42 dm900 enigma2[365]: use pmtpid 002c for service_id 2ee3
Jan 06 13:05:42 dm900 enigma2[365]: no version filtering
Jan 06 13:05:42 dm900 enigma2[365]: 002c:  02 2e e3 00 00 00
Jan 06 13:05:42 dm900 enigma2[365]: mask:  ff ff ff 00 00 00
Jan 06 13:05:42 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:05:42 dm900 enigma2[365]: doing version filtering
Jan 06 13:05:42 dm900 enigma2[365]: 0000:  00 00 00 0b 00 00
Jan 06 13:05:42 dm900 enigma2[365]: mask:  ff 00 00 3f 00 00
Jan 06 13:05:42 dm900 enigma2[365]: mode:  00 00 00 3e 00 00
Jan 06 13:05:42 dm900 enigma2[365]: + 1/1 TID 00
Jan 06 13:05:42 dm900 enigma2[365]: done!
Jan 06 13:05:42 dm900 enigma2[365]: PATready
Jan 06 13:05:42 dm900 enigma2[365]: no PAT entry found.. start delay
Jan 06 13:05:42 dm900 enigma2[365]: Seen two consecutive table version changes within 500ms. This seems broken, so auto update for pid 0000, table 00 is now disabled!!
Jan 06 13:05:42 dm900 enigma2[365]: + 1/1 TID 02
Jan 06 13:05:42 dm900 enigma2[365]: done!
Jan 06 13:05:42 dm900 enigma2[365]: [eDVBCAService] new service 1:0:1:2EE3:441:1:C00000:0:0:0:
Jan 06 13:05:42 dm900 enigma2[365]: [eDVBCAService] add demux 5 to slot 0 service 1:0:1:2EE3:441:1:C00000:0:0:0:
Jan 06 13:05:42 dm900 enigma2[365]: HBBTV broadcast data on pid 006f
Jan 06 13:05:42 dm900 enigma2[365]: [eDVBCAService] demux 5 mask 20
Jan 06 13:05:42 dm900 enigma2[365]: [eDVBCAServiceConn] send 73 bytes to '/tmp/camd.socket'
Jan 06 13:05:42 dm900 enigma2[365]: 9f 80 32 45 03 2e e3 07 00 17 01 81 08 00 c0 00 00 04 41 00 01 82 02 20 05 84 02 00 2c 85 02 02 43 02 00 a3 00 00 03 00 68 00 00 05 00 6c 00 00 06 00 69 00 00 06 00 6a 00 00 06 00 6e 00 00 0b 00 6f 00 00 0c 00 70 00 00
Jan 06 13:05:42 dm900 enigma2[365]: [eDVBCIInterfaces] addPMTHandler 1:0:1:2EE3:441:1:C00000:0:0:0:
Jan 06 13:05:42 dm900 enigma2[365]: [eDVBCIInterfaces] gotPMT
Jan 06 13:05:42 dm900 enigma2[365]: eventNewProgramInfo 0 0
Jan 06 13:05:42 dm900 enigma2[365]: start ait on pid 006c
Jan 06 13:05:42 dm900 enigma2[365]: no version filtering
Jan 06 13:05:42 dm900 enigma2[365]: 006c:  74 00 00 00 00 00
Jan 06 13:05:42 dm900 enigma2[365]: mask:  ff 00 00 00 00 00
Jan 06 13:05:42 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:05:42 dm900 enigma2[365]: have 1 video stream(s) (00a3), and 2 audio stream(s) (0068, 006a), and the pcr pid is 00a3, and the text pid is 0069
Jan 06 13:05:42 dm900 enigma2[365]: decoder state: play, vpid=163, apid=104
Jan 06 13:05:42 dm900 enigma2[365]: HBBTV broadcast data on pid 006f
Jan 06 13:05:42 dm900 enigma2[365]: [TeleText] serviceInfoChanged
Jan 06 13:05:42 dm900 enigma2[365]: [TeleText] TXT PID 105 DEMUX 5
Jan 06 13:05:42 dm900 enigma2[365]: [TeleText] send array('B', [1, 0, 105, 5])
Jan 06 13:05:42 dm900 enigma2[365]: doing version filtering
Jan 06 13:05:42 dm900 enigma2[365]: 002c:  02 2e e3 07 00 00
Jan 06 13:05:42 dm900 enigma2[365]: mask:  ff ff ff 3f 00 00
Jan 06 13:05:42 dm900 enigma2[365]: mode:  00 00 00 3e 00 00
Jan 06 13:05:43 dm900 enigma2[365]: nr_read 151 nr_write 1
Jan 06 13:05:43 dm900 enigma2[365]: sum 152 prev_sum 0
Jan 06 13:05:43 dm900 enigma2[365]: hdd was accessed since previous check!
Jan 06 13:05:43 dm900 enigma2[365]: [IDLE] 0 600 False
Jan 06 13:05:43 dm900 enigma2[365]: action ->  InfobarChannelSelection zapDown
Jan 06 13:05:43 dm900 enigma2[365]: playing 1:0:1:445C:453:1:C00000:0:0:0:
Jan 06 13:05:43 dm900 enigma2[365]: [eDVBCAService] free slot 0 demux 5 for service 1:0:1:2EE3:441:1:C00000:0:0:0:
Jan 06 13:05:43 dm900 enigma2[365]: [eDVBCAService] free service 1:0:1:2EE3:441:1:C00000:0:0:0:
Jan 06 13:05:43 dm900 enigma2[365]: [TeleText] service stopped
Jan 06 13:05:43 dm900 enigma2[365]: [TeleText] send array('B', [1, 0, 0, 0])
Jan 06 13:05:43 dm900 enigma2[365]: disable dvb subtitles
Jan 06 13:05:43 dm900 enigma2[365]: disable teletext subtitles page ffffffffffffffff (und)
Jan 06 13:05:43 dm900 enigma2[365]: decoder state: play, vpid=-1, apid=-1
Jan 06 13:05:43 dm900 enigma2[365]: DEMUX_STOP - pcr - ok
Jan 06 13:05:43 dm900 enigma2[365]: DEMUX_STOP - video - ok
Jan 06 13:05:43 dm900 enigma2[365]: VIDEO_STOP - ok
Jan 06 13:05:43 dm900 enigma2[365]: AUDIO_STOP - ok
Jan 06 13:05:43 dm900 enigma2[365]: DEMUX_STOP - audio - ok
Jan 06 13:05:43 dm900 enigma2[365]: AUDIO_CONTINUE - ok
Jan 06 13:05:43 dm900 enigma2[365]: DEMUX_STOP - ttx - ok
Jan 06 13:05:43 dm900 enigma2[365]: start release channel timer
Jan 06 13:05:43 dm900 enigma2[365]: [TeleText] service started
Jan 06 13:05:43 dm900 enigma2[365]: not pauseable.
Jan 06 13:05:43 dm900 enigma2[365]: RemovePopup, id = ZapError
Jan 06 13:05:43 dm900 enigma2[365]: [eDVBCAService] remove channel 0x2a5d650
Jan 06 13:05:43 dm900 enigma2[365]: [eDVBCAService] write leave transponder to '/tmp/camd.socket' ok
Jan 06 13:05:43 dm900 enigma2[365]: [eDVBLocalTimeHandler] remove channel 0x2a5d650
Jan 06 13:05:43 dm900 enigma2[365]: [EPGC] remove channel 0x2a5d650
Jan 06 13:05:43 dm900 enigma2[365]: (2) preClose
Jan 06 13:05:43 dm900 enigma2[365]: allocate channel.. 0453:0001:00c00000
Jan 06 13:05:43 dm900 enigma2[365]: [eDVBCAService] new channel 0x2a5d650!
Jan 06 13:05:43 dm900 enigma2[365]: (2)tune
Jan 06 13:05:43 dm900 enigma2[365]: RotorCmd ffffffff, lastRotorCmd ffffffff
Jan 06 13:05:43 dm900 enigma2[365]: prepare_sat System 0 Freq 12544750 Pol 0 SR 22000000 INV 2 FEC 4 orbpos 192 system 0 modulation 1 pilot 2, rolloff 0
Jan 06 13:05:43 dm900 enigma2[365]: tuning to 1944 mhz
Jan 06 13:05:43 dm900 enigma2[365]: OURSTATE: tuning
Jan 06 13:05:43 dm900 enigma2[365]: allocate Channel: res 0
Jan 06 13:05:43 dm900 enigma2[365]: allocate demux
Jan 06 13:05:43 dm900 enigma2[365]: [SEC] lock 0
Jan 06 13:05:43 dm900 enigma2[365]: getting program info failed.
Jan 06 13:05:43 dm900 enigma2[365]: allocate demux
Jan 06 13:05:43 dm900 enigma2[365]: disable teletext subtitles page ffffffffffffffff (und)
Jan 06 13:05:43 dm900 enigma2[365]: [SEC] invalidate current switch params
Jan 06 13:05:43 dm900 enigma2[365]: [SEC] update current switch params
Jan 06 13:05:43 dm900 enigma2[365]: [SEC] startTuneTimeout 5000
Jan 06 13:05:43 dm900 enigma2[365]: [SEC] setFrontend 1
Jan 06 13:05:43 dm900 enigma2[365]: (2)setting frontend
Jan 06 13:05:43 dm900 enigma2[365]: PES filter: DMX_SET_PES_FILTER - Invalid argument
Jan 06 13:05:43 dm900 enigma2[365]: decoder state: play, vpid=-1, apid=-1
Jan 06 13:05:43 dm900 enigma2[365]: [HbbTV].aitInvalidated
Jan 06 13:05:43 dm900 enigma2[365]: [SEC] unlock
Jan 06 13:05:43 dm900 enigma2[365]: [SEC] sleep 500ms
Jan 06 13:05:43 dm900 enigma2[365]: (2)fe event: status 0, freq 1944750, inversion off, m_tuning 1 F
Jan 06 13:05:44 dm900 enigma2[365]: (2)fe event: status 10, freq 16, inversion off, m_tuning 1 N
Jan 06 13:05:44 dm900 enigma2[365]: OURSTATE: ok
Jan 06 13:05:44 dm900 enigma2[365]: [eDVBCAService] channel 0x2a5d650 running
Jan 06 13:05:44 dm900 enigma2[365]: [eDVBLocalTimeHandler] channel 0x2a5d650 running
Jan 06 13:05:44 dm900 enigma2[365]: no version filtering
Jan 06 13:05:44 dm900 enigma2[365]: 0014:  70 00 00 00 00 00
Jan 06 13:05:44 dm900 enigma2[365]: mask:  fc 00 00 00 00 00
Jan 06 13:05:44 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:05:44 dm900 enigma2[365]: [EPGC] channel 0x2a5d650 running
Jan 06 13:05:44 dm900 enigma2[365]: [EPGC] next update in 2 sec
Jan 06 13:05:44 dm900 enigma2[365]: stop release channel timer
Jan 06 13:05:44 dm900 enigma2[365]: no version filtering
Jan 06 13:05:44 dm900 enigma2[365]: 0012:  4e 44 5c 00 00 00
Jan 06 13:05:44 dm900 enigma2[365]: mask:  ff ff ff 00 00 00
Jan 06 13:05:44 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:05:44 dm900 enigma2[365]: ok ... now we start!!
Jan 06 13:05:44 dm900 enigma2[365]: no version filtering
Jan 06 13:05:44 dm900 enigma2[365]: 0000:  00 00 00 00 00 00
Jan 06 13:05:44 dm900 enigma2[365]: mask:  ff 00 00 00 00 00
Jan 06 13:05:44 dm900 enigma2[365]: mode:  00 00 00 00 00 00
Jan 06 13:05:44 dm900 enigma2[365]: [EPGC] cleanupOutdated
Jan 06 13:05:45 dm900 enigma2[365]: [eDVBLocalTimeHandler] Receiver time is 'Fri Jan  6 13:05:44 2017'
Jan 06 13:05:45 dm900 enigma2[365]: [eDVBLocalTimeHandler] Transponder time is 'Fri Jan  6 13:05:45 2017'
Jan 06 13:05:45 dm900 enigma2[365]: [eDVBLocalTimeHandler] diff is 1
Jan 06 13:05:45 dm900 enigma2[365]: [eDVBLocalTimeHandler] diff < 120 .. use Transponder Time
Jan 06 13:05:45 dm900 enigma2[365]: [eDVBLocalTimeHandler] update RTC
Jan 06 13:05:45 dm900 enigma2[365]: [eDVBLocalTimeHandler] time_difference is 1
Jan 06 13:05:45 dm900 enigma2[365]: [eDVBLocalTimeHandler] update Linux Time
Jan 06 13:05:45 dm900 enigma2[365]: + 1/1 TID 00
Jan 06 13:05:45 dm900 enigma2[365]: done!
Jan 06 13:05:45 dm900 enigma2[365]: PATready
Jan 06 13:05:45 dm900 enigma2[365]: no PAT entry found.. start delay
Jan 06 13:05:45 dm900 enigma2[365]: doing version filtering
Jan 06 13:05:45 dm900 enigma2[365]: 0000:  00 00 00 05 00 00
Jan 06 13:05:45 dm900 enigma2[365]: mask:  ff 00 00 3f 00 00
Jan 06 13:05:45 dm900 enigma2[365]: mode:  00 00 00 3e 00 00
Jan 06 13:05:46 dm900 enigma2[365]: ignore sdt update data.... incorrect transponder tuned!!!
Jan 06 13:05:46 dm900 enigma2[365]: +- 1/2 TID 4e
Jan 06 13:05:46 dm900 enigma2[365]: DVB service failed to tune - error 3
Jan 06 13:05:46 dm900 enigma2[365]: RemovePopup, id = ZapError
Jan 06 13:05:46 dm900 enigma2[365]: AddPopup, id = ZapError domain = ZapError
Jan 06 13:05:46 dm900 enigma2[365]: [NotificationQueue::popNotification] domain ZapError deferred_callable: False
Jan 06 13:05:46 dm900 enigma2[365]: create buffer for widget 600 x 200
Jan 06 13:05:46 dm900 enigma2[365]: [HTTPRootResource].isSessionValid :: created session with id '0' for client with token 'd50770327472d421e7012f49099eb9eb5f68b124'
Jan 06 13:05:47 dm900 enigma2[365]: [WebComponents.EPG] setting command to '1:7:1:0:0:0:0:0:0:0:FROM BOUQUET "userbouquet.dbe00.tv" ORDER BY bouquet'
Jan 06 13:05:47 dm900 enigma2[365]: [WebComponents.EPG] getting EPG NOW/NEXT 1:7:1:0:0:0:0:0:0:0:FROM BOUQUET "userbouquet.dbe00.tv" ORDER BY bouquet
Jan 06 13:05:47 dm900 enigma2[365]: [SubServices].getSubservices called
Jan 06 13:05:47 dm900 enigma2[365]: SubServices is returning list  [('1:0:1:445C:453:1:C00000:0:0:0:', 'SAT.1')]
Jan 06 13:05:47 dm900 enigma2[365]: ++ 2/2 TID 4e
Jan 06 13:05:47 dm900 enigma2[365]: done!
Jan 06 13:05:47 dm900 enigma2[365]: doing version filtering
Jan 06 13:05:47 dm900 enigma2[365]: 0012:  4e 44 5c 23 00 00
Jan 06 13:05:47 dm900 enigma2[365]: mask:  ff ff ff 3f 00 00
Jan 06 13:05:47 dm900 enigma2[365]: mode:  00 00 00 3e 00 00
Jan 06 13:05:47 dm900 enigma2[365]: [EPGC] start caching events(1483704347)
Jan 06 13:05:50 dm900 enigma2[365]: Timeout!
Jan 06 13:05:54 dm900 enigma2[365]: [EPGC] abort non avail schedule other reading
Jan 06 13:05:54 dm900 enigma2[365]: [EPGC] abort non avail viasat reading