openHDF Enigma2 crash log crashdate=Mo Jan 22 23:03:03 2018 compiledate=Jan 21 2018 skin=XionHDF/skin.xml sourcedate=2018-01-21 branch=master rev=df7de1c component=Enigma2 stbmodel=hd51 stbmodel=hd51 kernelcmdline=brcm_cma=440M@328M brcm_cma=192M@768M root=/dev/mmcblk0p3 rw rootwait hd51_4.boxmode=1 brcm_cma=440M@328M brcm_cma=192M@768M console=ttyS0,115200 nimsockets=NIM Socket 0: imageversion=box_type=mutant51 imageissue=Welcome to OpenEmbedded Linux OE-Alliance for %h 23:01:46.7104 [ ] dvb/demux.cpp:90 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0 23:01:46.7105 [ ] dvb/demux.cpp:286 start [eDVBSectionReader] DMX_SET_FILTER pid=5100 23:01:46.7109 [ ] dvb/demux.cpp:90 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0 23:01:46.7110 [ ] dvb/demux.cpp:286 start [eDVBSectionReader] DMX_SET_FILTER pid=0 23:01:46.7123 [ ] base/ebase.cpp:279 processOneEvent poll: unhandled POLLERR/HUP/NVAL for fd 77(16) 23:01:46.7125 [ ] base/ebase.cpp:279 processOneEvent poll: unhandled POLLERR/HUP/NVAL for fd 80(16) 23:01:46.7216 [ ] base/ebase.cpp:279 processOneEvent poll: unhandled POLLERR/HUP/NVAL for fd 86(16) 23:01:46.7219 [ ] base/ebase.cpp:279 processOneEvent poll: unhandled POLLERR/HUP/NVAL for fd 89(16) 23:01:46.7221 [ ] base/ebase.cpp:279 processOneEvent poll: unhandled POLLERR/HUP/NVAL for fd 92(16) 23:01:46.7223 [ ] base/ebase.cpp:279 processOneEvent poll: unhandled POLLERR/HUP/NVAL for fd 95(16) 23:01:46.7223 [ ] base/ebase.cpp:279 processOneEvent poll: unhandled POLLERR/HUP/NVAL for fd 98(16) 23:01:46.7254 [ ] dvb/demux.cpp:90 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0 23:01:46.7255 [ ] dvb/demux.cpp:286 start [eDVBSectionReader] DMX_SET_FILTER pid=5100 23:01:46.7273 [ ] dvb/demux.cpp:90 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0 23:01:46.7275 [ ] dvb/demux.cpp:286 start [eDVBSectionReader] DMX_SET_FILTER pid=17 23:01:46.7279 [ ] base/ebase.cpp:279 processOneEvent poll: unhandled POLLERR/HUP/NVAL for fd 101(16) 23:01:46.7307 [ ] base/ebase.cpp:279 processOneEvent poll: unhandled POLLERR/HUP/NVAL for fd 112(16) 23:01:46.7507 [ ] service/servicedvb.cpp:1203 serviceEvent [eDVBServicePlay] eventNewProgramInfo timeshift_enabled=0 timeshift_active=0 23:01:46.7509 [ ] dvb/pmtparse.cpp:238 getProgramInfo [eDVBPMTParser] dvb subtitle PID 13f1 with wrong subtitling type (24)... force 0x10!! 23:01:46.7509 [ ] dvb/pmtparse.cpp:389 getProgramInfo [eDVBPMTParser] Rds PID 13f4 detected ? ! ? 23:01:46.7514 [ ] dvb/demux.cpp:90 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0 23:01:46.7515 [ ] dvb/demux.cpp:286 start [eDVBSectionReader] DMX_SET_FILTER pid=1170 23:01:46.7520 < > service/servicedvb.cpp:2877 updateDecoder [eDVBServicePlay] have 1 video stream(s) (13ed), and 3 audio stream(s) (13ee, 13ef, 13f2), and the pcr pid is 13ed, and the text pid is 13f0 23:01:46.7523 [ ] service/servicedvb.cpp:3561 setAC3Delay [eDVBServicePlay] Setting audio delay: setAC3Delay, 0 + 0 23:01:46.7524 [ ] service/servicedvb.cpp:3572 setPCMDelay [eDVBServicePlay] Setting audio delay: setPCMDelay, 0 + 0 23:01:46.7524 [ ] dvb/decoder.cpp:836 setState [eTSMPEGDecoder] decoder state: play, vpid=13ed, apid=13f2 23:01:46.7544 [ ] dvb/pmtparse.cpp:238 getProgramInfo [eDVBPMTParser] dvb subtitle PID 13f1 with wrong subtitling type (24)... force 0x10!! 23:01:46.7545 [ ] dvb/pmtparse.cpp:389 getProgramInfo [eDVBPMTParser] Rds PID 13f4 detected ? ! ? 23:01:46.7550 [ ] dvb/demux.cpp:90 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0 23:01:46.7551 [ ] dvb/demux.cpp:286 start [eDVBSectionReader] DMX_SET_FILTER pid=1170 23:01:46.7599 { } Plugins/Extensions/Volume_adjust/plugin.py:469 __evUpdatedInfo [Volume Adjust] Update Info 23:01:46.7600 { } Plugins/Extensions/Volume_adjust/plugin.py:473 __evUpdatedInfo [Volume Adjust] Volume = 100 23:01:46.7601 { } Plugins/Extensions/Volume_adjust/plugin.py:447 loadXML [Volume Adjust] load xml... 23:01:46.7633 [ ] dvb_ci/dvbci.cpp:1049 gotPMT [eDVBCIInterfaces] gotPMT 23:01:46.7647 [ ] dvb/demux.cpp:90 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0 23:01:46.7648 [ ] dvb/demux.cpp:286 start [eDVBSectionReader] DMX_SET_FILTER pid=5100 23:01:46.7656 [ ] dvb/demux.cpp:90 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0 23:01:46.7657 [ ] dvb/demux.cpp:286 start [eDVBSectionReader] DMX_SET_FILTER pid=5110 23:01:46.7675 [ ] base/ebase.cpp:279 processOneEvent poll: unhandled POLLERR/HUP/NVAL for fd 106(16) 23:01:46.7675 [ ] base/ebase.cpp:279 processOneEvent poll: unhandled POLLERR/HUP/NVAL for fd 109(16) 23:01:46.7678 [ ] base/ebase.cpp:279 processOneEvent poll: unhandled POLLERR/HUP/NVAL for fd 118(16) 23:01:46.7678 [ ] base/ebase.cpp:279 processOneEvent poll: unhandled POLLERR/HUP/NVAL for fd 121(16) 23:01:46.7747 [ ] base/ebase.cpp:279 processOneEvent poll: unhandled POLLERR/HUP/NVAL for fd 115(16) 23:01:46.8191 [ ] dvb/frontend.cpp:2260 tuneLoopInt [SEC] set dynamic current limiting 23:01:46.9773 [ ] dvb/demux.cpp:90 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0 23:01:46.9775 [ ] dvb/demux.cpp:286 start [eDVBSectionReader] DMX_SET_FILTER pid=5120 23:01:46.9815 [ ] dvb/dvbtime.cpp:469 updateTime [eDVBLocalTimerHandler] Transponder time is 22.01.2018 23:01:46 23:01:46.9816 [ ] dvb/dvbtime.cpp:535 updateTime [eDVBLocalTimerHandler] dont have correction.. set Transponder Diff 23:01:46.9816 [ ] dvb/dvbtime.cpp:49 setRTC [eDVBLocalTimerHandler] set RTC Time 23:01:46.9818 [ ] dvb/dvbtime.cpp:555 updateTime [eDVBLocalTimerHandler] update RTC 23:01:46.9818 [ ] dvb/dvbtime.cpp:575 updateTime [eDVBLocalTimerHandler] time update to 23:01:46 23:01:46.9818 [ ] dvb/dvbtime.cpp:578 updateTime [eDVBLocalTimerHandler] m_time_difference is 0 23:01:46.9822 [ ] dvb/dvb.cpp:2415 getDemux [eDVBChannel] getDemux cap=00 23:01:46.9999 [ ] dvb/demux.cpp:90 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0 23:01:47.0000 [ ] dvb/demux.cpp:286 start [eDVBSectionReader] DMX_SET_FILTER pid=5130 23:01:47.3484 < > dvb/decoder.cpp:543 video_event [eDVBVideo0] VIDEO_GET_EVENT FRAME_RATE_CHANGED 50000 fps 23:01:47.3490 < > dvb/decoder.cpp:543 video_event [eDVBVideo0] VIDEO_GET_EVENT SIZE_CHANGED 1280x720 aspect 3 23:01:47.3525 < > dvb/decoder.cpp:543 video_event [eDVBVideo0] VIDEO_GET_EVENT PROGRESSIVE_CHANGED 1 23:01:47.5788 [ ] service/servicedvb.cpp:1733 timeshift [eDVBServicePlay] timeshift 23:01:47.5965 [ ] dvb/pmt.cpp:950 SDTScanEvent [eDVBServicePMTHandler] sdt update done! 23:01:47.7543 { } Components/AVSwitch.py:322 setWss [VideoMode] setting wss: auto 23:01:47.7546 { } Components/AVSwitch.py:328 setPolicy43 [VideoMode] setting policy: bestfit 23:01:47.7548 { } Components/AVSwitch.py:345 setPolicy169 [VideoMode] setting policy2: scale 23:01:47.9758 [ ] dvb/demux.cpp:90 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0 23:01:47.9759 [ ] dvb/demux.cpp:286 start [eDVBSectionReader] DMX_SET_FILTER pid=18 23:01:48.0788 [ ] dvb/pmt.cpp:293 AITready [eDVBServicePMTHandler] AITready 23:01:48.0789 [ ] dvb/pmt.cpp:312 AITready [eDVBServicePMTHandler] Section Length : 960, Total Section Length : 963 23:01:48.0790 [ ] dvb/pmt.cpp:323 AITready [eDVBServicePMTHandler] found applicaions ids >> pid : 19, orgid : 19, appid : 1 23:01:48.0790 [ ] dvb/pmt.cpp:272 saveData [eDVBServicePMTHandler] section_number 1 > 0 23:01:48.0790 [ ] dvb/pmt.cpp:277 saveData [eDVBServicePMTHandler] last_section_number 1 > section_number 0 23:01:48.0792 [ ] dvb/pmt.cpp:287 saveData [eDVBServicePMTHandler] Save Data Len : [963] 23:01:48.0793 [ ] dvb/demux.cpp:90 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0 23:01:48.0794 [ ] dvb/demux.cpp:286 start [eDVBSectionReader] DMX_SET_FILTER pid=5172 23:01:48.0798 [ ] dvb/pmt.cpp:323 AITready [eDVBServicePMTHandler] found applicaions ids >> pid : 19, orgid : 19, appid : 2 23:01:48.0798 [ ] dvb/pmt.cpp:323 AITready [eDVBServicePMTHandler] found applicaions ids >> pid : 19, orgid : 19, appid : 4 23:01:48.0800 [ ] dvb/demux.cpp:90 openDemux [eDVBDemux] open demux /dev/dvb/adapter0/demux0 23:01:48.0800 [ ] dvb/demux.cpp:286 start [eDVBSectionReader] DMX_SET_FILTER pid=5172 23:01:48.0803 [ ] dvb/pmt.cpp:323 AITready [eDVBServicePMTHandler] found applicaions ids >> pid : 19, orgid : 19, appid : 5 23:01:48.0804 [ ] dvb/pmt.cpp:323 AITready [eDVBServicePMTHandler] found applicaions ids >> pid : 19, orgid : 19, appid : 20 23:01:48.0804 [ ] dvb/pmt.cpp:323 AITready [eDVBServicePMTHandler] found applicaions ids >> pid : 19, orgid : 19, appid : 3 23:01:48.0804 [ ] dvb/pmt.cpp:323 AITready [eDVBServicePMTHandler] found applicaions ids >> pid : 19, orgid : 19, appid : 35 23:01:48.0804 [ ] dvb/pmt.cpp:323 AITready [eDVBServicePMTHandler] found applicaions ids >> pid : 19, orgid : 19, appid : 42 23:01:48.0805 [ ] dvb/pmt.cpp:323 AITready [eDVBServicePMTHandler] found applicaions ids >> pid : 19, orgid : 19, appid : 56 23:01:48.0805 [ ] dvb/pmt.cpp:323 AITready [eDVBServicePMTHandler] found applicaions ids >> pid : 19, orgid : 19, appid : 66 23:01:48.0805 [ ] dvb/pmt.cpp:312 AITready [eDVBServicePMTHandler] Section Length : 233, Total Section Length : 236 23:01:48.0806 [ ] dvb/pmt.cpp:323 AITready [eDVBServicePMTHandler] found applicaions ids >> pid : 19, orgid : 19, appid : 36 23:01:48.0806 [ ] dvb/pmt.cpp:323 AITready [eDVBServicePMTHandler] found applicaions ids >> pid : 19, orgid : 19, appid : 145 23:01:48.0806 [ ] dvb/pmt.cpp:457 AITready [eDVBServicePMTHandler] Found : control[1], name[HBBTV-Start-DSMCC+Web], url[http://itv.ard.de/ardstart/index.html] 23:01:48.0806 [ ] dvb/pmt.cpp:457 AITready [eDVBServicePMTHandler] Found : control[2], name[EPG], url[http://itv.ard.de/ardepg/index.php] 23:01:48.0807 [ ] dvb/pmt.cpp:457 AITready [eDVBServicePMTHandler] Found : control[2], name[ARD-Text-DSMCC], url[http://itv2.ard.de/index.html] 23:01:48.0807 [ ] dvb/pmt.cpp:457 AITready [eDVBServicePMTHandler] Found : control[2], name[Tagesschau], url[http://www.tagesschau.de/hbbtv] 23:01:48.0807 [ ] dvb/pmt.cpp:457 AITready [eDVBServicePMTHandler] Found : control[2], name[Mediathek DasErste], url[http://hbbtv.daserste.de/index.php] 23:01:48.0807 [ ] dvb/pmt.cpp:457 AITready [eDVBServicePMTHandler] Found : control[2], name[HBBTV ARD-Mediathek], url[http://hbbtv.ardmediathek.de/hbbtv-ard/mediathek/?devicegroup=hbbtv] 23:01:48.0808 [ ] dvb/pmt.cpp:457 AITready [eDVBServicePMTHandler] Found : control[2], name[BR-Mediathek], url[http://hbbtv-mediathek.br.de/index.html] 23:01:48.0808 [ ] dvb/pmt.cpp:457 AITready [eDVBServicePMTHandler] Found : control[2], name[HBBTV Tatort], url[http://hbbtv-tatort.daserste.de/index.php] 23:01:48.0808 [ ] dvb/pmt.cpp:457 AITready [eDVBServicePMTHandler] Found : control[2], name[HbbTV SR Mediathek], url[http://hbbtv.ardmediathek.de/hbbtv-ard/mediathek/?devicegroup=hbbtv&client=sr] 23:01:48.0808 [ ] dvb/pmt.cpp:457 AITready [eDVBServicePMTHandler] Found : control[2], name[HBBTV Das Erste Check Eins], url[http://hbbtv.daserste.de/?checkeins=1] 23:01:48.0809 [ ] dvb/pmt.cpp:457 AITready [eDVBServicePMTHandler] Found : control[2], name[Sportschau], url[http://hbbtv.ardmediathek.de/hbbtv-sportschau/mediathek/?devicegroup=hbbtv] 23:01:48.0809 [ ] dvb/pmt.cpp:457 AITready [eDVBServicePMTHandler] Found : control[2], name[Olympische WS], url[http://itv.mit-xperts.com/zdfolympia2/index.php?ard=1] 23:01:48.4785 [ ] dvb/pmt.cpp:468 OCready [eDVBServicePMTHandler] OCready 23:01:48.5112 [ ] dvb/epgcache.cpp:1598 startEPG [eEPGCache] start caching events(1516658508) 23:01:48.5113 [ ] dvb/demux.cpp:286 start [eDVBSectionReader] DMX_SET_FILTER pid=3842 23:01:48.5117 [ ] dvb/demux.cpp:286 start [eDVBSectionReader] DMX_SET_FILTER pid=3003 23:01:48.5121 [ ] dvb/demux.cpp:286 start [eDVBSectionReader] DMX_SET_FILTER pid=18 23:01:48.5125 [ ] dvb/demux.cpp:286 start [eDVBSectionReader] DMX_SET_FILTER pid=18 23:01:48.5128 [ ] dvb/demux.cpp:286 start [eDVBSectionReader] DMX_SET_FILTER pid=18 23:01:48.5131 [ ] dvb/demux.cpp:286 start [eDVBSectionReader] DMX_SET_FILTER pid=5000 23:01:48.5134 [ ] dvb/demux.cpp:286 start [eDVBSectionReader] DMX_SET_FILTER pid=5000 23:01:48.5137 [ ] dvb/demux.cpp:286 start [eDVBSectionReader] DMX_SET_FILTER pid=57 23:01:48.7710 < > driver/hdmi_cec.cpp:376 hdmiEvent [eHdmiCEC] received message 84 16 00 04 23:01:49.0909 < > driver/hdmi_cec.cpp:376 hdmiEvent [eHdmiCEC] received message 84 16 00 04 23:01:49.4441 { } Plugins/Extensions/EnhancedMovieCenter/VlcPluginInterface.py:54 [VLC] Checking for buildin servicets ... no 23:01:49.4446 { E } Plugins/Extensions/EnhancedMovieCenter/VlcPluginInterface.py:59 [VLC] Checking for existing and usable servicets.so ... No module named servicets 23:01:49.4447 { } Plugins/Extensions/EnhancedMovieCenter/VlcPluginInterface.py:62 [VLC] Checking for usable gstreamer service ... yes 23:01:49.5061 { } Plugins/Extensions/EnhancedMovieCenter/EMCTasker.py:43 emcDebugOut EMC: Next trashcan cleanup in 119 minutes 23:01:49.8105 < > driver/hdmi_cec.cpp:376 hdmiEvent [eHdmiCEC] received message 87 00 0C E7 23:01:51.5070 { } Plugins/Extensions/EnhancedMovieCenter/EMCFileCache.py:214 delPathFromCache EMC delPathFromCache /media/hdd/movie/trashcan 23:01:51.5074 { } Plugins/Extensions/EnhancedMovieCenter/EMCTasker.py:43 emcDebugOut EMC: [EMCMS] trashcan cleanup: nothing to delete... 23:01:55.5139 [ ] dvb/epgcache.cpp:1961 abortNonAvail [eEPGCache] abort non avail schedule other reading 23:01:55.5144 [ ] dvb/epgcache.cpp:1985 abortNonAvail [eEPGCache] abort non avail netmed schedule reading 23:01:55.5148 [ ] dvb/epgcache.cpp:1992 abortNonAvail [eEPGCache] abort non avail netmed schedule other reading 23:01:55.5149 [ ] dvb/epgcache.cpp:2001 abortNonAvail [eEPGCache] abort non avail FreeSat schedule_other reading 23:01:55.5151 [ ] dvb/epgcache.cpp:2012 abortNonAvail [eEPGCache] abort non avail viasat reading 23:01:55.6444 < > dvb/epgcache.cpp:2273 readData [eEPGCache] nownext finished(1516658515) 23:02:02.9748 { } Plugins/Extensions/TVCharts/plugin.py:499 updateStatus [TVCharts] Status Update ... 23:02:06.9630 < > driver/hdmi_cec.cpp:376 hdmiEvent [eHdmiCEC] received message 84 10 00 05 23:02:07.1235 < > driver/hdmi_cec.cpp:376 hdmiEvent [eHdmiCEC] received message A6 06 10 56 10 23:02:07.3022 < > driver/hdmi_cec.cpp:376 hdmiEvent [eHdmiCEC] received message 84 15 00 04 23:02:07.4330 < > driver/hdmi_cec.cpp:376 hdmiEvent [eHdmiCEC] received message 85 23:02:07.4335 < > driver/hdmi_cec.cpp:529 sendMessage [eHdmiCEC] send message 82 11 00 23:02:07.9065 < > driver/hdmi_cec.cpp:376 hdmiEvent [eHdmiCEC] received message 84 10 00 05 23:02:08.2405 < > driver/hdmi_cec.cpp:376 hdmiEvent [eHdmiCEC] received message 84 00 00 00 23:02:08.7534 < > driver/hdmi_cec.cpp:376 hdmiEvent [eHdmiCEC] received message 87 00 90 3E 23:02:09.5147 < > driver/hdmi_cec.cpp:376 hdmiEvent [eHdmiCEC] received message 84 15 00 04 23:02:09.7406 < > driver/hdmi_cec.cpp:376 hdmiEvent [eHdmiCEC] received message 84 10 00 05 23:02:09.9463 < > driver/hdmi_cec.cpp:376 hdmiEvent [eHdmiCEC] received message 84 15 00 04 23:02:10.6616 < > driver/hdmi_cec.cpp:376 hdmiEvent [eHdmiCEC] received message 87 00 10 FA 23:02:10.8201 < > driver/hdmi_cec.cpp:376 hdmiEvent [eHdmiCEC] received message 87 00 05 CD 23:02:10.9791 < > driver/hdmi_cec.cpp:376 hdmiEvent [eHdmiCEC] received message 87 00 05 CD 23:02:15.3245 < > dvb/epgcache.cpp:2273 readData [eEPGCache] schedule finished(1516658535) 23:02:15.3250 [ ] dvb/epgcache.cpp:1577 finishEPG [eEPGCache] stop caching events(1516658535) 23:02:15.3251 [ ] dvb/epgcache.cpp:1579 finishEPG [eEPGCache] next update in 60 min 23:03:03.9087 [ ] driver/rcinput.cpp:38 handleCode 1 a7 1 23:03:03.9096 { } Components/ActionMap.py:46 action action -> InfobarInstantRecord instantRecord 23:03:03.9113 { } Screens/InfoBarGenerics.py:5019 instantRecord IPTV Service Name: 1:0:19:283D:3FB:1:C00000:0:0:0: 23:03:03.9115 { E } e2reactor.py:40 poll Traceback (most recent call last): 23:03:03.9116 { E } e2reactor.py:40 poll File "/usr/lib/enigma2/python/Components/ActionMap.py", line 48, in action 23:03:03.9117 { E } e2reactor.py:40 poll File "/usr/lib/enigma2/python/Screens/InfoBarGenerics.py", line 5025, in instantRecord 23:03:03.9119 { E } e2reactor.py:40 poll File "/usr/lib/enigma2/python/Components/config.py", line 1858, in __getattr__ 23:03:03.9120 { E } e2reactor.py:40 poll KeyError: 'serviceapp' 23:03:03.9121 [ E ] python/python.cpp:209 call (PyObject_CallObject(>,('InfobarInstantRecord', 'instantRecord')) failed) dmesg