Problem: nicht endende Aufnahmen

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

    • Problem: nicht endende Aufnahmen

      Hallo!

      Ich habe relativ oft das Problem, dass Aufnahmen nicht funktionieren. Es landen dann meist nur die Metadaten und eine 0 Byte große .ts auf der Festplatte, teilweise auch gar nichts und in ganz seltenen Fällen extrem lange Aufnahmen. Nach der eigentlichen Aufnahme läuft die Box unendlich weiter und im Display/Infobar blinkt weiterhin "Rec". Man kann die Box dann auch nicht mehr runter fahren. Darauf folgende Aufnahmen klappen dann normalerweise auch nicht mehr. Die Box scheint dabei eigentlich im Standby zu sein. Wenn man den TV einschaltet, ist kein Bild. Die erste Reaktion kommt, wenn man bei der Fernbedienung der Box Power drückt. Dann kommt häufig "kein Tuner frei". In der Timerliste ist dann aber kein aktiver Timer zu finden.
      Das einzige was dann hilft ist ein Neustart. Neustart der GUI reicht aber schon.

      Soweit ich mich erinnern kann, war das mit VTi 6 und 7 noch kein größeres Problem.

      Hat jemand Vorschläge wie das Problem zu lösen oder näher einzugrenzen ist?
      • Welche Logs könnte ich mir anschauen, wenn die Box meint etwas aufzunehmen?
      • Wie bekomme ich raus, was die Tuner glauben gerade zu machen?
      • Gibt es Logs der Timeraktivitäten?

      Grüße Vulam


      Hier noch ein paar Daten:
      • Solo² mit interner 1TB HDD (>60% frei)
      • SAT Empfang, nur ein Kabel vom LNB an Tuner B, Tuner A intern durchgeschleift, konfiguriert nach Anleitung.
      • Aktuelles VTi Image 8.2.3, schon neu geflasht, nur Bouquets aus Backup. Mit VTiZero die USB Tuner und WLAN entfernt.
        Autotimer+EPGrefresh aus Feed installiert und alles von Hand neu eingerichtet, keine anderen Plugins.
      • Alle Timer sind automatisch erstellt vom Plugin Autotimer. Sie Funktionieren normalerweise auch, nur halt gelegentlich nicht. Einstellungen sollten also ok sein.
      • EPGrefresh läuft von 3:00 - 5:00, danach Autotimer, danach DeepStandby. Die Timer sind erst nach 6:00.
        diese Modi wurden ausprobiert: PiP (versteckt) + im Vordergrund
      • Die Timer überlappen nicht, zumindest nicht über verschiedene Sender hinweg:
        Beispiel: 1x morgens Kika HD / 2x mittags RTL Nitro / 2x abends RTL Nitro
        Die Doppelaufnahmen sind zwei Folgen einer Serie und überlappen zwangsweise. (Ich habe immer 5min Vorlauf und 10min Nachlauf eingestellt.)
      • Sender umschalten vor Aufnahme ist aktiviert

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

    • EPGrefresh läuft ab 3:00 und nur über meine Favoriten (ca 20 Sender), sollte also lange vorher fertig sein.
      Mein letztes Fehler-Beispiel war dann Mittags, also 8 Stunden nach EPGrefresh.
      Ich kontrolliere jetzt auch morgens immer, ob die Box im DeepStandby ist. Da ist der erste Timer dann schon durch.

      "Exit" statt "Power" könnte ich mal probieren (beim nächsten Fehlerfall, kann also ein paar Tage dauern).
    • Hat etwas gedauert, bis zum nächsten Fehlerfall... aber gestern war es wieder so weit:
      Lange nach der Aufnahme läuft die Box weiter und es blinkt "Rec" im Display.

      Django80 schrieb:

      Passiert irgendwas wenn du während einer Aufnahme exit drückst?
      Ich habe dann mal versucht "Exit" zu drücken. Das erzeugt aber keine Reaktion.
      Die einzige Möglichkeit für eine Reaktion war wie sonst auch über "Power" auf der Fernbedienung. Die Box ist wohl im Standby?

      Die Box hat dann gemeldet "kein freier Tuner", während sie versucht hat "Das Erste HD" darzustellen. Letzte Aufnahme war von RTL Nitro.
      Kaputt war dann die erste Aufnahme vom Abend. Die zweite scheint ok zu sein.

      Ich hatte vorher das Plugin infoBarTunerState installiert um etwas mehr über die Tuner zu sehen. Aber das hat in diesem Fall nur die kommende Aufnahme am nächsten Tag angezeigt. Also nichts über aktuelle Tunerbelegung. Die Meldung "kein freier Tuner" von der Box war also gelogen.

      Django80 schrieb:

      EPGrefresh benötigt den Tuner zum updaten,könnte das nicht schon der Übeltäter sein?
      Auf Deinen Hinweis hin habe ich bei EPGrefresh mal von "PiP (versteckt)" auf "im Vordergrund" umgestellt. So müsste man ja mitkriegen, wenn EPGrefresh die Sender wechselt. Da war aber auch nichts von zu erkennen.

      Ich hatte den Tag über kontrolliert, ob die Box nach jeder Aufnahme wieder im DeepStandby war. Das war Morgens und Mittags der Fall, Abends dann nicht. EPGrefresh müsste vor der ersten Aufnahme am Morgen gelaufen sein.

      Ich hätte auch noch ein Log von enigma2:
      Spoiler anzeigen

      setenv('prefix', '/usr', 0)
      setenv('exec_prefix', '/usr', 0)
      setenv('bindir', '/usr/bin', 0)
      setenv('sbindir', '/usr/sbin', 0)
      setenv('libexecdir', '/usr/libexec', 0)
      setenv('datarootdir', '${prefix}/share', 0)
      setenv('datadir', '/usr/share', 0)
      setenv('sysconfdir', '/etc', 0)
      setenv('sharedstatedir', '/com', 0)
      setenv('localstatedir', '/var', 0)
      setenv('libdir', '/usr/lib', 0)
      setenv('localedir', '${datarootdir}/locale', 0)
      setenv('prefix', '/usr', 1)
      setenv('exec_prefix', '/usr', 1)
      setenv('bindir', '/usr/bin', 1)
      setenv('sbindir', '/usr/sbin', 1)
      setenv('libexecdir', '/usr/libexec', 1)
      setenv('datarootdir', '/usr/share', 1)
      setenv('datadir', '/usr/share', 1)
      setenv('sysconfdir', '/etc', 1)
      setenv('sharedstatedir', '/com', 1)
      setenv('localstatedir', '/var', 1)
      setenv('libdir', '/usr/lib', 1)
      setenv('localedir', '/usr/share/locale', 1)
      resolve: resolve ${datadir}/enigma2/encoding.conf
      resolve: -> /usr/share/enigma2/encoding.conf
      resolve: resolve ${libdir}/enigma2/python
      resolve: -> /usr/lib/enigma2/python
      + (1) Background File Eraser
      + (5) Tuxtxt
      + (8) graphics acceleration manager
      + (9) GFBDC
      21600k video mem
      [Animation] set animation mode 0
      SetMode : wanted: 720x576x32, got 1920x1440x32
      - double buffering available!
      12960kB available for acceleration surfaces.
      resolution: 720 x 576 x 32 (stride: 7680)
      + (9) gLCDDC
      found OLED display!
      lcd buffer 0x7ed2b8 8448 bytes, stride 132
      + (9) Font Render Class
      [FONT] initializing lib...
      [FONT] loading fonts...
      PYTHONPATH: /usr/lib/enigma2/python
      [FONT] Intializing font cache, using max. 4MB...
      + (10) gRC
      RC thread created successfully
      + (15) eWindowStyleManager
      + (20) DVB-CI UI
      + (20) Hdmi CEC driver
      + (20) UHF Modulator
      couldnt open /dev/rfmod0!!!!
      + (20) RC Input layer
      + (20) misc options
      + (20) AVSwitch Driver
      + (21) input device driver
      Input device "dreambox advanced remote control (native)" is not a keyboard.
      Found 1 input devices!
      + (21) Console RC Driver
      failed to open /dev/tty0
      + (30) eActionMap
      + (35) CI Slots
      scanning for common interfaces..
      before: 1
      after: 1
      setIoPrio best-effort level 7 ok
      before: 1
      after: 1
      setIoPrio idle level 6 ok
      done, found 1 common interface slots
      + (40) eServiceCenter
      settings instance.
      + (41) eServiceFactoryM2TS
      + (41) eServiceFactoryMP3
      + (41) eServiceFactoryFS
      + (41) eServiceFactoryDVB
      reached rl 70
      resolve: resolve ${sysconfdir}/enigma2/lamedb
      resolve: -> /etc/enigma2/lamedb
      ---- opening lame channel db
      reading services (version 4)
      loaded 1627 services
      scanning for frontends..
      opening frontend 0
      close frontend 0
      opening frontend 1
      close frontend 1
      found 1 adapter, 2 frontends(2 sim) and 9 demux, boxtype 4
      Use valid Linux Time :) (RTC?)
      [EPGC] Initialized EPGCache (wait for setCacheFile call now)
      resolve: resolve ${datadir}/enigma2/skin_default/pal.png
      resolve: -> /usr/share/enigma2/skin_default/pal.png
      Loading spinners...
      resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait1.png
      resolve: -> /usr/share/enigma2/skin_default/spinner/wait1.png
      resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait2.png
      resolve: -> /usr/share/enigma2/skin_default/spinner/wait2.png
      resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait3.png
      resolve: -> /usr/share/enigma2/skin_default/spinner/wait3.png
      resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait4.png
      resolve: -> /usr/share/enigma2/skin_default/spinner/wait4.png
      resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait5.png
      resolve: -> /usr/share/enigma2/skin_default/spinner/wait5.png
      resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait6.png
      resolve: -> /usr/share/enigma2/skin_default/spinner/wait6.png
      resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait7.png
      resolve: -> /usr/share/enigma2/skin_default/spinner/wait7.png
      resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait8.png
      resolve: -> /usr/share/enigma2/skin_default/spinner/wait8.png
      resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait9.png
      resolve: -> /usr/share/enigma2/skin_default/spinner/wait9.png
      resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait10.png
      resolve: -> /usr/share/enigma2/skin_default/spinner/wait10.png
      resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait11.png
      resolve: -> /usr/share/enigma2/skin_default/spinner/wait11.png
      resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait12.png
      resolve: -> /usr/share/enigma2/skin_default/spinner/wait12.png
      resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait13.png
      resolve: -> /usr/share/enigma2/skin_default/spinner/wait13.png
      resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait14.png
      resolve: -> /usr/share/enigma2/skin_default/spinner/wait14.png
      resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait15.png
      resolve: -> /usr/share/enigma2/skin_default/spinner/wait15.png
      resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait16.png
      resolve: -> /usr/share/enigma2/skin_default/spinner/wait16.png
      resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait17.png
      resolve: -> /usr/share/enigma2/skin_default/spinner/wait17.png
      resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait18.png
      resolve: -> /usr/share/enigma2/skin_default/spinner/wait18.png
      resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait19.png
      resolve: -> /usr/share/enigma2/skin_default/spinner/wait19.png
      found 18 spinner!

      setIoPrio best-effort level 3 ok
      resolve: resolve ${libdir}/enigma2/python/mytest.py
      resolve: -> /usr/lib/enigma2/python/mytest.py
      resolve: resolve ${sysconfdir}/
      resolve: -> /etc/
      resolve: resolve ${sysconfdir}/
      resolve: -> /etc/
      resolve: resolve ${datadir}/fonts/
      resolve: -> /usr/share/fonts/
      resolve: resolve ${sysconfdir}/enigma2/
      resolve: -> /etc/enigma2/
      resolve: resolve ${libdir}/enigma2/python/Plugins/
      resolve: -> /usr/lib/enigma2/python/Plugins/
      resolve: resolve ${datadir}/enigma2/po/
      resolve: -> /usr/share/enigma2/po/
      resolve: resolve ${datadir}/enigma2/
      resolve: -> /usr/share/enigma2/
      resolve: resolve ${datadir}/enigma2/
      resolve: -> /usr/share/enigma2/
      resolve: resolve ${sysconfdir}/enigma2/playlist/
      resolve: -> /etc/enigma2/playlist/
      resolve: resolve ${datadir}/enigma2/defaults/
      resolve: -> /usr/share/enigma2/defaults/
      resolve: resolve ${datadir}/enigma2/dealer
      resolve: -> /usr/share/enigma2/dealer
      resolve: resolve ${datadir}/meta
      resolve: -> /usr/share/meta
      resolve: resolve ${datadir}/enigma2/defaults/
      resolve: -> /usr/share/enigma2/defaults/
      enumerating block devices...
      found block device 'sda': ok, removable=False, cdrom=False, partitions=['sda1']
      new Harddisk sda -> /dev/sda -> /dev/sda
      found block device 'sda1': error querying properties
      found block device 'loop0': blacklisted
      found block device 'loop1': blacklisted
      found block device 'loop2': blacklisted
      found block device 'loop3': blacklisted
      found block device 'loop4': blacklisted
      found block device 'loop5': blacklisted
      found block device 'loop6': blacklisted
      found block device 'loop7': blacklisted
      found block device 'mtdblock0': blacklisted
      found block device 'mtdblock1': blacklisted
      found block device 'mtdblock2': blacklisted
      found block device 'mtdblock3': blacklisted
      found block device 'mtdblock4': blacklisted
      not loading user skin: [Errno 2] No such file or directory: '/etc/enigma2/skin_user.xml'
      [VTi] loading user defined colors for skin AtileHD/skin_user_colors.xml
      [VTi] loading user defined header file for skin AtileHD/skin_user_header.xml
      menu_mainmenu
      Reading satellites.xml
      resolve: resolve ${datadir}/enigma2/unicable.xml
      resolve: -> /usr/share/enigma2/unicable.xml
      [InitNimManager] check multi type slot 0
      [InitNimManager] check multi type slot 1
      [Nimmanager] slot 0 create config satellite..
      [Nimmanager] slot 1 create config satellite..
      removing internal link on frontend id 0
      sec config cleared
      setSlotInfo for dvb frontend 0 to slotid 0, descr BCM7356 DVB-S2 NIM (internal), need rotorworkaround No, enabled No, DVB-S2 Yes, DVB-T2 No
      setSlotInfo for dvb frontend 1 to slotid 1, descr BCM7356 DVB-S2 NIM (internal), need rotorworkaround No, enabled No, DVB-S2 Yes, DVB-T2 No
      link tuner 0 to tuner 1
      setting internal link on frontend id 0
      slot: 0 configmode: loopthrough
      slot: 1 configmode: simple
      diseqcmode: single
      sec config completed
      resolve: resolve ${datadir}/enigma2/setup.xml
      resolve: -> /usr/share/enigma2/setup.xml
      main thread is non-idle! display spinner!
      Preferred tag editor set to None
      resolve: resolve ${sysconfdir}/enigma2/
      resolve: -> /etc/enigma2/
      loading bouquet... /etc/enigma2/bouquets.tv
      resolve: resolve ${sysconfdir}/enigma2/
      resolve: -> /etc/enigma2/
      loading bouquet... /etc/enigma2/userbouquet.favourites.tv
      18 entries in Bouquet userbouquet.favourites.tv
      resolve: resolve ${sysconfdir}/enigma2/
      resolve: -> /etc/enigma2/
      loading bouquet... /etc/enigma2/userbouquet.regionalsender__tv_.tv
      11 entries in Bouquet userbouquet.regionalsender__tv_.tv
      resolve: resolve ${sysconfdir}/enigma2/
      resolve: -> /etc/enigma2/
      loading bouquet... /etc/enigma2/userbouquet.vti_192_000.tv
      86 entries in Bouquet userbouquet.vti_192_000.tv
      resolve: resolve ${sysconfdir}/enigma2/
      resolve: -> /etc/enigma2/
      loading bouquet... /etc/enigma2/userbouquet.vti_192_001.tv
      45 entries in Bouquet userbouquet.vti_192_001.tv
      resolve: resolve ${sysconfdir}/enigma2/
      resolve: -> /etc/enigma2/
      loading bouquet... /etc/enigma2/userbouquet.vti_192_002.tv
      16 entries in Bouquet userbouquet.vti_192_002.tv
      resolve: resolve ${sysconfdir}/enigma2/
      resolve: -> /etc/enigma2/
      loading bouquet... /etc/enigma2/userbouquet.vti_192_003.tv
      50 entries in Bouquet userbouquet.vti_192_003.tv
      resolve: resolve ${sysconfdir}/enigma2/
      resolve: -> /etc/enigma2/
      loading bouquet... /etc/enigma2/userbouquet.vti_192_004.tv
      24 entries in Bouquet userbouquet.vti_192_004.tv
      resolve: resolve ${sysconfdir}/enigma2/
      resolve: -> /etc/enigma2/
      loading bouquet... /etc/enigma2/userbouquet.vti_192_005.tv
      30 entries in Bouquet userbouquet.vti_192_005.tv
      resolve: resolve ${sysconfdir}/enigma2/
      resolve: -> /etc/enigma2/
      loading bouquet... /etc/enigma2/userbouquet.vti_192_006.tv
      24 entries in Bouquet userbouquet.vti_192_006.tv
      resolve: resolve ${sysconfdir}/enigma2/
      resolve: -> /etc/enigma2/
      loading bouquet... /etc/enigma2/userbouquet.vti_192_007.tv
      44 entries in Bouquet userbouquet.vti_192_007.tv
      resolve: resolve ${sysconfdir}/enigma2/
      resolve: -> /etc/enigma2/
      loading bouquet... /etc/enigma2/userbouquet.vti_192_008.tv
      19 entries in Bouquet userbouquet.vti_192_008.tv
      resolve: resolve ${sysconfdir}/enigma2/
      resolve: -> /etc/enigma2/
      loading bouquet... /etc/enigma2/userbouquet.vti_192_009.tv
      145 entries in Bouquet userbouquet.vti_192_009.tv
      resolve: resolve ${sysconfdir}/enigma2/
      resolve: -> /etc/enigma2/
      loading bouquet... /etc/enigma2/userbouquet.vti_192_010.tv
      104 entries in Bouquet userbouquet.vti_192_010.tv
      resolve: resolve ${sysconfdir}/enigma2/
      resolve: -> /etc/enigma2/
      loading bouquet... /etc/enigma2/userbouquet.vti_192_011.tv
      47 entries in Bouquet userbouquet.vti_192_011.tv
      14 entries in Bouquet bouquets.tv
      resolve: resolve ${sysconfdir}/enigma2/
      resolve: -> /etc/enigma2/
      loading bouquet... /etc/enigma2/bouquets.radio
      resolve: resolve ${sysconfdir}/enigma2/
      resolve: -> /etc/enigma2/
      loading bouquet... /etc/enigma2/userbouquet.favourites.radio
      64 entries in Bouquet userbouquet.favourites.radio
      1 entries in Bouquet bouquets.radio
      [eDVBLocalTimeHandler] enable sync local time with transponder time!
      add dreampackage scanner plugin
      added
      [FONT] adding font /usr/share/fonts/nmsbd.ttf...[glClass] Selected config: R=8 G=8 B=8 A=8 Depth=24 Stencil=0
      [glClass] ANIMATION #6 selected
      executing main
      OK (Display)
      SetMode : wanted: 1280x720x32, got 720x576x32
      - double buffering available!
      10800kB available for acceleration surfaces.
      resolution: 1280 x 720 x 32 (stride: 7680)
      [FONT] adding font /usr/share/fonts/lcd.ttf...OK (LCD)
      [FONT] adding font /usr/share/fonts/ae_AlMateen.ttf...OK (Replacement)
      [FONT] adding font /usr/share/fonts/tuxtxt.ttf...OK (Console)
      [FONT] adding font /usr/share/fonts/nmsbd.ttf...OK (Arial)
      [FONT] adding font /usr/share/enigma2/AtileHD/fonts/Roboto-Regular.ttf...OK (Regular)
      [FONT] adding font /usr/share/enigma2/AtileHD/fonts/Roboto-Regular.ttf...OK (RegularLight)
      [FONT] adding font /usr/share/enigma2/AtileHD/fonts/meteocons.ttf...OK (Meteo)
      [FONT] adding font /usr/share/fonts/lcd.ttf...OK (LCD)
      [FONT] adding font /usr/share/fonts/ae_AlMateen.ttf...OK (Replacement)
      [FONT] adding font /usr/share/fonts/tuxtxt.ttf...OK (Console)
      [FONT] adding font /usr/share/fonts/nmsbd.ttf...OK (Arial)
      [FONT] adding font /usr/share/enigma2/AtileHD/fonts/Roboto-Regular.ttf...OK (Regular)
      [FONT] adding font /usr/share/enigma2/AtileHD/fonts/Roboto-Regular.ttf...OK (RegularLight)
      [FONT] adding font /usr/share/enigma2/AtileHD/fonts/meteocons.ttf...OK (Meteo)
      [iInputDevices] getInputDevices <ERROR: ioctl(EVIOCGNAME): [Errno 25] Inappropriate ioctl for device >
      [iInputDevices] getInputDevices <ERROR: ioctl(EVIOCGNAME): [Errno 25] Inappropriate ioctl for device >
      main thread is non-idle! display spinner!
      cannot open /proc/stb/avs/0/input_choices
      --> setting scaler_sharpness to: 00000000
      couldn't open /proc/stb/misc/12V_output
      resolve: resolve ${datadir}/enigma2/keymap.xml
      resolve: -> /usr/share/enigma2/keymap.xml
      setLCDBrightness 25
      setLCDBrightness 127
      resolve: resolve ${datadir}/keymaps/
      resolve: -> /usr/share/keymaps/
      resolve: resolve ${datadir}/keymaps/
      resolve: -> /usr/share/keymaps/
      resolve: resolve ${datadir}/keymaps/
      resolve: -> /usr/share/keymaps/
      Activating keymap: Keyboard English
      resolve: resolve ${datadir}/keymaps/
      resolve: -> /usr/share/keymaps/
      Activating language German
      language set to de_DE
      FIXME: request for unknown slot
      FIXME: request for unknown slot
      FIXME: request for unknown slot
      [WebInterface] set language to de
      [PiconManager] set language to de
      [PiconManager] set language to de
      main thread is non-idle! display spinner!
      resolve: resolve ${datadir}/enigma2/setup.xml
      resolve: -> /usr/share/enigma2/setup.xml
      resolve: resolve ${libdir}
      resolve: -> /usr/lib
      resolve: resolve ${libdir}/enigma2/python/Plugins/SystemPlugins/TransCodingSetup/plugin.pyo
      resolve: -> /usr/lib/enigma2/python/Plugins/SystemPlugins/TransCodingSetup/plugin.pyo
      [WebInterface] set language to de
      [eTPM] connect error
      [WebInterface] fallback to default translation for Webinterface
      resolve: resolve ${datadir}/enigma2/
      resolve: -> /usr/share/enigma2/
      Restarting internet superserver: inetd .
      <ZappingModeSelection> set zapping mode : mute
      --> setting contrast to: 00008000
      --> setting saturation to: 00008000
      --> setting hue to: 00008000
      --> setting brightness to: 00008000
      --> setting block_noise_reduction to: 00000000
      --> setting mosquito_noise_reduction to: 00000000
      --> setting digital_contour_removal to: 00000000
      --> setting splitmode to: off
      --> setting sharpness to: 00000000
      --> setting auto_flesh to: 00000000
      --> setting green_boost to: 00000000
      --> setting blue_boost to: 00000000
      --> setting dynamic_contrast to: 00000000
      --> setting scaler_vertical_dejagging to: disable
      --> setting smooth to: disable
      --> applying pep values
      [UIPositionSetup] write dst_left : 0
      [UIPositionSetup] write dst_width : 720
      [UIPositionSetup] write dst_top : 0
      [UIPositionSetup] write dst_height : 576
      [DeviceManager2] Loading skin /usr/lib/enigma2/python/Plugins/SystemPlugins/DeviceManager2/skin.xml
      <RemoteControlCode> Write Remote Control Code : 2
      remove DVI-PC because it does not exist.
      hotplug on DVI
      set Videomode DVI 1080p multi
      set aspect, policy, policy2, wss 16:9 panscan letterbox auto
      [CI_Assignment] activating ci configs:
      [CI_Activate] FOUND 1 CI Slots
      resolve: resolve ${sysconfdir}/enigma2/ci
      resolve: -> /etc/enigma2/ci
      [CI_Activate_Config_CI0] no config file found
      [CI_Activate_Config_CI0] error parsing xml...
      starting hotplug handler
      [TIMER] record time changed, start prepare is now: Tue Sep 29 17:34:40 2015
      sanitycheck
      check
      checkTimerlist
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      [Timer] Record <RecordTimer.RecordTimerEntry object at 0x1e00f70>
      ProcessRepeated
      next real activation is Tue Sep 29 17:34:40 2015
      [TIMER] record time changed, start prepare is now: Tue Sep 29 17:54:40 2015
      sanitycheck
      check
      checkTimerlist
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      [Timer] Record <RecordTimer.RecordTimerEntry object at 0x1e02030>
      ProcessRepeated
      next real activation is Tue Sep 29 17:34:40 2015
      [TIMER] record time changed, start prepare is now: Wed Sep 30 06:09:40 2015
      sanitycheck
      check
      checkTimerlist
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      [Timer] Record <RecordTimer.RecordTimerEntry object at 0x1e02090>
      ProcessRepeated
      next real activation is Tue Sep 29 17:34:40 2015
      [TIMER] record time changed, start prepare is now: Wed Sep 30 11:54:40 2015
      sanitycheck
      check
      checkTimerlist
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      [Timer] Record <RecordTimer.RecordTimerEntry object at 0x1e020f0>
      ProcessRepeated
      next real activation is Tue Sep 29 17:34:40 2015
      [TIMER] record time changed, start prepare is now: Wed Sep 30 12:19:40 2015
      sanitycheck
      check
      checkTimerlist
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      [Timer] Record <RecordTimer.RecordTimerEntry object at 0x1e02250>
      ProcessRepeated
      next real activation is Tue Sep 29 17:34:40 2015
      [TIMER] record time changed, start prepare is now: Wed Sep 30 17:34:40 2015
      sanitycheck
      check
      checkTimerlist
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      [Timer] Record <RecordTimer.RecordTimerEntry object at 0x1e02330>
      ProcessRepeated
      next real activation is Tue Sep 29 17:34:40 2015
      [TIMER] record time changed, start prepare is now: Wed Sep 30 17:54:40 2015
      sanitycheck
      check
      checkTimerlist
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      [Timer] Record <RecordTimer.RecordTimerEntry object at 0x1e023d0>
      ProcessRepeated
      next real activation is Tue Sep 29 17:34:40 2015
      [TIMER] record time changed, start prepare is now: Thu Oct 1 06:09:40 2015
      sanitycheck
      check
      checkTimerlist
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      [Timer] Record <RecordTimer.RecordTimerEntry object at 0x1e02470>
      ProcessRepeated
      next real activation is Tue Sep 29 17:34:40 2015
      [TIMER] record time changed, start prepare is now: Thu Oct 1 11:59:40 2015
      sanitycheck
      check
      checkTimerlist
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      [Timer] Record <RecordTimer.RecordTimerEntry object at 0x1e02510>
      ProcessRepeated
      next real activation is Tue Sep 29 17:34:40 2015
      [TIMER] record time changed, start prepare is now: Thu Oct 1 12:24:40 2015
      sanitycheck
      check
      checkTimerlist
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      [Timer] Record <RecordTimer.RecordTimerEntry object at 0x1e025b0>
      ProcessRepeated
      next real activation is Tue Sep 29 17:34:40 2015
      [TIMER] record time changed, start prepare is now: Thu Oct 1 17:34:40 2015
      sanitycheck
      check
      checkTimerlist
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      [Timer] Record <RecordTimer.RecordTimerEntry object at 0x1e02650>
      ProcessRepeated
      next real activation is Tue Sep 29 17:34:40 2015
      [TIMER] record time changed, start prepare is now: Thu Oct 1 17:54:40 2015
      sanitycheck
      check
      checkTimerlist
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      [Timer] Record <RecordTimer.RecordTimerEntry object at 0x1e026d0>
      ProcessRepeated
      next real activation is Tue Sep 29 17:34:40 2015
      [TIMER] record time changed, start prepare is now: Fri Oct 2 06:09:40 2015
      sanitycheck
      check
      checkTimerlist
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      [Timer] Record <RecordTimer.RecordTimerEntry object at 0x1e026b0>
      ProcessRepeated
      next real activation is Tue Sep 29 17:34:40 2015
      [TIMER] record time changed, start prepare is now: Fri Oct 2 11:49:40 2015
      sanitycheck
      check
      checkTimerlist
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      [Timer] Record <RecordTimer.RecordTimerEntry object at 0x1e02790>
      ProcessRepeated
      next real activation is Tue Sep 29 17:34:40 2015
      [TIMER] record time changed, start prepare is now: Fri Oct 2 12:14:40 2015
      sanitycheck
      check
      checkTimerlist
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      [Timer] Record <RecordTimer.RecordTimerEntry object at 0x1e027b0>
      ProcessRepeated
      next real activation is Tue Sep 29 17:34:40 2015
      [TIMER] record time changed, start prepare is now: Fri Oct 2 17:34:40 2015
      sanitycheck
      check
      checkTimerlist
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      [Timer] Record <RecordTimer.RecordTimerEntry object at 0x1e02750>
      ProcessRepeated
      next real activation is Tue Sep 29 17:34:40 2015
      [TIMER] record time changed, start prepare is now: Fri Oct 2 17:54:40 2015
      sanitycheck
      check
      checkTimerlist
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      [Timer] Record <RecordTimer.RecordTimerEntry object at 0x1e02670>
      ProcessRepeated
      next real activation is Tue Sep 29 17:34:40 2015
      [TIMER] record time changed, start prepare is now: Sat Oct 3 17:54:40 2015
      sanitycheck
      check
      checkTimerlist
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      [Timer] Record <RecordTimer.RecordTimerEntry object at 0x1e02b10>
      ProcessRepeated
      next real activation is Tue Sep 29 17:34:40 2015
      [TIMER] record time changed, start prepare is now: Sat Oct 3 18:24:40 2015
      sanitycheck
      check
      checkTimerlist
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      [Timer] Record <RecordTimer.RecordTimerEntry object at 0x1e02bb0>
      ProcessRepeated
      next real activation is Tue Sep 29 17:34:40 2015
      [TIMER] record time changed, start prepare is now: Sun Oct 4 04:39:40 2015
      sanitycheck
      check
      checkTimerlist
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2EF4:441:1:C00000:0:0:0:
      record: 0
      [Timer] Record <RecordTimer.RecordTimerEntry object at 0x1e02c70>
      ProcessRepeated
      next real activation is Tue Sep 29 17:34:40 2015
      [TIMER] record time changed, start prepare is now: Sun Oct 4 17:54:40 2015
      sanitycheck
      check
      checkTimerlist
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2EF4:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      [Timer] Record <RecordTimer.RecordTimerEntry object at 0x1e02d10>
      ProcessRepeated
      next real activation is Tue Sep 29 17:34:40 2015
      [TIMER] record time changed, start prepare is now: Mon Oct 5 06:09:40 2015
      sanitycheck
      check
      checkTimerlist
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2EF4:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      [Timer] Record <RecordTimer.RecordTimerEntry object at 0x1e02c10>
      ProcessRepeated
      next real activation is Tue Sep 29 17:34:40 2015
      [TIMER] record time changed, start prepare is now: Mon Oct 5 11:59:40 2015
      sanitycheck
      check
      checkTimerlist
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2EF4:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      [Timer] Record <RecordTimer.RecordTimerEntry object at 0x1e02e30>
      ProcessRepeated
      next real activation is Tue Sep 29 17:34:40 2015
      [TIMER] record time changed, start prepare is now: Mon Oct 5 12:24:40 2015
      sanitycheck
      check
      checkTimerlist
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2EF4:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      [Timer] Record <RecordTimer.RecordTimerEntry object at 0x1e02d30>
      ProcessRepeated
      next real activation is Tue Sep 29 17:34:40 2015
      [TIMER] record time changed, start prepare is now: Mon Oct 5 17:34:40 2015
      sanitycheck
      check
      checkTimerlist
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2EF4:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      [Timer] Record <RecordTimer.RecordTimerEntry object at 0x1e02e10>
      ProcessRepeated
      next real activation is Tue Sep 29 17:34:40 2015
      [TIMER] record time changed, start prepare is now: Mon Oct 5 17:59:40 2015
      sanitycheck
      check
      checkTimerlist
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2EF4:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      [Timer] Record <RecordTimer.RecordTimerEntry object at 0x1e02cb0>
      ProcessRepeated
      next real activation is Tue Sep 29 17:34:40 2015
      [TIMER] record time changed, start prepare is now: Sat Oct 10 10:29:40 2015
      sanitycheck
      check
      checkTimerlist
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2EF4:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B66:3F3:1:C00000:0:0:0:
      record: 0
      [Timer] Record <RecordTimer.RecordTimerEntry object at 0x1e02ff0>
      ProcessRepeated
      next real activation is Tue Sep 29 17:34:40 2015
      [TIMER] record time changed, start prepare is now: Sat Oct 10 17:54:40 2015
      sanitycheck
      check
      checkTimerlist
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2EF4:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B66:3F3:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      [Timer] Record <RecordTimer.RecordTimerEntry object at 0x1e02bd0>
      ProcessRepeated
      next real activation is Tue Sep 29 17:34:40 2015
      [TIMER] record time changed, start prepare is now: Sun Oct 11 17:54:40 2015
      sanitycheck
      check
      checkTimerlist
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2EF4:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B66:3F3:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      [Timer] Record <RecordTimer.RecordTimerEntry object at 0x1e0c110>
      ProcessRepeated
      next real activation is Tue Sep 29 17:34:40 2015
      RecordTimer.TryQuitMainloop
      RecordTimer.staticGotRecordEvent(iRecordableService.evEnd)
      another recording starts in 184.392807007 seconds... do not shutdown yet
      hbbtv.app: no process found
      [browser] browser start
      Looking for embedded skin
      InfoBarTunerState start
      Looking for embedded skin
      Repeated: 1
      Repeated: 3
      Repeated: 7
      Repeated: 15
      Repeated: 31
      Repeated: 63
      Repeated: 127
      ProcessRepeated
      localrepeatedbegindate: Tue Sep 29 03:00:00 2015
      localbegin: Tue Sep 29 03:00:00 2015
      localend: Tue Sep 29 03:00:00 2015
      localnow: Tue Sep 29 17:31:36 2015
      Day: 0
      Day: 1
      Day: 2
      Day: 3
      Day: 4
      Day: 5
      Day: 6
      localbegin after addOneDay: Wed Sep 30 03:00:00 2015
      localend after addOneDay: Wed Sep 30 03:00:00 2015
      ProcessRepeated result
      Wed Sep 30 03:00:00 2015
      Wed Sep 30 03:00:01 2015
      next real activation is Wed Sep 30 03:00:01 2015
      [SECUREBOOT] autostart
      [Secureboot] starting
      No skin to read...
      [AutoShutDown] start....
      Looking for embedded skin
      port changed to DVI
      mode changed to 1080p
      default ('1080p', 'Standard')
      preferedmodes ['720p', '1080i', '576p', '480p', '576i', '480i', ('1080p', 'Standard')]
      [Toplevel.importExternalModules] Imported external module: Example
      [Toplevel.importExternalModules] Imported external module: EPGRefresh
      [HTTPRootResource}.__init__
      [Webinterface] started on 0.0.0.0:81 auth=False ssl=False
      [WebInterface.registerBonjourService] No module named Bonjour.Bonjour
      [HTTPRootResource}.__init__
      [Webinterface] started on 127.0.0.1:80 auth=False ssl=False
      [HTTPRootResource}.__init__
      [Webinterface] started on 0.0.0.0:443 auth=True ssl=True
      [WebInterface.registerBonjourService] No module named Bonjour.Bonjour
      [EPGC] setCacheFile read/write epg data from/to '/hdd/epg.dat'
      [EPGC] time updated.. start EPG Mainloop
      before: 1
      after: 1
      [EPGC] create epg.dat backup
      not showing fine-tuning wizard, config variable doesn't exist
      showtestcard is false
      Looking for embedded skin
      setValue 95
      Setvolume: 100 100 (raw)
      Setvolume: 0 0 (-1db)
      Setvolume: 95 95 (raw)
      Setvolume: 4 4 (-1db)
      service reference for epg query is not valid
      service reference for epg query is not valid
      warning, skin is missing element etitle in <class 'Screens.ChannelSelection.ChannelSelection'>
      RemovePopup, id = ZapError
      [EPGC] 28409 events read from /hdd/epg.dat
      [EPGC] create real epg.dat backup
      RecordTimer.stopTryQuitMainloop
      [SILENT_REC] we want no MessageBox --> go to standby instead
      Looking for embedded skin
      playing service..
      not pauseable.
      RemovePopup, id = ZapError
      allocate channel.. 03fb:0001
      opening frontend 1
      [eDVBCAService] new channel 0x205fc88!
      (1)tune
      RotorCmd ffffffff, lastRotorCmd ffffffff
      prepare_sat System 1 Freq 11493750 Pol 0 SR 22000000 INV 2 FEC 2 orbpos 192 system 1 modulation 2 pilot 2, rolloff 0
      tuning to 1743 mhz
      OURSTATE: tuning
      allocate Channel: res 0
      allocate demux
      resolve: resolve ${sysconfdir}/scan_tp_valid_check.py
      resolve: -> /etc/scan_tp_valid_check.py
      enter standby
      stopService
      start release channel timer
      setLCDBrightness 25
      [AutoShutDown] go to standby . . .
      [AutoShutDown] Starting ShutDownTimer
      [SEC] set static current limiting
      [SEC] invalidate current switch params
      [SEC] setVoltage 2
      [SEC] sleep 10ms
      child has terminated
      pipes closed
      child has terminated
      pipes closed
      child has terminated
      pipes closed
      set sequence pos 3
      [SEC] update current switch params
      [SEC] startTuneTimeout 5000
      [SEC] setFrontend 1
      setting frontend 1
      [SEC] sleep 500ms
      (1)fe event: status 0, inversion off, m_tuning 1
      child has terminated
      pipes closed
      0.0.0.0
      169.254
      192.168
      nameservers: [[xxx, xxx, xxx, xxx]]
      read configured interface: {'lo': {'dhcp': False}, 'eth0': {'dhcp': True}}
      self.ifaces after loading: {'eth0': {'preup': False, 'predown': False, 'ip': [xxx, xxx, xxx, xxx], 'up': True, 'dns-nameservers': False, 'mac': '00:11:22:33:44:55', 'dhcp': True, 'bcast': [xxx, xxx, xxx, xxx], 'netmask': [255, 255, 255, 0], 'gateway': [xxx, xxx, xxx, xxx]}}
      SerienRecorder plugin not found
      resolve: resolve ${libdir}/enigma2/python/Plugins/Extensions/WebInterface/plugin.py
      resolve: -> /usr/lib/enigma2/python/Plugins/Extensions/WebInterface/plugin.py
      [OpenWebif] failed to listen on Port 80
      (1)fe event: status 7, inversion off, m_tuning 2
      (1)fe event: status 1f, inversion off, m_tuning 3
      OURSTATE: ok
      [eDVBCAService] channel 0x205fc88 running
      [eDVBLocalTimerHandler] channel 0x205fc88 running
      no version filtering
      0014: 70 00 00 00 00 00
      mask: fc 00 00 00 00 00
      mode: 00 00 00 00 00 00
      [eEPGCache] channel 0x205fc88 running
      stop release channel timer
      [EPGC] next update in 2 sec
      [SEC] set dynamic current limiting
      [eDVBLocalTimerHandler] diff is 4
      [eDVBLocalTimerHandler] diff < 120 .. use Transponder Time
      [eDVBLocalTimerHandler] update RTC
      [eDVBLocalTimerHandler] time update to 17:31:42
      [eDVBLocalTimerHandler] m_time_difference is 4
      [eDVBLocalTimerHandler] set Linux Time
      unknown client
      unknown client
      [EPGC] start caching events(1443540704)
      [EPGC] abort non avail schedule other reading
      [EPGC] abort non avail viasat reading
      [EPGC] abort non avail mhw reading
      [EPGC] nownext finished(1443540712)
      child has terminated
      pipes closed
      child has terminated
      pipes closed
      next real activation is Wed Sep 30 03:00:01 2015
      [EPGC] schedule finished(1443540801)
      [EPGC] stop caching events(1443540801)
      [EPGC] next update in 60 min
      lookup for events with 'biene maja' in title, short and extended event description(ignore case)
      lookup for events with 'Tatort' in title(ignore case)
      lookup for events with 'Formel 1: Das Rennen' in title(ignore case)
      lookup for events with 'Formel 1: Qualifying' in title(ignore case)
      lookup for events with 'Sportschau' in title(ignore case)
      [AutoTimer] Won't modify existing timer because either no modification allowed or repeated timer
      [AutoTimer] Won't modify existing timer because either no modification allowed or repeated timer
      lookup for events with 'Sportschau' in title(ignore case)
      [AutoTimer] Won't modify existing timer because either no modification allowed or repeated timer
      [AutoTimer] Won't modify existing timer because either no modification allowed or repeated timer
      [AutoTimer] Won't modify existing timer because either no modification allowed or repeated timer
      lookup for events with 'ritter trenk' in title(ignore case)
      lookup for events with 'warehouse' in title(ignore case)
      [AutoTimer] Won't modify existing timer because either no modification allowed or repeated timer
      [TIMER] activating state 1
      begin_date: 20150929 1735
      service_name: RTLNITRO
      name: M*A*S*H
      description: Alle lieben Kim
      lookup for events with 'klitschko' in title(ignore case)
      lookup for events with 'Mia and Me' in title(ignore case)
      [AutoTimer] Won't modify existing timer because either no modification allowed or repeated timer
      lookup for events with 'Briefe von Felix' in title(ignore case)
      [AutoTimer] Won't modify existing timer because either no modification allowed or repeated timer
      [AutoTimer] Won't modify existing timer because either no modification allowed or repeated timer
      [AutoTimer] Won't modify existing timer because either no modification allowed or repeated timer
      [AutoTimer] Won't modify existing timer because either no modification allowed or repeated timer
      lookup for events with 'M*A*S*H' in title, short and extended event description(ignore case)
      [AutoTimer] Won't modify existing timer because either no modification allowed or repeated timer
      [AutoTimer] Won't modify existing timer because either no modification allowed or repeated timer
      [AutoTimer] Won't modify existing timer because either no modification allowed or repeated timer
      [AutoTimer] Won't modify existing timer because either no modification allowed or repeated timer
      [AutoTimer] Won't modify existing timer because either no modification allowed or repeated timer
      [AutoTimer] Won't modify existing timer because either no modification allowed or repeated timer
      [AutoTimer] Won't modify existing timer because either no modification allowed or repeated timer
      [AutoTimer] Won't modify existing timer because either no modification allowed or repeated timer
      [AutoTimer] Won't modify existing timer because either no modification allowed or repeated timer
      [AutoTimer] Won't modify existing timer because either no modification allowed or repeated timer
      [AutoTimer] Won't modify existing timer because either no modification allowed or repeated timer
      [AutoTimer] Won't modify existing timer because either no modification allowed or repeated timer
      [AutoTimer] Won't modify existing timer because either no modification allowed or repeated timer
      [AutoTimer] Won't modify existing timer because either no modification allowed or repeated timer
      [AutoTimer] Won't modify existing timer because either no modification allowed or repeated timer
      [AutoTimer] Won't modify existing timer because either no modification allowed or repeated timer
      [AutoTimer] Won't modify existing timer because either no modification allowed or repeated timer
      [AutoTimer] Won't modify existing timer because either no modification allowed or repeated timer
      [TIMER] record time changed, start prepare is now: Tue Oct 6 11:54:40 2015
      [TIMER] [AutoTimer] Try to add new timer based on AutoTimer M*A*S*H.
      sanitycheck
      check
      checkTimerlist
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2EF4:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B66:3F3:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      [Timer] Record <RecordTimer.RecordTimerEntry object at 0x1f6c250>
      ProcessRepeated
      [TIMER] activating state 1
      begin_date: 20150929 1735
      service_name: RTLNITRO
      name: M*A*S*H
      description: Alle lieben Kim
      [TIMER] Filename calculated as: '/hdd/movie/M A S H/20150929 1735 - RTLNITRO - M_A_S_H'
      recording service: <enigma.eServiceReference; proxy of <Swig Object of type 'eServiceReference *' at 0x1df6a88> >
      record: 0
      [add callback]
      [eDVBCAService] remove channel 0x205fc88
      [eDVBCAService] write leave transponder failed!!
      [eDVBLocalTimerHandler] remove channel 0x205fc88
      [eEPGCache] remove channel 0x205fc88
      allocate channel.. 0441:0001
      [eDVBCAService] new channel 0x205fc88!
      (1)tune
      RotorCmd ffffffff, lastRotorCmd ffffffff
      prepare_sat System 0 Freq 12187500 Pol 0 SR 27500000 INV 2 FEC 3 orbpos 192 system 0 modulation 1 pilot 2, rolloff 0
      tuning to 1587 mhz
      OURSTATE: tuning
      allocate Channel: res 0
      allocate demux
      resolve: resolve ${sysconfdir}/scan_tp_valid_check.py
      resolve: -> /etc/scan_tp_valid_check.py
      query epg event id 19658
      found event.. store to disc
      [TIMER] prepare ok, waiting for begin
      [TIMER] Filename calculated as: '/hdd/movie/M A S H/20150929 1735 - RTLNITRO - M_A_S_H'
      recording service: <enigma.eServiceReference; proxy of <Swig Object of type 'eServiceReference *' at 0x1df6a88> >
      record: 0
      [remove callback]
      [add callback]
      use cached_channel
      allocate Channel: res 0
      resolve: resolve ${sysconfdir}/scan_tp_valid_check.py
      resolve: -> /etc/scan_tp_valid_check.py
      query epg event id 19658
      found event.. store to disc
      [TIMER] prepare ok, waiting for begin
      IBTS Timer Event 1 0
      IBTS StatePrepared
      IBTS Timer Event 2 0
      IBTS Timer running ID <RecordTimer.RecordTimerEntry object at 0x1e00f70> False
      Looking for embedded skin
      IBTS show
      next real activation is Tue Sep 29 17:54:40 2015
      [SEC] set static current limiting
      IBTS tunerShow
      IBTS updateNextTimer 1
      begin_date: 20150929 1755
      service_name: RTLNITRO
      name: M*A*S*H
      description: Immer einen Schritt voraus
      [TIMER] Filename calculated as: '/hdd/movie/M A S H/20150929 1755 - RTLNITRO - M_A_S_H'
      main thread is non-idle! display spinner!
      Looking for embedded skin
      [SEC] invalidate current switch params
      set sequence pos 3
      [SEC] setTone 1
      [SEC] sleep 10ms
      [SEC] update current switch params
      [SEC] startTuneTimeout 5000
      [SEC] setFrontend 1
      setting frontend 1
      [SEC] sleep 500ms
      [TIMER] record time changed, start prepare is now: Tue Oct 6 12:19:40 2015
      [TIMER] [AutoTimer] Try to add new timer based on AutoTimer M*A*S*H.
      sanitycheck
      check
      checkTimerlist
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2EF4:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B98:3F2:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:1:2F1D:441:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:2B66:3F3:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      recording service: 1:0:19:283D:3FB:1:C00000:0:0:0:
      record: 0
      [Timer] Record <RecordTimer.RecordTimerEntry object at 0x1f5e310>
      ProcessRepeated
      next real activation is Tue Sep 29 17:54:40 2015
      (1)fe event: status 0, inversion off, m_tuning 1
      (1)fe event: status 1f, inversion off, m_tuning 2
      OURSTATE: ok
      [eDVBCAService] channel 0x205fc88 running
      [eDVBLocalTimerHandler] channel 0x205fc88 running
      no version filtering
      0014: 70 00 00 00 00 00
      mask: fc 00 00 00 00 00
      mode: 00 00 00 00 00 00
      [eEPGCache] channel 0x205fc88 running
      stop release channel timer
      RECORD service event 6
      tuned..
      no version filtering
      0012: 4e 2f 1d 00 00 00
      mask: ff ff ff 00 00 00
      mode: 00 00 00 00 00 00
      ok ... now we start!!
      no version filtering
      0000: 00 00 00 00 00 00
      mask: ff 00 00 00 00 00
      mode: 00 00 00 00 00 00
      [EPGC] next update in 2 sec
      RECORD service event 5
      RECORD service event 6
      tuned..
      no version filtering
      0012: 4e 2f 1d 00 00 00
      mask: ff ff ff 00 00 00
      mode: 00 00 00 00 00 00
      [TIMER] record event 2
      ok ... now we start!!
      no version filtering
      0000: 00 00 00 00 00 00
      mask: ff 00 00 00 00 00
      mode: 00 00 00 00 00 00
      RECORD service event 5
      [TIMER] record event 6
      + 1/1 TID 00
      done!
      PATready
      use pmtpid 0035 for service_id 2f1d
      no version filtering
      0035: 02 2f 1d 00 00 00
      mask: ff ff ff 00 00 00
      mode: 00 00 00 00 00 00
      doing version filtering
      0000: 00 00 00 0b 00 00
      mask: ff 00 00 3f 00 00
      mode: 00 00 00 3e 00 00
      + 1/1 TID 00
      done!
      PATready
      use pmtpid 0035 for service_id 2f1d
      no version filtering
      0035: 02 2f 1d 00 00 00
      mask: ff ff ff 00 00 00
      mode: 00 00 00 00 00 00
      doing version filtering
      0000: 00 00 00 0b 00 00
      mask: ff 00 00 3f 00 00
      mode: 00 00 00 3e 00 00
      [SEC] set dynamic current limiting
      + 1/1 TID 02
      done!
      RECORD service event 5
      [eDVBCAService] new service 1:0:1:2F1D:441:1:C00000:0:0:0:
      [eDVBCAService] add demux 0 to slot 0 service 1:0:1:2F1D:441:1:C00000:0:0:0:
      no version filtering
      0055: 74 00 00 00 00 00
      mask: ff 00 00 00 00 00
      mode: 00 00 00 00 00 00
      demux 0 mask 01 prevhash 00000000
      doing version filtering
      0035: 02 2f 1d 03 00 00
      mask: ff ff ff 3f 00 00
      mode: 00 00 00 3e 00 00
      + 1/1 TID 02
      done!
      RECORD service event 5
      [TIMER] record event 6
      [eDVBCAService] add demux 0 to slot 1 service 1:0:1:2F1D:441:1:C00000:0:0:0:
      no version filtering
      0055: 74 00 00 00 00 00
      mask: ff 00 00 00 00 00
      mode: 00 00 00 00 00 00
      demux 0 mask 01 prevhash 00350101
      [eDVBCAService] don't build/send the same CA PMT twice
      doing version filtering
      0035: 02 2f 1d 03 00 00
      mask: ff ff ff 3f 00 00
      mode: 00 00 00 3e 00 00
      +- 1/2 TID 4e
      +- 1/2 TID 4e
      sdt update done!
      sdt update done!
      + 1/1 TID 74
      done!
      AITready
      Section Length : 506, Total Section Length : 509
      found applicaions ids >> pid : ffffffff, orgid : 33, appid : 400
      Save Data Len : [509]
      found applicaions ids >> pid : ffffffff, orgid : 33, appid : 405
      found applicaions ids >> pid : ffffffff, orgid : 33, appid : 103
      found applicaions ids >> pid : ffffffff, orgid : 33, appid : 112
      found applicaions ids >> pid : ffffffff, orgid : 33, appid : 402
      Found : control[1], name[RTL Nitro Startleiste], url[cdn.digitaltext.rtl.de/launchbar/index-rtlnitro.html]
      Found : control[2], name[RTL Nitro EPG], url[cdn.digitaltext.rtl.de/index-rtlnitro.html]
      Found : control[2], name[Clipfish Music], url[hbbtv.clipfish.de/index.php]
      Found : control[2], name[RTL Specials (CDN)], url[cdn.specials.digitaltext.rtl.de/index.html]
      Found : control[2], name[RTL Nitro Digitaltext], url[cdn.digitaltext.rtl.de/index.html]
      RECORD service event 10
      + 1/1 TID 74
      done!
      AITready
      Section Length : 506, Total Section Length : 509
      found applicaions ids >> pid : ffffffff, orgid : 33, appid : 400
      Save Data Len : [509]
      found applicaions ids >> pid : ffffffff, orgid : 33, appid : 405
      found applicaions ids >> pid : ffffffff, orgid : 33, appid : 103
      found applicaions ids >> pid : ffffffff, orgid : 33, appid : 112
      found applicaions ids >> pid : ffffffff, orgid : 33, appid : 402
      Found : control[1], name[RTL Nitro Startleiste], url[cdn.digitaltext.rtl.de/launchbar/index-rtlnitro.html]
      Found : control[2], name[RTL Nitro EPG], url[cdn.digitaltext.rtl.de/index-rtlnitro.html]
      Found : control[2], name[Clipfish Music], url[hbbtv.clipfish.de/index.php]
      Found : control[2], name[RTL Specials (CDN)], url[cdn.specials.digitaltext.rtl.de/index.html]
      Found : control[2], name[RTL Nitro Digitaltext], url[cdn.digitaltext.rtl.de/index.html]
      RECORD service event 10
      ++ 2/2 TID 4e
      done!
      [eDVBServiceRecord] now running: Walker, Texas Ranger (3000 seconds)
      doing version filtering
      0012: 4e 2f 1d 0d 00 00
      mask: ff ff ff 3f 00 00
      mode: 00 00 00 3e 00 00
      ++ 2/2 TID 4e
      done!
      [eDVBServiceRecord] now running: Walker, Texas Ranger (3000 seconds)
      [TIMER] record event 9
      doing version filtering
      0012: 4e 2f 1d 0d 00 00
      mask: ff ff ff 3f 00 00
      mode: 00 00 00 3e 00 00
      [EPGC] start caching events(1443540884)
      [EPGC] abort non avail schedule other reading
      [EPGC] abort non avail viasat reading
      [EPGC] abort non avail mhw reading
      [EPGC] nownext finished(1443540891)
      IBTS tunerHide
      next real activation is Wed Sep 30 03:00:01 2015
      [EPGC] schedule finished(1443540905)
      [EPGC] stop caching events(1443540905)
      [EPGC] next update in 60 min
      [eDVBLocalTimerHandler] diff is -2
      [eDVBLocalTimerHandler] diff < 120 .. use Transponder Time
      [eDVBLocalTimerHandler] update RTC
      [eDVBLocalTimerHandler] time update to 17:35:04
      [eDVBLocalTimerHandler] m_time_difference is -2
      [eDVBLocalTimerHandler] set Linux Time
      next real activation is Tue Sep 29 17:54:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Tue Sep 29 17:54:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      +- 1/2 TID 4e
      +- 1/2 TID 4e
      ++ 2/2 TID 4e
      done!
      [eDVBServiceRecord] now running: M*A*S*H (1200 seconds)
      doing version filtering
      0012: 4e 2f 1d 0f 00 00
      mask: ff ff ff 3f 00 00
      mode: 00 00 00 3e 00 00
      ++ 2/2 TID 4e
      done!
      [eDVBServiceRecord] now running: M*A*S*H (1200 seconds)
      [TIMER] record event 9
      doing version filtering
      0012: 4e 2f 1d 0f 00 00
      mask: ff ff ff 3f 00 00
      mode: 00 00 00 3e 00 00
      next real activation is Tue Sep 29 17:54:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      child has terminated
      pipes closed
      next real activation is Tue Sep 29 17:54:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Tue Sep 29 17:54:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Tue Sep 29 17:54:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Tue Sep 29 17:54:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Tue Sep 29 17:54:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Tue Sep 29 17:54:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Tue Sep 29 17:54:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Tue Sep 29 17:54:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      [TIMER] activating state 1
      begin_date: 20150929 1755
      service_name: RTLNITRO
      name: M*A*S*H
      description: Immer einen Schritt voraus
      [TIMER] Filename calculated as: '/hdd/movie/M A S H/20150929 1755 - RTLNITRO - M_A_S_H'
      recording service: <enigma.eServiceReference; proxy of <Swig Object of type 'eServiceReference *' at 0x1df6ea8> >
      record: 0
      [add callback]
      use cached_channel
      allocate Channel: res 0
      RECORD service event 6
      tuned..
      no version filtering
      0012: 4e 2f 1d 00 00 00
      mask: ff ff ff 00 00 00
      mode: 00 00 00 00 00 00
      [TIMER] record event 2
      ok ... now we start!!
      no version filtering
      0000: 00 00 00 00 00 00
      mask: ff 00 00 00 00 00
      mode: 00 00 00 00 00 00
      RECORD service event 5
      [TIMER] record event 6
      resolve: resolve ${sysconfdir}/scan_tp_valid_check.py
      resolve: -> /etc/scan_tp_valid_check.py
      query epg event id 19586
      found event.. store to disc
      [TIMER] prepare ok, waiting for begin
      IBTS Timer Event 1 0
      IBTS StatePrepared
      +- 1/2 TID 4e
      + 1/1 TID 00
      done!
      PATready
      use pmtpid 0035 for service_id 2f1d
      no version filtering
      0035: 02 2f 1d 00 00 00
      mask: ff ff ff 00 00 00
      mode: 00 00 00 00 00 00
      doing version filtering
      0000: 00 00 00 0b 00 00
      mask: ff 00 00 3f 00 00
      mode: 00 00 00 3e 00 00
      + 1/1 TID 02
      done!
      RECORD service event 5
      [TIMER] record event 6
      [eDVBCAService] add demux 0 to slot 2 service 1:0:1:2F1D:441:1:C00000:0:0:0:
      no version filtering
      0055: 74 00 00 00 00 00
      mask: ff 00 00 00 00 00
      mode: 00 00 00 00 00 00
      demux 0 mask 01 prevhash 00350101
      [eDVBCAService] don't build/send the same CA PMT twice
      doing version filtering
      0035: 02 2f 1d 03 00 00
      mask: ff ff ff 3f 00 00
      mode: 00 00 00 3e 00 00
      ++ 2/2 TID 4e
      done!
      [eDVBServiceRecord] now running: M*A*S*H (1200 seconds)
      [TIMER] record event 9
      doing version filtering
      0012: 4e 2f 1d 0f 00 00
      mask: ff ff ff 3f 00 00
      mode: 00 00 00 3e 00 00
      + 1/1 TID 74
      done!
      AITready
      Section Length : 506, Total Section Length : 509
      found applicaions ids >> pid : ffffffff, orgid : 33, appid : 400
      Save Data Len : [509]
      found applicaions ids >> pid : ffffffff, orgid : 33, appid : 405
      found applicaions ids >> pid : ffffffff, orgid : 33, appid : 103
      found applicaions ids >> pid : ffffffff, orgid : 33, appid : 112
      found applicaions ids >> pid : ffffffff, orgid : 33, appid : 402
      Found : control[1], name[RTL Nitro Startleiste], url[cdn.digitaltext.rtl.de/launchbar/index-rtlnitro.html]
      Found : control[2], name[RTL Nitro EPG], url[cdn.digitaltext.rtl.de/index-rtlnitro.html]
      Found : control[2], name[Clipfish Music], url[hbbtv.clipfish.de/index.php]
      Found : control[2], name[RTL Specials (CDN)], url[cdn.specials.digitaltext.rtl.de/index.html]
      Found : control[2], name[RTL Nitro Digitaltext], url[cdn.digitaltext.rtl.de/index.html]
      RECORD service event 10
      next real activation is Wed Sep 30 03:00:01 2015
      [TIMER] activating state 2
      [TIMER] start recording
      [TIMER] record event 0
      AddPopup, id = None
      Recording to /hdd/movie/M A S H/20150929 1755 - RTLNITRO - M_A_S_H.ts...
      start recording...
      RECORD: have 1 video stream(s) (00ad), and 1 audio stream(s) (0092) (0056), and the pcr pid is 00ad, and the text pid is 0054
      ADD PID: 0000
      ADD PID: 0035
      ADD PID: 0054
      ADD PID: 0056
      ADD PID: 0092
      ADD PID: 00ad
      before: 1
      after: 1
      setIoPrio realtime level 7 ok
      FILEPUSH THREAD START
      [TIMER] record event 4
      IBTS Timer Event 2 0
      IBTS Timer running ID <RecordTimer.RecordTimerEntry object at 0x1e02030> False
      Looking for embedded skin
      IBTS show
      next real activation is Tue Sep 29 18:10:00 2015
      IBTS tunerShow
      IBTS updateNextTimer 1
      begin_date: 20150930 0610
      service_name: KiKA HD
      name: Briefe von Felix - Ein Hase auf Weltreise
      description: Gestrandet im Pazifik
      [TIMER] Filename calculated as: '/hdd/movie/20150930 0610 - KiKA HD - Briefe von Felix - Ein Hase auf Weltreise'
      IBTS tunerHide
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Tue Sep 29 18:10:00 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Tue Sep 29 18:10:00 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Tue Sep 29 18:10:00 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Tue Sep 29 18:10:00 2015
      [AutoShutDown] PowerOff STB
      [SILENT_REC] we are already in standby
      Looking for embedded skin
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Tue Sep 29 18:10:00 2015
      +- 1/2 TID 4e
      +- 1/2 TID 4e
      +- 1/2 TID 4e
      ++ 2/2 TID 4e
      done!
      [eDVBServiceRecord] now running: M*A*S*H (1800 seconds)
      doing version filtering
      0012: 4e 2f 1d 11 00 00
      mask: ff ff ff 3f 00 00
      mode: 00 00 00 3e 00 00
      ++ 2/2 TID 4e
      done!
      [eDVBServiceRecord] now running: M*A*S*H (1800 seconds)
      [TIMER] record event 9
      doing version filtering
      0012: 4e 2f 1d 11 00 00
      mask: ff ff ff 3f 00 00
      mode: 00 00 00 3e 00 00
      ++ 2/2 TID 4e
      done!
      pcr of eit change: 1627b0638
      [eDVBServiceRecord] now running: M*A*S*H (1800 seconds)
      [TIMER] record event 9
      doing version filtering
      0012: 4e 2f 1d 11 00 00
      mask: ff ff ff 3f 00 00
      mode: 00 00 00 3e 00 00
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Tue Sep 29 18:10:00 2015
      no version filtering
      0014: 70 00 00 00 00 00
      mask: fc 00 00 00 00 00
      mode: 00 00 00 00 00 00
      [eDVBLocalTimerHandler] diff is 1
      [eDVBLocalTimerHandler] diff < 120 .. use Transponder Time
      [eDVBLocalTimerHandler] difference between linux time and RTC time is < 60 sec... so the transponder time looks ok
      [eDVBLocalTimerHandler] time update to 18:05:33
      [eDVBLocalTimerHandler] m_time_difference is 1
      [eDVBLocalTimerHandler] set Linux Time
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Tue Sep 29 18:10:00 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Tue Sep 29 18:10:00 2015
      next real activation is Wed Sep 30 03:00:01 2015
      [TIMER] activating state 3
      [TIMER] stop recording
      stop recording!
      (was not recording)
      [TIMER] record event 5
      [TIMER] record event 1
      [remove callback]
      [eDVBCAService] free slot 0 demux 0 for service 1:0:1:2F1D:441:1:C00000:0:0:0:
      demux 0 mask 01 prevhash 00350101
      [eDVBCAService] don't build/send the same CA PMT twice
      [SILENT_REC] we are in auto mode
      RecordTimer.TryQuitMainloop
      RecordTimer.staticGotRecordEvent(iRecordableService.evEnd)
      IBTS Timer Event 3 0
      IBTS updateType FINISHED
      IBTS show
      next real activation is Tue Sep 29 18:40:00 2015
      IBTS tunerShow
      IBTS updateNextTimer 1
      IBTS tunerHide
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Tue Sep 29 18:40:00 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Tue Sep 29 18:40:00 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Tue Sep 29 18:40:00 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Tue Sep 29 18:40:00 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Tue Sep 29 18:40:00 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Tue Sep 29 18:40:00 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Tue Sep 29 18:40:00 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Tue Sep 29 18:40:00 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Tue Sep 29 18:40:00 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Tue Sep 29 18:40:00 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Tue Sep 29 18:40:00 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Tue Sep 29 18:40:00 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Tue Sep 29 18:40:00 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Tue Sep 29 18:40:00 2015
      +- 1/2 TID 4e
      +- 1/2 TID 4e
      ++ 2/2 TID 4e
      done!
      [eDVBServiceRecord] now running: Hör' mal, wer da hämmert! (1500 seconds)
      doing version filtering
      0012: 4e 2f 1d 13 00 00
      mask: ff ff ff 3f 00 00
      mode: 00 00 00 3e 00 00
      ++ 2/2 TID 4e
      done!
      pcr of eit change: 16c3d0a68
      [eDVBServiceRecord] now running: Hör' mal, wer da hämmert! (1500 seconds)
      [TIMER] record event 9
      doing version filtering
      0012: 4e 2f 1d 13 00 00
      mask: ff ff ff 3f 00 00
      mode: 00 00 00 3e 00 00
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Tue Sep 29 18:40:00 2015
      [EPGC] start caching events(1443544504)
      [EPGC] abort non avail schedule other reading
      [EPGC] abort non avail viasat reading
      [EPGC] abort non avail mhw reading
      [EPGC] nownext finished(1443544511)
      [EPGC] schedule finished(1443544525)
      [EPGC] stop caching events(1443544525)
      [EPGC] next update in 60 min
      no version filtering
      0014: 70 00 00 00 00 00
      mask: fc 00 00 00 00 00
      mode: 00 00 00 00 00 00
      [eDVBLocalTimerHandler] diff is 0
      [eDVBLocalTimerHandler] diff < 120 .. use Transponder Time
      [eDVBLocalTimerHandler] not changed
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Tue Sep 29 18:40:00 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Tue Sep 29 18:40:00 2015
      next real activation is Wed Sep 30 03:00:01 2015
      [TIMER] activating state 3
      [TIMER] stop recording
      stop recording!
      stopping thread.
      FILEPUSH THREAD STOP
      thread joined 0
      loading streaminfo for /hdd/movie/M A S H/20150929 1755 - RTLNITRO - M_A_S_H.ts
      fixed up 1627b0638 to 2acb40d (offset 0)
      fixed up 16c3d0a68 to c6eb83d (offset 0)
      [TIMER] record event 5
      [TIMER] record event 1
      RecordTimer.staticGotRecordEvent(iRecordableService.evEnd)
      [remove callback]
      [eDVBCAService] free slot 1 demux 0 for service 1:0:1:2F1D:441:1:C00000:0:0:0:
      demux 0 mask 01 prevhash 00350101
      [eDVBCAService] don't build/send the same CA PMT twice
      [SILENT_REC] we are in auto mode
      IBTS Timer Event 3 0
      IBTS updateType FINISHED
      IBTS show
      next real activation is Wed Sep 30 06:09:40 2015
      IBTS tunerShow
      IBTS updateNextTimer 1
      IBTS tunerHide
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Wed Sep 30 06:09:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Wed Sep 30 06:09:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Wed Sep 30 06:09:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Wed Sep 30 06:09:40 2015
      child has terminated
      pipes closed
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Wed Sep 30 06:09:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Wed Sep 30 06:09:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Wed Sep 30 06:09:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Wed Sep 30 06:09:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Wed Sep 30 06:09:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Wed Sep 30 06:09:40 2015
      +- 1/2 TID 4e
      ++ 2/2 TID 4e
      done!
      [eDVBServiceRecord] now running: Hör' mal, wer da hämmert! (1800 seconds)
      doing version filtering
      0012: 4e 2f 1d 15 00 00
      mask: ff ff ff 3f 00 00
      mode: 00 00 00 3e 00 00
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Wed Sep 30 06:09:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Wed Sep 30 06:09:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Wed Sep 30 06:09:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Wed Sep 30 06:09:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Wed Sep 30 06:09:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      no version filtering
      0014: 70 00 00 00 00 00
      mask: fc 00 00 00 00 00
      mode: 00 00 00 00 00 00
      next real activation is Wed Sep 30 06:09:40 2015
      [eDVBLocalTimerHandler] diff is 0
      [eDVBLocalTimerHandler] diff < 120 .. use Transponder Time
      [eDVBLocalTimerHandler] not changed
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Wed Sep 30 06:09:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Wed Sep 30 06:09:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Wed Sep 30 06:09:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Wed Sep 30 06:09:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Wed Sep 30 06:09:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Wed Sep 30 06:09:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Wed Sep 30 06:09:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Wed Sep 30 06:09:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Wed Sep 30 06:09:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Wed Sep 30 06:09:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Wed Sep 30 06:09:40 2015
      +- 1/2 TID 4e
      ++ 2/2 TID 4e
      done!
      [eDVBServiceRecord] now running: Eine schrecklich nette Familie (1500 seconds)
      doing version filtering
      0012: 4e 2f 1d 17 00 00
      mask: ff ff ff 3f 00 00
      mode: 00 00 00 3e 00 00
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Wed Sep 30 06:09:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Wed Sep 30 06:09:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Wed Sep 30 06:09:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Wed Sep 30 06:09:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Wed Sep 30 06:09:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Wed Sep 30 06:09:40 2015
      [EPGC] start caching events(1443548126)
      [EPGC] abort non avail schedule other reading
      [EPGC] abort non avail viasat reading
      [EPGC] abort non avail mhw reading
      [EPGC] nownext finished(1443548133)
      next real activation is Wed Sep 30 03:00:01 2015
      [EPGC] schedule finished(1443548147)
      [EPGC] stop caching events(1443548147)
      [EPGC] next update in 60 min
      next real activation is Wed Sep 30 06:09:40 2015
      no version filtering
      0014: 70 00 00 00 00 00
      mask: fc 00 00 00 00 00
      mode: 00 00 00 00 00 00
      [eDVBLocalTimerHandler] diff is 0
      [eDVBLocalTimerHandler] diff < 120 .. use Transponder Time
      [eDVBLocalTimerHandler] not changed
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Wed Sep 30 06:09:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Wed Sep 30 06:09:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Wed Sep 30 06:09:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Wed Sep 30 06:09:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Wed Sep 30 06:09:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Wed Sep 30 06:09:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Wed Sep 30 06:09:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Wed Sep 30 06:09:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      next real activation is Wed Sep 30 06:09:40 2015
      next real activation is Wed Sep 30 03:00:01 2015
      +- 1/2 TID 4e
      ++ 2/2 TID 4e
      done!
      [eDVBServiceRecord] now running: Eine schrecklich nette Familie (1500 seconds)
      doing version filtering
      0012: 4e 2f 1d 19 00 00
      mask: ff ff ff 3f 00 00
      mode: 00 00 00 3e 00 00
      next real activation is Wed Sep 30 06:09:40 2015
      action -> StandbyActions power
      leave standby
      RemovePopup, id = goStandby
      (found in notifications)
      (found in current notifications)
      playing service..
      not pauseable.
      RemovePopup, id = ZapError
      allocate channel.. 03fb:0001
      available channel.. 0441:0001
      allocate Channel: res -6
      DVB service failed to tune - error 0
      RemovePopup, id = ZapError
      AddPopup, id = ZapError
      setLCDBrightness 127
      [AutoShutDown] leave standby . . .
      Timeout!
      Timeout!
      IBTS show
      IBTS tunerShow
      IBTS updateNextTimer 1
      IBTS hide
      IBTS tunerHide
      action -> InfobarMenuActions mainMenu
      loading mainmenu XML...
      Subtitles Subtitles
      TimerEdit TimerEditList
      PluginBrowser PluginBrowser
      action -> WizardActions down
      action -> WizardActions down
      action -> WizardActions ok
      unknown action WizardActions/ok! typo in keymap?
      action -> OkCancelActions ok
      EMPTY: 0
      ENABLE: 1
      DISABLE: 2
      CLEANUP: 3
      DELETE: 4
      key_red_choice: 0
      next real activation is Wed Sep 30 03:00:01 2015
      action -> DirectionActions down
      action -> DirectionActions downUp
      unknown action DirectionActions/downUp! typo in keymap?
      action -> DirectionActions down
      action -> DirectionActions downUp
      unknown action DirectionActions/downUp! typo in keymap?
      action -> DirectionActions down
      action -> DirectionActions downUp
      unknown action DirectionActions/downUp! typo in keymap?
      action -> DirectionActions down
      action -> DirectionActions downUp
      unknown action DirectionActions/downUp! typo in keymap?
      action -> DirectionActions down
      action -> DirectionActions downUp
      unknown action DirectionActions/downUp! typo in keymap?
      action -> DirectionActions down
      action -> DirectionActions downUp
      unknown action DirectionActions/downUp! typo in keymap?
      action -> DirectionActions down
      action -> DirectionActions downUp
      unknown action DirectionActions/downUp! typo in keymap?
      action -> DirectionActions down
      action -> DirectionActions downUp
      unknown action DirectionActions/downUp! typo in keymap?
      action -> DirectionActions down
      action -> DirectionActions downUp
      unknown action DirectionActions/downUp! typo in keymap?
      action -> DirectionActions down
      action -> DirectionActions downUp
      unknown action DirectionActions/downUp! typo in keymap?
      action -> DirectionActions down
      action -> DirectionActions downUp
      unknown action DirectionActions/downUp! typo in keymap?
      action -> DirectionActions down
      action -> DirectionActions downUp
      unknown action DirectionActions/downUp! typo in keymap?
      action -> DirectionActions down
      action -> DirectionActions downUp
      unknown action DirectionActions/downUp! typo in keymap?
      action -> DirectionActions down
      action -> DirectionActions downUp
      unknown action DirectionActions/downUp! typo in keymap?
      action -> DirectionActions down
      action -> DirectionActions downUp
      unknown action DirectionActions/downUp! typo in keymap?
      action -> DirectionActions down
      action -> DirectionActions downUp
      unknown action DirectionActions/downUp! typo in keymap?
      action -> DirectionActions down
      action -> DirectionActions downUp
      unknown action DirectionActions/downUp! typo in keymap?
      action -> DirectionActions down
      action -> DirectionActions downUp
      unknown action DirectionActions/downUp! typo in keymap?
      action -> DirectionActions down
      action -> DirectionActions downUp
      unknown action DirectionActions/downUp! typo in keymap?
      action -> DirectionActions down
      action -> DirectionActions downUp
      unknown action DirectionActions/downUp! typo in keymap?
      action -> DirectionActions down
      action -> DirectionActions downUp
      unknown action DirectionActions/downUp! typo in keymap?
      action -> DirectionActions down
      action -> DirectionActions downUp
      unknown action DirectionActions/downUp! typo in keymap?
      action -> DirectionActions down
      action -> DirectionActions downUp
      unknown action DirectionActions/downUp! typo in keymap?
      action -> DirectionActions down
      action -> DirectionActions downUp
      unknown action DirectionActions/downUp! typo in keymap?
      action -> DirectionActions down
      action -> DirectionActions downUp
      unknown action DirectionActions/downUp! typo in keymap?
      action -> DirectionActions down
      action -> DirectionActions downUp
      unknown action DirectionActions/downUp! typo in keymap?
      action -> DirectionActions down
      action -> DirectionActions downUp
      unknown action DirectionActions/downUp! typo in keymap?
      action -> DirectionActions down
      action -> DirectionActions downUp
      unknown action DirectionActions/downUp! typo in keymap?
      action -> DirectionActions up
      action -> DirectionActions upUp
      unknown action DirectionActions/upUp! typo in keymap?
      action -> DirectionActions up
      action -> DirectionActions upUp
      unknown action DirectionActions/upUp! typo in keymap?
      action -> DirectionActions up
      action -> DirectionActions upUp
      unknown action DirectionActions/upUp! typo in keymap?
      action -> DirectionActions up
      action -> DirectionActions upUp
      unknown action DirectionActions/upUp! typo in keymap?
      action -> DirectionActions up
      action -> DirectionActions upUp
      unknown action DirectionActions/upUp! typo in keymap?
      action -> DirectionActions up
      action -> DirectionActions upRepeated
      unknown action DirectionActions/upRepeated! typo in keymap?
      action -> DirectionActions upRepeated
      unknown action DirectionActions/upRepeated! typo in keymap?
      action -> DirectionActions upRepeated
      unknown action DirectionActions/upRepeated! typo in keymap?
      action -> DirectionActions upRepeated
      unknown action DirectionActions/upRepeated! typo in keymap?
      action -> DirectionActions upRepeated
      unknown action DirectionActions/upRepeated! typo in keymap?
      action -> DirectionActions upUp
      unknown action DirectionActions/upUp! typo in keymap?
      action -> DirectionActions up
      action -> DirectionActions upUp
      unknown action DirectionActions/upUp! typo in keymap?
      action -> DirectionActions up
      action -> DirectionActions upUp
      unknown action DirectionActions/upUp! typo in keymap?
      action -> DirectionActions up
      action -> DirectionActions upUp
      unknown action DirectionActions/upUp! typo in keymap?
      action -> DirectionActions up
      action -> DirectionActions upUp
      unknown action DirectionActions/upUp! typo in keymap?
      action -> DirectionActions up
      action -> DirectionActions upRepeated
      unknown action DirectionActions/upRepeated! typo in keymap?
      action -> DirectionActions upRepeated
      unknown action DirectionActions/upRepeated! typo in keymap?
      action -> DirectionActions upRepeated
      unknown action DirectionActions/upRepeated! typo in keymap?
      action -> DirectionActions upRepeated
      unknown action DirectionActions/upRepeated! typo in keymap?
      action -> DirectionActions upUp
      unknown action DirectionActions/upUp! typo in keymap?
      action -> DirectionActions up
      action -> DirectionActions upUp
      unknown action DirectionActions/upUp! typo in keymap?
      action -> DirectionActions up
      action -> DirectionActions upUp
      unknown action DirectionActions/upUp! typo in keymap?
      action -> DirectionActions up
      action -> DirectionActions upUp
      unknown action DirectionActions/upUp! typo in keymap?
      action -> DirectionActions up
      action -> DirectionActions upUp
      unknown action DirectionActions/upUp! typo in keymap?
      action -> OkCancelActions cancel
      action -> WizardActions up
      next real activation is Wed Sep 30 06:09:40 2015
      action -> WizardActions ok
      unknown action WizardActions/ok! typo in keymap?
      action -> OkCancelActions ok
    • Hier ist mal eine Zusammenfassung des Monats September. Aufgeführt habe ich die 5 "üblichen Aufnahmen" unter der Woche:
      morgens 1x KIKA HD, mittags 2x RTL nitro, abends 2x RTL nitro
      Am Wochenende laufen auch unregelmäßig Aufnahmen. Die haben im September aber alle geklappt.

      Spoiler anzeigen

      01.09.2015 Di ;) ;) ;) ;) ;)
      02.09.2015 Mi ;) ;) ;) ;) ;)
      03.09.2015 Do ;) ;) ;) ;cursing: ;cursing:
      04.09.2015 Fr ;) ;) ;) ;) ;)
      05.09.2015 Sa
      06.09.2015 So
      07.09.2015 Mo ;) ;) ;) ;) ;)
      08.09.2015 Di ;) ;) ;) ;cursing: ;)
      09.09.2015 Mi ;cursing: ;) ;) ;) ;)
      10.09.2015 Do ;) ;) ;) ;cursing: ;)
      11.09.2015 Fr ;) ;) ;) ;) ;)
      12.09.2015 Sa
      13.09.2015 So
      14.09.2015 Mo ;) ;) ;) ;) ;)
      15.09.2015 Di ;) ;) ;) ;) ;)
      16.09.2015 Mi ;) ;) ;) ;cursing: ;)
      17.09.2015 Do ;) ;) ;) ;) ;)
      18.09.2015 Fr ;) ;) ;) ;cursing: ;)
      19.09.2015 Sa
      20.09.2015 So
      21.09.2015 Mo ;) ;) ;) ;) ;)
      22.09.2015 Di ;) ;) ;) ;cursing: ;)
      23.09.2015 Mi ;) ;) ;) ;) ;)
      24.09.2015 Do ;) ;) ;) ;) ;)
      25.09.2015 Fr ;) ;) ;) ;) ;)
      26.09.2015 Sa
      27.09.2015 So
      28.09.2015 Mo ;) ;) ;) ;) ;)
      29.09.2015 Di ;) ;) ;) ;cursing: ;)
      30.09.2015 Mi ;) ;) ;) ;cursing: ;)

      Ich kann keine Regelmäßigkeit erkennen. Es ist kein Zusammenhang mit Wetter/Wolken oder Anwesenheit feststellbar.
      Der Fehler passiert zwar meist abends, aber halt nicht immer. Komisch ist auch, dass oft die erste Abendaufnahme fehlschlägt, die zweite aber doch klappt.

      Im September habe ich die "ständig aufnehmende" Box immer rechtzeitig neu gestartet. Ansonsten sind häufig alle nachfolgenden Aufnahmen auch hinüber.

      Hat irgendwer eine Idee, wie ich herausbekomme, was die Tuner gerade machen?
    • Ich habe meine SAT Anlage mal auf Unicable umgerüstet. Damit kann ich nun beide Tuner der Solo² mit eigenem Signal versorgen.
      Die Probleme sind dadurch FAST verschwunden. Einmal in ca 4 Wochen ist es aber trotzdem wieder hängen geblieben.

      Immer einen freier Tuner zu haben hilft also den Problemfall zu vermeiden.
      Daraus folgt aber auch, dass man den Fehler eigentlich reproduzieren können müsste:
      • nur 1 Kabel vom LNB (Legacy), Tuner intern verbunden
      • immer Doppelaufnahmen programmieren (also überlappend, aber gleicher Sender)
      • eventuell vorher einen Kanalwechsel (anderer Transponder/Sat Ebene)
      • ein paar Tage warten . . .