10:32:11.8041 dvb/sec.cpp:136 canTune [eDVBSatelliteEquipmentControl] 1 option(s) at position 192
10:32:11.8041 dvb/sec.cpp:150 canTune [eDVBSatelliteEquipmentControl] sat 192 found
10:32:11.8042 dvb/sec.cpp:194 canTune ret1 15000
10:32:11.8042 dvb/sec.cpp:240 canTune [eDVBSatelliteEquipmentControl] ret5 15000
10:32:11.8042 dvb/sec.cpp:257 canTune [eDVBSatelliteEquipmentControl] ret 15000, score old 0
10:32:11.8042 dvb/sec.cpp:264 canTune [eDVBSatelliteEquipmentControl] score new 15000
10:32:11.8042 dvb/sec.cpp:279 canTune [eDVBSatelliteEquipmentControl] final score 15000
10:32:11.8043 dvb/sec.cpp:72 canTune [eDVBSatelliteEquipmentControl] direct_connected 1
10:32:11.8043 dvb/sec.cpp:111 canTune [eDVBSatelliteEquipmentControl] canTune 8
10:32:11.8044 dvb/sec.cpp:279 canTune [eDVBSatelliteEquipmentControl] final score 0
10:32:11.8044 dvb/sec.cpp:72 canTune [eDVBSatelliteEquipmentControl] direct_connected 1
10:32:11.8044 dvb/sec.cpp:111 canTune [eDVBSatelliteEquipmentControl] canTune 16
10:32:11.8044 dvb/sec.cpp:279 canTune [eDVBSatelliteEquipmentControl] final score 0
10:32:11.8044 dvb/sec.cpp:72 canTune [eDVBSatelliteEquipmentControl] direct_connected 1
10:32:11.8045 dvb/sec.cpp:111 canTune [eDVBSatelliteEquipmentControl] canTune 32
10:32:11.8045 dvb/sec.cpp:279 canTune [eDVBSatelliteEquipmentControl] final score 0
10:32:11.8045 dvb/sec.cpp:72 canTune [eDVBSatelliteEquipmentControl] direct_connected 1
10:32:11.8045 dvb/sec.cpp:111 canTune [eDVBSatelliteEquipmentControl] canTune 64
10:32:11.8045 dvb/sec.cpp:279 canTune [eDVBSatelliteEquipmentControl] final score 0
10:32:11.8046 dvb/sec.cpp:72 canTune [eDVBSatelliteEquipmentControl] direct_connected 1
10:32:11.8046 dvb/sec.cpp:111 canTune [eDVBSatelliteEquipmentControl] canTune 128
10:32:11.8046 dvb/sec.cpp:279 canTune [eDVBSatelliteEquipmentControl] final score 0
10:32:11.8049 dvb/frontend.cpp:714 openFrontend [eDVBFrontend] m_need_delivery_system_workaround = 0
10:32:11.8049 dvb/frontend.cpp:716 openFrontend [eDVBFrontend] opening frontend 0
10:32:12.2579 dvb/frontend.cpp:2973 tune tune tuner 0
10:32:12.2580 dvb/sec.cpp:72 canTune [eDVBSatelliteEquipmentControl] direct_connected 1
10:32:12.2580 dvb/sec.cpp:111 canTune [eDVBSatelliteEquipmentControl] canTune 1
10:32:12.2580 dvb/sec.cpp:126 canTune [eDVBSatelliteEquipmentControl] lnb 0 found
10:32:12.2581 dvb/sec.cpp:136 canTune [eDVBSatelliteEquipmentControl] 1 option(s) at position 192
10:32:12.2581 dvb/sec.cpp:150 canTune [eDVBSatelliteEquipmentControl] sat 192 found
10:32:12.2581 dvb/sec.cpp:194 canTune ret1 15000
10:32:12.2581 dvb/sec.cpp:240 canTune [eDVBSatelliteEquipmentControl] ret5 15000
10:32:12.2581 dvb/sec.cpp:257 canTune [eDVBSatelliteEquipmentControl] ret 15000, score old 0
10:32:12.2582 dvb/sec.cpp:264 canTune [eDVBSatelliteEquipmentControl] score new 15000
10:32:12.2582 dvb/sec.cpp:279 canTune [eDVBSatelliteEquipmentControl] final score 15005
10:32:12.2582 dvb/sec.cpp:1053 prepare [eDVBSatelliteEquipmentControl] RotorCmd ffffffff, lastRotorCmd ffffffff
10:32:12.2583 dvb/frontend.cpp:2893 prepare_sat frontend 0 prepare_sat System 1 Freq 10906000 Pol 1 SR 22000000 INV 2 FEC 2 orbpos 192 system 1 modulation 2 pilot 2, rolloff 0, is_id 0, pls_mode 0, pls_code 1
10:32:12.2584 dvb/frontend.cpp:2899 prepare_sat tuning to 1156 MHz
10:32:12.2584 dvb/dvb.cpp:1882 frontendStateChanged [eDVBChannel] OURSTATE: tuner 0 tuning
10:32:12.2585 dvb/pmt.cpp:1000 tuneExt [eDVBServicePMTHandler] allocate Channel: res 0
10:32:12.2585 dvb_ci/dvbci.cpp:850 addPMTHandler [eDVBCIInterfaces] addPMTHandler 1:0:19:7537:426:1:C00000:0:0:0:
10:32:12.2586 dvb/dvb.cpp:2410 getDemux [eDVBChannel] getDemux cap=00
10:32:12.2586 dvb/dvb.cpp:1098 allocateDemux [eDVBResourceManager] allocate demux cap=00
10:32:12.2587 dvb/dvb.cpp:1274 allocateDemux [eDVBResourceManager] allocating demux adapter=0, demux=0, source=-1
10:32:12.2587 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0
10:32:12.3216 base/e2avahi.cpp:48 activated [Avahi] watch activated: 0x1
10:32:12.3226 base/ebase.cpp:279 processOneEvent [eMainloop

rocessOneEvent] unhandled POLLERR/HUP/NVAL for fd 33(17)
10:32:12.3227 base/ebase.cpp:279 processOneEvent [eMainloop

rocessOneEvent] unhandled POLLERR/HUP/NVAL for fd 35(17)
10:32:12.3290 gdi/gpixmap.cpp:725 blit [gPixmap] ignore unsupported 8bpp -> 16bpp alphablend!
10:32:12.3455 base/console.cpp:110 execute [eConsoleAppContainer] Starting /bin/sh
10:32:12.3462 base/ebase.cpp:279 processOneEvent [eMainloop

rocessOneEvent] unhandled POLLERR/HUP/NVAL for fd 45(16)
10:32:12.3509 base/e2avahi.cpp:26 timeout [Avahi] timeout elapsed
10:32:12.3519 base/e2avahi.cpp:372 avahi_timeout_update [Avahi] avahi_timeout_update
10:32:12.3727 dvb/frontend.cpp:2259 tuneLoopInt [SEC] set static current limiting
10:32:12.3805 base/e2avahi.cpp:26 timeout [Avahi] timeout elapsed
10:32:12.3810 base/e2avahi.cpp:372 avahi_timeout_update [Avahi] avahi_timeout_update
10:32:12.3812 dvb/frontend.cpp:2208 tuneLoopInt [SEC] invalidate current switch params
10:32:12.3862 base/e2avahi.cpp:26 timeout [Avahi] timeout elapsed
10:32:12.3864 base/e2avahi.cpp:372 avahi_timeout_update [Avahi] avahi_timeout_update
10:32:12.3865 base/e2avahi.cpp:26 timeout [Avahi] timeout elapsed
10:32:12.3865 base/e2avahi.cpp:372 avahi_timeout_update [Avahi] avahi_timeout_update
10:32:12.3866 dvb/frontend.cpp:1928 tuneLoopInt [eDVBFrontend] [SEC] tuner 0 setVoltage 1
10:32:12.5427 Components/Network.py:126 routeFinished 0.0.0.0
10:32:12.5429 Components/Network.py:126 routeFinished 192.168
10:32:12.5570 plugin/controllers/SR.py:24 __init__ SerienRecorder plugin not found
10:32:12.5572 plugin/controllers/ER.py:25 __init__ EPG Refresh Plugin not found
10:32:12.5646 plugin/httpserver.py:156 buildRootTree [OpenWebif] no plugins to load
10:32:12.5667 plugin/httpserver.py:177 HttpdStart [OpenWebif] started on 80
10:32:12.5671 base/e2avahi.cpp:360 avahi_timeout_new [Avahi] avahi_timeout_new
10:32:12.5677 base/e2avahi.cpp:380 avahi_timeout_free [Avahi] avahi_timeout_free
10:32:12.5679 base/e2avahi.cpp:360 avahi_timeout_new [Avahi] avahi_timeout_new
10:32:12.5682 base/e2avahi.cpp:380 avahi_timeout_free [Avahi] avahi_timeout_free
10:32:12.5684 base/e2avahi.cpp:360 avahi_timeout_new [Avahi] avahi_timeout_new
10:32:12.5689 base/e2avahi.cpp:380 avahi_timeout_free [Avahi] avahi_timeout_free
10:32:12.5689 base/e2avahi.cpp:360 avahi_timeout_new [Avahi] avahi_timeout_new
10:32:12.5695 base/e2avahi.cpp:380 avahi_timeout_free [Avahi] avahi_timeout_free
10:32:12.5696 base/e2avahi.cpp:151 avahi_service_try_register [Avahi] Registered gbquad4k (_http._tcp) on gbquad4k:80
10:32:12.5796 base/ebase.cpp:279 processOneEvent [eMainloop

rocessOneEvent] unhandled POLLERR/HUP/NVAL for fd 34(16)
10:32:12.5798 base/e2avahi.cpp:26 timeout [Avahi] timeout elapsed
10:32:12.5799 base/e2avahi.cpp:196 avahi_browser_callback [Avahi] Resolving service 'gbquad4k' of type '_e2stream._tcp'
10:32:12.5807 base/e2avahi.cpp:360 avahi_timeout_new [Avahi] avahi_timeout_new
10:32:12.5818 base/e2avahi.cpp:380 avahi_timeout_free [Avahi] avahi_timeout_free
10:32:12.5819 base/e2avahi.cpp:372 avahi_timeout_update [Avahi] avahi_timeout_update
10:32:12.5822 dvb/frontend.cpp:1919 tuneLoopInt [eDVBFrontend] [SEC] tuner 0 sleep 10ms
10:32:12.5846 base/e2avahi.cpp:26 timeout [Avahi] timeout elapsed
10:32:12.5847 base/e2avahi.cpp:196 avahi_browser_callback [Avahi] Resolving service 'gbquad4k' of type '_e2stream._tcp'
10:32:12.5848 base/e2avahi.cpp:360 avahi_timeout_new [Avahi] avahi_timeout_new
10:32:12.5859 base/e2avahi.cpp:380 avahi_timeout_free [Avahi] avahi_timeout_free
10:32:12.5860 base/e2avahi.cpp:372 avahi_timeout_update [Avahi] avahi_timeout_update
10:32:12.5861 base/e2avahi.cpp:26 timeout [Avahi] timeout elapsed
10:32:12.5862 base/e2avahi.cpp:372 avahi_timeout_update [Avahi] avahi_timeout_update
10:32:12.5863 base/e2avahi.cpp:26 timeout [Avahi] timeout elapsed
10:32:12.5866 base/e2avahi.cpp:360 avahi_timeout_new [Avahi] avahi_timeout_new
10:32:12.5870 base/e2avahi.cpp:380 avahi_timeout_free [Avahi] avahi_timeout_free
10:32:12.5871 base/e2avahi.cpp:372 avahi_timeout_update [Avahi] avahi_timeout_update
10:32:12.5876 base/e2avahi.cpp:26 timeout [Avahi] timeout elapsed
10:32:12.5877 base/e2avahi.cpp:360 avahi_timeout_new [Avahi] avahi_timeout_new
10:32:12.5881 base/e2avahi.cpp:380 avahi_timeout_free [Avahi] avahi_timeout_free
10:32:12.5882 base/e2avahi.cpp:372 avahi_timeout_update [Avahi] avahi_timeout_update
10:32:12.5934 dvb/frontend.cpp:2218 tuneLoopInt [SEC] update current switch params
10:32:12.5935 dvb/frontend.cpp:2030 tuneLoopInt [SEC] tuner 0 startTuneTimeout 5000
10:32:12.5936 dvb/frontend.cpp:2023 tuneLoopInt [SEC] tuner 0 setFrontend: events enabled
10:32:12.5937 dvb/frontend.cpp:2445 setFrontend setting frontend 0 events: on
10:32:12.6421 dvb/frontend.cpp:1066 feEvent [eDVBFrontend] (0)fe event: status 0, inversion off, m_tuning 1
10:32:12.6422 dvb/frontend.cpp:1919 tuneLoopInt [eDVBFrontend] [SEC] tuner 0 sleep 500ms
10:32:12.6744 /usr/lib/python2.7/threading.py:801 __bootstrap_inner DVB-S2 19.2E Astra 1KR/1L/1M/1... 10906 Mhz 22 2/3 V 19:7537:426:1:C0
TuxTxt cache cleared
10:32:12.8413 dvb/frontend.cpp:1066 feEvent [eDVBFrontend] (0)fe event: status 1f, inversion off, m_tuning 2
10:32:12.8414 dvb/dvb.cpp:1878 frontendStateChanged [eDVBChannel] OURSTATE: tuner 0 ok
10:32:12.8414 dvb/dvbtime.cpp:674 DVBChannelStateChanged [eDVBLocalTimerHandler] channel 0x103ff98 running
10:32:12.8415 dvb/dvb.cpp:2410 getDemux [eDVBChannel] getDemux cap=00
10:32:12.8415 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0
10:32:12.8416 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=20
10:32:12.8420 dvb/epgcache.cpp:681 DVBChannelStateChanged [eEPGCache] channel 0x103ff98 running
10:32:12.8420 dvb/dvb.cpp:2410 getDemux [eDVBChannel] getDemux cap=00
10:32:12.8421 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0
10:32:12.8421 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0
10:32:12.8421 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0
10:32:12.8422 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0
10:32:12.8422 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0
10:32:12.8422 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0
10:32:12.8423 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0
10:32:12.8423 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0
10:32:12.8424 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0
10:32:12.8424 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0
10:32:12.8424 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0
10:32:12.8425 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0
10:32:12.8425 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0
10:32:12.8426 dvb/epgcache.cpp:2071 startChannel [eEPGCache] next update in 2 sec
10:32:12.8426 dvb/dvb.cpp:1484 DVBChannelStateChanged [eDVBResourceManager] stop release channel timer
10:32:12.8427 dvb/dvb.cpp:2410 getDemux [eDVBChannel] getDemux cap=01
10:32:12.8427 dvb/dvb.cpp:1098 allocateDemux [eDVBResourceManager] allocate demux cap=01
10:32:12.8427 dvb/dvb.cpp:1207 allocateDemux [eDVBResourceManager] allocating shared demux adapter=0, demux=0, source=0
10:32:12.8427 dvb/pmt.cpp:77 channelStateChanged [eDVBServicePMTHandler] ok ... now we start!!
10:32:12.8428 service/servicedvb.cpp:1203 serviceEvent [eDVBServicePlay] eventNewProgramInfo timeshift_enabled=0 timeshift_active=0
10:32:12.8428 service/servicedvb.cpp:2872 updateDecoder [eDVBServicePlay] have 1 video stream(s) (00a6), and 1 audio stream(s) (0074), and the pcr pid is 00a6, and the text pid is ffffffff
10:32:12.8429 dvb/dvb.cpp:2410 getDemux [eDVBChannel] getDemux cap=01
10:32:12.8479 service/servicedvb.cpp:3556 setAC3Delay [eDVBServicePlay] Setting audio delay: setAC3Delay, 0 + 0
10:32:12.8481 service/servicedvb.cpp:3567 setPCMDelay [eDVBServicePlay] Setting audio delay: setPCMDelay, 0 + 0
10:32:12.8482 dvb/decoder.cpp:836 setState [eTSMPEGDecoder] decoder state: play, vpid=00a6, apid=0074
10:32:12.8482 dvb/decoder.cpp:707 startPid [eDVBPCR0] DMX_SET_PES_FILTER pid=0x00a6 ok
10:32:12.8483 dvb/decoder.cpp:715 startPid [eDVBPCR0] DEMUX_START ok
10:32:12.8484 dvb/decoder.cpp:84 startPid [eDVBAudio0] DMX_SET_PES_FILTER pid=0x0074 ok
10:32:12.8485 dvb/decoder.cpp:92 startPid [eDVBAudio0] DEMUX_START ok
10:32:12.8485 dvb/decoder.cpp:138 startPid [eDVBAudio0] AUDIO_SET_BYPASS bypass=1 ok
10:32:12.8486 dvb/decoder.cpp:191 freeze [eDVBAudio0] AUDIO_PAUSE ok
10:32:12.8486 dvb/decoder.cpp:146 startPid [eDVBAudio0] AUDIO_PLAY ok
10:32:12.8705 dvb/decoder.cpp:265 eDVBVideo [eDVBVideo] Video Device: /dev/dvb/adapter0/video0
10:32:12.8705 dvb/decoder.cpp:276 eDVBVideo [eDVBVideo] demux device: /dev/dvb/adapter0/demux0
10:32:12.8706 dvb/decoder.cpp:356 startPid [eDVBVideo0] VIDEO_SET_STREAMTYPE 1 - ok
10:32:12.8706 dvb/decoder.cpp:391 startPid [eDVBVideo0] DMX_SET_PES_FILTER pid=0x00a6 ok
10:32:12.8706 dvb/decoder.cpp:399 startPid [eDVBVideo0] DEMUX_START ok
10:32:12.8707 dvb/decoder.cpp:460 freeze [eDVBVideo0] VIDEO_FREEZE ok
10:32:12.8707 dvb/decoder.cpp:414 startPid [eDVBVideo0] VIDEO_PLAY ok
10:32:12.8771 dvb/decoder.cpp:484 setSlowMotion [eDVBVideo0] VIDEO_SLOWMOTION 0 ok
10:32:12.8772 dvb/decoder.cpp:499 setFastForward [eDVBVideo0] VIDEO_FAST_FORWARD 0 ok
10:32:12.8772 dvb/decoder.cpp:472 unfreeze [eDVBVideo0] VIDEO_CONTINUE ok
10:32:12.8772 dvb/decoder.cpp:203 unfreeze [eDVBAudio0] AUDIO_CONTINUE ok
10:32:12.8773 dvb/decoder.cpp:222 setChannel [eDVBAudio0] AUDIO_CHANNEL_SELECT 0 ok
10:32:12.8774 dvb/teletext.cpp:222 eDVBTeletextParser [eDVBTeletextParser] Starting!
10:32:12.8774 dvb/teletext.cpp:645 setPageAndMagazine [eDVBTeletextParser] disable teletext subtitles page ffffffffffffffff (und)
10:32:12.8775 dvb/demux.cpp:337 eDVBPESReader [eDVBPESReader] Created. Opening demux
10:32:12.8775 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0
10:32:12.8776 dvb/teletext.cpp:230 eDVBTeletextParser [eDVBTeletextParser] created teletext subtitle PES reader!
10:32:12.8776 dvb/demux.cpp:337 eDVBPESReader [eDVBPESReader] Created. Opening demux
10:32:12.8777 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0
10:32:12.8777 dvb/teletext.cpp:463 start [eDVBTeletextParser] starting PES reader on pid=ffffffff
10:32:12.8821 dvb/cahandler.cpp:267 registerService [eDVBCAService] new service 1:0:19:7537:426:1:C00000:0:0:0:
10:32:12.8822 dvb/cahandler.cpp:285 registerService [eDVBCAService] add demux 0 to slot 0 service 1:0:19:7537:426:1:C00000:0:0:0:
10:32:12.8823 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0
10:32:12.8824 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=0
10:32:12.8880 service/servicedvb.cpp:1728 timeshift [eDVBServicePlay] timeshift
10:32:12.8974 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0
10:32:12.8975 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=18
10:32:12.8998 Tools/Notifications.py:36 RemovePopup RemovePopup, id = ZapError
10:32:12.8999 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0
10:32:12.9000 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=0
10:32:12.9026 dvb/decoder.cpp:543 video_event [eDVBVideo0] VIDEO_GET_EVENT SIZE_CHANGED 0x0 aspect 2
10:32:12.9054 dvb/decoder.cpp:543 video_event [eDVBVideo0] VIDEO_GET_EVENT FRAME_RATE_CHANGED 65535 fps
10:32:12.9056 dvb/decoder.cpp:543 video_event [eDVBVideo0] VIDEO_GET_EVENT PROGRESSIVE_CHANGED 1
10:32:12.9062 dvb/pmt.cpp:207 PATready [eDVBServicePMTHandler] PATready
10:32:12.9063 dvb/pmt.cpp:218 PATready [eDVBServicePMTHandler] PAT TSID: 0x0426 (1062)
10:32:12.9064 dvb/pmt.cpp:247 PATready [eDVBServicePMTHandler] use pmtpid 0406 for service_id 7537
10:32:12.9064 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0
10:32:12.9065 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=1030
10:32:12.9069 gdi/gpixmap.cpp:725 blit [gPixmap] ignore unsupported 8bpp -> 16bpp alphablend!
10:32:12.9076 gdi/gpixmap.cpp:725 blit [gPixmap] ignore unsupported 8bpp -> 16bpp alphablend!
10:32:12.9085 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0
10:32:12.9086 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=0
10:32:12.9397 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0
10:32:12.9402 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=1024
10:32:12.9427 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0
10:32:12.9431 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=17
10:32:12.9490 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0
10:32:12.9491 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=1025
10:32:12.9732 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0
10:32:12.9734 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=1026
10:32:12.9989 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0
10:32:12.9990 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=1027
10:32:13.0188 service/servicedvb.cpp:1203 serviceEvent [eDVBServicePlay] eventNewProgramInfo timeshift_enabled=0 timeshift_active=0
10:32:13.0194 service/servicedvb.cpp:2872 updateDecoder [eDVBServicePlay] have 1 video stream(s) (00a6), and 2 audio stream(s) (0074, 0075), and the pcr pid is 00a6, and the text pid is ffffffff
10:32:13.0196 service/servicedvb.cpp:3556 setAC3Delay [eDVBServicePlay] Setting audio delay: setAC3Delay, 0 + 0
10:32:13.0197 service/servicedvb.cpp:3567 setPCMDelay [eDVBServicePlay] Setting audio delay: setPCMDelay, 0 + 0
10:32:13.0198 dvb/decoder.cpp:836 setState [eTSMPEGDecoder] decoder state: play, vpid=00a6, apid=0074
10:32:13.0198 dvb/decoder.cpp:484 setSlowMotion [eDVBVideo0] VIDEO_SLOWMOTION 0 ok
10:32:13.0198 dvb/decoder.cpp:499 setFastForward [eDVBVideo0] VIDEO_FAST_FORWARD 0 ok
10:32:13.0198 dvb/decoder.cpp:472 unfreeze [eDVBVideo0] VIDEO_CONTINUE ok
10:32:13.0199 dvb/decoder.cpp:203 unfreeze [eDVBAudio0] AUDIO_CONTINUE ok
10:32:13.0240 dvb_ci/dvbci.cpp:937 gotPMT [eDVBCIInterfaces] gotPMT
10:32:13.0295 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0
10:32:13.0296 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=1030
10:32:13.0484 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0
10:32:13.0485 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=1028
10:32:13.0732 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0
10:32:13.0734 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=1029
10:32:13.1232 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0
10:32:13.1234 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=1030
10:32:13.1423 dvb/frontend.cpp:2259 tuneLoopInt [SEC] set dynamic current limiting
10:32:13.4068 Components/AVSwitch.py:301 setAspect [VideoHardware] setting aspect: 16:9
10:32:13.4071 Components/AVSwitch.py:315 setWss [VideoHardware] setting wss: auto
10:32:13.4073 Components/AVSwitch.py:321 setPolicy43 [VideoHardware] setting policy: panscan
10:32:13.4076 Components/AVSwitch.py:338 setPolicy169 [VideoHardware] setting policy2: letterbox
10:32:13.4988 base/e2avahi.cpp:48 activated [Avahi] watch activated: 0x1
10:32:13.4989 base/e2avahi.cpp:372 avahi_timeout_update [Avahi] avahi_timeout_update
10:32:13.4989 base/e2avahi.cpp:26 timeout [Avahi] timeout elapsed
10:32:13.4990 base/e2avahi.cpp:372 avahi_timeout_update [Avahi] avahi_timeout_update
10:32:13.7692 dvb/pmt.cpp:950 SDTScanEvent [eDVBServicePMTHandler] sdt update done!
10:32:13.8882 service/servicedvb.cpp:1728 timeshift [eDVBServicePlay] timeshift
10:32:14.1865 dvb/dvbtime.cpp:478 updateTime [eDVBLocalTimerHandler] Transponder time is 05.12.2017 10:32:14
10:32:14.1866 dvb/dvbtime.cpp:491 updateTime [eDVBLocalTimerHandler] diff is 0
10:32:14.1866 dvb/dvbtime.cpp:494 updateTime [eDVBLocalTimerHandler] diff < 120 .. use Transponder Time
10:32:14.1867 dvb/dvbtime.cpp:555 updateTime [eDVBLocalTimerHandler] not changed
10:32:14.1871 dvb/dvb.cpp:2410 getDemux [eDVBChannel] getDemux cap=00
10:32:14.3754 dvb/decoder.cpp:543 video_event [eDVBVideo0] VIDEO_GET_EVENT SIZE_CHANGED 1920x1080 aspect 3
10:32:14.3788 dvb/decoder.cpp:543 video_event [eDVBVideo0] VIDEO_GET_EVENT FRAME_RATE_CHANGED 25000 fps
10:32:14.3790 dvb/decoder.cpp:543 video_event [eDVBVideo0] VIDEO_GET_EVENT PROGRESSIVE_CHANGED 0
10:32:14.8439 dvb/epgcache.cpp:1594 startEPG [eEPGCache] start caching events(1512466334)
10:32:14.8440 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=211
10:32:14.8445 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=561
10:32:14.8448 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=3842
10:32:14.8452 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=3003
10:32:14.8456 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=18
10:32:14.8461 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=18
10:32:14.8468 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=18
10:32:14.8476 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=5000
10:32:14.8478 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=5000
10:32:14.8482 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=57
10:32:14.8804 Components/AVSwitch.py:301 setAspect [VideoHardware] setting aspect: 16:9
10:32:14.8806 Components/AVSwitch.py:315 setWss [VideoHardware] setting wss: auto
10:32:14.8808 Components/AVSwitch.py:321 setPolicy43 [VideoHardware] setting policy: panscan
10:32:14.8812 Components/AVSwitch.py:338 setPolicy169 [VideoHardware] setting policy2: letterbox
10:32:17.3971 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0
10:32:17.3972 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=18
10:32:21.8485 dvb/epgcache.cpp:1950 abortNonAvail [eEPGCache] abort non avail schedule reading
10:32:21.8494 dvb/epgcache.cpp:1957 abortNonAvail [eEPGCache] abort non avail schedule other reading
10:32:21.8500 dvb/epgcache.cpp:1981 abortNonAvail [eEPGCache] abort non avail netmed schedule reading
10:32:21.8503 dvb/epgcache.cpp:1988 abortNonAvail [eEPGCache] abort non avail netmed schedule other reading
10:32:21.8504 dvb/epgcache.cpp:1997 abortNonAvail [eEPGCache] abort non avail FreeSat schedule_other reading
10:32:21.8505 dvb/epgcache.cpp:2008 abortNonAvail [eEPGCache] abort non avail viasat reading
10:32:21.8506 dvb/epgcache.cpp:2016 abortNonAvail [eEPGCache] abort non avail mhw reading
10:32:22.6866 dvb/epgcache.cpp:2269 readData [eEPGCache] nownext finished(1512466342)
10:32:22.6871 dvb/epgcache.cpp:1573 finishEPG [eEPGCache] stop caching events(1512466342)
10:32:22.6872 dvb/epgcache.cpp:1575 finishEPG [eEPGCache] next update in 60 min
10:32:25.7550 Components/Sources/StreamService.py:25 handleCommand [StreamService] handle command 1:0:19:7863:41A:1:C00000:0:0:0:
10:32:25.7553 Components/Sources/StreamService.py:38 execBegin [StreamService]e execBegin 1:0:19:7863:41A:1:C00000:0:0:0:
10:32:25.7566 Navigation.py:321 recordService recording service: <enigma.eServiceReference; proxy of <Swig Object of type 'eServiceReference *' at 0xb01807a0> >
10:32:25.7571 dvb/dvb.cpp:1405 allocateChannel [eDVBResourceManager] allocate channel.. 041a:0001
10:32:25.7572 dvb/dvb.cpp:1408 allocateChannel [eDVBResourceManager] available channel.. 0426:0001
10:32:25.7572 dvb/sec.cpp:72 canTune [eDVBSatelliteEquipmentControl] direct_connected 1
10:32:25.7572 dvb/sec.cpp:111 canTune [eDVBSatelliteEquipmentControl] canTune 1
10:32:25.7572 dvb/sec.cpp:126 canTune [eDVBSatelliteEquipmentControl] lnb 0 found
10:32:25.7573 dvb/sec.cpp:136 canTune [eDVBSatelliteEquipmentControl] 1 option(s) at position 192
10:32:25.7573 dvb/sec.cpp:150 canTune [eDVBSatelliteEquipmentControl] sat 192 found
10:32:25.7573 dvb/sec.cpp:194 canTune ret1 15000
10:32:25.7573 dvb/sec.cpp:240 canTune [eDVBSatelliteEquipmentControl] ret5 15000
10:32:25.7574 dvb/sec.cpp:257 canTune [eDVBSatelliteEquipmentControl] ret 15000, score old 0
10:32:25.7574 dvb/sec.cpp:264 canTune [eDVBSatelliteEquipmentControl] score new 15000
10:32:25.7574 dvb/sec.cpp:279 canTune [eDVBSatelliteEquipmentControl] final score 15005
10:32:25.7574 dvb/sec.cpp:72 canTune [eDVBSatelliteEquipmentControl] direct_connected 0
10:32:25.7575 dvb/sec.cpp:111 canTune [eDVBSatelliteEquipmentControl] canTune 2
10:32:25.7575 dvb/sec.cpp:126 canTune [eDVBSatelliteEquipmentControl] lnb 0 found
10:32:25.7575 dvb/sec.cpp:136 canTune [eDVBSatelliteEquipmentControl] 1 option(s) at position 192
10:32:25.7575 dvb/sec.cpp:150 canTune [eDVBSatelliteEquipmentControl] sat 192 found
10:32:25.7575 dvb/sec.cpp:194 canTune ret1 15000
10:32:25.7575 dvb/sec.cpp:207 canTune [eDVBSatelliteEquipmentControl] ret2 15015
10:32:25.7576 dvb/sec.cpp:240 canTune [eDVBSatelliteEquipmentControl] ret5 15015
10:32:25.7576 dvb/sec.cpp:257 canTune [eDVBSatelliteEquipmentControl] ret 15015, score old 0
10:32:25.7576 dvb/sec.cpp:264 canTune [eDVBSatelliteEquipmentControl] score new 15015
10:32:25.7576 dvb/sec.cpp:279 canTune [eDVBSatelliteEquipmentControl] final score 15015
10:32:25.7577 dvb/sec.cpp:72 canTune [eDVBSatelliteEquipmentControl] direct_connected 1
10:32:25.7577 dvb/sec.cpp:111 canTune [eDVBSatelliteEquipmentControl] canTune 4
10:32:25.7577 dvb/sec.cpp:126 canTune [eDVBSatelliteEquipmentControl] lnb 0 found
10:32:25.7577 dvb/sec.cpp:136 canTune [eDVBSatelliteEquipmentControl] 1 option(s) at position 192
10:32:25.7577 dvb/sec.cpp:150 canTune [eDVBSatelliteEquipmentControl] sat 192 found
10:32:25.7578 dvb/sec.cpp:194 canTune ret1 15000
10:32:25.7578 dvb/sec.cpp:207 canTune [eDVBSatelliteEquipmentControl] ret2 15015
10:32:25.7578 dvb/sec.cpp:240 canTune [eDVBSatelliteEquipmentControl] ret5 15015
10:32:25.7578 dvb/sec.cpp:257 canTune [eDVBSatelliteEquipmentControl] ret 15015, score old 0
10:32:25.7578 dvb/sec.cpp:264 canTune [eDVBSatelliteEquipmentControl] score new 15015
10:32:25.7579 dvb/sec.cpp:279 canTune [eDVBSatelliteEquipmentControl] final score 15020
10:32:25.7579 dvb/sec.cpp:72 canTune [eDVBSatelliteEquipmentControl] direct_connected 1
10:32:25.7579 dvb/sec.cpp:111 canTune [eDVBSatelliteEquipmentControl] canTune 8
10:32:25.7579 dvb/sec.cpp:279 canTune [eDVBSatelliteEquipmentControl] final score 0
10:32:25.7579 dvb/sec.cpp:72 canTune [eDVBSatelliteEquipmentControl] direct_connected 1
10:32:25.7580 dvb/sec.cpp:111 canTune [eDVBSatelliteEquipmentControl] canTune 16
10:32:25.7580 dvb/sec.cpp:279 canTune [eDVBSatelliteEquipmentControl] final score 0
10:32:25.7580 dvb/sec.cpp:72 canTune [eDVBSatelliteEquipmentControl] direct_connected 1
10:32:25.7580 dvb/sec.cpp:111 canTune [eDVBSatelliteEquipmentControl] canTune 32
10:32:25.7580 dvb/sec.cpp:279 canTune [eDVBSatelliteEquipmentControl] final score 0
10:32:25.7581 dvb/sec.cpp:72 canTune [eDVBSatelliteEquipmentControl] direct_connected 1
10:32:25.7581 dvb/sec.cpp:111 canTune [eDVBSatelliteEquipmentControl] canTune 64
10:32:25.7581 dvb/sec.cpp:279 canTune [eDVBSatelliteEquipmentControl] final score 0
10:32:25.7581 dvb/sec.cpp:72 canTune [eDVBSatelliteEquipmentControl] direct_connected 1
10:32:25.7582 dvb/sec.cpp:111 canTune [eDVBSatelliteEquipmentControl] canTune 128
10:32:25.7582 dvb/sec.cpp:279 canTune [eDVBSatelliteEquipmentControl] final score 0
10:32:25.7583 dvb/fbc.cpp:36 setProcData [*] setProcData /proc/stb/frontend/2/fbc_connect -> 0
10:32:25.7584 dvb/fbc.cpp:36 setProcData [*] setProcData /proc/stb/frontend/2/fbc_link -> 1
10:32:25.7587 dvb/frontend.cpp:714 openFrontend [eDVBFrontend] m_need_delivery_system_workaround = 0
10:32:25.7587 dvb/frontend.cpp:716 openFrontend [eDVBFrontend] opening frontend 2
10:32:25.7920 dvb/frontend.cpp:2973 tune tune tuner 2
10:32:25.7921 dvb/sec.cpp:72 canTune [eDVBSatelliteEquipmentControl] direct_connected 1
10:32:25.7921 dvb/sec.cpp:111 canTune [eDVBSatelliteEquipmentControl] canTune 4
10:32:25.7921 dvb/sec.cpp:126 canTune [eDVBSatelliteEquipmentControl] lnb 0 found
10:32:25.7921 dvb/sec.cpp:136 canTune [eDVBSatelliteEquipmentControl] 1 option(s) at position 192
10:32:25.7922 dvb/sec.cpp:150 canTune [eDVBSatelliteEquipmentControl] sat 192 found
10:32:25.7922 dvb/sec.cpp:194 canTune ret1 15000
10:32:25.7922 dvb/sec.cpp:207 canTune [eDVBSatelliteEquipmentControl] ret2 15015
10:32:25.7922 dvb/sec.cpp:240 canTune [eDVBSatelliteEquipmentControl] ret5 15015
10:32:25.7922 dvb/sec.cpp:257 canTune [eDVBSatelliteEquipmentControl] ret 15015, score old 0
10:32:25.7923 dvb/sec.cpp:264 canTune [eDVBSatelliteEquipmentControl] score new 15015
10:32:25.7923 dvb/sec.cpp:279 canTune [eDVBSatelliteEquipmentControl] final score 15020
10:32:25.7923 dvb/sec.cpp:1053 prepare [eDVBSatelliteEquipmentControl] RotorCmd ffffffff, lastRotorCmd ffffffff
10:32:25.7924 dvb/sec.cpp:1275 prepare [eDVBSatelliteEquipmentControl] takeover_sec 0
10:32:25.7924 dvb/sec.cpp:1279 prepare [eDVBSatelliteEquipmentControl] waittakeover_sec 2
10:32:25.7925 dvb/frontend.cpp:2893 prepare_sat frontend 2 prepare_sat System 1 Freq 10729000 Pol 1 SR 22000000 INV 2 FEC 2 orbpos 192 system 1 modulation 2 pilot 2, rolloff 0, is_id 0, pls_mode 0, pls_code 1
10:32:25.7925 dvb/frontend.cpp:2899 prepare_sat tuning to 979 MHz
10:32:25.7925 dvb/dvb.cpp:1882 frontendStateChanged [eDVBChannel] OURSTATE: tuner 2 tuning
10:32:25.7926 dvb/pmt.cpp:1000 tuneExt [eDVBServicePMTHandler] allocate Channel: res 0
10:32:25.7926 dvb_ci/dvbci.cpp:850 addPMTHandler [eDVBCIInterfaces] addPMTHandler 1:0:19:7863:41A:1:C00000:0:0:0:
10:32:25.7927 dvb/dvb.cpp:2410 getDemux [eDVBChannel] getDemux cap=00
10:32:25.7927 dvb/dvb.cpp:1098 allocateDemux [eDVBResourceManager] allocate demux cap=00
10:32:25.7927 dvb/dvb.cpp:1274 allocateDemux [eDVBResourceManager] allocating demux adapter=0, demux=1, source=-1
10:32:25.7928 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux1
10:32:25.8422 Components/Sources/StreamService.py:31 recordEvent [StreamService] RECORD event for us: <enigma.iRecordableServicePtr; proxy of <Swig Object of type 'ePtr< iRecordableService > *' at 0xb0180b60> >
10:32:25.8434 dvb/frontend.cpp:2332 tuneLoopInt [SEC-Slave] tuner 0 end takeover frontend
10:32:25.8435 dvb/frontend.cpp:1903 tuneLoopInt [eDVBFrontend] tuner 1 is closed, reopen
10:32:25.8440 dvb/frontend.cpp:714 openFrontend [eDVBFrontend] m_need_delivery_system_workaround = 0
10:32:25.8441 dvb/frontend.cpp:716 openFrontend [eDVBFrontend] opening frontend 1
10:32:26.1321 dvb/frontend.cpp:2366 tuneLoopInt [SEC-Master] tuner 2 start wait takeover frontend
10:32:26.1345 dvb/frontend.cpp:2417 tuneLoopInt [SEC] tuner 0 newTunertype 0
10:32:27.1282 dvb/frontend.cpp:2374 tuneLoopInt [SEC-Master] tuner 2 timeout wait takeover frontend
10:32:27.1282 dvb/frontend.cpp:2384 tuneLoopInt [SEC-Master] tuner 2 end wait takeover frontend
10:32:27.1283 dvb/frontend.cpp:2030 tuneLoopInt [SEC] tuner 2 startTuneTimeout 1000
10:32:28.1283 dvb/dvb.cpp:1906 frontendStateChanged [eDVBChannel] OURSTATE: tuner 2 failed, retune
10:32:28.1284 dvb/frontend.cpp:2973 tune tune tuner 2
10:32:28.1284 dvb/sec.cpp:72 canTune [eDVBSatelliteEquipmentControl] direct_connected 1
10:32:28.1285 dvb/sec.cpp:111 canTune [eDVBSatelliteEquipmentControl] canTune 4
10:32:28.1285 dvb/sec.cpp:126 canTune [eDVBSatelliteEquipmentControl] lnb 0 found
10:32:28.1285 dvb/sec.cpp:136 canTune [eDVBSatelliteEquipmentControl] 1 option(s) at position 192
10:32:28.1285 dvb/sec.cpp:150 canTune [eDVBSatelliteEquipmentControl] sat 192 found
10:32:28.1285 dvb/sec.cpp:194 canTune ret1 15000
10:32:28.1286 dvb/sec.cpp:207 canTune [eDVBSatelliteEquipmentControl] ret2 15015
10:32:28.1286 dvb/sec.cpp:240 canTune [eDVBSatelliteEquipmentControl] ret5 15015
10:32:28.1286 dvb/sec.cpp:257 canTune [eDVBSatelliteEquipmentControl] ret 15015, score old 0
10:32:28.1286 dvb/sec.cpp:264 canTune [eDVBSatelliteEquipmentControl] score new 15015
10:32:28.1286 dvb/sec.cpp:279 canTune [eDVBSatelliteEquipmentControl] final score 15020
10:32:28.1287 dvb/sec.cpp:1053 prepare [eDVBSatelliteEquipmentControl] RotorCmd ffffffff, lastRotorCmd ffffffff
10:32:28.1287 dvb/sec.cpp:1275 prepare [eDVBSatelliteEquipmentControl] takeover_sec 0
10:32:28.1287 dvb/sec.cpp:1279 prepare [eDVBSatelliteEquipmentControl] waittakeover_sec 2
10:32:28.1287 dvb/frontend.cpp:2893 prepare_sat frontend 2 prepare_sat System 1 Freq 10729000 Pol 1 SR 22000000 INV 2 FEC 2 orbpos 192 system 1 modulation 2 pilot 2, rolloff 0, is_id 0, pls_mode 0, pls_code 1
10:32:28.1288 dvb/frontend.cpp:2899 prepare_sat tuning to 979 MHz
10:32:28.1288 dvb/dvb.cpp:1882 frontendStateChanged [eDVBChannel] OURSTATE: tuner 2 tuning
10:32:28.1288 dvb/pmt.cpp:115 channelStateChanged [eDVBServicePMTHandler] tune failed.
10:32:28.1289 service/servicedvbrecord.cpp:37 serviceEvent [eDVBServiceRecord] RECORD service event 1
10:32:28.1289 service/servicedvbrecord.cpp:60 serviceEvent [eDVBServiceRecord] record failed to tune
10:32:28.1291 Components/Sources/StreamService.py:31 recordEvent [StreamService] RECORD event for us: <enigma.iRecordableServicePtr; proxy of <Swig Object of type 'ePtr< iRecordableService > *' at 0xb01808c0> >
10:32:28.1298 dvb/pmt.cpp:954 SDTScanEvent [eDVBServicePMTHandler] ignore sdt update data.... incorrect transponder tuned!!!
10:32:28.1299 dvb/pmt.cpp:956 SDTScanEvent [eDVBServicePMTHandler] incorrect namespace. expected: c00000 current: ffffffff
10:32:28.1299 dvb/pmt.cpp:958 SDTScanEvent [eDVBServicePMTHandler] incorrect transport_stream_id. expected: 41a current: ffffffff
10:32:28.1300 dvb/pmt.cpp:960 SDTScanEvent [eDVBServicePMTHandler] incorrect namespace. expected: 1 current: ffffffff
10:32:28.1309 dvb/frontend.cpp:2311 tuneLoopInt [SEC-Slave] tuner 0 start takeover frontend
10:32:28.1311 dvb/frontend.cpp:2349 tuneLoopInt [SEC-Master] tuner 2 WAIT_TAKEOVER
10:32:28.1313 dvb/frontend.cpp:2259 tuneLoopInt [SEC] set static current limiting
10:32:28.1314 dvb/frontend.cpp:2208 tuneLoopInt [SEC] invalidate current switch params
10:32:28.1315 dvb/frontend.cpp:2218 tuneLoopInt [SEC] update current switch params
10:32:28.1315 dvb/frontend.cpp:2030 tuneLoopInt [SEC] tuner 2 startTuneTimeout 5000
10:32:28.1315 dvb/frontend.cpp:2023 tuneLoopInt [SEC] tuner 2 setFrontend: events enabled
10:32:28.1316 dvb/frontend.cpp:2445 setFrontend setting frontend 2 events: on
10:32:28.1801 dvb/frontend.cpp:1066 feEvent [eDVBFrontend] (2)fe event: status 0, inversion off, m_tuning 1
10:32:28.1801 dvb/frontend.cpp:1919 tuneLoopInt [eDVBFrontend] [SEC] tuner 2 sleep 500ms
10:32:28.3793 dvb/frontend.cpp:1066 feEvent [eDVBFrontend] (2)fe event: status 1f, inversion off, m_tuning 2
10:32:28.3794 dvb/dvb.cpp:1878 frontendStateChanged [eDVBChannel] OURSTATE: tuner 2 ok
10:32:28.3794 dvb/dvbtime.cpp:674 DVBChannelStateChanged [eDVBLocalTimerHandler] channel 0x1074220 running
10:32:28.3794 dvb/dvb.cpp:2410 getDemux [eDVBChannel] getDemux cap=00
10:32:28.3795 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux1
10:32:28.3795 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=20
10:32:28.3799 dvb/epgcache.cpp:681 DVBChannelStateChanged [eEPGCache] channel 0x1074220 running
10:32:28.3799 dvb/dvb.cpp:2410 getDemux [eDVBChannel] getDemux cap=00
10:32:28.3800 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux1
10:32:28.3800 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux1
10:32:28.3800 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux1
10:32:28.3801 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux1
10:32:28.3801 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux1
10:32:28.3801 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux1
10:32:28.3802 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux1
10:32:28.3802 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux1
10:32:28.3802 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux1
10:32:28.3803 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux1
10:32:28.3804 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux1
10:32:28.3804 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux1
10:32:28.3804 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux1
10:32:28.3805 dvb/epgcache.cpp:2071 startChannel [eEPGCache] next update in 2 sec
10:32:28.3806 dvb/dvb.cpp:1484 DVBChannelStateChanged [eDVBResourceManager] stop release channel timer
10:32:28.3806 dvb/dvb.cpp:2410 getDemux [eDVBChannel] getDemux cap=01
10:32:28.3806 dvb/dvb.cpp:1098 allocateDemux [eDVBResourceManager] allocate demux cap=01
10:32:28.3806 dvb/dvb.cpp:1207 allocateDemux [eDVBResourceManager] allocating shared demux adapter=0, demux=1, source=2
10:32:28.3807 dvb/pmt.cpp:77 channelStateChanged [eDVBServicePMTHandler] ok ... now we start!!
10:32:28.3807 service/servicedvbrecord.cpp:37 serviceEvent [eDVBServiceRecord] RECORD service event 5
10:32:28.3810 Components/Sources/StreamService.py:31 recordEvent [StreamService] RECORD event for us: <enigma.iRecordableServicePtr; proxy of <Swig Object of type 'ePtr< iRecordableService > *' at 0xb0180680> >
10:32:28.3814 dvb/cahandler.cpp:267 registerService [eDVBCAService] new service 1:0:19:7863:41A:1:C00000:0:0:0:
10:32:28.3814 dvb/cahandler.cpp:285 registerService [eDVBCAService] add demux 1 to slot 0 service 1:0:19:7863:41A:1:C00000:0:0:0:
10:32:28.3815 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux1
10:32:28.3815 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=0
10:32:28.3819 service/servicedvbrecord.cpp:37 serviceEvent [eDVBServiceRecord] RECORD service event 6
10:32:28.3819 service/servicedvbrecord.cpp:42 serviceEvent [eDVBServiceRecord] tuned..
10:32:28.3819 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux1
10:32:28.3820 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=18
10:32:28.3826 Components/Sources/StreamService.py:31 recordEvent [StreamService] RECORD event for us: <enigma.iRecordableServicePtr; proxy of <Swig Object of type 'ePtr< iRecordableService > *' at 0xb0180680> >
10:32:28.3829 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux1
10:32:28.3830 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=0
10:32:28.4156 dvb/pmt.cpp:207 PATready [eDVBServicePMTHandler] PATready
10:32:28.4157 dvb/pmt.cpp:218 PATready [eDVBServicePMTHandler] PAT TSID: 0x041a (1050)
10:32:28.4157 dvb/pmt.cpp:247 PATready [eDVBServicePMTHandler] use pmtpid 0413 for service_id 7863
10:32:28.4157 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux1
10:32:28.4158 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=1043
10:32:28.4161 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux1
10:32:28.4161 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=0
10:32:28.4169 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux1
10:32:28.4170 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=1027
10:32:28.4172 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux1
10:32:28.4173 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=17
10:32:28.5439 service/servicedvbrecord.cpp:37 serviceEvent [eDVBServiceRecord] RECORD service event 5
10:32:28.5440 service/servicedvbrecord.cpp:328 doRecord [eDVBServiceRecord] start streaming...
10:32:28.5443 Components/Sources/StreamService.py:31 recordEvent [StreamService] RECORD event for us: <enigma.iRecordableServicePtr; proxy of <Swig Object of type 'ePtr< iRecordableService > *' at 0xb0180e30> >
10:32:28.5454 Components/Sources/StreamService.py:31 recordEvent [StreamService] RECORD event for us: <enigma.iRecordableServicePtr; proxy of <Swig Object of type 'ePtr< iRecordableService > *' at 0xb0180e30> >
10:32:28.5456 dvb_ci/dvbci.cpp:937 gotPMT [eDVBCIInterfaces] gotPMT
10:32:28.5474 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux1
10:32:28.5475 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=1043
10:32:28.5751 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux1
10:32:28.5753 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=1028
10:32:28.6023 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux1
10:32:28.6024 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=1029
10:32:28.6803 dvb/frontend.cpp:2259 tuneLoopInt [SEC] set dynamic current limiting
10:32:28.6804 dvb/frontend.cpp:2399 tuneLoopInt [SEC-Master] tuner 2 RELEASE
10:32:28.6804 dvb/frontend.cpp:2402 tuneLoopInt [SEC-Master] tuner 2 release frontend
10:32:28.6882 dvb/frontend.cpp:2332 tuneLoopInt [SEC-Slave] tuner 0 end takeover frontend
10:32:28.6983 dvb/frontend.cpp:2417 tuneLoopInt [SEC] tuner 0 newTunertype 0
10:32:28.7540 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux1
10:32:28.7541 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=1030
10:32:28.8205 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux1
10:32:28.8206 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=1031
10:32:28.8267 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux1
10:32:28.8268 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=1033
10:32:28.8523 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux1
10:32:28.8524 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=1038
10:32:28.8939 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux1
10:32:28.8940 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=1039
10:32:28.9039 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux1
10:32:28.9039 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=1041
10:32:28.9289 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux1
10:32:28.9289 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=1043
10:32:28.9441 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux1
10:32:28.9441 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=1044
10:32:29.1343 dvb/frontend.cpp:916 closeFrontend [eDVBFrontend] try to close frontend 1
10:32:29.1343 dvb/frontend.cpp:976 closeFrontend [eDVBFrontend] dont close frontend 1 until the linked frontend 2 in slot 2 is still in use
10:32:29.6045 dvb/pmt.cpp:950 SDTScanEvent [eDVBServicePMTHandler] sdt update done!
10:32:29.6047 dvb/dvbtime.cpp:478 updateTime [eDVBLocalTimerHandler] Transponder time is 05.12.2017 10:32:29
10:32:29.6047 dvb/dvbtime.cpp:491 updateTime [eDVBLocalTimerHandler] diff is 0
10:32:29.6047 dvb/dvbtime.cpp:494 updateTime [eDVBLocalTimerHandler] diff < 120 .. use Transponder Time
10:32:29.6048 dvb/dvbtime.cpp:555 updateTime [eDVBLocalTimerHandler] not changed
10:32:29.6049 dvb/dvb.cpp:2410 getDemux [eDVBChannel] getDemux cap=00
10:32:30.3851 dvb/epgcache.cpp:1594 startEPG [eEPGCache] start caching events(1512466350)
10:32:30.3852 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=211
10:32:30.3857 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=561
10:32:30.3861 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=3842
10:32:30.3864 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=3003
10:32:30.3870 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=18
10:32:30.3876 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=18
10:32:30.3884 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=18
10:32:30.3894 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=5000
10:32:30.3898 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=5000
10:32:30.3903 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=57
10:32:31.3539 service/servicedvbrecord.cpp:570 gotNewEvent [eDVBServiceRecord] now running: LA MAÑANA DE LA 1 (12300 seconds)
10:32:31.3543 Components/Sources/StreamService.py:31 recordEvent [StreamService] RECORD event for us: <enigma.iRecordableServicePtr; proxy of <Swig Object of type 'ePtr< iRecordableService > *' at 0xb0180d10> >
10:32:31.3548 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux1
10:32:31.3549 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=18
10:32:36.7674 spanotifications/plugin/__init__.py:16 _ [spaNotifications fallback to default translation for VU+ type
10:32:36.7684 spanotifications/plugin/__init__.py:16 _ [spaNotifications fallback to default translation for VU+ type
10:32:36.7776 skin.py:1225 readSkin [SKIN] Parsing embedded skin <embedded-in-'Popup'>
10:32:36.7784 skin.py:1472 readSkin [SKIN] processing screen <embedded-in-'Popup'>:
10:32:36.7827 Components/GUISkin.py:35 createGUIScreen warning, skin is missing element text in <class 'plugin.Popup.Popup'>
10:32:36.7849 Screens/Screen.py:151 show [SCREENNAME] Popup
10:32:36.7890 skin.py:1472 readSkin [SKIN] processing screen SimpleSummary:
10:32:36.7979 Screens/Screen.py:151 show [SCREENNAME] ['Popup_summary', 'SimpleSummary']
10:32:36.7996 Screens/Screen.py:151 show [SCREENNAME] Popup
10:32:37.3906 dvb/epgcache.cpp:1950 abortNonAvail [eEPGCache] abort non avail schedule reading
10:32:37.3917 dvb/epgcache.cpp:1957 abortNonAvail [eEPGCache] abort non avail schedule other reading
10:32:37.3922 dvb/epgcache.cpp:1981 abortNonAvail [eEPGCache] abort non avail netmed schedule reading
10:32:37.3925 dvb/epgcache.cpp:1988 abortNonAvail [eEPGCache] abort non avail netmed schedule other reading
10:32:37.3927 dvb/epgcache.cpp:1997 abortNonAvail [eEPGCache] abort non avail FreeSat schedule_other reading
10:32:37.3929 dvb/epgcache.cpp:2008 abortNonAvail [eEPGCache] abort non avail viasat reading
10:32:37.3929 dvb/epgcache.cpp:2016 abortNonAvail [eEPGCache] abort non avail mhw reading
10:32:37.4096 dvb/epgcache.cpp:2269 readData [eEPGCache] nownext finished(1512466357)
10:32:37.4106 dvb/epgcache.cpp:1573 finishEPG [eEPGCache] stop caching events(1512466357)
10:32:37.4109 dvb/epgcache.cpp:1575 finishEPG [eEPGCache] next update in 60 min
10:32:41.7889 Screens/Screen.py:151 show [SCREENNAME] InfoBarSummary
10:32:41.7945 dvb/dvbtime.cpp:379 syncDVBTime [eDVBLocalTimeHandler] sync local time with transponder time!
10:32:41.7946 dvb/dvb.cpp:2410 getDemux [eDVBChannel] getDemux cap=00
10:32:41.7947 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0
10:32:41.7947 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=20
10:32:41.7953 dvb/dvb.cpp:2410 getDemux [eDVBChannel] getDemux cap=00
10:32:41.7954 dvb/demux.cpp:66 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux1
10:32:41.7954 dvb/demux.cpp:262 start [eDVBSectionReader] DMX_SET_FILTER pid=20
10:32:41.8067 gdi/gpixmap.cpp:725 blit [gPixmap] ignore unsupported 8bpp -> 16bpp alphablend!
10:32:41.8073 gdi/gpixmap.cpp:725 blit [gPixmap] ignore unsupported 8bpp -> 16bpp alphablend!
10:32:41.9347 dvb/dvbtime.cpp:478 updateTime [eDVBLocalTimerHandler] Transponder time is 05.12.2017 10:32:41
10:32:41.9348 dvb/dvbtime.cpp:491 updateTime [eDVBLocalTimerHandler] diff is 0
10:32:41.9348 dvb/dvbtime.cpp:494 updateTime [eDVBLocalTimerHandler] diff < 120 .. use Transponder Time
10:32:41.9348 dvb/dvbtime.cpp:555 updateTime [eDVBLocalTimerHandler] not changed
10:32:41.9350 dvb/dvb.cpp:2410 getDemux [eDVBChannel] getDemux cap=00
10:32:41.9366 dvb/dvbtime.cpp:478 updateTime [eDVBLocalTimerHandler] Transponder time is 05.12.2017 10:32:41
10:32:41.9366 dvb/dvbtime.cpp:491 updateTime [eDVBLocalTimerHandler] diff is 0
10:32:41.9366 dvb/dvbtime.cpp:494 updateTime [eDVBLocalTimerHandler] diff < 120 .. use Transponder Time
10:32:41.9366 dvb/dvbtime.cpp:555 updateTime [eDVBLocalTimerHandler] not changed
10:32:41.9369 dvb/dvb.cpp:2410 getDemux [eDVBChannel] getDemux cap=00
10:32:49.4129 spanotifications/plugin/__init__.py:16 _ [spaNotifications fallback to default translation for VU+ type
10:32:49.4139 spanotifications/plugin/__init__.py:16 _ [spaNotifications fallback to default translation for VU+ type
10:33:00.8632 spanotifications/plugin/__init__.py:16 _ [spaNotifications fallback to default translation for VU+ type
10:33:00.8646 spanotifications/plugin/__init__.py:16 _ [spaNotifications fallback to default translation for VU+ type
netstat: showing only processes with your user ID
10:33:12.3694 spanotifications/plugin/__init__.py:16 _ [spaNotifications fallback to default translation for VU+ type
10:33:12.3721 spanotifications/plugin/__init__.py:16 _ [spaNotifications fallback to default translation for VU+ type
10:33:23.5512 spanotifications/plugin/__init__.py:16 _ [spaNotifications fallback to default translation for VU+ type
10:33:23.5522 spanotifications/plugin/__init__.py:16 _ [spaNotifications fallback to default translation for VU+ type
10:33:29.1344 dvb/frontend.cpp:916 closeFrontend [eDVBFrontend] try to close frontend 1
10:33:29.1345 dvb/frontend.cpp:976 closeFrontend [eDVBFrontend] dont close frontend 1 until the linked frontend 2 in slot 2 is still in use
10:33:34.7304 spanotifications/plugin/__init__.py:16 _ [spaNotifications fallback to default translation for VU+ type
10:33:34.7316 spanotifications/plugin/__init__.py:16 _ [spaNotifications fallback to default translation for VU+ type
10:33:45.9356 spanotifications/plugin/__init__.py:16 _ [spaNotifications fallback to default translation for VU+ type
10:33:45.9367 spanotifications/plugin/__init__.py:16 _ [spaNotifications fallback to default translation for VU+ type
netstat: showing only processes with your user ID
10:33:57.1124 spanotifications/plugin/__init__.py:16 _ [spaNotifications fallback to default translation for VU+ type
10:33:57.1134 spanotifications/plugin/__init__.py:16 _ [spaNotifications fallback to default translation for VU+ type
10:34:08.2823 spanotifications/plugin/__init__.py:16 _ [spaNotifications fallback to default translation for VU+ type
10:34:08.2833 spanotifications/plugin/__init__.py:16 _ [spaNotifications fallback to default translation for VU+ type
10:34:20.0281 spanotifications/plugin/__init__.py:16 _ [spaNotifications fallback to default translation for VU+ type
10:34:20.0293 spanotifications/plugin/__init__.py:16 _ [spaNotifications fallback to default translation for VU+ type
10:34:21.6085 Components/Sources/StreamService.py:56 execEnd [StreamService] execEnd 1:0:19:7863:41A:1:C00000:0:0:0:
10:34:21.6088 service/servicedvbrecord.cpp:179 stop [eDVBServiceRecord] stop recording!
10:34:21.6089 service/servicedvbrecord.cpp:586 saveCutlist [eDVBServiceRecord] saving cutlist failed because tstools failed
10:34:21.6335 dvb/cahandler.cpp:333 unregisterService [eDVBCAService] free slot 0 demux 1 for service 1:0:19:7863:41A:1:C00000:0:0:0:
10:34:21.6336 dvb/cahandler.cpp:497 ~eDVBCAService [eDVBCAService] free service 1:0:19:7863:41A:1:C00000:0:0:0:
10:34:21.6343 dvb/dvb.cpp:1490 DVBChannelStateChanged [eDVBResourceManager] start release channel timer
10:34:21.6383 /usr/lib/python2.7/site-packages/twisted/logger/_file.py:66 __call__ Unhandled error in Deferred:
10:34:21.6389 /usr/lib/python2.7/site-packages/twisted/logger/_file.py:66 __call__
Traceback (most recent call last):
Failure: twisted.internet.error.ConnectionLost: Connection to the other side was lost in a non-clean fashion.
10:34:21.6444 Tools/Trashcan.py:130 work [Trashcan] probing folders
10:34:21.6830 Tools/Trashcan.py:150 work [Trashcan] found following trashcan's: ['/media/hdd/movie/.Trash']
10:34:21.6831 Tools/Trashcan.py:153 work [Trashcan] looking in trashcan /media/hdd/movie/.Trash
10:34:21.6847 Tools/Trashcan.py:158 work [Trashcan] /media/hdd/movie/.Trash: Size: 0
10:34:21.6849 Tools/Trashcan.py:192 work [Trashcan] /media/hdd/movie/.Trash: Size now: 0
10:34:21.6861 Components/Task.py:375 jobDone job Compone