Do Mär 2 20:12:08 2017 Feb 28 2017 XionHDF/skin.xml 2017-02-26 5.5 ultimo bmem=192M@64M console=ttyS0,1000000 ubi.mtd=rootfs root=ubi0:dreambox-rootfs rootfstype=ubifs rw NIM Socket 0: driver/hdmi_cec.cpp:373 hdmiEvent eHdmiCEC: received message 89 01 20:11:58.0635 [ ] dvb/frontend.cpp:791 feEvent (0)fe event: status 0, inversion off, m_tuning 1 20:11:58.0750 < > driver/hdmi_cec.cpp:373 hdmiEvent eHdmiCEC: received message 00 20:11:58.0773 < > driver/hdmi_cec.cpp:373 hdmiEvent eHdmiCEC: received message 89 01 20:11:58.0788 < > driver/hdmi_cec.cpp:373 hdmiEvent eHdmiCEC: received message 89 01 20:11:58.0822 < > driver/hdmi_cec.cpp:373 hdmiEvent eHdmiCEC: received message 00 20:11:58.0853 < > driver/hdmi_cec.cpp:373 hdmiEvent eHdmiCEC: received message 89 01 20:11:58.0875 { } Components/Network.py:125 routeFinished 0.0.0.0 20:11:58.0882 { } Components/Network.py:125 routeFinished 192.168 20:11:58.1307 { E } plugin/controllers/SR.py:24 __init__ SerienRecorder plugin not found 20:11:58.1557 { } plugin/httpserver.py:177 HttpdStart [OpenWebif] started on 80 20:11:58.1570 [ ] base/ebase.cpp:290 processOneEvent poll: unhandled POLLERR/HUP/NVAL for fd 46(16) 20:11:58.1594 < > driver/hdmi_cec.cpp:373 hdmiEvent eHdmiCEC: received message 89 01 20:11:58.1639 [ ] dvb/frontend.cpp:791 feEvent (0)fe event: status 3, inversion off, m_tuning 2 20:11:58.1648 < > driver/hdmi_cec.cpp:373 hdmiEvent eHdmiCEC: received message 00 20:11:58.1663 < > driver/hdmi_cec.cpp:373 hdmiEvent eHdmiCEC: received message 89 01 20:11:58.2327 [ ] dvb/frontend.cpp:791 feEvent (0)fe event: status 1f, inversion off, m_tuning 3 20:11:58.2329 [ ] dvb/dvb.cpp:1718 frontendStateChanged OURSTATE: tuner 0 ok 20:11:58.2331 [ ] dvb/dvbtime.cpp:588 DVBChannelStateChanged [eDVBLocalTimerHandler] channel 0xf303b0 running 20:11:58.2342 [ ] dvb/epgcache.cpp:644 DVBChannelStateChanged [eEPGCache] channel 0xf303b0 running 20:11:58.2350 [ ] dvb/epgcache.cpp:1854 startChannel [EPGC] next update in 2 sec 20:11:58.2352 [ ] dvb/dvb.cpp:1333 DVBChannelStateChanged stop release channel timer 20:11:58.2353 [ ] dvb/pmt.cpp:67 channelStateChanged ok ... now we start!! 20:11:58.2354 [ ] service/servicedvb.cpp:1218 serviceEvent eventNewProgramInfo 0 0 20:11:58.2355 < > service/servicedvb.cpp:2788 updateDecoder have 1 video stream(s) (00a6), and 1 audio stream(s) (0080), and the pcr pid is 00a6, and the text pid is 0044 20:11:58.2358 [ ] dvb/dvb.cpp:1038 allocateDemux allocate demux 20:11:58.2581 [ ] dvb/decoder.cpp:829 setState decoder state: play, vpid=166, apid=128 20:11:58.2583 < > dvb/decoder.cpp:702 startPid DMX_SET_PES_FILTER(0xa6) - pcr - ok 20:11:58.2586 < > dvb/decoder.cpp:710 startPid DEMUX_START - pcr - ok 20:11:58.2603 < > dvb/decoder.cpp:84 startPid DMX_SET_PES_FILTER(0x80) - audio - ok 20:11:58.2607 < > dvb/decoder.cpp:92 startPid DEMUX_START - audio - ok 20:11:58.2609 < > dvb/decoder.cpp:138 startPid AUDIO_SET_BYPASS(1) - ok 20:11:58.2654 < > dvb/decoder.cpp:191 freeze AUDIO_PAUSE - ok 20:11:58.2657 < > dvb/decoder.cpp:146 startPid AUDIO_PLAY - ok 20:11:58.2690 [ ] dvb/decoder.cpp:267 eDVBVideo Video Device: /dev/dvb/adapter0/video0 20:11:58.2692 [ ] dvb/decoder.cpp:274 eDVBVideo demux device: /dev/dvb/adapter0/demux0 20:11:58.2705 < > dvb/decoder.cpp:354 startPid VIDEO_SET_STREAMTYPE 0 - ok 20:11:58.2707 < > dvb/decoder.cpp:389 startPid DMX_SET_PES_FILTER(0xa6) - video - ok 20:11:58.2709 < > dvb/decoder.cpp:397 startPid DEMUX_START - video - ok 20:11:58.2724 < > dvb/decoder.cpp:458 freeze VIDEO_FREEZE - ok 20:11:58.2726 < > dvb/decoder.cpp:412 startPid VIDEO_PLAY - ok 20:11:58.2803 < > dvb/decoder.cpp:779 startPid DMX_SET_PES_FILTER(0x44) - ttx - ok 20:11:58.2806 < > dvb/decoder.cpp:787 startPid DEMUX_START - ttx - ok 20:11:58.2887 < > dvb/decoder.cpp:482 setSlowMotion VIDEO_SLOWMOTION(0) - ok 20:11:58.2889 < > dvb/decoder.cpp:497 setFastForward VIDEO_FAST_FORWARD(0) - ok 20:11:58.2891 < > dvb/decoder.cpp:470 unfreeze VIDEO_CONTINUE - ok 20:11:58.2892 < > dvb/decoder.cpp:203 unfreeze AUDIO_CONTINUE - ok 20:11:58.2893 < > dvb/decoder.cpp:222 setChannel AUDIO_CHANNEL_SELECT(0) - ok 20:11:58.2896 [ ] dvb/teletext.cpp:640 setPageAndMagazine disable teletext subtitles page ffffffffffffffff (und) 20:11:58.2972 { E } Components/Pixmap.py:133 setPixmapNum setPixmapNum(0) failed! defined pixmaps: [] 20:11:58.3214 { } Plugins/Extensions/Volume_adjust/plugin.py:469 __evUpdatedInfo [Volume Adjust] Update Info 20:11:58.3219 { } Plugins/Extensions/Volume_adjust/plugin.py:473 __evUpdatedInfo [Volume Adjust] Volume = 70 20:11:58.3230 { } Plugins/Extensions/Volume_adjust/plugin.py:447 loadXML [Volume Adjust] load xml... 20:11:58.3241 { } Plugins/Extensions/Volume_adjust/plugin.py:484 __evUpdatedInfo [Volume Adjust] New Channel 20:11:58.3246 { } Plugins/Extensions/Volume_adjust/plugin.py:489 __evUpdatedInfo [Volume Adjust] oldvol = 0 20:11:58.3988 [ ] dvb/cahandler.cpp:263 registerService [eDVBCAService] new service 1:0:1:2EF4:441:1:FFFF0000:0:0:0: 20:11:58.3990 [ ] dvb/cahandler.cpp:281 registerService [eDVBCAService] add demux 0 to slot 0 service 1:0:1:2EF4:441:1:FFFF0000:0:0:0: 20:11:58.4771 { E } Tools/Notifications.py:36 RemovePopup RemovePopup, id = ZapError 20:11:58.4787 < > dvb/decoder.cpp:540 video_event VIDEO_GET_EVENT - ok 20:11:58.4926 < > dvb/decoder.cpp:540 video_event VIDEO_GET_EVENT - ok 20:11:58.4940 < > dvb/decoder.cpp:540 video_event VIDEO_GET_EVENT - ok unhandled DVBAPI Video Event 32 20:11:58.4957 [ ] dvb/pmt.cpp:187 PATready PATready 20:11:58.4959 [ ] dvb/pmt.cpp:198 PATready PAT TSID: 0x0441 (1089) 20:11:58.4961 [ ] dvb/pmt.cpp:227 PATready use pmtpid 002e for service_id 2ef4 20:11:58.5044 < > dvb/decoder.cpp:540 video_event VIDEO_GET_EVENT - ok 20:11:58.5130 < > dvb/decoder.cpp:540 video_event VIDEO_GET_EVENT - ok unhandled DVBAPI Video Event 32 20:11:58.5257 [ ] dvb/pmt.cpp:737 SDTScanEvent sdt update done! 20:11:58.5926 { } Plugins/Extensions/EnhancedMovieCenter/EMCTasker.py:43 emcDebugOut EMC: Setting EPG language: de_DE 20:11:58.8589 [ ] service/servicedvb.cpp:1218 serviceEvent eventNewProgramInfo 0 0 20:11:58.8630 < > service/servicedvb.cpp:2788 updateDecoder have 1 video stream(s) (00a6), and 1 audio stream(s) (0080), and the pcr pid is 00a6, and the text pid is 0044 20:11:58.8638 [ ] dvb/decoder.cpp:829 setState decoder state: play, vpid=166, apid=128 20:11:58.8820 { } Plugins/Extensions/Volume_adjust/plugin.py:469 __evUpdatedInfo [Volume Adjust] Update Info 20:11:58.8824 { } Plugins/Extensions/Volume_adjust/plugin.py:473 __evUpdatedInfo [Volume Adjust] Volume = 70 20:11:58.8830 { } Plugins/Extensions/Volume_adjust/plugin.py:447 loadXML [Volume Adjust] load xml... 20:11:58.9372 [ ] dvb_ci/dvbci.cpp:867 gotPMT [eDVBCIInterfaces] gotPMT 20:11:58.9484 { } Components/AVSwitch.py:328 setPolicy43 [VideoMode] setting policy: panscan 20:11:58.9508 { } Components/AVSwitch.py:335 setPolicy169 [VideoMode] setting policy2: panscan 20:11:58.9770 < > driver/hdmi_cec.cpp:373 hdmiEvent eHdmiCEC: received message 89 01 20:11:59.2834 < > dvb/decoder.cpp:540 video_event VIDEO_GET_EVENT - ok 20:11:59.5831 [ ] dvb/pmt.cpp:237 AITready AITready 20:12:00.2444 [ ] dvb/epgcache.cpp:1558 startEPG [EPGC] start caching events 20:12:00.6495 { } Plugins/Extensions/HbbTV/aitreader.py:96 doDump Name : RTL2 Start 20:12:00.6499 { } Plugins/Extensions/HbbTV/aitreader.py:97 doDump URL : http://www.rtl2.de/hbbtvp 20:12:00.6503 { } Plugins/Extensions/HbbTV/aitreader.py:98 doDump OrgID : 26 20:12:00.6507 { } Plugins/Extensions/HbbTV/aitreader.py:99 doDump AppID : 700 20:12:00.6511 { } Plugins/Extensions/HbbTV/aitreader.py:100 doDump Control Code : 1 20:12:00.6514 { } Plugins/Extensions/HbbTV/aitreader.py:101 doDump Profile Code : 0 20:12:00.6517 { } Plugins/Extensions/HbbTV/aitreader.py:102 doDump 20:12:00.6648 { } Components/AVSwitch.py:328 setPolicy43 [VideoMode] setting policy: panscan 20:12:00.6682 { } Components/AVSwitch.py:335 setPolicy169 [VideoMode] setting policy2: panscan 20:12:00.7713 { } Plugins/Extensions/EnhancedMovieCenter/VlcPluginInterface.py:54 [VLC] Checking for buildin servicets ... no 20:12:00.7727 { E } Plugins/Extensions/EnhancedMovieCenter/VlcPluginInterface.py:59 [VLC] Checking for existing and usable servicets.so ... No module named servicets 20:12:00.7733 { } Plugins/Extensions/EnhancedMovieCenter/VlcPluginInterface.py:62 [VLC] Checking for usable gstreamer service ... yes 20:12:01.0608 { E } Plugins/Extensions/EnhancedMovieCenter/MovieSelection.py:90 [EMCMS] python-mutagen is not available: No module named mutagen.mp3 20:12:01.0686 { } Plugins/Extensions/EnhancedMovieCenter/EMCTasker.py:43 emcDebugOut EMC: Next trashcan cleanup in 288 minutes 20:12:03.0702 { } Plugins/Extensions/EnhancedMovieCenter/EMCTasker.py:43 emcDebugOut EMC: [EMCMS] trashcan cleanup: no trashcan... 20:12:03.4342 { } skin.py:971 readSkin [SKIN] Parsing embedded skin 20:12:03.4370 { } skin.py:1158 readSkin [SKIN] processing screen : 20:12:03.4710 [ ] service/servicedvb.cpp:2405 startTimeshift Start timeshift! 20:12:03.4718 [ ] service/servicedvb.cpp:2436 startTimeshift recording to /media/hdd/timeshift/timeshift.2y65VI 20:12:03.4734 [ ] base/ioprio.cpp:83 setIoPrio setIoPrio realtime level 7 ok 20:12:03.4736 [ ] base/filepush.cpp:372 thread [eFilePushThreadRecorder] THREAD START 20:12:03.4856 { } Plugins/Extensions/PermanentTimeshift/plugin.py:1425 ptsCreateEITFile PTS Plugin: /usr/lib/enigma2/python/Plugins/Extensions/PermanentTimeshift/eitsave.so: undefined symbol: _ZN9eEPGCache10cache_lockE 20:12:06.8160 < > driver/hdmi_cec.cpp:373 hdmiEvent eHdmiCEC: received message 00 20:12:06.9093 < > driver/hdmi_cec.cpp:373 hdmiEvent eHdmiCEC: received message 89 01 20:12:07.2489 [ ] dvb/epgcache.cpp:1748 abortNonAvail [EPGC] abort non avail schedule other reading 20:12:07.2494 [ ] dvb/epgcache.cpp:1772 abortNonAvail [EPGC] abort non avail netmed schedule reading 20:12:07.2497 [ ] dvb/epgcache.cpp:1779 abortNonAvail [EPGC] abort non avail netmed schedule other reading 20:12:07.2499 [ ] dvb/epgcache.cpp:1788 abortNonAvail [EPGC] abort non avail FreeSat schedule_other reading 20:12:07.2501 [ ] dvb/epgcache.cpp:1799 abortNonAvail [EPGC] abort non avail viasat reading 20:12:07.4301 < > dvb/epgcache.cpp:2046 readData [EPGC] nownext 20:12:07.4302 [ ] dvb/epgcache.cpp:2087 readData finished(1488481927) 20:12:08.2387 [ ] driver/rcinput.cpp:23 handleCode 1 cf 1 20:12:08.2406 { } Components/ActionMap.py:46 action action -> InfobarTimeshiftActivateActions timeshiftActivateEndAndPause 20:12:08.2416 [ ] dvb/decoder.cpp:829 setState decoder state: play, vpid=-1, apid=-1 20:12:08.2417 < > dvb/decoder.cpp:723 stop DEMUX_STOP - pcr - ok 20:12:08.2425 < > dvb/decoder.cpp:425 stop DEMUX_STOP - video - ok 20:12:08.2452 < > dvb/decoder.cpp:434 stop VIDEO_STOP - ok 20:12:08.2462 < > dvb/decoder.cpp:159 stop AUDIO_STOP - ok 20:12:08.2674 < > dvb/decoder.cpp:167 stop DEMUX_STOP - audio - ok 20:12:08.2703 < > dvb/decoder.cpp:203 unfreeze AUDIO_CONTINUE - ok 20:12:08.2706 < > dvb/decoder.cpp:800 stop DEMUX_STOP - ttx - ok 20:12:08.2845 [ ] dvb/pmt.cpp:806 tuneExt alloc PVR 20:12:08.2847 [ ] dvb/dvb.cpp:1038 allocateDemux allocate demux 20:12:08.2858 [ ] dvb/tstools.cpp:96 setSource loading streaminfo for /media/hdd/timeshift/timeshift.2y65VI 20:12:08.2860 [ E ] base/cfile.h:17 CFile error /media/hdd/timeshift/timeshift.2y65VI.ap [No such file or directory] 20:12:08.2868 [ ] base/ioprio.cpp:83 setIoPrio setIoPrio best-effort level 0 ok 20:12:08.2868 [ ] dvb/pmt.cpp:67 channelStateChanged ok ... now we start!! 20:12:08.2870 [ ] base/filepush.cpp:60 thread FILEPUSH THREAD START 20:12:08.2870 [ ] service/servicedvb.cpp:1254 serviceEventTimeshift eventNewProgramInfo TS 20:12:08.2873 < > service/servicedvb.cpp:2788 updateDecoder have 1 video stream(s) (00a6), and 1 audio stream(s) (0080), and the pcr pid is 00a6, and the text pid is 0044 20:12:08.2880 [ ] dvb/dvb.cpp:1994 getNextSourceSpan seeking relative to end. len=399600, seek = -1000 20:12:08.2884 [ ] dvb/tstools.cpp:651 takeSamples samples step 41942988, pts begin 6831927825, pts end 6832327425, offs begin 14316, offs end 2495164: 20:12:08.2888 [ ] dvb/tstools.cpp:124 getPTS eDVBTSTools::getPTS got it from sc file offset=14316 pts=6831927825 20:12:08.2891 [ ] dvb/tstools.cpp:694 takeSample adding sample 14316: pts 0 -> pos 14316 (diff 0 bytes) 20:12:08.2895 [ ] dvb/tstools.cpp:411 getOffset using: 0:399600 -> 14316:2495164 20:12:08.2899 [ ] dvb/tstools.cpp:124 getPTS eDVBTSTools::getPTS got it from sc file offset=2452488 pts=6832334625 20:12:08.2900 [ ] dvb/tstools.cpp:694 takeSample adding sample 2488932: pts 406800 -> pos 2452488 (diff -36444 bytes) 20:12:08.2902 [ ] dvb/tstools.cpp:444 getOffset calculated diff 91 ms 20:12:08.2903 [ ] dvb/tstools.cpp:461 getOffset aborting. Taking 2488932 as offset for 406800 20:12:08.2904 [ ] dvb/dvb.cpp:2040 getNextSourceSpan ok, resolved skip (rel: 0, diff 406800), now at 0025fa64 20:12:08.2978 [ ] dvb/decoder.cpp:829 setState decoder state: play, vpid=166, apid=128 20:12:08.2988 < > dvb/decoder.cpp:84 startPid DMX_SET_PES_FILTER(0x80) - audio - ok 20:12:08.2992 < > dvb/decoder.cpp:92 startPid DEMUX_START - audio - ok 20:12:08.2993 < > dvb/decoder.cpp:138 startPid AUDIO_SET_BYPASS(1) - ok 20:12:08.3024 < > dvb/decoder.cpp:191 freeze AUDIO_PAUSE - ok 20:12:08.3027 < > dvb/decoder.cpp:146 startPid AUDIO_PLAY - ok 20:12:08.3054 [ ] dvb/decoder.cpp:267 eDVBVideo Video Device: /dev/dvb/adapter0/video0 20:12:08.3056 [ ] dvb/decoder.cpp:274 eDVBVideo demux device: /dev/dvb/adapter0/demux4 20:12:08.3069 < > dvb/decoder.cpp:354 startPid VIDEO_SET_STREAMTYPE 0 - ok 20:12:08.3071 < > dvb/decoder.cpp:389 startPid DMX_SET_PES_FILTER(0xa6) - video - ok 20:12:08.3072 < > dvb/decoder.cpp:397 startPid DEMUX_START - video - ok 20:12:08.3089 < > dvb/decoder.cpp:458 freeze VIDEO_FREEZE - ok 20:12:08.3091 < > dvb/decoder.cpp:412 startPid VIDEO_PLAY - ok 20:12:08.3164 < > dvb/decoder.cpp:779 startPid DMX_SET_PES_FILTER(0x44) - ttx - ok 20:12:08.3169 < > dvb/decoder.cpp:787 startPid DEMUX_START - ttx - ok 20:12:08.3222 < > dvb/decoder.cpp:482 setSlowMotion VIDEO_SLOWMOTION(0) - ok 20:12:08.3224 < > dvb/decoder.cpp:497 setFastForward VIDEO_FAST_FORWARD(0) - ok 20:12:08.3226 < > dvb/decoder.cpp:470 unfreeze VIDEO_CONTINUE - ok 20:12:08.3230 < > dvb/decoder.cpp:203 unfreeze AUDIO_CONTINUE - ok 20:12:08.3232 [ ] dvb/teletext.cpp:640 setPageAndMagazine disable teletext subtitles page ffffffffffffffff (und) 20:12:08.3443 { } Plugins/Extensions/Volume_adjust/plugin.py:469 __evUpdatedInfo [Volume Adjust] Update Info 20:12:08.3448 { } Plugins/Extensions/Volume_adjust/plugin.py:473 __evUpdatedInfo [Volume Adjust] Volume = 70 20:12:08.3451 { } Plugins/Extensions/Volume_adjust/plugin.py:447 loadXML [Volume Adjust] load xml... 20:12:08.3472 [ ] service/servicedvb.cpp:2771 switchToTimeshift eDVBServicePlay::switchToTimeshift, in pause mode now. 20:12:08.3474 [ ] service/servicedvb.cpp:1624 pause eDVBServicePlay::pause 20:12:08.3474 [ ] dvb/decoder.cpp:829 setState decoder state: pause, vpid=166, apid=128 20:12:08.3476 < > dvb/decoder.cpp:482 setSlowMotion VIDEO_SLOWMOTION(0) - ok 20:12:08.3477 < > dvb/decoder.cpp:497 setFastForward VIDEO_FAST_FORWARD(0) - ok 20:12:08.3478 < > dvb/decoder.cpp:458 freeze VIDEO_FREEZE - ok 20:12:08.3479 < > dvb/decoder.cpp:191 freeze AUDIO_PAUSE - ok 20:12:08.3488 < > service/servicedvb.cpp:2788 updateDecoder have 1 video stream(s) (00a6), and 1 audio stream(s) (0080), and the pcr pid is 00a6, and the text pid is 0044 20:12:08.3495 [ ] dvb/decoder.cpp:829 setState decoder state: pause, vpid=166, apid=128 20:12:08.3549 [ ] service/servicedvb.cpp:1624 pause eDVBServicePlay::pause 20:12:08.3570 [ E ] python/python.cpp:209 call (PyObject_CallObject(>,('InfobarTimeshiftActivateActions', 'timeshiftActivateEndAndPause')) failed) 20:12:08.5412 [ ] base/filepush.cpp:159 thread wait for driver eof timeout 20:12:08.7941 [ ] base/filepush.cpp:159 thread wait for driver eof timeout 20:12:09.0471 [ ] base/filepush.cpp:159 thread wait for driver eof timeout ]]>