Duo2 Absturz bei Neustart

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

    • die debug musst du einschalten wenn es keinen crashlog gibt, ansonsten darf jeder mal raten.
    • Ah verzeiht bitte! Jetzt habe ich auch den Debug-Mode korrekt aktiviert.

      GUI-Neustart funktioniert.
      Neustart funktioniert nicht.

      Anbei der (hoffentlich richtige) Log:
      Spoiler anzeigen

      23:47:21.557 [e2-core] [VTi] version: 13.0.2 --> build: 2018-01-29 (e729409cb) | vti-master
      23:47:21.717 [e2-core] + (1) Background File Eraser
      23:47:21.719 [e2-core] + (5) Tuxtxt
      23:47:21.720 [e2-core] + (8) graphics acceleration manager
      23:47:21.721 [e2-core] + (9) GFBDC
      23:47:21.722 [e2-core] 21600k video mem
      23:47:21.724 [e2-core] [Animation] set animation mode 0
      23:47:21.725 [e2-core] SetMode : wanted: 1280x720x32, got 1920x1080x32
      23:47:21.746 [e2-core] - double buffering available!
      23:47:21.760 [e2-core] 10800kB available for acceleration surfaces.
      23:47:21.761 [e2-core] resolution: 1280 x 720 x 32 (stride: 7680)
      23:47:21.762 [e2-core] + (9) gLCDDC
      23:47:21.763 [e2-core] found OLED display!
      23:47:21.765 [e2-core] lcd buffer 0x93dbf0 4480 bytes, stride 140
      23:47:21.766 [e2-core] + (9) Font Render Class
      23:47:21.767 [e2-core] [FONT] initializing lib...
      23:47:21.768 [e2-core] [FONT] loading fonts...
      23:47:21.769 [e2-core] [FONT] Intializing font cache, using max. 4MB...
      23:47:21.770 [e2-core] + (10) gRC
      23:47:21.771 [e2-core] RC thread created successfully
      23:47:21.773 [e2-core] + (15) eWindowStyleManager
      23:47:21.774 [e2-core] + (20) DVB-CI UI
      23:47:21.775 [e2-core] + (20) Hdmi CEC driver
      23:47:21.776 [e2-core] + (20) UHF Modulator
      23:47:21.777 [e2-core] couldnt open /dev/rfmod0!!!!
      23:47:21.778 [e2-core] + (20) RC Input layer
      23:47:21.779 [e2-core] + (20) misc options
      23:47:21.780 [e2-core] + (20) AVSwitch Driver
      23:47:21.782 [e2-core] + (21) input device driver
      23:47:21.783 [e2-core] [eInputDeviceInit] adding device /dev/input/event0
      23:47:21.784 [e2-core] Input device "dreambox advanced remote control (native)" is not a keyboard.
      23:47:21.786 [e2-core] Found 1 input devices!
      23:47:21.787 [e2-core] + (21) Console RC Driver
      23:47:21.788 [e2-core] failed to open /dev/tty0
      23:47:21.789 [e2-core] + (30) eActionMap
      23:47:21.790 [e2-core] + (35) CI Slots
      23:47:21.791 [e2-core] scanning for common interfaces..
      23:47:21.796 [e2-core] cannot open /proc/stb/tsmux/input8
      23:47:21.797 [e2-core] cannot open /proc/stb/tsmux/input9
      23:47:22.006 [e2-core] before: 1
      23:47:22.008 [e2-core] after: 1
      23:47:22.009 [e2-core] setIoPrio best-effort level 7 ok
      23:47:22.010 [e2-core] before: 1
      23:47:22.011 [e2-core] after: 1
      23:47:22.012 [e2-core] setIoPrio idle level 6 ok
      23:47:22.014 [e2-core] done, found 2 common interface slots
      23:47:22.015 [e2-core] + (40) eServiceCenter
      23:47:22.016 [e2-core] settings instance.
      23:47:22.017 [e2-core] + (41) eServiceFactoryM2TS
      23:47:22.018 [e2-core] + (41) eServiceFactoryMP3
      23:47:22.019 [e2-core] + (41) eServiceFactoryHDMI
      23:47:22.020 [e2-core] + (41) eServiceFactoryFS
      23:47:22.021 [e2-core] + (41) eServiceFactoryDVB
      23:47:22.022 [e2-core] + (42) eServiceRecordDB
      23:47:22.023 [e2-core] + (42) eVTiApp
      23:47:22.024 [e2-core] reached rl 70
      23:47:22.025 [e2-core] resolve: resolve ${sysconfdir}/enigma2/lamedb
      23:47:22.026 [e2-core] resolve: -> /etc/enigma2/lamedb
      23:47:22.027 [e2-core] ---- opening lame channel db
      23:47:22.028 [e2-core] reading services (version 4)
      23:47:22.055 [e2-core] loaded 616 services
      23:47:22.056 [e2-core] scanning for frontends..
      23:47:22.057 [e2-core] [eDVBFrontend] opening frontend 0
      23:47:22.058 [e2-core] opening frontend 0
      23:47:22.059 [e2-core] close frontend 0
      23:47:22.061 [e2-core] [eDVBFrontend] opening frontend 1
      23:47:22.062 [e2-core] opening frontend 1
      23:47:22.063 [e2-core] close frontend 1
      23:47:22.065 [e2-core] found 1 adapter, 2 frontends(2 sim) and 9 demux, boxtype 4
      23:47:22.066 [e2-core] Use valid Linux Time :) (RTC?)
      23:47:22.067 [e2-core] [eEPGCache] Initialized EPGCache (wait for setCacheFile call now)
      23:47:22.069 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/pal.png
      23:47:22.070 [e2-core] resolve: -> /usr/share/enigma2/skin_default/pal.png
      23:47:22.076 [e2-core] Loading spinners...
      23:47:22.077 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait1.png
      23:47:22.078 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait1.png
      23:47:22.079 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait2.png
      23:47:22.080 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait2.png
      23:47:22.082 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait3.png
      23:47:22.083 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait3.png
      23:47:22.084 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait4.png
      23:47:22.085 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait4.png
      23:47:22.087 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait5.png
      23:47:22.088 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait5.png
      23:47:22.089 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait6.png
      23:47:22.090 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait6.png
      23:47:22.092 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait7.png
      23:47:22.093 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait7.png
      23:47:22.094 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait8.png
      23:47:22.095 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait8.png
      23:47:22.097 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait9.png
      23:47:22.098 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait9.png
      23:47:22.099 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait10.png
      23:47:22.100 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait10.png
      23:47:22.101 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait11.png
      23:47:22.102 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait11.png
      23:47:22.104 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait12.png
      23:47:22.105 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait12.png
      23:47:22.107 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait13.png
      23:47:22.108 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait13.png
      23:47:22.109 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait14.png
      23:47:22.110 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait14.png
      23:47:22.112 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait15.png
      23:47:22.113 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait15.png
      23:47:22.115 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait16.png
      23:47:22.116 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait16.png
      23:47:22.117 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait17.png
      23:47:22.118 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait17.png
      23:47:22.120 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait18.png
      23:47:22.121 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait18.png
      23:47:22.122 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait19.png
      23:47:22.123 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait19.png
      23:47:22.125 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait20.png
      23:47:22.126 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait20.png
      23:47:22.128 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait21.png
      23:47:22.129 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait21.png
      23:47:22.130 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait22.png
      23:47:22.132 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait22.png
      23:47:22.133 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait23.png
      23:47:22.134 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait23.png
      23:47:22.136 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait24.png
      23:47:22.138 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait24.png
      23:47:22.139 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait25.png
      23:47:22.140 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait25.png
      23:47:22.142 [e2-core] resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait26.png
      23:47:22.143 [e2-core] resolve: -> /usr/share/enigma2/skin_default/spinner/wait26.png
      23:47:22.144 [e2-core] found 25 spinner!

      23:47:22.145 [e2-core] setIoPrio best-effort level 3 ok
      23:47:22.146 [e2-core] resolve: resolve ${libdir}/enigma2/python/mytest.py
      23:47:22.147 [e2-core] resolve: -> /usr/lib/enigma2/python/mytest.py
      23:47:22.268 [e2-core] resolve: resolve ${sysconfdir}/
      23:47:22.269 [e2-core] resolve: -> /etc/
      23:47:22.270 [e2-core] resolve: resolve ${sysconfdir}/
      23:47:22.271 [e2-core] resolve: -> /etc/
      23:47:22.272 [e2-core] resolve: resolve ${datadir}/fonts/
      23:47:22.273 [e2-core] resolve: -> /usr/share/fonts/
      23:47:22.276 [e2-core] resolve: resolve ${sysconfdir}/enigma2/
      23:47:22.277 [e2-core] resolve: -> /etc/enigma2/
      23:47:22.278 [e2-core] resolve: resolve ${libdir}/enigma2/python/Plugins/
      23:47:22.279 [e2-core] resolve: -> /usr/lib/enigma2/python/Plugins/
      23:47:22.280 [e2-core] resolve: resolve ${datadir}/enigma2/po/
      23:47:22.281 [e2-core] resolve: -> /usr/share/enigma2/po/
      23:47:22.282 [e2-core] resolve: resolve ${datadir}/enigma2/
      23:47:22.283 [e2-core] resolve: -> /usr/share/enigma2/
      23:47:22.285 [e2-core] resolve: resolve ${datadir}/enigma2/
      23:47:22.286 [e2-core] resolve: -> /usr/share/enigma2/
      23:47:22.287 [e2-core] resolve: resolve ${sysconfdir}/enigma2/playlist/
      23:47:22.288 [e2-core] resolve: -> /etc/enigma2/playlist/
      23:47:22.289 [e2-core] resolve: resolve ${datadir}/enigma2/defaults/
      23:47:22.290 [e2-core] resolve: -> /usr/share/enigma2/defaults/
      23:47:22.291 [e2-core] resolve: resolve ${datadir}/enigma2/dealer
      23:47:22.292 [e2-core] resolve: -> /usr/share/enigma2/dealer
      23:47:22.293 [e2-core] resolve: resolve ${datadir}/meta
      23:47:22.294 [e2-core] resolve: -> /usr/share/meta
      23:47:22.295 [e2-core] resolve: resolve ${datadir}/enigma2/defaults/
      23:47:22.296 [e2-core] resolve: -> /usr/share/enigma2/defaults/
      23:47:22.303 [e2-python] [dvbapp2] set os enivronment variable SSL_CERT_FILE= /etc/ssl/certs/ca-certificates.crt
      23:47:22.359 [e2-python] enumerating block devices...
      23:47:22.364 [e2-python] found block device 'sda': ok, removable=True, cdrom=False, partitions=['sda1']
      23:47:22.402 [e2-python] found block device 'sda1': error querying properties
      23:47:22.406 [e2-python] found block device 'loop0': blacklisted
      23:47:22.409 [e2-python] found block device 'loop1': blacklisted
      23:47:22.412 [e2-python] found block device 'loop2': blacklisted
      23:47:22.415 [e2-python] found block device 'loop3': blacklisted
      23:47:22.418 [e2-python] found block device 'loop4': blacklisted
      23:47:22.420 [e2-python] found block device 'loop5': blacklisted
      23:47:22.423 [e2-python] found block device 'loop6': blacklisted
      23:47:22.426 [e2-python] found block device 'loop7': blacklisted
      23:47:22.429 [e2-python] found block device 'mtdblock0': blacklisted
      23:47:22.433 [e2-python] found block device 'mtdblock1': blacklisted
      23:47:22.437 [e2-python] found block device 'mtdblock2': blacklisted
      23:47:22.440 [e2-python] found block device 'mtdblock3': blacklisted
      23:47:22.449 [e2-python] found block device 'mtdblock4': blacklisted
      23:47:22.751 [e2-python] not loading user skin: [Errno 2] No such file or directory: '/etc/enigma2/skin_user.xml'
      23:47:22.756 [e2-python] [VTi] loading vfd skin: vfd_skin/skin_vfd_clock2016.xml
      23:47:22.757 [e2-python] [VTi] not loading user defined colors for skin
      23:47:22.759 [e2-python] [VTi] not loading user defined header file for skin
      23:47:24.620 [e2-python] [DataBase] init database: /media/hdd/vtidb.db
      23:47:24.658 [e2-python] Reading cables.xml
      23:47:24.660 [e2-core] couldn't open /etc/tuxbox/cables.xml!!
      23:47:24.662 [e2-python] Reading terrestrial.xml
      23:47:24.689 [e2-core] resolve: resolve ${datadir}/enigma2/unicable.xml
      23:47:24.690 [e2-core] resolve: -> /usr/share/enigma2/unicable.xml
      23:47:24.844 [e2-python] [InitNimManager] check multi type slot 0
      23:47:24.845 [e2-python] [InitNimManager] slot 0 is multi type : {'1': 'DVB-T', '0': 'DVB-C'}
      23:47:24.847 [e2-core] [eDVBResourceManager::setFrontendType] index : 0, type : DVB-C
      23:47:24.849 [e2-python] tuner type is already already 0
      23:47:24.850 [e2-python] [InitNimManager] check multi type slot 1
      23:47:24.851 [e2-python] [InitNimManager] slot 1 is multi type : {'1': 'DVB-T', '0': 'DVB-C'}
      23:47:24.853 [e2-core] [eDVBResourceManager::setFrontendType] index : 1, type : DVB-C
      23:47:24.855 [e2-python] tuner type is already already 0
      23:47:24.857 [e2-python] [Nimmanager] slot 0 create config cable..
      23:47:24.861 [e2-python] [Nimmanager] slot 1 create config cable..
      23:47:24.866 [e2-python] sec config cleared
      23:47:24.868 [e2-core] setSlotInfo for dvb frontend 0 to slotid 0, descr Vuplus DVB-C NIM(CXD1978), need rotorworkaround No, enabled Yes, DVB-S2 No, DVB-T2 No, DVB-S2X No
      23:47:24.869 [e2-core] setSlotInfo for dvb frontend 1 to slotid 1, descr Vuplus DVB-C NIM(CXD1978), need rotorworkaround No, enabled Yes, DVB-S2 No, DVB-T2 No, DVB-S2X No
      23:47:24.871 [e2-python] sec config completed
      23:47:24.950 [e2-core] resolve: resolve ${datadir}/enigma2/setup.xml
      23:47:24.951 [e2-core] resolve: -> /usr/share/enigma2/setup.xml
      23:47:24.970 [e2-python] Preferred tag editor set to None
      23:47:25.112 [e2-core] resolve: resolve ${sysconfdir}/enigma2/
      23:47:25.113 [e2-core] resolve: -> /etc/enigma2/
      23:47:25.114 [e2-core] loading bouquet... /etc/enigma2/bouquets.tv
      23:47:25.116 [e2-core] resolve: resolve ${sysconfdir}/enigma2/
      23:47:25.117 [e2-core] resolve: -> /etc/enigma2/
      23:47:25.118 [e2-core] loading bouquet... /etc/enigma2/userbouquet.favourites.tv
      23:47:25.119 [e2-core] 18 entries in Bouquet userbouquet.favourites.tv
      23:47:25.120 [e2-core] resolve: resolve ${sysconfdir}/enigma2/
      23:47:25.121 [e2-core] resolve: -> /etc/enigma2/
      23:47:25.122 [e2-core] loading bouquet... /etc/enigma2/userbouquet.976c1.tv
      23:47:25.123 [e2-core] 14 entries in Bouquet userbouquet.976c1.tv
      23:47:25.125 [e2-core] resolve: resolve ${sysconfdir}/enigma2/
      23:47:25.126 [e2-core] resolve: -> /etc/enigma2/
      23:47:25.127 [e2-core] loading bouquet... /etc/enigma2/userbouquet.adab8.tv
      23:47:25.128 [e2-core] 6 entries in Bouquet userbouquet.adab8.tv
      23:47:25.129 [e2-core] resolve: resolve ${sysconfdir}/enigma2/
      23:47:25.130 [e2-core] resolve: -> /etc/enigma2/
      23:47:25.131 [e2-core] loading bouquet... /etc/enigma2/userbouquet.dba27.tv
      23:47:25.132 [e2-core] 25 entries in Bouquet userbouquet.dba27.tv
      23:47:25.133 [e2-core] resolve: resolve ${sysconfdir}/enigma2/
      23:47:25.135 [e2-core] resolve: -> /etc/enigma2/
      23:47:25.136 [e2-core] loading bouquet... /etc/enigma2/userbouquet.49996.tv
      23:47:25.138 [e2-core] 12 entries in Bouquet userbouquet.49996.tv
      23:47:25.139 [e2-core] resolve: resolve ${sysconfdir}/enigma2/
      23:47:25.140 [e2-core] resolve: -> /etc/enigma2/
      23:47:25.141 [e2-core] loading bouquet... /etc/enigma2/userbouquet.371b8.tv
      23:47:25.142 [e2-core] 5 entries in Bouquet userbouquet.371b8.tv
      23:47:25.144 [e2-core] resolve: resolve ${sysconfdir}/enigma2/
      23:47:25.145 [e2-core] resolve: -> /etc/enigma2/
      23:47:25.146 [e2-core] loading bouquet... /etc/enigma2/userbouquet.2839a.tv
      23:47:25.149 [e2-core] 174 entries in Bouquet userbouquet.2839a.tv
      23:47:25.150 [e2-core] resolve: resolve ${sysconfdir}/enigma2/
      23:47:25.151 [e2-core] resolve: -> /etc/enigma2/
      23:47:25.152 [e2-core] loading bouquet... /etc/enigma2/userbouquet.65203.tv
      23:47:25.154 [e2-core] 48 entries in Bouquet userbouquet.65203.tv
      23:47:25.155 [e2-core] 8 entries in Bouquet bouquets.tv
      23:47:25.156 [e2-core] resolve: resolve ${sysconfdir}/enigma2/
      23:47:25.157 [e2-core] resolve: -> /etc/enigma2/
      23:47:25.158 [e2-core] loading bouquet... /etc/enigma2/bouquets.radio
      23:47:25.159 [e2-core] resolve: resolve ${sysconfdir}/enigma2/
      23:47:25.160 [e2-core] resolve: -> /etc/enigma2/
      23:47:25.161 [e2-core] loading bouquet... /etc/enigma2/userbouquet.favourites.radio
      23:47:25.162 [e2-core] 0 entries in Bouquet userbouquet.favourites.radio
      23:47:25.163 [e2-core] 1 entries in Bouquet bouquets.radio
      23:47:25.188 [e2-core] resolve: resolve ${sysconfdir}/enigma2/remote_id_
      23:47:25.189 [e2-core] resolve: -> /etc/enigma2/remote_id_
      23:47:25.197 [e2-core] [eDVBLocalTimeHandler] enable sync local time with transponder time!
      23:47:25.860 [e2-core] main thread is non-idle! display spinner!
      23:47:26.011 [e2-core] [FONT] adding font /usr/share/fonts/nmsbd.ttf...OK (Display)
      23:47:26.020 [e2-core] SetMode : wanted: 1920x1080x32, got 1280x720x32
      23:47:26.047 [e2-core] - double buffering available!
      23:47:26.068 [e2-core] 5400kB available for acceleration surfaces.
      23:47:26.069 [e2-core] resolution: 1920 x 1080 x 32 (stride: 7680)
      23:47:26.092 [e2-core] [FONT] adding font /usr/share/fonts/MyriadPro-Regular.otf...OK (Regular)
      23:47:26.094 [e2-core] [FONT] adding font /usr/share/fonts/MyriadPro-Semibold.otf...OK (Semibold)
      23:47:26.096 [e2-core] [FONT] adding font /usr/share/fonts/MyriadPro-SemiboldIt.otf...OK (Semiboldit)
      23:47:26.098 [e2-core] [FONT] adding font /usr/share/fonts/MyriadPro-Semibold.otf...OK (SimpleBold)
      23:47:26.100 [e2-core] [FONT] adding font /usr/share/fonts/MyriadPro-Regular.otf...OK (SimpleRegular)
      23:47:26.101 [e2-core] [FONT] adding font /usr/share/fonts/lcd.ttf...OK (LCD)
      23:47:26.103 [e2-core] [FONT] adding font /usr/share/fonts/ae_AlMateen.ttf...OK (Replacement)
      23:47:26.105 [e2-core] [FONT] adding font /usr/share/fonts/tuxtxt.ttf...OK (Console)
      23:47:26.107 [e2-core] [FONT] adding font /usr/share/fonts/nmsbd.ttf...OK (Subtitlefont)
      23:47:26.137 [e2-core] [FONT] adding font /usr/share/fonts/HeadlineNEWS.ttf...OK (VFD)
      23:47:26.139 [e2-core] [FONT] adding font /usr/share/fonts/HeadlineNEWS.ttf...OK (VFD_II)
      23:47:26.145 [e2-python] [iInputDevices] getInputDevices <ERROR: ioctl(EVIOCGNAME): [Errno 22] Invalid argument >
      23:47:26.177 [e2-core] couldn't open /proc/stb/misc/12V_output
      23:47:26.178 [e2-core] resolve: resolve ${datadir}/enigma2/keymap.xml
      23:47:26.179 [e2-core] resolve: -> /usr/share/enigma2/keymap.xml
      23:47:26.358 [e2-core] resolve: resolve ${datadir}/keymaps/
      23:47:26.360 [e2-core] resolve: -> /usr/share/keymaps/
      23:47:26.361 [e2-core] resolve: resolve ${datadir}/keymaps/
      23:47:26.362 [e2-core] resolve: -> /usr/share/keymaps/
      23:47:26.368 [e2-core] resolve: resolve ${datadir}/keymaps/
      23:47:26.369 [e2-core] resolve: -> /usr/share/keymaps/
      23:47:26.379 [e2-python] Activating keymap: Keyboard English
      23:47:26.380 [e2-core] resolve: resolve ${datadir}/keymaps/
      23:47:26.381 [e2-core] resolve: -> /usr/share/keymaps/
      23:47:26.385 [e2-python] Activating language German
      23:47:27.047 [e2-python] language set to de_DE
      23:47:27.058 [e2-core] FIXME: request for unknown slot
      23:47:27.060 [e2-core] FIXME: request for unknown slot
      23:47:27.064 [e2-core] setLCDBrightness 25
      23:47:27.066 [e2-core] setLCDBrightness 255
      23:47:27.195 [e2-core] cannot open /proc/stb/avs/0/input_choices
      23:47:27.205 [e2-python] --> setting scaler_sharpness to: 00000000
      23:47:28.168 [e2-core] main thread is non-idle! display spinner!
      23:47:29.359 [e2-core] [FONT] adding font /usr/lib/enigma2/python/Plugins/Extensions/VMC/fonts/IconFonts/PVR_State.ttf...OK (MPVR)
      23:47:29.360 [e2-core] [FONT] adding font /usr/lib/enigma2/python/Plugins/Extensions/VMC/fonts/IconFonts/vmclogo.ttf...OK (LOGO)
      23:47:29.362 [e2-core] [FONT] adding font /usr/lib/enigma2/python/Plugins/Extensions/VMC/fonts/RC.ttf...OK (VRegular)
      23:47:29.363 [e2-core] [FONT] adding font /usr/lib/enigma2/python/Plugins/Extensions/VMC/fonts/RobotoCondensed-Bold.ttf...OK (VBold)
      23:47:29.365 [e2-core] [FONT] adding font /usr/lib/enigma2/python/Plugins/Extensions/VMC/fonts/RobotoCondensed-Light.ttf...OK (VLight)
      23:47:29.366 [e2-core] [FONT] adding font /usr/lib/enigma2/python/Plugins/Extensions/VMC/fonts/IconFonts/fontawesome.ttf...OK (Icons)
      23:47:29.368 [e2-core] [FONT] adding font /usr/lib/enigma2/python/Plugins/Extensions/VMC/fonts/IconFonts/VMCIcons.ttf...OK (VMCIcons)
      23:47:29.369 [e2-core] [FONT] adding font /usr/lib/enigma2/python/Plugins/Extensions/VMC/fonts/IconFonts/UFC.ttf...OK (UFC)
      23:47:29.371 [e2-core] [FONT] adding font /usr/lib/enigma2/python/Plugins/Extensions/VMC/fonts/IconFonts/Material-Design-Icons.ttf...OK (VMCMaterializeIcons)
      23:47:29.411 [e2-python] [CoverFind] set language to de
      23:47:29.422 [e2-python] [CoverFind] set language to de
      23:47:29.429 [e2-python] [CoverFind] fallback to default Enigma2 Translation for CoverFind
      23:47:29.438 [e2-python] [CoverFind] fallback to default Enigma2 Translation for CoverFind
      23:47:29.445 [e2-python] [TMDb] set language to de
      23:47:29.457 [e2-python] [TMDb] set language to de
      23:47:29.484 [e2-python] [TMDb] fallback to default Enigma2 Translation for TMDb
      23:47:29.493 [e2-python] [TMDb] fallback to default Enigma2 Translation for TMDb
      23:47:29.497 [e2-python] [TMDb] fallback to default Enigma2 Translation for TMDb Infos ...
      23:47:29.501 [e2-python] [TMDb] fallback to default Enigma2 Translation for TMDb
      23:47:29.506 [e2-python] [TMDb] fallback to default Enigma2 Translation for TMDb Infos ...
      23:47:30.058 [e2-python] Preferred tag editor changed to <class 'Plugins.Extensions.TagEditor.plugin.TagEditor'>
      23:47:30.152 [e2-core] [FONT] adding font /usr/lib/enigma2/python/Plugins/Extensions/TVSpielfilm/font/Sans.ttf...OK (Sans)
      23:47:30.681 [e2-python] remove DVI-PC because it does not exist.
      23:47:30.695 [e2-python] set HDMI Colorspace : Edid(Auto)
      23:47:30.698 [e2-python] hotplug on DVI
      23:47:30.705 [e2-python] set Videomode DVI 1080p multi
      23:47:30.729 [e2-python] set aspect, policy, policy2, wss 16:9 panscan letterbox auto
      23:47:32.975 [e2-core] resolve: resolve ${datadir}/enigma2/setup.xml
      23:47:32.977 [e2-core] resolve: -> /usr/share/enigma2/setup.xml
      23:47:32.978 [e2-core] resolve: resolve ${libdir}
      23:47:32.979 [e2-core] resolve: -> /usr/lib
      23:47:33.863 [e2-python] [OpenWebif] -D- tuner '0' 'Vuplus DVB-C NIM(CXD1978)' 'Tuner A'
      23:47:33.981 [e2-python] [OpenWebif] -D- tuner '1' 'Vuplus DVB-C NIM(CXD1978)' 'Tuner B'
      23:47:33.994 [e2-core] resolve: resolve ${libdir}/enigma2/python/Plugins/SystemPlugins/TransCodingSetup/plugin.pyo
      23:47:33.995 [e2-core] resolve: -> /usr/lib/enigma2/python/Plugins/SystemPlugins/TransCodingSetup/plugin.pyo
      23:47:34.049 [e2-core] resolve: resolve ${datadir}/enigma2/
      23:47:34.050 [e2-core] resolve: -> /usr/share/enigma2/
      23:47:34.257 [e2-python] [SerienRecorder] Skinfactor: 1.5
      23:47:34.348 [e2-core] resolve: resolve ${libdir}/enigma2/python/Plugins/SystemPlugins/vps/vps
      23:47:34.349 [e2-core] resolve: -> /usr/lib/enigma2/python/Plugins/SystemPlugins/vps/vps
      23:47:34.718 [e2-python] [LCD4linux] libusb found :) 2018-01-29-vti-master (e729409cb)
      23:47:37.049 [e2-python] [MovieCut] set language to de
      23:47:37.054 [e2-core] resolve: resolve ${libdir}/enigma2/python/Plugins/Extensions/MovieCut/bin/mcut
      23:47:37.055 [e2-core] resolve: -> /usr/lib/enigma2/python/Plugins/Extensions/MovieCut/bin/mcut
      23:47:37.470 [e2-python] <ZappingModeSelection> set zapping mode : mute
      23:47:37.490 [e2-core] resolve: resolve ${datadir}/enigma2/
      23:47:37.491 [e2-core] resolve: -> /usr/share/enigma2/
      23:47:37.528 [e2-core] resolve: resolve ${libdir}/enigma2/python/Plugins/SystemPlugins/WirelessLan
      23:47:37.529 [e2-core] resolve: -> /usr/lib/enigma2/python/Plugins/SystemPlugins/WirelessLan
      23:47:37.541 [e2-python] --> setting contrast to: 00008000
      23:47:37.543 [e2-python] --> setting saturation to: 00008000
      23:47:37.546 [e2-python] --> setting hue to: 00008000
      23:47:37.548 [e2-python] --> setting brightness to: 00008000
      23:47:37.551 [e2-python] --> setting block_noise_reduction to: 00000000
      23:47:37.584 [e2-python] --> setting mosquito_noise_reduction to: 00000000
      23:47:37.624 [e2-python] --> setting digital_contour_removal to: 00000000
      23:47:37.665 [e2-python] --> setting splitmode to: off
      23:47:37.668 [e2-python] --> setting sharpness to: 00000000
      23:47:37.670 [e2-python] --> setting auto_flesh to: 00000000
      23:47:37.673 [e2-python] --> setting green_boost to: 00000000
      23:47:37.676 [e2-python] --> setting blue_boost to: 00000000
      23:47:37.679 [e2-python] --> setting dynamic_contrast to: 00000000
      23:47:37.685 [e2-python] --> setting scaler_vertical_dejagging to: disable
      23:47:37.687 [e2-python] --> setting smooth to: disable
      23:47:37.688 [e2-python] --> applying pep values
      23:47:37.841 [e2-python] [UIPositionSetup] write dst_left : 0
      23:47:37.842 [e2-python] [UIPositionSetup] write dst_width : 720
      23:47:37.844 [e2-python] [UIPositionSetup] write dst_top : 0
      23:47:37.845 [e2-python] [UIPositionSetup] write dst_height : 576
      23:47:37.865 [e2-python] [DeviceManager2] Loading skin /usr/lib/enigma2/python/Plugins/SystemPlugins/DeviceManager2/skin.xml
      23:47:37.891 [e2-python] [AutoMount.py] -getAutoMountPoints:self.automounts --> {}
      23:47:37.892 [e2-python] [AutoMount.py] self.automounts without mounts {}
      23:47:37.905 [e2-python] [NetworkBrowser] fallback to default translation for NetworkBrowser
      23:47:37.909 [e2-python] [NetworkBrowser] fallback to default translation for Search for network shares
      23:47:37.914 [e2-python] [NetworkBrowser] fallback to default translation for MountManager
      23:47:37.917 [e2-python] [NetworkBrowser] fallback to default translation for Manage network shares
      23:47:37.940 [e2-python] <RemoteControlCode> Write Remote Control Code : 2
      23:47:38.035 [e2-python] [CI_Assignment] activating ci configs:
      23:47:38.037 [e2-core] resolve: resolve /usr/share/enigma2/ci_auto_assign.xml
      23:47:38.038 [e2-core] resolve: -> /usr/share/enigma2/ci_auto_assign.xml
      23:47:38.098 [e2-core] resolve: resolve ${sysconfdir}/enigma2/ci
      23:47:38.100 [e2-core] resolve: -> /etc/enigma2/ci
      23:47:38.101 [e2-core] resolve: resolve ${sysconfdir}/enigma2/ci
      23:47:38.102 [e2-core] resolve: -> /etc/enigma2/ci
      23:47:38.104 [e2-python] starting hotplug handler
      23:47:38.111 [e2-python] add device sda to bdpoll current state: medium inserted
      23:47:38.119 [e2-python] [TIMER] record time changed, start prepare is now: Wed Feb 14 20:14:40 2018
      23:47:38.120 [e2-python] sanitycheck
      23:47:38.122 [e2-python] check
      23:47:38.123 [e2-python] checkTimerlist
      23:47:38.125 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.126 [e2-core] record: 0
      23:47:38.128 [e2-core] Slot 0, score 2
      23:47:38.129 [e2-core] Slot 1, score 2
      23:47:38.130 [e2-core] [eDVBFrontend] opening frontend 0
      23:47:38.131 [e2-core] RECORD service event 14
      23:47:38.133 [e2-python] [Timer] Record <RecordTimer.RecordTimerEntry object at 0x5caa0650>
      23:47:38.134 [e2-python] ProcessRepeated
      23:47:38.136 [e2-python] next real activation is Wed Feb 14 20:14:40 2018
      23:47:38.139 [e2-python] [TIMER] record time changed, start prepare is now: Wed Feb 14 20:49:40 2018
      23:47:38.140 [e2-python] sanitycheck
      23:47:38.142 [e2-python] check
      23:47:38.143 [e2-python] checkTimerlist
      23:47:38.145 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.146 [e2-core] record: 0
      23:47:38.147 [e2-core] Slot 0, score 2
      23:47:38.148 [e2-core] Slot 1, score 2
      23:47:38.149 [e2-core] RECORD service event 14
      23:47:38.151 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.152 [e2-core] record: 0
      23:47:38.153 [e2-core] RECORD service event 14
      23:47:38.155 [e2-python] [Timer] Record <RecordTimer.RecordTimerEntry object at 0x5caa06b0>
      23:47:38.156 [e2-python] ProcessRepeated
      23:47:38.158 [e2-python] next real activation is Wed Feb 14 20:14:40 2018
      23:47:38.160 [e2-python] [TIMER] record time changed, start prepare is now: Wed Feb 14 21:49:40 2018
      23:47:38.162 [e2-python] sanitycheck
      23:47:38.164 [e2-python] check
      23:47:38.165 [e2-python] checkTimerlist
      23:47:38.167 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.168 [e2-core] record: 0
      23:47:38.169 [e2-core] Slot 0, score 2
      23:47:38.170 [e2-core] Slot 1, score 2
      23:47:38.171 [e2-core] RECORD service event 14
      23:47:38.173 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.174 [e2-core] record: 0
      23:47:38.175 [e2-core] RECORD service event 14
      23:47:38.177 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.178 [e2-core] record: 0
      23:47:38.179 [e2-core] RECORD service event 14
      23:47:38.181 [e2-python] [Timer] Record <RecordTimer.RecordTimerEntry object at 0x5caa06d0>
      23:47:38.182 [e2-python] ProcessRepeated
      23:47:38.184 [e2-python] next real activation is Wed Feb 14 20:14:40 2018
      23:47:38.187 [e2-python] [TIMER] record time changed, start prepare is now: Fri Feb 16 20:14:40 2018
      23:47:38.189 [e2-python] sanitycheck
      23:47:38.190 [e2-python] check
      23:47:38.192 [e2-python] checkTimerlist
      23:47:38.195 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.196 [e2-core] record: 0
      23:47:38.198 [e2-core] Slot 0, score 2
      23:47:38.199 [e2-core] Slot 1, score 2
      23:47:38.200 [e2-core] RECORD service event 14
      23:47:38.202 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.204 [e2-core] record: 0
      23:47:38.206 [e2-core] RECORD service event 14
      23:47:38.208 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.209 [e2-core] record: 0
      23:47:38.210 [e2-core] RECORD service event 14
      23:47:38.212 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.213 [e2-core] record: 0
      23:47:38.214 [e2-core] Slot 0, score 2
      23:47:38.215 [e2-core] Slot 1, score 2
      23:47:38.216 [e2-core] RECORD service event 14
      23:47:38.218 [e2-python] [Timer] Record <RecordTimer.RecordTimerEntry object at 0x5caa0750>
      23:47:38.219 [e2-python] ProcessRepeated
      23:47:38.221 [e2-python] next real activation is Wed Feb 14 20:14:40 2018
      23:47:38.224 [e2-python] [TIMER] record time changed, start prepare is now: Fri Feb 16 21:04:40 2018
      23:47:38.226 [e2-python] sanitycheck
      23:47:38.228 [e2-python] check
      23:47:38.229 [e2-python] checkTimerlist
      23:47:38.231 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.232 [e2-core] record: 0
      23:47:38.234 [e2-core] Slot 0, score 2
      23:47:38.235 [e2-core] Slot 1, score 2
      23:47:38.236 [e2-core] RECORD service event 14
      23:47:38.237 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.238 [e2-core] record: 0
      23:47:38.239 [e2-core] RECORD service event 14
      23:47:38.241 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.242 [e2-core] record: 0
      23:47:38.244 [e2-core] RECORD service event 14
      23:47:38.246 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.247 [e2-core] record: 0
      23:47:38.248 [e2-core] Slot 0, score 2
      23:47:38.249 [e2-core] Slot 1, score 2
      23:47:38.250 [e2-core] RECORD service event 14
      23:47:38.252 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.253 [e2-core] record: 0
      23:47:38.254 [e2-core] RECORD service event 14
      23:47:38.256 [e2-python] [Timer] Record <RecordTimer.RecordTimerEntry object at 0x5caa0730>
      23:47:38.258 [e2-python] ProcessRepeated
      23:47:38.260 [e2-python] next real activation is Wed Feb 14 20:14:40 2018
      23:47:38.262 [e2-python] [TIMER] record time changed, start prepare is now: Fri Feb 16 21:54:40 2018
      23:47:38.264 [e2-python] sanitycheck
      23:47:38.265 [e2-python] check
      23:47:38.267 [e2-python] checkTimerlist
      23:47:38.269 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.270 [e2-core] record: 0
      23:47:38.271 [e2-core] Slot 0, score 2
      23:47:38.272 [e2-core] Slot 1, score 2
      23:47:38.273 [e2-core] RECORD service event 14
      23:47:38.275 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.276 [e2-core] record: 0
      23:47:38.277 [e2-core] RECORD service event 14
      23:47:38.279 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.280 [e2-core] record: 0
      23:47:38.281 [e2-core] RECORD service event 14
      23:47:38.283 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.285 [e2-core] record: 0
      23:47:38.286 [e2-core] Slot 0, score 2
      23:47:38.287 [e2-core] Slot 1, score 2
      23:47:38.288 [e2-core] RECORD service event 14
      23:47:38.290 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.291 [e2-core] record: 0
      23:47:38.292 [e2-core] RECORD service event 14
      23:47:38.294 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.295 [e2-core] record: 0
      23:47:38.297 [e2-core] RECORD service event 14
      23:47:38.298 [e2-python] [Timer] Record <RecordTimer.RecordTimerEntry object at 0x5caa0890>
      23:47:38.299 [e2-python] ProcessRepeated
      23:47:38.302 [e2-python] next real activation is Wed Feb 14 20:14:40 2018
      23:47:38.304 [e2-python] [TIMER] record time changed, start prepare is now: Sat Feb 17 21:44:40 2018
      23:47:38.306 [e2-python] sanitycheck
      23:47:38.307 [e2-python] check
      23:47:38.308 [e2-python] checkTimerlist
      23:47:38.311 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.312 [e2-core] record: 0
      23:47:38.313 [e2-core] Slot 0, score 2
      23:47:38.314 [e2-core] Slot 1, score 2
      23:47:38.315 [e2-core] RECORD service event 14
      23:47:38.316 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.318 [e2-core] record: 0
      23:47:38.319 [e2-core] RECORD service event 14
      23:47:38.320 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.322 [e2-core] record: 0
      23:47:38.323 [e2-core] RECORD service event 14
      23:47:38.325 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.326 [e2-core] record: 0
      23:47:38.328 [e2-core] Slot 0, score 2
      23:47:38.329 [e2-core] Slot 1, score 2
      23:47:38.331 [e2-core] RECORD service event 14
      23:47:38.333 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.334 [e2-core] record: 0
      23:47:38.336 [e2-core] RECORD service event 14
      23:47:38.338 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.340 [e2-core] record: 0
      23:47:38.341 [e2-core] RECORD service event 14
      23:47:38.343 [e2-python] recording service: 1:0:19:2B66:437:66:FFFF0000:0:0:0:
      23:47:38.345 [e2-core] record: 0
      23:47:38.347 [e2-core] Slot 0, score 2
      23:47:38.348 [e2-core] Slot 1, score 2
      23:47:38.349 [e2-core] RECORD service event 14
      23:47:38.350 [e2-python] [Timer] Record <RecordTimer.RecordTimerEntry object at 0x5caa0a30>
      23:47:38.352 [e2-python] ProcessRepeated
      23:47:38.354 [e2-python] next real activation is Wed Feb 14 20:14:40 2018
      23:47:38.357 [e2-python] [TIMER] record time changed, start prepare is now: Mon Feb 19 20:14:40 2018
      23:47:38.358 [e2-python] sanitycheck
      23:47:38.359 [e2-python] check
      23:47:38.361 [e2-python] checkTimerlist
      23:47:38.363 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.365 [e2-core] record: 0
      23:47:38.366 [e2-core] Slot 0, score 2
      23:47:38.367 [e2-core] Slot 1, score 2
      23:47:38.368 [e2-core] RECORD service event 14
      23:47:38.370 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.371 [e2-core] record: 0
      23:47:38.372 [e2-core] RECORD service event 14
      23:47:38.374 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.375 [e2-core] record: 0
      23:47:38.376 [e2-core] RECORD service event 14
      23:47:38.378 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.379 [e2-core] record: 0
      23:47:38.381 [e2-core] Slot 0, score 2
      23:47:38.382 [e2-core] Slot 1, score 2
      23:47:38.383 [e2-core] RECORD service event 14
      23:47:38.385 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.386 [e2-core] record: 0
      23:47:38.387 [e2-core] RECORD service event 14
      23:47:38.389 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.390 [e2-core] record: 0
      23:47:38.391 [e2-core] RECORD service event 14
      23:47:38.393 [e2-python] recording service: 1:0:19:2B66:437:66:FFFF0000:0:0:0:
      23:47:38.394 [e2-core] record: 0
      23:47:38.396 [e2-core] Slot 0, score 2
      23:47:38.397 [e2-core] Slot 1, score 2
      23:47:38.398 [e2-core] RECORD service event 14
      23:47:38.399 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.400 [e2-core] record: 0
      23:47:38.402 [e2-core] Slot 0, score 2
      23:47:38.403 [e2-core] Slot 1, score 2
      23:47:38.404 [e2-core] RECORD service event 14
      23:47:38.406 [e2-python] [Timer] Record <RecordTimer.RecordTimerEntry object at 0x5caa0ab0>
      23:47:38.407 [e2-python] ProcessRepeated
      23:47:38.410 [e2-python] next real activation is Wed Feb 14 20:14:40 2018
      23:47:38.412 [e2-python] [TIMER] record time changed, start prepare is now: Wed Feb 21 20:14:40 2018
      23:47:38.414 [e2-python] sanitycheck
      23:47:38.415 [e2-python] check
      23:47:38.416 [e2-python] checkTimerlist
      23:47:38.418 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.420 [e2-core] record: 0
      23:47:38.421 [e2-core] Slot 0, score 2
      23:47:38.422 [e2-core] Slot 1, score 2
      23:47:38.423 [e2-core] RECORD service event 14
      23:47:38.425 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.426 [e2-core] record: 0
      23:47:38.427 [e2-core] RECORD service event 14
      23:47:38.429 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.430 [e2-core] record: 0
      23:47:38.431 [e2-core] RECORD service event 14
      23:47:38.433 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.435 [e2-core] record: 0
      23:47:38.436 [e2-core] Slot 0, score 2
      23:47:38.437 [e2-core] Slot 1, score 2
      23:47:38.438 [e2-core] RECORD service event 14
      23:47:38.439 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.441 [e2-core] record: 0
      23:47:38.442 [e2-core] RECORD service event 14
      23:47:38.444 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.445 [e2-core] record: 0
      23:47:38.446 [e2-core] RECORD service event 14
      23:47:38.448 [e2-python] recording service: 1:0:19:2B66:437:66:FFFF0000:0:0:0:
      23:47:38.449 [e2-core] record: 0
      23:47:38.450 [e2-core] Slot 0, score 2
      23:47:38.451 [e2-core] Slot 1, score 2
      23:47:38.452 [e2-core] RECORD service event 14
      23:47:38.454 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.455 [e2-core] record: 0
      23:47:38.457 [e2-core] Slot 0, score 2
      23:47:38.458 [e2-core] Slot 1, score 2
      23:47:38.459 [e2-core] RECORD service event 14
      23:47:38.460 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.462 [e2-core] record: 0
      23:47:38.463 [e2-core] Slot 0, score 2
      23:47:38.464 [e2-core] Slot 1, score 2
      23:47:38.465 [e2-core] RECORD service event 14
      23:47:38.467 [e2-python] [Timer] Record <RecordTimer.RecordTimerEntry object at 0x5caa0b10>
      23:47:38.469 [e2-python] ProcessRepeated
      23:47:38.471 [e2-python] next real activation is Wed Feb 14 20:14:40 2018
      23:47:38.475 [e2-python] [TIMER] record time changed, start prepare is now: Wed Feb 21 20:49:40 2018
      23:47:38.477 [e2-python] sanitycheck
      23:47:38.478 [e2-python] check
      23:47:38.480 [e2-python] checkTimerlist
      23:47:38.482 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.484 [e2-core] record: 0
      23:47:38.486 [e2-core] Slot 0, score 2
      23:47:38.487 [e2-core] Slot 1, score 2
      23:47:38.488 [e2-core] RECORD service event 14
      23:47:38.489 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.491 [e2-core] record: 0
      23:47:38.492 [e2-core] RECORD service event 14
      23:47:38.494 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.495 [e2-core] record: 0
      23:47:38.496 [e2-core] RECORD service event 14
      23:47:38.498 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.499 [e2-core] record: 0
      23:47:38.500 [e2-core] Slot 0, score 2
      23:47:38.501 [e2-core] Slot 1, score 2
      23:47:38.503 [e2-core] RECORD service event 14
      23:47:38.505 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.506 [e2-core] record: 0
      23:47:38.508 [e2-core] RECORD service event 14
      23:47:38.509 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.511 [e2-core] record: 0
      23:47:38.512 [e2-core] RECORD service event 14
      23:47:38.514 [e2-python] recording service: 1:0:19:2B66:437:66:FFFF0000:0:0:0:
      23:47:38.515 [e2-core] record: 0
      23:47:38.516 [e2-core] Slot 0, score 2
      23:47:38.517 [e2-core] Slot 1, score 2
      23:47:38.518 [e2-core] RECORD service event 14
      23:47:38.520 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.521 [e2-core] record: 0
      23:47:38.523 [e2-core] Slot 0, score 2
      23:47:38.524 [e2-core] Slot 1, score 2
      23:47:38.525 [e2-core] RECORD service event 14
      23:47:38.527 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.528 [e2-core] record: 0
      23:47:38.529 [e2-core] Slot 0, score 2
      23:47:38.530 [e2-core] Slot 1, score 2
      23:47:38.531 [e2-core] RECORD service event 14
      23:47:38.533 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.534 [e2-core] record: 0
      23:47:38.535 [e2-core] RECORD service event 14
      23:47:38.537 [e2-python] [Timer] Record <RecordTimer.RecordTimerEntry object at 0x5caa0bb0>
      23:47:38.538 [e2-python] ProcessRepeated
      23:47:38.541 [e2-python] next real activation is Wed Feb 14 20:14:40 2018
      23:47:38.544 [e2-python] [TIMER] record time changed, start prepare is now: Wed Feb 21 21:49:40 2018
      23:47:38.545 [e2-python] sanitycheck
      23:47:38.547 [e2-python] check
      23:47:38.548 [e2-python] checkTimerlist
      23:47:38.550 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.551 [e2-core] record: 0
      23:47:38.552 [e2-core] Slot 0, score 2
      23:47:38.554 [e2-core] Slot 1, score 2
      23:47:38.555 [e2-core] RECORD service event 14
      23:47:38.556 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.557 [e2-core] record: 0
      23:47:38.559 [e2-core] RECORD service event 14
      23:47:38.560 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.561 [e2-core] record: 0
      23:47:38.562 [e2-core] RECORD service event 14
      23:47:38.565 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.566 [e2-core] record: 0
      23:47:38.567 [e2-core] Slot 0, score 2
      23:47:38.568 [e2-core] Slot 1, score 2
      23:47:38.569 [e2-core] RECORD service event 14
      23:47:38.571 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.572 [e2-core] record: 0
      23:47:38.573 [e2-core] RECORD service event 14
      23:47:38.575 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.576 [e2-core] record: 0
      23:47:38.577 [e2-core] RECORD service event 14
      23:47:38.579 [e2-python] recording service: 1:0:19:2B66:437:66:FFFF0000:0:0:0:
      23:47:38.580 [e2-core] record: 0
      23:47:38.581 [e2-core] Slot 0, score 2
      23:47:38.582 [e2-core] Slot 1, score 2
      23:47:38.584 [e2-core] RECORD service event 14
      23:47:38.585 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.587 [e2-core] record: 0
      23:47:38.588 [e2-core] Slot 0, score 2
      23:47:38.589 [e2-core] Slot 1, score 2
      23:47:38.590 [e2-core] RECORD service event 14
      23:47:38.592 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.593 [e2-core] record: 0
      23:47:38.594 [e2-core] Slot 0, score 2
      23:47:38.595 [e2-core] Slot 1, score 2
      23:47:38.596 [e2-core] RECORD service event 14
      23:47:38.598 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.599 [e2-core] record: 0
      23:47:38.600 [e2-core] RECORD service event 14
      23:47:38.602 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.603 [e2-core] record: 0
      23:47:38.605 [e2-core] RECORD service event 14
      23:47:38.607 [e2-python] [Timer] Record <RecordTimer.RecordTimerEntry object at 0x5caa0c30>
      23:47:38.608 [e2-python] ProcessRepeated
      23:47:38.611 [e2-python] next real activation is Wed Feb 14 20:14:40 2018
      23:47:38.614 [e2-python] [TIMER] record time changed, start prepare is now: Sat Feb 24 20:14:40 2018
      23:47:38.616 [e2-python] sanitycheck
      23:47:38.618 [e2-python] check
      23:47:38.620 [e2-python] checkTimerlist
      23:47:38.622 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.624 [e2-core] record: 0
      23:47:38.626 [e2-core] Slot 0, score 2
      23:47:38.627 [e2-core] Slot 1, score 2
      23:47:38.628 [e2-core] RECORD service event 14
      23:47:38.630 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.631 [e2-core] record: 0
      23:47:38.632 [e2-core] RECORD service event 14
      23:47:38.634 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.635 [e2-core] record: 0
      23:47:38.636 [e2-core] RECORD service event 14
      23:47:38.638 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.639 [e2-core] record: 0
      23:47:38.640 [e2-core] Slot 0, score 2
      23:47:38.641 [e2-core] Slot 1, score 2
      23:47:38.642 [e2-core] RECORD service event 14
      23:47:38.644 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.646 [e2-core] record: 0
      23:47:38.647 [e2-core] RECORD service event 14
      23:47:38.649 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.650 [e2-core] record: 0
      23:47:38.651 [e2-core] RECORD service event 14
      23:47:38.653 [e2-python] recording service: 1:0:19:2B66:437:66:FFFF0000:0:0:0:
      23:47:38.654 [e2-core] record: 0
      23:47:38.655 [e2-core] Slot 0, score 2
      23:47:38.657 [e2-core] Slot 1, score 2
      23:47:38.658 [e2-core] RECORD service event 14
      23:47:38.659 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.660 [e2-core] record: 0
      23:47:38.662 [e2-core] Slot 0, score 2
      23:47:38.663 [e2-core] Slot 1, score 2
      23:47:38.664 [e2-core] RECORD service event 14
      23:47:38.665 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.667 [e2-core] record: 0
      23:47:38.668 [e2-core] Slot 0, score 2
      23:47:38.669 [e2-core] Slot 1, score 2
      23:47:38.670 [e2-core] RECORD service event 14
      23:47:38.671 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.673 [e2-core] record: 0
      23:47:38.674 [e2-core] RECORD service event 14
      23:47:38.675 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.677 [e2-core] record: 0
      23:47:38.678 [e2-core] RECORD service event 14
      23:47:38.680 [e2-python] recording service: 1:0:19:2B66:437:66:FFFF0000:0:0:0:
      23:47:38.681 [e2-core] record: 0
      23:47:38.682 [e2-core] Slot 0, score 2
      23:47:38.683 [e2-core] Slot 1, score 2
      23:47:38.684 [e2-core] RECORD service event 14
      23:47:38.686 [e2-python] [Timer] Record <RecordTimer.RecordTimerEntry object at 0x5caa0c90>
      23:47:38.687 [e2-python] ProcessRepeated
      23:47:38.690 [e2-python] next real activation is Wed Feb 14 20:14:40 2018
      23:47:38.692 [e2-python] [TIMER] record time changed, start prepare is now: Mon Feb 26 20:14:40 2018
      23:47:38.694 [e2-python] sanitycheck
      23:47:38.695 [e2-python] check
      23:47:38.697 [e2-python] checkTimerlist
      23:47:38.699 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.700 [e2-core] record: 0
      23:47:38.701 [e2-core] Slot 0, score 2
      23:47:38.702 [e2-core] Slot 1, score 2
      23:47:38.703 [e2-core] RECORD service event 14
      23:47:38.705 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.706 [e2-core] record: 0
      23:47:38.707 [e2-core] RECORD service event 14
      23:47:38.709 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.710 [e2-core] record: 0
      23:47:38.711 [e2-core] RECORD service event 14
      23:47:38.713 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.714 [e2-core] record: 0
      23:47:38.716 [e2-core] Slot 0, score 2
      23:47:38.717 [e2-core] Slot 1, score 2
      23:47:38.718 [e2-core] RECORD service event 14
      23:47:38.719 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.720 [e2-core] record: 0
      23:47:38.722 [e2-core] RECORD service event 14
      23:47:38.724 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.725 [e2-core] record: 0
      23:47:38.726 [e2-core] RECORD service event 14
      23:47:38.728 [e2-python] recording service: 1:0:19:2B66:437:66:FFFF0000:0:0:0:
      23:47:38.729 [e2-core] record: 0
      23:47:38.730 [e2-core] Slot 0, score 2
      23:47:38.731 [e2-core] Slot 1, score 2
      23:47:38.732 [e2-core] RECORD service event 14
      23:47:38.734 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.735 [e2-core] record: 0
      23:47:38.737 [e2-core] Slot 0, score 2
      23:47:38.738 [e2-core] Slot 1, score 2
      23:47:38.739 [e2-core] RECORD service event 14
      23:47:38.740 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.741 [e2-core] record: 0
      23:47:38.743 [e2-core] Slot 0, score 2
      23:47:38.744 [e2-core] Slot 1, score 2
      23:47:38.745 [e2-core] RECORD service event 14
      23:47:38.747 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.748 [e2-core] record: 0
      23:47:38.749 [e2-core] RECORD service event 14
      23:47:38.751 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.753 [e2-core] record: 0
      23:47:38.755 [e2-core] RECORD service event 14
      23:47:38.757 [e2-python] recording service: 1:0:19:2B66:437:66:FFFF0000:0:0:0:
      23:47:38.758 [e2-core] record: 0
      23:47:38.760 [e2-core] Slot 0, score 2
      23:47:38.762 [e2-core] Slot 1, score 2
      23:47:38.763 [e2-core] RECORD service event 14
      23:47:38.765 [e2-python] recording service: 1:0:19:6E:D:85:FFFF0000:0:0:0:
      23:47:38.767 [e2-core] record: 0
      23:47:38.768 [e2-core] Slot 0, score 2
      23:47:38.769 [e2-core] Slot 1, score 2
      23:47:38.770 [e2-core] RECORD service event 14
      23:47:38.772 [e2-python] [Timer] Record <RecordTimer.RecordTimerEntry object at 0x5caa0cb0>
      23:47:38.774 [e2-python] ProcessRepeated
      23:47:38.776 [e2-python] next real activation is Wed Feb 14 20:14:40 2018
      23:47:38.839 [e2-python] [browser] browser start
      23:47:38.850 [e2-python] Looking for embedded skin
      23:47:38.939 [e2-python] Looking for embedded skin
      23:47:38.957 [e2-python] >
      <
      >
      <
      >
      <
      >
      <
      >
      <
      >
      <
      >
      <
      >
      <
      >
      <
      >
      <
      >
      <
      >
      <
      >
      <
      >
      <
      >
      <
      >
      <
      >
      <
      >
      <
      >
      <
      >
      <
      >
      <
      >
      <
      >
      <
      >
      <
      >
      <
      >
      <
      >
      <
      23:47:39.075 [e2-python]
      23:47:39.078 [e2-python] /media/net/autofs
      23:47:39.080 [e2-python] /media/net/autonet
      23:47:39.104 [e2-python] {'/media/VMC': 'cifs//192.168.0.12/VMC', '/media/net/autofs/tv': 'nfs//192.168.0.10/volume1/tv/', '/media/net/autofs/video': 'nfs//192.168.0.10/volume1/video', '/media/net/autofs/photo': 'nfs//192.168.0.10/volume1/photo', '/': 'cifs//192.168.0.12/rootfs', '/media/net/autofs/': 'nfs//', '/media/hdd': 'cifs//192.168.0.12/Harddisk'}
      23:47:41.329 [e2-core] Setvolume: 100 100 (raw)
      23:47:41.330 [e2-core] Setvolume: 0 0 (-1db)
      23:47:41.425 [e2-python] Repeated: 1
      23:47:41.427 [e2-python] Repeated: 3
      23:47:41.428 [e2-python] Repeated: 7
      23:47:41.429 [e2-python] Repeated: 15
      23:47:41.430 [e2-python] Repeated: 31
      23:47:41.431 [e2-python] Repeated: 63
      23:47:41.433 [e2-python] Repeated: 127
      23:47:41.434 [e2-python] ProcessRepeated
      23:47:41.435 [e2-python] localrepeatedbegindate: Tue Feb 13 04:00:00 2018
      23:47:41.437 [e2-python] localbegin: Tue Feb 13 04:00:00 2018
      23:47:41.438 [e2-python] localend: Tue Feb 13 04:00:00 2018
      23:47:41.439 [e2-python] localnow: Tue Feb 13 23:47:42 2018
      23:47:41.440 [e2-python] Day: 0
      23:47:41.442 [e2-python] Day: 1
      23:47:41.443 [e2-python] Day: 2
      23:47:41.444 [e2-python] Day: 3
      23:47:41.446 [e2-python] Day: 4
      23:47:41.447 [e2-python] Day: 5
      23:47:41.448 [e2-python] Day: 6
      23:47:41.450 [e2-python] localbegin after addOneDay: Wed Feb 14 04:00:00 2018
      23:47:41.451 [e2-python] localend after addOneDay: Wed Feb 14 04:00:00 2018
      23:47:41.452 [e2-python] ProcessRepeated result
      23:47:41.454 [e2-python] Wed Feb 14 04:00:00 2018
      23:47:41.455 [e2-python] Wed Feb 14 04:00:01 2018
      23:47:41.457 [e2-python] next real activation is Wed Feb 14 04:00:01 2018
      23:47:41.495 [e2-python] [92m[EPG Share] INITIALIZING EPGSHARE AUTOUPDATETIMER[0m
      23:47:41.498 [e2-python] [92m[EPG Share] Nächstes Auto EPG Update startet in 841 min. um 13:49 Uhr.[0m
      23:47:41.502 [e2-python] [93m[SerienRecorder] Auto-Check: AN[0m
      23:47:41.612 [e2-python] [VPS-Plugin] next execution in 900 sec
      23:47:41.622 [e2-python] [AutoShutDown] start....
      23:47:41.632 [e2-python] Looking for embedded skin
      23:47:41.640 [e2-python] port changed to DVI
      23:47:41.641 [e2-python] mode changed to 1080p
      23:47:41.644 [e2-python] default ('1080p', 'Standard')
      23:47:41.645 [e2-python] preferedmodes ['720p', '1080i', '576p', '480p', '576i', '480i', ('1080p', 'Standard')]
      23:47:41.652 [e2-core] [eEPGCache] disable Vu+ DVB EPG blacklist mode
      23:47:41.654 [e2-core] [eEPGCache] set Vu+ in EPG-server (default) mode
      23:47:41.655 [e2-core] [eEPGCache] setCacheFile read/write epg data from/to '/hdd/epg.dat'
      23:47:41.656 [e2-core] [eEPGCache] time updated.. start EPG Mainloop
      23:47:41.657 [e2-core] before: 1
      23:47:41.658 [e2-core] after: 1
      23:47:41.661 [e2-python] not showing fine-tuning wizard, config variable doesn't exist
      23:47:41.661 [e2-core] [eEPGCache] create epg.dat backup
      23:47:41.663 [e2-python] showtestcard is false
      23:47:41.670 [e2-python] Looking for embedded skin
      23:47:41.730 [e2-python] setValue 75
      23:47:41.732 [e2-core] Setvolume: 75 75 (raw)
      23:47:41.733 [e2-core] Setvolume: 16 16 (-1db)
      23:47:42.097 [e2-core] [eEPGCache] service reference for epg query is not valid
      23:47:42.099 [e2-core] [eEPGCache] service reference for epg query is not valid
      23:47:42.138 [e2-python] warning, skin is missing element etitle in <class 'Screens.ChannelSelection.ChannelSelection'>
      23:47:42.486 [e2-core] [eEPGCache] 32519 events read from /hdd/epg.dat
      23:47:42.494 [e2-core] [eEPGCache] create real epg.dat backup
      23:47:42.601 [e2-python] RemovePopup, id = DebugInfoMessage
      23:47:42.686 [e2-python] RemovePopup, id = ZapError
      23:47:43.338 [e2-core] [Animation] set animation mode 1
      23:47:43.551 [e2-python] playing service..
      23:47:43.576 [e2-python] not pauseable.
      23:47:43.578 [e2-python] RemovePopup, id = ZapError
      23:47:43.579 [e2-core] allocate channel.. 000d:0085
      23:47:43.580 [e2-core] Slot 0, score 2
      23:47:43.581 [e2-core] Slot 1, score 2
      23:47:43.582 [e2-core] opening frontend 0
      23:47:43.588 [e2-core] [eDVBCAService] new channel 0x2b42db8!
      23:47:43.589 [e2-core] (0)tune
      23:47:43.590 [e2-core] tuning to 162000 khz, sr 6900000, fec 0, modulation 5, inversion 2
      23:47:43.591 [e2-core] OURSTATE: tuning
      23:47:43.592 [e2-core] allocate Channel: res 0
      23:47:43.593 [e2-core] FIXME: request for unknown slot
      23:47:43.594 [e2-core] allocate demux
      23:47:43.596 [e2-core] resolve: resolve ${sysconfdir}/scan_tp_valid_check.py
      23:47:43.597 [e2-core] resolve: -> /etc/scan_tp_valid_check.py
      23:47:43.610 [e2-core] [SEC] startTuneTimeout 5000
      23:47:43.611 [e2-core] [SEC] setFrontend 1
      23:47:43.612 [e2-core] setting frontend 0
      23:47:43.655 [e2-core] (0)fe event: status 0, inversion off, m_tuning 1
      23:47:43.657 [e2-core] child has terminated
      23:47:43.659 [e2-core] pipes closed
      23:47:43.661 [e2-core] child has terminated
      23:47:43.662 [e2-core] pipes closed
      23:47:43.726 [e2-core] child has terminated
      23:47:43.728 [e2-core] pipes closed
      23:47:43.734 [e2-core] child has terminated
      23:47:43.736 [e2-core] pipes closed
      23:47:43.738 [e2-core] child has terminated
      23:47:43.739 [e2-core] pipes closed
      23:47:43.750 [e2-core] (0)fe event: status 1f, inversion off, m_tuning 2
      23:47:43.752 [e2-core] OURSTATE: ok
      23:47:43.755 [e2-core] [eDVBCAService] channel 0x2b42db8 running
      23:47:43.756 [e2-core] [eDVBLocalTimerHandler] channel 0x2b42db8 running
      23:47:43.758 [e2-core] no version filtering
      23:47:43.759 [e2-core] 0014: 70 00 00 00 00 00
      23:47:43.761 [e2-core] mask: fc 00 00 00 00 00
      23:47:43.762 [e2-core] mode: 00 00 00 00 00 00
      23:47:43.765 [e2-core] [eEPGCache] channel 0x2b42db8 running
      23:47:43.767 [e2-core] stop release channel timer
      23:47:43.769 [e2-core] no version filtering
      23:47:43.767 [e2-core] [eEPGCache] next update in 2 sec
      23:47:43.770 [e2-core] 0012: 4e 00 6b 00 00 00
      23:47:43.773 [e2-core] mask: ff ff ff 00 00 00
      23:47:43.774 [e2-core] mode: 00 00 00 00 00 00
      23:47:43.780 [e2-core] ok ... now we start!!
      23:47:43.782 [e2-core] no version filtering
      23:47:43.784 [e2-core] 0000: 00 00 00 00 00 00
      23:47:43.785 [e2-core] mask: ff 00 00 00 00 00
      23:47:43.786 [e2-core] mode: 00 00 00 00 00 00
      23:47:43.788 [e2-core] eventNewProgramInfo 0 0
      23:47:43.790 [e2-core] have 1 video stream(s) (05ff), and 1 audio stream(s) (0603), and the pcr pid is 05ff, and the text pid is ffffffff
      23:47:43.791 [e2-core] allocate demux
      23:47:43.799 [e2-core] disable teletext subtitles
      23:47:43.809 [e2-core] PES filter: DMX_SET_PES_FILTER - Invalid argument
      23:47:43.810 [e2-core] decoder state: play, vpid=1535, apid=1539
      23:47:43.812 [e2-core] DMX_SET_PES_FILTER(0x5ff) - pcr - ok
      23:47:43.813 [e2-core] DEMUX_START - pcr - ok
      23:47:43.815 [e2-core] DMX_SET_PES_FILTER(0x603) - audio - ok
      23:47:43.816 [e2-core] DEMUX_START - audio - ok
      23:47:43.817 [e2-core] AUDIO_SET_BYPASS(0) - ok
      23:47:43.818 [e2-core] AUDIO_PAUSE - ok
      23:47:43.825 [e2-core] AUDIO_PLAY - ok
      23:47:43.826 [e2-core] Video Device: /dev/dvb/adapter0/video0
      23:47:43.828 [e2-core] demux device: /dev/dvb/adapter0/demux0
      23:47:43.829 [e2-core] VIDEO_SET_STREAMTYPE 1 - ok
      23:47:43.831 [e2-core] DMX_SET_PES_FILTER(0x5ff) - video - ok
      23:47:43.832 [e2-core] DEMUX_START - video - ok
      23:47:43.833 [e2-core] VIDEO_FREEZE - ok
      23:47:43.840 [e2-core] VIDEO_PLAY - ok
      23:47:43.841 [e2-core] VIDEO_SLOWMOTION(0) - ok
      23:47:43.842 [e2-core] VIDEO_FAST_FORWARD(0) - ok
      23:47:43.844 [e2-core] VIDEO_CONTINUE - ok
      23:47:43.846 [e2-core] AUDIO_CONTINUE - ok
      23:47:43.847 [e2-core] AUDIO_CHANNEL_SELECT(0) - ok
      23:47:43.850 [e2-python] not pauseable.
      23:47:43.858 [e2-python] [AutoRes] service changed
      23:47:43.872 [e2-core] child has terminated
      23:47:43.874 [e2-core] pipes closed
      23:47:43.875 [e2-python] 0.0.0.0
      23:47:43.877 [e2-python] 169.254
      23:47:43.878 [e2-python] 192.168
      23:47:43.880 [e2-core] child has terminated
      23:47:43.881 [e2-core] pipes closed
      23:47:43.891 [e2-python] nameservers: [[192, 168, 0, 1]]
      23:47:43.892 [e2-python] read configured interface: {'lo': {'dhcp': False}, 'wlan0': {'dhcp': True}, 'eth0': {'dhcp': False}}
      23:47:43.894 [e2-python] self.ifaces after loading: {'wlan0': {'preup': False, 'predown': False, 'ip': [0, 0, 0, 0], 'up': False, 'dns-nameservers': False, 'mac': '00:00:00:00:00:00', 'dhcp': True, 'netmask': [0, 0, 0, 0], 'gateway': [0, 0, 0, 0]}, 'eth0': {'preup': False, 'predown': False, 'ip': [192, 168, 0, 12], 'up': True, 'dns-nameservers': '\tdns-nameservers 192.168.0.1\n', 'mac': '00:1d:ec:05:c4:9c', 'dhcp': False, 'netmask': [255, 255, 255, 0], 'gateway': [192, 168, 0, 1]}}
      23:47:43.917 [e2-core] resolve: resolve ${libdir}/enigma2/python/Plugins/Extensions/WebInterface/plugin.py
      23:47:43.918 [e2-core] resolve: -> /usr/lib/enigma2/python/Plugins/Extensions/WebInterface/plugin.py
      23:47:43.919 [e2-core] resolve: resolve ${libdir}/enigma2/python/Plugins/Extensions/WebInterface
      23:47:43.920 [e2-core] resolve: -> /usr/lib/enigma2/python/Plugins/Extensions/WebInterface
      23:47:43.922 [e2-core] resolve: resolve ${libdir}/enigma2/python/Plugins/Extensions/OpenWebif/pluginshook.src
      23:47:43.923 [e2-core] resolve: -> /usr/lib/enigma2/python/Plugins/Extensions/OpenWebif/pluginshook.src
      23:47:43.939 [e2-python] [OpenWebif] started on 80
      23:47:43.942 [e2-core] VIDEO_GET_EVENT - ok
      23:47:43.947 [e2-python] [AutoRes] got event evVideoSizeChanged
      23:47:43.950 [e2-core] + 1/1 TID 00
      23:47:43.951 [e2-core] done!
      23:47:43.954 [e2-core] PATready
      23:47:43.955 [e2-core] use pmtpid 0065 for service_id 006b
      23:47:43.956 [e2-core] no version filtering
      23:47:43.957 [e2-core] 0065: 02 00 6b 00 00 00
      23:47:43.958 [e2-core] mask: ff ff ff 00 00 00
      23:47:44.044 [e2-core] mode: 00 00 00 00 00 00
      23:47:44.046 [e2-core] doing version filtering
      23:47:44.048 [e2-core] 0000: 00 00 00 27 00 00
      23:47:44.049 [e2-core] mask: ff 00 00 3f 00 00
      23:47:44.050 [e2-core] mode: 00 00 00 3e 00 00
      23:47:44.053 [e2-core] VIDEO_GET_EVENT - ok
      23:47:44.055 [e2-python] [AutoRes] got event evFramerateChanged
      23:47:44.185 [e2-core] + 1/1 TID 02
      23:47:44.186 [e2-core] done!
      23:47:44.187 [e2-core] eventNewProgramInfo 0 0
      23:47:44.190 [e2-core] [autoAudioTrack] use audio track: 0
      23:47:44.192 [e2-core] have 1 video stream(s) (05ff), and 2 audio stream(s) (0603, 0604), and the pcr pid is 05ff, and the text pid is ffffffff
      23:47:44.199 [e2-core] PES filter: DMX_SET_PES_FILTER - Invalid argument
      23:47:44.200 [e2-core] decoder state: play, vpid=1535, apid=1539
      23:47:44.201 [e2-core] VIDEO_SLOWMOTION(0) - ok
      23:47:44.202 [e2-core] VIDEO_FAST_FORWARD(0) - ok
      23:47:44.204 [e2-core] VIDEO_CONTINUE - ok
      23:47:44.205 [e2-core] AUDIO_CONTINUE - ok
      23:47:44.209 [e2-core] [autoAudioTrack] use audio track: 0
      23:47:44.282 [e2-core] [eDVBCAService] new service 1:0:19:6B:D:85:FFFF0000:0:0:0:
      23:47:44.283 [e2-core] [eDVBCAService] add demux 0 to slot 0 service 1:0:19:6B:D:85:FFFF0000:0:0:0:
      23:47:44.285 [e2-core] demux 0 mask 01 prevhash 00000000
      23:47:44.286 [e2-core] [eDVBCAService] send 74 bytes
      23:47:44.288 [e2-core] 9f 80 32 46 03 00 6b 29 00 31 01 81 08 ff ff 00 00 00 0d 00 85 82 02 01 00 84 02 00 65 09 04 18 50 f9 64 09 04 18 35 fb 64 09 04 18 38 fc 64 09 04 18 31 fd 64 09 04 09 8e fe 64 1b 05 ff 00 00 06 06 03 00 00 06 06 04 00 00
      23:47:44.289 [e2-core] doing version filtering
      23:47:44.290 [e2-core] 0065: 02 00 6b 29 00 00
      23:47:44.291 [e2-core] mask: ff ff ff 3f 00 00
      23:47:44.292 [e2-core] mode: 00 00 00 3e 00 00
      23:47:44.298 [e2-core] +- 1/2 TID 4e
      23:47:44.860 [e2-python] [AutoRes] determineContent
      23:47:45.174 [e2-core] ++ 2/2 TID 4e
      23:47:45.175 [e2-core] done!
      23:47:45.215 [e2-core] doing version filtering
      23:47:45.218 [e2-core] 0012: 4e 00 6b 0b 00 00
      23:47:45.220 [e2-core] mask: ff ff ff 3f 00 00
      23:47:45.221 [e2-core] mode: 00 00 00 3e 00 00
      23:47:45.227 [e2-core] sdt update done!
      23:47:45.668 [e2-core] VIDEO_GET_EVENT - ok
      23:47:45.673 [e2-python] [AutoRes] got event evVideoSizeChanged
      23:47:45.675 [e2-core] VIDEO_GET_EVENT - ok
      23:47:45.677 [e2-python] [AutoRes] got event evFramerateChanged
      23:47:45.791 [e2-core] [eEPGCache] start caching events(1518562065)
      23:47:45.792 [e2-python] [AutoRes] determineContent
      23:47:46.631 [e2-core] [eDVBLocalTimerHandler] diff is 0
      23:47:46.633 [e2-core] [eDVBLocalTimerHandler] diff < 120 .. use Transponder Time
      23:47:46.634 [e2-core] [eDVBLocalTimerHandler] not changed
      23:47:50.997 [e2-python] send: 'POST / HTTP/1.1\r\nHost: 127.0.0.1:19210\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.12.4\r\nContent-Length: 53\r\nContent-Type: application/x-www-form-urlencoded\r\n\r\nMAC=00%3A1d%3Aec%3A05%3Ac4%3A9c&DBRequest=getClientID'
      23:47:51.022 [e2-python] reply: 'HTTP/1.1 200 OK\r\n'
      23:47:51.025 [e2-python] header: Transfer-Encoding: chunked
      23:47:51.027 [e2-python] header: Access-Control-Allow-Headers: x-prototype-version,x-requested-with
      23:47:51.028 [e2-python] header: Access-Control-Max-Age: 2520
      23:47:51.029 [e2-python] header: Server: TwistedWeb/16.2.0
      23:47:51.031 [e2-python] header: Date: Tue, 13 Feb 2018 22:47:51 GMT
      23:47:51.032 [e2-python] header: Access-Control-Allow-Origin: *
      23:47:51.034 [e2-python] header: Access-Control-Allow-Methods: POST
      23:47:51.035 [e2-python] header: Content-Type: application/json
      23:47:51.156 [e2-python] send: 'POST / HTTP/1.1\r\nHost: 127.0.0.1:19210\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.12.4\r\nContent-Length: 33\r\nContent-Type: application/x-www-form-urlencoded\r\n\r\nDBRequest=deleteMounts&CLIENTID=1'
      23:47:51.597 [e2-core] child has terminated
      23:47:51.598 [e2-core] pipes closed
      23:47:52.850 [e2-core] [eEPGCache] abort non avail viasat reading
      23:47:52.851 [e2-core] [eEPGCache] abort non avail mhw reading
      23:47:52.917 [e2-core] [eEPGCache] nownext finished(1518562072)
      23:47:55.349 [e2-core] [eEPGCache] schedule finished(1518562075)
      23:47:57.672 [e2-python] action -> MsgBoxActions cancel
      23:47:59.667 [e2-python] action -> InfobarChannelSelection zapUp
      23:47:59.671 [e2-python] playing service..
      23:47:59.674 [e2-core] [eDVBCAService] free slot 0 demux 0 for service 1:0:19:6B:D:85:FFFF0000:0:0:0:
      23:47:59.675 [e2-core] [eDVBCAService] free service 1:0:19:6B:D:85:FFFF0000:0:0:0:
      23:47:59.692 [e2-core] decoder state: play, vpid=-1, apid=-1
      23:47:59.693 [e2-core] DEMUX_STOP - pcr - ok
      23:47:59.695 [e2-core] DEMUX_STOP - video - ok
      23:47:59.696 [e2-core] VIDEO_STOP - ok
      23:47:59.720 [e2-core] AUDIO_STOP - ok
      23:47:59.721 [e2-core] DEMUX_STOP - audio - ok
      23:47:59.722 [e2-core] AUDIO_CONTINUE - ok
      23:47:59.730 [e2-core] start release channel timer
      23:47:59.756 [e2-python] not pauseable.
      23:47:59.758 [e2-python] RemovePopup, id = ZapError
      23:47:59.759 [e2-core] use cached_channel
      23:47:59.760 [e2-core] stop release channel timer
      23:47:59.761 [e2-core] allocate Channel: res 0
      23:47:59.763 [e2-core] no version filtering
      23:47:59.764 [e2-core] 0012: 4e 00 74 00 00 00
      23:47:59.765 [e2-core] mask: ff ff ff 00 00 00
      23:47:59.766 [e2-core] mode: 00 00 00 00 00 00
      23:47:59.773 [e2-core] ok ... now we start!!
      23:47:59.775 [e2-core] no version filtering
      23:47:59.776 [e2-core] 0000: 00 00 00 00 00 00
      23:47:59.776 [e2-core] mask: ff 00 00 00 00 00
      23:47:59.777 [e2-core] mode: 00 00 00 00 00 00
      23:47:59.779 [e2-core] eventNewProgramInfo 0 0
      23:47:59.780 [e2-core] have 1 video stream(s) (02ff), and 1 audio stream(s) (0303), and the pcr pid is 02ff, and the text pid is ffffffff
      23:47:59.786 [e2-core] disable teletext subtitles
      23:47:59.795 [e2-core] PES filter: DMX_SET_PES_FILTER - Invalid argument
      23:47:59.796 [e2-core] decoder state: play, vpid=767, apid=771
      23:47:59.797 [e2-core] DMX_SET_PES_FILTER(0x2ff) - pcr - ok
      23:47:59.798 [e2-core] DEMUX_START - pcr - ok
      23:47:59.799 [e2-core] DMX_SET_PES_FILTER(0x303) - audio - ok
      23:47:59.800 [e2-core] DEMUX_START - audio - ok
      23:47:59.801 [e2-core] AUDIO_SET_BYPASS(0) - ok
      23:47:59.802 [e2-core] AUDIO_PAUSE - ok
      23:47:59.809 [e2-core] AUDIO_PLAY - ok
      23:47:59.810 [e2-core] Video Device: /dev/dvb/adapter0/video0
      23:47:59.811 [e2-core] demux device: /dev/dvb/adapter0/demux0
      23:47:59.812 [e2-core] VIDEO_SET_STREAMTYPE 1 - ok
      23:47:59.813 [e2-core] DMX_SET_PES_FILTER(0x2ff) - video - ok
      23:47:59.814 [e2-core] DEMUX_START - video - ok
      23:47:59.815 [e2-core] VIDEO_FREEZE - ok
      23:47:59.822 [e2-core] VIDEO_PLAY - ok
      23:47:59.824 [e2-core] VIDEO_SLOWMOTION(0) - ok
      23:47:59.825 [e2-core] VIDEO_FAST_FORWARD(0) - ok
      23:47:59.826 [e2-core] VIDEO_CONTINUE - ok
      23:47:59.827 [e2-core] AUDIO_CONTINUE - ok
      23:47:59.829 [e2-python] not pauseable.
      23:47:59.836 [e2-python] [AutoRes] service changed
      23:47:59.846 [e2-core] resolve: resolve ${sysconfdir}/scan_tp_valid_check.py
      23:47:59.847 [e2-core] resolve: -> /etc/scan_tp_valid_check.py
      23:48:00.026 [e2-core] +- 1/2 TID 4e
      23:48:00.082 [e2-core] + 1/1 TID 00
      23:48:00.084 [e2-core] done!
      23:48:00.085 [e2-core] PATready
      23:48:00.086 [e2-core] use pmtpid 0062 for service_id 0074
      23:48:00.088 [e2-core] no version filtering
      23:48:00.089 [e2-core] 0062: 02 00 74 00 00 00
      23:48:00.090 [e2-core] mask: ff ff ff 00 00 00
      23:48:00.091 [e2-core] mode: 00 00 00 00 00 00
      23:48:00.092 [e2-core] doing version filtering
      23:48:00.093 [e2-core] 0000: 00 00 00 27 00 00
      23:48:00.094 [e2-core] mask: ff 00 00 3f 00 00
      23:48:00.096 [e2-core] mode: 00 00 00 3e 00 00
      23:48:00.359 [e2-core] + 1/1 TID 02
      23:48:00.363 [e2-core] done!
      23:48:00.391 [e2-core] eventNewProgramInfo 0 0
      23:48:00.394 [e2-core] [autoAudioTrack] use audio track: 0
      23:48:00.405 [e2-core] have 1 video stream(s) (02ff), and 2 audio stream(s) (0303, 0304), and the pcr pid is 02ff, and the text pid is ffffffff
      23:48:00.413 [e2-core] PES filter: DMX_SET_PES_FILTER - Invalid argument
      23:48:00.416 [e2-core] decoder state: play, vpid=767, apid=771
      23:48:00.417 [e2-core] VIDEO_SLOWMOTION(0) - ok
      23:48:00.419 [e2-core] VIDEO_FAST_FORWARD(0) - ok
      23:48:00.420 [e2-core] VIDEO_CONTINUE - ok
      23:48:00.421 [e2-core] AUDIO_CONTINUE - ok
      23:48:00.427 [e2-core] [autoAudioTrack] use audio track: 0
      23:48:00.440 [e2-core] [eDVBCAService] new service 1:0:19:74:D:85:FFFF0000:0:0:0:
      23:48:00.441 [e2-core] [eDVBCAService] add demux 0 to slot 0 service 1:0:19:74:D:85:FFFF0000:0:0:0:
      23:48:00.442 [e2-core] demux 0 mask 01 prevhash 00000000
      23:48:00.445 [e2-core] [eDVBCAService] send 74 bytes
      23:48:00.448 [e2-core] 9f 80 32 46 03 00 74 1f 00 31 01 81 08 ff ff 00 00 00 0d 00 85 82 02 01 00 84 02 00 62 09 04 18 50 f9 5b 09 04 18 35 fb 5b 09 04 18 38 fc 5b 09 04 18 31 fd 5b 09 04 09 8e fe 5b 1b 02 ff 00 00 06 03 03 00 00 06 03 04 00 00
      23:48:00.454 [e2-core] doing version filtering
      23:48:00.455 [e2-core] 0062: 02 00 74 1f 00 00
      23:48:00.457 [e2-core] mask: ff ff ff 3f 00 00
      23:48:00.458 [e2-core] mode: 00 00 00 3e 00 00
      23:48:00.838 [e2-python] [AutoRes] determineContent
      23:48:00.977 [e2-core] ++ 2/2 TID 4e
      23:48:00.978 [e2-core] done!
      23:48:00.995 [e2-core] doing version filtering
      23:48:00.996 [e2-core] 0012: 4e 00 74 2d 00 00
      23:48:00.997 [e2-core] mask: ff ff ff 3f 00 00
      23:48:00.998 [e2-core] mode: 00 00 00 3e 00 00
      23:48:01.797 [e2-core] [eEPGCache] schedule other finished(1518562081)
      23:48:01.799 [e2-core] [eEPGCache] stop caching events(1518562081)
      23:48:01.801 [e2-core] [eEPGCache] next update in 60 min
      23:48:02.029 [e2-python] action -> GlobalActions volumeUp
      23:48:02.049 [e2-core] Setvolume: 80 80 (raw)
      23:48:02.050 [e2-core] Setvolume: 13 13 (-1db)
      23:48:02.054 [e2-python] setValue 80
      23:48:03.333 [e2-python] action -> GlobalActions volumeUp
      23:48:03.334 [e2-core] Setvolume: 85 85 (raw)
      23:48:03.335 [e2-core] Setvolume: 10 10 (-1db)
      23:48:03.337 [e2-python] setValue 85
      23:48:03.902 [e2-python] action -> InfobarChannelSelection zapUp
      23:48:03.906 [e2-python] playing service..
      23:48:03.908 [e2-core] [eDVBCAService] free slot 0 demux 0 for service 1:0:19:74:D:85:FFFF0000:0:0:0:
      23:48:03.909 [e2-core] [eDVBCAService] free service 1:0:19:74:D:85:FFFF0000:0:0:0:
      23:48:03.924 [e2-core] decoder state: play, vpid=-1, apid=-1
      23:48:03.925 [e2-core] DEMUX_STOP - pcr - ok
      23:48:03.927 [e2-core] DEMUX_STOP - video - ok
      23:48:03.928 [e2-core] VIDEO_STOP - ok
      23:48:03.953 [e2-core] AUDIO_STOP - ok
      23:48:03.954 [e2-core] DEMUX_STOP - audio - ok
      23:48:03.955 [e2-core] AUDIO_CONTINUE - ok
      23:48:03.960 [e2-core] start release channel timer
      23:48:03.986 [e2-python] not pauseable.
      23:48:03.988 [e2-python] RemovePopup, id = ZapError
      23:48:03.989 [e2-core] [eDVBCAService] remove channel 0x2b42db8
      23:48:03.991 [e2-core] [eDVBLocalTimerHandler] remove channel 0x2b42db8
      23:48:03.992 [e2-core] [eEPGCache] remove channel 0x2b42db8
      23:48:03.997 [e2-core] allocate channel.. 0006:0085
      23:48:03.998 [e2-core] Slot 0, score 2
      23:48:04.000 [e2-core] Slot 1, score 2
      23:48:04.006 [e2-core] [eDVBCAService] new channel 0x2b42db8!
      23:48:04.007 [e2-core] (0)tune
      23:48:04.008 [e2-core] tuning to 354000 khz, sr 6900000, fec 0, modulation 5, inversion 2
      23:48:04.009 [e2-core] OURSTATE: tuning
      23:48:04.010 [e2-core] allocate Channel: res 0
      23:48:04.011 [e2-core] allocate demux
      23:48:04.012 [e2-core] resolve: resolve ${sysconfdir}/scan_tp_valid_check.py
      23:48:04.013 [e2-core] resolve: -> /etc/scan_tp_valid_check.py
      23:48:04.029 [e2-core] [SEC] startTuneTimeout 5000
      23:48:04.030 [e2-core] [SEC] setFrontend 1
      23:48:04.032 [e2-core] setting frontend 0
      23:48:04.258 [e2-core] (0)fe event: status 0, inversion off, m_tuning 1
      23:48:04.334 [e2-core] (0)fe event: status 1f, inversion off, m_tuning 2
      23:48:04.335 [e2-core] OURSTATE: ok
      23:48:04.336 [e2-core] [eDVBCAService] channel 0x2b42db8 running
      23:48:04.337 [e2-core] [eDVBLocalTimerHandler] channel 0x2b42db8 running
      23:48:04.338 [e2-core] no version filtering
      23:48:04.339 [e2-core] 0014: 70 00 00 00 00 00
      23:48:04.340 [e2-core] mask: fc 00 00 00 00 00
      23:48:04.341 [e2-core] mode: 00 00 00 00 00 00
      23:48:04.343 [e2-core] [eEPGCache] channel 0x2b42db8 running
      23:48:04.344 [e2-core] [eEPGCache] next update in 2 sec
      23:48:04.345 [e2-core] stop release channel timer
      23:48:04.347 [e2-core] no version filtering
      23:48:04.348 [e2-core] 0012: 4e 00 83 00 00 00
      23:48:04.349 [e2-core] mask: ff ff ff 00 00 00
      23:48:04.350 [e2-core] mode: 00 00 00 00 00 00
      23:48:04.360 [e2-core] ok ... now we start!!
      23:48:04.362 [e2-core] no version filtering
      23:48:04.363 [e2-core] 0000: 00 00 00 00 00 00
      23:48:04.364 [e2-core] mask: ff 00 00 00 00 00
      23:48:04.365 [e2-core] mode: 00 00 00 00 00 00
      23:48:04.367 [e2-core] eventNewProgramInfo 0 0
      23:48:04.368 [e2-core] have 1 video stream(s) (04ff), and 1 audio stream(s) (0503), and the pcr pid is 04ff, and the text pid is ffffffff
      23:48:04.369 [e2-core] allocate demux
      23:48:04.375 [e2-core] disable teletext subtitles
      23:48:04.385 [e2-core] PES filter: DMX_SET_PES_FILTER - Invalid argument
      23:48:04.386 [e2-core] decoder state: play, vpid=1279, apid=1283
      23:48:04.387 [e2-core] DMX_SET_PES_FILTER(0x4ff) - pcr - ok
      23:48:04.388 [e2-core] DEMUX_START - pcr - ok
      23:48:04.389 [e2-core] DMX_SET_PES_FILTER(0x503) - audio - ok
      23:48:04.390 [e2-core] DEMUX_START - audio - ok
      23:48:04.391 [e2-core] AUDIO_SET_BYPASS(0) - ok
      23:48:04.392 [e2-core] AUDIO_PAUSE - ok
      23:48:04.399 [e2-core] AUDIO_PLAY - ok
      23:48:04.400 [e2-core] Video Device: /dev/dvb/adapter0/video0
      23:48:04.401 [e2-core] demux device: /dev/dvb/adapter0/demux0
      23:48:04.402 [e2-core] VIDEO_SET_STREAMTYPE 1 - ok
      23:48:04.403 [e2-core] DMX_SET_PES_FILTER(0x4ff) - video - ok
      23:48:04.404 [e2-core] DEMUX_START - video - ok
      23:48:04.405 [e2-core] VIDEO_FREEZE - ok
      23:48:04.412 [e2-core] VIDEO_PLAY - ok
      23:48:04.413 [e2-core] VIDEO_SLOWMOTION(0) - ok
      23:48:04.414 [e2-core] VIDEO_FAST_FORWARD(0) - ok
      23:48:04.415 [e2-core] VIDEO_CONTINUE - ok
      23:48:04.416 [e2-core] AUDIO_CONTINUE - ok
      23:48:04.422 [e2-python] not pauseable.
      23:48:04.435 [e2-python] [AutoRes] service changed
      23:48:04.551 [e2-core] -+ 1/2 TID 4e
      23:48:04.594 [e2-core] [eDVBLocalTimerHandler] diff is 0
      23:48:04.596 [e2-core] [eDVBLocalTimerHandler] diff < 120 .. use Transponder Time
      23:48:04.597 [e2-core] [eDVBLocalTimerHandler] not changed
      23:48:04.642 [e2-core] + 1/1 TID 00
      23:48:04.644 [e2-core] done!
      23:48:04.646 [e2-core] PATready
      23:48:04.647 [e2-core] use pmtpid 0064 for service_id 0083
      23:48:04.648 [e2-core] no version filtering
      23:48:04.649 [e2-core] 0064: 02 00 83 00 00 00
      23:48:04.650 [e2-core] mask: ff ff ff 00 00 00
      23:48:04.652 [e2-core] mode: 00 00 00 00 00 00
      23:48:04.653 [e2-core] doing version filtering
      23:48:04.655 [e2-core] 0000: 00 00 00 31 00 00
      23:48:04.656 [e2-core] mask: ff 00 00 3f 00 00
      23:48:04.657 [e2-core] mode: 00 00 00 3e 00 00
      23:48:05.040 [e2-core] + 1/1 TID 02
      23:48:05.041 [e2-core] done!
      23:48:05.042 [e2-core] eventNewProgramInfo 0 0
      23:48:05.045 [e2-core] [autoAudioTrack] use audio track: 0
      23:48:05.046 [e2-core] have 1 video stream(s) (04ff), and 2 audio stream(s) (0503, 0504), and the pcr pid is 04ff, and the text pid is ffffffff
      23:48:05.054 [e2-core] PES filter: DMX_SET_PES_FILTER - Invalid argument
      23:48:05.055 [e2-core] decoder state: play, vpid=1279, apid=1283
      23:48:05.056 [e2-core] VIDEO_SLOWMOTION(0) - ok
      23:48:05.057 [e2-core] VIDEO_FAST_FORWARD(0) - ok
      23:48:05.058 [e2-core] VIDEO_CONTINUE - ok
      23:48:05.059 [e2-core] AUDIO_CONTINUE - ok
      23:48:05.064 [e2-core] [autoAudioTrack] use audio track: 0
      23:48:05.075 [e2-core] [eDVBCAService] new service 1:0:19:83:6:85:FFFF0000:0:0:0:
      23:48:05.076 [e2-core] [eDVBCAService] add demux 0 to slot 0 service 1:0:19:83:6:85:FFFF0000:0:0:0:
      23:48:05.077 [e2-core] demux 0 mask 01 prevhash 00000000
      23:48:05.079 [e2-core] [eDVBCAService] send 62 bytes
      23:48:05.081 [e2-core] 9f 80 32 3a 03 00 83 2b 00 25 01 81 08 ff ff 00 00 00 06 00 85 82 02 01 00 84 02 00 64 09 04 18 50 f9 5b 09 04 18 38 fc 5b 09 04 09 8e fe 5b 1b 04 ff 00 00 06 05 03 00 00 06 05 04 00 00
      23:48:05.082 [e2-core] doing version filtering
      23:48:05.084 [e2-core] 0064: 02 00 83 2b 00 00
      23:48:05.085 [e2-core] mask: ff ff ff 3f 00 00
      23:48:05.086 [e2-core] mode: 00 00 00 3e 00 00
      23:48:05.437 [e2-python] [AutoRes] determineContent
      23:48:05.460 [e2-core] ++ 2/2 TID 4e
      23:48:05.489 [e2-core] done!
      23:48:05.502 [e2-core] doing version filtering
      23:48:05.504 [e2-core] 0012: 4e 00 83 31 00 00
      23:48:05.506 [e2-core] mask: ff ff ff 3f 00 00
      23:48:05.507 [e2-core] mode: 00 00 00 3e 00 00
      23:48:05.535 [e2-core] sdt update done!
      23:48:06.354 [e2-core] [eEPGCache] start caching events(1518562086)
      23:48:10.438 [e2-python] action -> InfobarMenuActions mainMenu
      23:48:10.439 [e2-python] loading mainmenu XML...
      23:48:10.448 [e2-python] Subtitles Subtitles
      23:48:10.451 [e2-python] TimerEdit TimerEditList
      23:48:10.454 [e2-python] PluginBrowser PluginBrowser
      23:48:12.490 [e2-python] action -> WizardActions up
      23:48:12.935 [e2-python] action -> WizardActions right
      23:48:13.362 [e2-core] [eEPGCache] abort non avail viasat reading
      23:48:13.364 [e2-core] [eEPGCache] abort non avail mhw reading
      23:48:13.366 [e2-core] [eEPGCache] nownext finished(1518562093)
      23:48:13.707 [e2-python] action -> WizardActions left
      23:48:14.566 [e2-python] action -> WizardActions ok
      23:48:14.568 [e2-python] unknown action WizardActions/ok! typo in keymap?
      23:48:14.569 [e2-python] action -> OkCancelActions ok
      23:48:14.577 [e2-python] SleepTimerEdit SleepTimerEdit
      23:48:14.579 [e2-python] TimerEdit EnergyTimerEditList
      23:48:14.581 [e2-python] Standby Standby
      23:48:14.584 [e2-python] Standby TryQuitMainloop
      23:48:14.586 [e2-python] Standby TryQuitMainloop
      23:48:14.587 [e2-python] TaskList TaskListScreen
      23:48:14.590 [e2-python] Standby TryQuitMainloop
      23:48:15.220 [e2-core] [eEPGCache] schedule other finished(1518562095)
      23:48:16.409 [e2-python] action -> WizardActions right
      23:48:16.954 [e2-python] action -> WizardActions up
      23:48:17.588 [e2-python] action -> WizardActions up
      23:48:17.694 [e2-python] action -> WizardActions up
      23:48:18.354 [e2-python] action -> WizardActions up
      23:48:18.842 [e2-python] action -> WizardActions ok
      23:48:18.844 [e2-python] unknown action WizardActions/ok! typo in keymap?
      23:48:18.845 [e2-python] action -> OkCancelActions ok
      23:48:18.859 [e2-python] Looking for embedded skin
      23:48:18.880 [e2-python] connectionLost? [Failure instance: Traceback (failure with no frames): <class 'twisted.internet.error.ConnectionLost'>: Connection to the other side was lost in a non-clean fashion: Connection lost.
      ]23:48:18.881 [e2-python]
      23:48:18.980 [e2-python] Deep-Standby WakeUp um 14.02.2018 - 13:47
      23:48:18.982 [e2-python] [93m[SerienRecorder] Deep-Standby WakeUp: AUS[0m
      23:48:18.985 [e2-python] set wakeup time to 2018/02/14 03:56
      23:48:19.097 [e2-python] stopService
      23:48:19.099 [e2-core] [eDVBCAService] free slot 0 demux 0 for service 1:0:19:83:6:85:FFFF0000:0:0:0:
      23:48:19.100 [e2-core] [eDVBCAService] free service 1:0:19:83:6:85:FFFF0000:0:0:0:
      23:48:19.120 [e2-core] decoder state: play, vpid=-1, apid=-1
      23:48:19.122 [e2-core] DEMUX_STOP - pcr - ok
      23:48:19.124 [e2-core] DEMUX_STOP - video - ok
      23:48:19.125 [e2-core] VIDEO_STOP - ok
      23:48:19.149 [e2-core] AUDIO_STOP - ok
      23:48:19.150 [e2-core] DEMUX_STOP - audio - ok
      23:48:19.151 [e2-core] AUDIO_CONTINUE - ok
      23:48:19.158 [e2-core] start release channel timer
      23:48:19.302 [e2-python] [EPGRefresh] Stopping Timer
      23:48:19.320 [e2-core] resolve: resolve ${sysconfdir}/enigma2/lamedb
      23:48:19.322 [e2-core] resolve: -> /etc/enigma2/lamedb
      23:48:19.323 [e2-core] ---- saving lame channel db
      23:48:19.345 [e2-core] saved 45 channels and 616 services!
      23:48:19.348 [e2-core] release cached channel (timer timeout)
      23:48:19.364 [e2-core] [eDVBCAService] remove channel 0x2b42db8
      23:48:19.365 [e2-core] [eDVBLocalTimerHandler] remove channel 0x2b42db8
      23:48:19.366 [e2-core] [eEPGCache] remove channel 0x2b42db8
      23:48:19.373 [e2-core] [eEPGCache] abort caching events !!
      23:48:19.375 [e2-core] stop release channel timer
      23:48:19.388 [e2-core] [eEPGCache] store epg to realpath '/media/net/autofs/tv/epg.dat'
      23:48:19.433 [e2-core] [eEPGCache] 32519 events written to /hdd/epg.dat
      23:48:19.819 [e2-core] thread joined 0
      23:48:21.103 [e2-core] set RTC to previous valid time
      23:48:21.215 [e2-core] - (42) eServiceRecordDB
      23:48:21.216 [e2-core] - (42) eVTiApp
      23:48:21.220 [e2-core] [eVTiApp] ...shutdown
      23:48:21.221 [e2-core] - (41) eServiceFactoryM2TS
      23:48:21.226 [e2-core] - (41) eServiceFactoryMP3
      23:48:21.228 [e2-core] - (41) eServiceFactoryHDMI
      23:48:21.231 [e2-core] - (41) eServiceFactoryFS
      23:48:21.232 [e2-core] - (41) eServiceFactoryDVB
      23:48:21.233 [e2-core] - (41) eServiceFactoryDVD
      23:48:21.234 [e2-core] - (40) eServiceCenter
      23:48:21.235 [e2-core] - (35) CI Slots
      23:48:21.239 [e2-core] - (30) eActionMap
      23:48:21.243 [e2-core] - (21) input device driver
      23:48:21.252 [e2-core] - (21) Console RC Driver
      23:48:21.254 [e2-core] - (20) DVB-CI UI
      23:48:21.256 [e2-core] - (20) Hdmi CEC driver
      23:48:21.257 [e2-core] - (20) UHF Modulator
      23:48:21.259 [e2-core] - (20) RC Input layer
      23:48:21.261 [e2-core] - (20) misc options
      23:48:21.262 [e2-core] - (20) AVSwitch Driver
      23:48:21.264 [e2-core] - (15) eWindowStyleManager
      23:48:21.265 [e2-core] - (10) gRC
      23:48:21.266 [e2-core] waiting for gRC thread shutdown
      23:48:21.354 [e2-core] gRC thread has finished
      23:48:21.357 [e2-core] - (9) GFBDC
      23:48:21.513 [e2-core] - (9) gLCDDC
      23:48:21.514 [e2-core] - (9) Font Render Class
      23:48:21.515 [e2-core] - (8) graphics acceleration manager
      23:48:21.516 [e2-core] - (5) Tuxtxt
      23:48:21.517 [e2-core] - (1) Background File Eraser
      23:48:21.519 [e2-core] reached rl -1
      23:48:52.250 [e2-python] send: 'POST / HTTP/1.1\r\nHost: 127.0.0.1:19210\r\nConnection: keep-alive\r\nAccept-Encoding: gzip, deflate\r\nAccept: */*\r\nUser-Agent: python-requests/2.12.4\r\nContent-Length: 33\r\nContent-Type: application/x-www-form-urlencoded\r\n\r\nDBRequest=deleteMounts&CLIENTID=1'