Sat Feb 5 14:58:17 2011 Jan 22 2011 crashlog@dream-multimedia-tv.de Ai.HD/skin.xml Jan 22 2011 experimental dm800se root=/dev/mtdblock3 rootfstype=jffs2 rw console=ttyS0,115200 NIM Socket 0: setValue 100 cannot open /proc/stb/audio/j1_mute(No such file or directory) Setvolume: 100 100 (raw) Setvolume: 0 0 (-1db) Setvolume: 100 100 (raw) Setvolume: 0 0 (-1db) nr_read 827 nr_write 11127 sum 11954 prev_sum 0 hdd was accessed since previous check! [IDLE] 0 120 False lookup for events with 'TV total' in title(ignore case) [EPGC] 31340 events read from /media/hdd/epg.dat [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3094488 bytes for cache used [AutoTimer] Warning, we're messing with a timer which might not have been set by us time changed ProcessRepeated It's now Sat Feb 5 14:55:23 2011 next real activation is Sun Feb 6 03:29:40 2011 [timer.py] next activation: 1296914223 (in 99617 ms) lookup for events with 'Markus Lanz' in title(ignore case) [AutoTimer] Warning, we're messing with a timer which might not have been set by us time changed ProcessRepeated It's now Sat Feb 5 14:55:23 2011 next real activation is Sun Feb 6 03:29:40 2011 [timer.py] next activation: 1296914223 (in 99461 ms) [AutoTimer] Warning, we're messing with a timer which might not have been set by us time changed ProcessRepeated It's now Sat Feb 5 14:55:23 2011 next real activation is Sun Feb 6 03:29:40 2011 [timer.py] next activation: 1296914223 (in 99453 ms) [AutoTimer] Warning, we're messing with a timer which might not have been set by us time changed ProcessRepeated It's now Sat Feb 5 14:55:23 2011 next real activation is Sun Feb 6 03:29:40 2011 [timer.py] next activation: 1296914223 (in 99444 ms) lookup for events with 'Schlag den Raab' in title(ignore case) lookup for events with 'Wer wird Millionär?' as title(case sensitive) [AutoTimer] Warning, we're messing with a timer which might not have been set by us time changed ProcessRepeated It's now Sat Feb 5 14:55:23 2011 next real activation is Sun Feb 6 03:29:40 2011 [timer.py] next activation: 1296914223 (in 99285 ms) lookup for events with 'Unser Song für Deutschland' in title(ignore case) [AutoTimer] Warning, we're messing with a timer which might not have been set by us time changed ProcessRepeated It's now Sat Feb 5 14:55:23 2011 next real activation is Sun Feb 6 03:29:40 2011 [timer.py] next activation: 1296914223 (in 99168 ms) lookup for events with 'Verrückt nach Meer' as title(case sensitive) [AutoTimer] Warning, we're messing with a timer which might not have been set by us time changed ProcessRepeated It's now Sat Feb 5 14:55:23 2011 next real activation is Sun Feb 6 03:29:40 2011 [timer.py] next activation: 1296914223 (in 99056 ms) [AutoTimer] Warning, we're messing with a timer which might not have been set by us time changed ProcessRepeated It's now Sat Feb 5 14:55:23 2011 next real activation is Sun Feb 6 03:29:40 2011 [timer.py] next activation: 1296914223 (in 99047 ms) [AutoTimer] Warning, we're messing with a timer which might not have been set by us time changed ProcessRepeated It's now Sat Feb 5 14:55:23 2011 next real activation is Sun Feb 6 03:29:40 2011 [timer.py] next activation: 1296914223 (in 99037 ms) [AutoTimer] Warning, we're messing with a timer which might not have been set by us time changed ProcessRepeated It's now Sat Feb 5 14:55:23 2011 next real activation is Sun Feb 6 03:29:40 2011 [timer.py] next activation: 1296914223 (in 99028 ms) [AutoTimer] Warning, we're messing with a timer which might not have been set by us time changed ProcessRepeated It's now Sat Feb 5 14:55:23 2011 next real activation is Sun Feb 6 03:29:40 2011 [timer.py] next activation: 1296914223 (in 99018 ms) reused converter! allocating new converter! allocating new converter! resolve: resolve ${datadir}/enigma2/%s/ resolve: -> /usr/share/enigma2/%s/ allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! reused converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! RemovePopup, id = ZapError Looking for embedded skin allocating new converter! allocating new converter! allocating new converter! allocating new converter! reused converter! reused converter! reused converter! reused converter! reused converter! reused converter! reused converter! allocating new converter! reused converter! reused converter! reused converter! reused converter! allocating new converter! reused converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! reused converter! reused converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! reused converter! allocating new converter! allocating new converter! reused converter! allocating new converter! allocating new converter! reused converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! reused converter! allocating new converter! allocating new converter! reused converter! allocating new converter! allocating new converter! reused converter! allocating new converter! allocating new converter! Looking for embedded skin reused converter! playing 1:0:19:2B5C:41B:A401:FFFF0000:0:0:0: not pauseable. RemovePopup, id = ZapError allocate channel.. 041b:a401 opening frontend 0 [eDVBCAService] new channel 0x2ef9b010! (0)tune tuning to 362000 khz, sr 6900000, fec 0, modulation 5, inversion 2 OURSTATE: tuning allocate Channel: res 0 [eDVBCIInterfaces] addPMTHandler 1:0:19:2B5C:41B:A401:FFFF0000:0:0:0: allocate demux resolve: resolve ${sysconfdir}/scan_tp_valid_check.py resolve: -> /etc/scan_tp_valid_check.py [SEC] startTuneTimeout 5000 [SEC] setFrontend 1 setting frontend 0 nr_read 827 nr_write 11127 sum 11954 prev_sum 11954 hdd IDLE! [IDLE] 4.39619588852 120 False (0)fe event: status 0, inversion off, m_tuning 1 (0)fe event: status 1f, inversion off, m_tuning 2 OURSTATE: ok [eDVBCAService] channel 0x2ef9b010 running [eDVBLocalTimerHandler] channel 0x2ef9b010 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 0x2ef9b010 running stop release channel timer [EPGC] next update in 2 sec no version filtering 0012: 4e 2b 5c 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 eventNewProgramInfo 0 0 have 1 video stream(s) (177a), and 1 audio stream(s) (1784), and the pcr pid is 177a, and the text pid is 178e allocate demux disable teletext subtitles decoder state: play, vpid=6010, apid=6020 DMX_SET_PES_FILTER(0x177a) - pcr - ok DEMUX_START - pcr - ok DMX_SET_PES_FILTER(0x1784) - audio - ok DEMUX_START - audio - ok AUDIO_SET_BYPASS(1) - ok AUDIO_PAUSE - ok AUDIO_PLAY - ok Video Device: /dev/dvb/adapter0/video0 demux device: /dev/dvb/adapter0/demux0 VIDEO_SET_STREAMTYPE 1 - ok DMX_SET_PES_FILTER(0x177a) - video - ok DEMUX_START - video - ok VIDEO_FREEZE - ok VIDEO_PLAY - ok DMX_SET_PES_FILTER(0x178e) - ttx - ok DEMUX_START - ttx - ok VIDEO_SLOWMOTION(0) - ok VIDEO_FAST_FORWARD(0) - ok VIDEO_CONTINUE - ok AUDIO_CONTINUE - ok AUDIO_CHANNEL_SELECT(0) - ok not pauseable. [ePopen] command: ping -c 1 82.149.226.170 [ePopen] command: ping -c 1 193.99.144.85 [ePopen] command: ping -c 1 209.85.135.103 [AutoRes] service changed child has terminated pipes closed child has terminated pipes closed [ePopen] command: route -n | grep eth0 poll: unhandled POLLERR/HUP/NVAL for fd 30(16) child has terminated pipes closed poll: unhandled POLLERR/HUP/NVAL for fd 33(16) poll: unhandled POLLERR/HUP/NVAL for fd 35(16) + 1/1 TID 00 done! PATready use pmtpid 1770 for service_id 2b5c no version filtering 1770: 02 2b 5c 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 doing version filtering 0000: 00 00 00 0f 00 00 mask: ff 00 00 3f 00 00 mode: 00 00 00 3e 00 00 VIDEO_GET_EVENT - ok [AutoRes] got event evFramerateChanged child has terminated pipes closed child has terminated pipes closed poll: unhandled POLLERR/HUP/NVAL for fd 66(16) poll: unhandled POLLERR/HUP/NVAL for fd 69(16) child has terminated pipes closed 192.168 169.254 0.0.0.0 nameservers: [[78, 42, 43, 62], [82, 212, 62, 62]] read configured interface: {'lo': {'dhcp': False}, 'eth0': {'dhcp': True}} self.ifaces after loading: {'eth0': {'preup': False, 'ip': [192, 168, 0, 130], 'up': True, 'mac': '00:09:34:2b:cc:c2', 'dhcp': True, 'bcast': [192, 168, 0, 255], 'netmask': [255, 255, 255, 0], 'gateway': [192, 168, 0, 1], 'postdown': False}} [Toplevel.importExternalModules] Imported external module: AutoTimer [Toplevel.importExternalModules] Imported external module: EPGRefresh [Toplevel.importExternalModules] Imported external module: Example [WebInterface] checking for SSL Certificates [Webinterface] started on 0.0.0.0:80 auth=False ssl=False [WebInterface.registerBonjourService] No module named Bonjour.Bonjour [Webinterface] started on 0.0.0.0:443 auth=True ssl=True [WebInterface.registerBonjourService] No module named Bonjour.Bonjour poll: unhandled POLLERR/HUP/NVAL for fd 32(16) + 1/1 TID 02 done! eventNewProgramInfo 0 0 have 1 video stream(s) (177a), and 3 audio stream(s) (1784, 1785, 1786), and the pcr pid is 177a, and the text pid is 178e decoder state: play, vpid=6010, apid=6020 [eDVBCAService] new service 1:0:19:2B5C:41B:A401:FFFF0000:0:0:0: [eDVBCAService] add demux 0 to slot 0 service 1:0:19:2B5C:41B:A401:FFFF0000:0:0:0: [eDVBCIInterfaces] gotPMT demux 0 mask 01 prevhash 00000000 [eDVBCAService] send 64 bytes 9f 80 32 3c 03 2b 5c 05 00 13 01 81 08 ff ff 00 00 04 1b a4 01 82 02 01 00 84 02 17 70 1b 17 7a 00 00 03 17 84 00 00 03 17 85 00 00 06 17 86 00 00 06 17 8e 00 00 05 17 ac 00 00 06 17 ad 00 00 doing version filtering 1770: 02 2b 5c 05 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 sdt update done! -+ 1/2 TID 4e VIDEO_GET_EVENT - ok [AutoRes] got event evFramerateChanged child has terminated pipes closed poll: unhandled POLLERR/HUP/NVAL for fd 72(16) [AutoRes] determineContent [AutoRes] switch deinterlacer mode to auto [AutoRes] new content is 1280x720p50 [AutoRes] determined videomode 720p ++ 2/2 TID 4e done! doing version filtering 0012: 4e 2b 5c 0d 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 [EPGC] start caching events(1296914127) [eDVBLocalTimerHandler] diff is 0 [eDVBLocalTimerHandler] diff < 120 .. use Transponder Time [eDVBLocalTimerHandler] not changed PTS-Plugin: Erasing stranded timeshift pts_livebuffer.1 before: 1 after: 1 before: 1 before: 1 setIoPrio best-effort level 7 ok file /media/hdd/.timeshift//pts_livebuffer.1.del erased file /media/hdd/.timeshift//pts_livebuffer.1.meta.del erased file /media/hdd/.timeshift//pts_livebuffer.1.eit.del erased Looking for embedded skin reused converter! reused converter! reused converter! Start timeshift! recording to /media/hdd/.timeshift//timeshift.n5GKHZ before: 1 after: 1 setIoPrio realtime level 7 ok FILEPUSH THREAD START [EITSave] query epg event id 38097, 1:0:19:2B5C:41B:A401:FFFF0000:0:0:0: [EITSave] found event.. store to disc [EPGC] abort non avail viasat reading [EPGC] nownext finished(1296914137) [EPGC] schedule other finished(1296914137) nr_read 918 nr_write 11163 sum 12081 prev_sum 11954 hdd was accessed since previous check! [IDLE] 0 120 False [TVCharts] Status Update ... no ancillary data in audio stream... abort radiotext pes parser [EPGC] schedule finished(1296914147) [EPGC] stop caching events(1296914147) [EPGC] next update in 60 min nr_read 919 nr_write 11247 sum 12166 prev_sum 12081 hdd was accessed since previous check! [IDLE] 0 120 False It's now Sat Feb 5 14:55:51 2011 [EPGRefresh] Not in timespan, ending timer next real activation is Sun Feb 6 01:00:01 2011 [timer.py] next activation: 1296914251 (in 99995 ms) nr_read 919 nr_write 11353 sum 12272 prev_sum 12166 hdd was accessed since previous check! [IDLE] 0 120 False nr_read 920 nr_write 11433 sum 12353 prev_sum 12272 hdd was accessed since previous check! [IDLE] 0 120 False [Elektro] Testtime; 02:00:00 [Elektro] wday 1: 5 [Elektro] wday 2: 5 [Elektro] Current time: 14:56:00 [Elektro] Wakeup time: 10:00:00 [Elektro] Sleep time: 02:00:00 [Elektro] Current Rel-time: 07:56:00 [Elektro] Wakeup Rel-time: 03:00:00 [Elektro] Sleep Rel-time: 19:00:00 [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3093910 bytes for cache used nr_read 920 nr_write 11512 sum 12432 prev_sum 12353 hdd was accessed since previous check! [IDLE] 0 120 False nr_read 920 nr_write 11607 sum 12527 prev_sum 12432 hdd was accessed since previous check! [IDLE] 0 120 False nr_read 921 nr_write 11687 sum 12608 prev_sum 12527 hdd was accessed since previous check! [IDLE] 0 120 False It's now Sat Feb 5 14:57:00 2011 [timer.py] next activation: 1296914320 (in 99998 ms) It's now Sat Feb 5 14:57:00 2011 next real activation is Sat Feb 5 17:00:00 2011 [timer.py] next activation: 1296914320 (in 99996 ms) nr_read 922 nr_write 11764 sum 12686 prev_sum 12608 hdd was accessed since previous check! [IDLE] 0 120 False It's now Sat Feb 5 14:57:03 2011 next real activation is Sun Feb 6 03:29:40 2011 [timer.py] next activation: 1296914323 (in 99997 ms) nr_read 922 nr_write 11860 sum 12782 prev_sum 12686 hdd was accessed since previous check! [IDLE] 0 120 False [Elektro] Testtime; 02:00:00 [Elektro] wday 1: 5 [Elektro] wday 2: 5 [Elektro] Current time: 14:57:00 [Elektro] Wakeup time: 10:00:00 [Elektro] Sleep time: 02:00:00 [Elektro] Current Rel-time: 07:57:00 [Elektro] Wakeup Rel-time: 03:00:00 [Elektro] Sleep Rel-time: 19:00:00 [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3093896 bytes for cache used nr_read 922 nr_write 11944 sum 12866 prev_sum 12782 hdd was accessed since previous check! [IDLE] 0 120 False It's now Sat Feb 5 14:57:31 2011 next real activation is Sun Feb 6 01:00:01 2011 [timer.py] next activation: 1296914351 (in 99997 ms) nr_read 923 nr_write 12026 sum 12949 prev_sum 12866 hdd was accessed since previous check! [IDLE] 0 120 False nr_read 923 nr_write 12107 sum 13030 prev_sum 12949 hdd was accessed since previous check! [IDLE] 0 120 False nr_read 924 nr_write 12187 sum 13111 prev_sum 13030 hdd was accessed since previous check! [IDLE] 0 120 False action -> InfobarMenuActions mainMenu loading mainmenu XML... TimerEdit TimerEditList PluginBrowser PluginBrowser allocating new converter! allocating new converter! nr_read 924 nr_write 12271 sum 13195 prev_sum 13111 hdd was accessed since previous check! [IDLE] 0 120 False action -> OkCancelActions cancel action -> EasyInfoActions info_but Looking for embedded skin Looking for embedded skin action -> WizardActions up unknown action WizardActions/up! typo in keymap? action -> WizardActions ok Traceback (most recent call last): File "/usr/lib/enigma2/python/Components/ActionMap.py", line 46, in action res = self.actions[action]() File "/usr/lib/enigma2/python/Plugins/Extensions/EasyInfo/plugin.py", line 305, in go self.goEntry(cursel[0]) File "/usr/lib/enigma2/python/Plugins/Extensions/EasyInfo/plugin.py", line 310, in goEntry self.EINcallbackFunc(entry) File "/usr/lib/enigma2/python/Plugins/Extensions/EasyInfo/plugin.py", line 418, in EINcallbackFunc EINession.open(IMDB, IeventName) NameError: global name 'EINession' is not defined (PyObject_CallObject(>,('WizardActions', 'ok')) failed) ]]>