Tue Apr 6 18:36:56 2010 Apr 1 2010 nabil1978@web.de dm8000 root=/dev/mtdblock3 rootfstype=jffs2 rw console=null url=http://www.dreamboxupdate.com/ catalog=http://www.dreamboxupdate.com/ ]]> 5 [AutoMount.py] CheckMountPointFinished [AutoMount.py] result None [AutoMount.py] retval None LEN 0 PATH im CheckMountPointFinished /media/net/TV [AutoMount.py] CheckMountPoint [AutoMount.py] activeMounts:---> 5 [AutoMount.py] CheckMountPointFinished [AutoMount.py] result None [AutoMount.py] retval None LEN 0 PATH im CheckMountPointFinished /media/net/DVD [AutoMount.py] CheckMountPoint [AutoMount.py] activeMounts:---> 5 [AutoMount.py] CheckMountPointFinished [AutoMount.py] result None [AutoMount.py] retval None LEN 0 PATH im CheckMountPointFinished /media/net/video [AutoMount.py] CheckMountPoint [AutoMount.py] activeMounts:---> 5 [AutoMount.py] CheckMountPointFinished [AutoMount.py] result None [AutoMount.py] retval None LEN 0 PATH im CheckMountPointFinished /media/net/music [AutoMount.py] CheckMountPoint [AutoMount.py] activeMounts:---> 5 [AutoMount.py] CheckMountPointFinished [AutoMount.py] result None [AutoMount.py] retval None LEN 0 PATH im CheckMountPointFinished /media/net/pics starting hotplug handler [CrashlogAutoSubmit] - autostart [CI_Assignment] activating ci configs: [CI_Activate] FOUND 4 CI Slots [CI_Activate_Config_CI0] no config file found [CI_Activate_Config_CI0] error parsing xml... [CI_Activate_Config_CI1] no config file found [CI_Activate_Config_CI1] error parsing xml... [CI_Activate_Config_CI2] no config file found [CI_Activate_Config_CI2] error parsing xml... [CI_Activate_Config_CI3] no config file found [CI_Activate_Config_CI3] error parsing xml... It's now Tue Apr 6 18:35:34 2010 [timer.py] next activation: 1270571834 (in 99064 ms) [TIMER] record time changed, start prepare is now: Sun Apr 4 18:48:43 2010 sanitycheck check checkTimerlist recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 [Timer] Record ProcessRepeated already passed, skipping shouldSkip: True state == ended False waiting && disabled: 0 [TIMER] record time changed, start prepare is now: Sun Apr 4 21:39:40 2010 sanitycheck check checkTimerlist recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 [Timer] Record ProcessRepeated already passed, skipping shouldSkip: True state == ended False waiting && disabled: 0 [TIMER] record time changed, start prepare is now: Sun Apr 4 20:09:40 2010 sanitycheck check checkTimerlist recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 [Timer] Record ProcessRepeated already passed, skipping shouldSkip: True state == ended False waiting && disabled: 0 [TIMER] record time changed, start prepare is now: Mon Apr 5 16:04:40 2010 sanitycheck check checkTimerlist recording service: 1:0:1:4013:2201:2114:EEEE0000:0:0:0: record: 0 [Timer] Record ProcessRepeated already passed, skipping shouldSkip: True state == ended False waiting && disabled: 0 [TIMER] record time changed, start prepare is now: Mon Apr 5 21:34:40 2010 sanitycheck check checkTimerlist recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 [Timer] Record ProcessRepeated already passed, skipping shouldSkip: True state == ended False waiting && disabled: 0 [TIMER] record time changed, start prepare is now: Mon Apr 5 20:04:40 2010 sanitycheck check checkTimerlist recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 [Timer] Record ProcessRepeated already passed, skipping shouldSkip: True state == ended False waiting && disabled: 0 [TIMER] record time changed, start prepare is now: Mon Apr 5 23:19:40 2010 sanitycheck check checkTimerlist recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 [Timer] Record ProcessRepeated already passed, skipping shouldSkip: True state == ended False waiting && disabled: 0 [TIMER] record time changed, start prepare is now: Tue Apr 6 00:04:40 2010 sanitycheck check checkTimerlist recording service: 1:0:1:4018:2201:2114:EEEE0000:0:0:0: record: 0 [Timer] Record ProcessRepeated already passed, skipping shouldSkip: True state == ended False waiting && disabled: 0 [TIMER] record time changed, start prepare is now: Tue Apr 6 00:29:40 2010 sanitycheck check checkTimerlist recording service: 1:0:1:4013:2201:2114:EEEE0000:0:0:0: record: 0 [Timer] Record ProcessRepeated already passed, skipping shouldSkip: True state == ended False waiting && disabled: 0 [TIMER] record time changed, start prepare is now: Tue Apr 6 00:29:40 2010 sanitycheck check checkTimerlist recording service: 1:0:1:4022:2202:2114:EEEE0000:0:0:0: record: 0 [Timer] Record ProcessRepeated already passed, skipping shouldSkip: True state == ended False waiting && disabled: 0 [TIMER] record time changed, start prepare is now: Tue Apr 6 01:34:40 2010 sanitycheck check checkTimerlist recording service: 1:0:1:4015:2202:2114:EEEE0000:0:0:0: record: 0 [Timer] Record ProcessRepeated already passed, skipping shouldSkip: True state == ended False waiting && disabled: 0 It's now Tue Apr 6 18:35:35 2010 [timer.py] next activation: 1270571835 (in 99742 ms) Looking for embedded skin allocating new converter! [CrashlogAutoSubmit] - autostart [CrashlogAutoSubmit] - getMailExchange not showing fine-tuning wizard, config variable doesn't exist showtestcard is false Looking for embedded skin setValue 20 cannot open /proc/stb/audio/j1_mute(No such file or directory) Setvolume: 100 100 (raw) Setvolume: 0 0 (-1db) Setvolume: 20 20 (raw) Setvolume: 51 51 (-1db) 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 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! 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! reused 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! playing 1:0:1:4016:2202:2114:EEEE0000:0:0:0: not pauseable. RemovePopup, id = ZapError allocate channel.. 2202:2114 opening frontend 2 [eDVBCAService] new channel 0x10a73f98! (2)tune OURSTATE: tuning allocate Channel: res 0 [eDVBCIInterfaces] addPMTHandler 1:0:1:4016:2202:2114:EEEE0000:0:0:0: allocate demux [SEC] startTuneTimeout 5000 [SEC] setVoltage 0 [SEC] setFrontend 1 setting frontend 2 child has terminated pipes closed child has terminated pipes closed [ePopen] command: route -n | grep eth0 child has terminated pipes closed [ePopen] command: route -n | grep ath0 poll: unhandled POLLERR/HUP/NVAL for fd 32(16) child has terminated pipes closed poll: unhandled POLLERR/HUP/NVAL for fd 37(16) poll: unhandled POLLERR/HUP/NVAL for fd 38(16) poll: unhandled POLLERR/HUP/NVAL for fd 40(16) (2)fe event: status 0, inversion off, m_tuning 1 (2)fe event: status 1f, inversion off, m_tuning 2 OURSTATE: ok [eDVBCAService] channel 0x10a73f98 running [eDVBLocalTimerHandler] channel 0x10a73f98 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 0x10a73f98 running stop release channel timer no version filtering 0012: 4e 40 16 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) (0161), and 1 audio stream(s) (0162), and the pcr pid is 0161, and the text pid is 0167 allocate demux disable teletext subtitles decoder state: play, vpid=353, apid=354 DMX_SET_PES_FILTER(0x161) - pcr - ok DEMUX_START - pcr - ok DMX_SET_PES_FILTER(0x162) - audio - ok DEMUX_START - audio - ok AUDIO_SET_BYPASS(1) - ok AUDIO_PAUSE - ok AUDIO_PLAY - [EPGC] next update in 2 sec ok Video Device: /dev/dvb/adapter0/video0 demux device: /dev/dvb/adapter0/demux0 VIDEO_SET_STREAMTYPE 0 - ok DMX_SET_PES_FILTER(0x161) - video - ok DEMUX_START - video - ok VIDEO_FREEZE - ok VIDEO_PLAY - ok DMX_SET_PES_FILTER(0x167) - 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. [EPGC] start caching events(1270571740) Timeout! child has terminated pipes closed 192.168 169.254 0.0.0.0 child has terminated pipes closed nameservers: [[192, 168, 1, 1]] read configured interface: {'lo': {'dhcp': False}, 'eth0': {'dhcp': True}} self.ifaces after loading: {'ath0': {'preup': False, 'ip': [0, 0, 0, 0], 'up': False, 'netmask': [0, 0, 0, 0], 'dhcp': True, 'gateway': [0, 0, 0, 0], 'postdown': False}, 'eth0': {'preup': False, 'ip': [192, 168, 1, 5], 'up': True, 'mac': '00:09:34:1c:4e:11', 'dhcp': True, 'bcast': [192, 168, 1, 255], 'netmask': [255, 255, 255, 0], 'gateway': [192, 168, 1, 1], 'postdown': False}} [Toplevel.importExternalModules] Could NOT import external module: AutoTimer [Toplevel.importExternalModules] Exception Caught No module named AutoTimer.AutoTimerResource [Toplevel.importExternalModules] Could NOT import external module: EPGRefresh [Toplevel.importExternalModules] Exception Caught No module named EPGRefresh.EPGRefreshResource [Toplevel.importExternalModules] Imported external module: Example [WebInterface] checking for SSL Certificates [Webinterface] started on 192.168.1.5:80 auth= True ssl= False [Webinterface] started on 192.168.1.5:443 auth= True ssl= True [Webinterface] started on 127.0.0.1:80 auth= False ssl= False poll: unhandled POLLERR/HUP/NVAL for fd 38(16) poll: unhandled POLLERR/HUP/NVAL for fd 39(16) -+ 1/2 TID 4e + 1/1 TID 00 done! no version filtering 0160: 02 40 16 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 doing version filtering 0000: 00 00 00 09 00 00 mask: ff 00 00 3f 00 00 mode: 00 00 00 3e 00 00 ERROR reading PES (fd=46) - Value too large for defined data type poll: unhandled POLLERR/HUP/NVAL for fd 46(8) ERROR reading PES (fd=48) - Value too large for defined data type poll: unhandled POLLERR/HUP/NVAL for fd 48(8) VIDEO_GET_EVENT - ok [CrashlogAutoSubmit] gotMXServer: 82.149.226.184 [CrashlogAutoSubmit] - mxServerFound --> 82.149.226.184 [CrashlogAutoSubmit] - found crashlog: enigma2_crash_1270571706.log ++ 2/2 TID 4e done! doing version filtering 0012: 4e 40 16 11 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 VIDEO_GET_EVENT - ok + 1/1 TID 02 done! eventNewProgramInfo 0 0 have 1 video stream(s) (0161), and 1 audio stream(s) (0162), and the pcr pid is 0161, and the text pid is 0167 decoder state: play, vpid=353, apid=354 [eDVBCAService] new service 1:0:1:4016:2202:2114:EEEE0000:0:0:0: [eDVBCAService] add demux 0 to slot 0 service 1:0:1:4016:2202:2114:EEEE0000:0:0:0: [eDVBCIInterfaces] gotPMT demux 0 mask 01 prevhash 00000000 [eDVBCAService] send 44 bytes 9f 80 32 28 03 40 16 05 00 13 01 81 08 ee ee 00 00 22 02 21 14 82 02 01 00 84 02 01 60 06 01 67 00 00 03 01 62 00 00 02 01 61 00 00 doing version filtering 0160: 02 40 16 05 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 [eDVBLocalTimerHandler] diff is -34 [eDVBLocalTimerHandler] diff < 120 .. use Transponder Time [eDVBLocalTimerHandler] update RTC [eDVBLocalTimerHandler] time update to 18:35:08 [eDVBLocalTimerHandler] m_time_difference is -34 [eDVBLocalTimerHandler] set Linux Time [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 85108 bytes for cache used sdt update done! Timeout! [EPGC] abort non avail schedule other reading [EPGC] abort non avail viasat reading [EPGC] nownext finished(1270571712) [EPGC] schedule finished(1270571720) [EPGC] stop caching events(1270571720) [EPGC] next update in 60 min no ancillary data in audio stream... abort radiotext pes parser nr_read 215 nr_write 44 sum 259 prev_sum 0 hdd was accessed since previous check! [IDLE] 0 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 232489 bytes for cache used action -> WizardActions ok [CrashlogAutoSubmit] - handleAnswer --> send [CrashlogAutoSubmit] - send_mail [CrashlogAutoSubmit] - Message sent successfully --> (1, [('enigma2@crashlog.dream-multimedia-tv.de', 250, '2.1.5 Ok')]) It's now Tue Apr 6 18:36:39 2010 [timer.py] next activation: 1270571899 (in 99989 ms) It's now Tue Apr 6 18:36:40 2010 [timer.py] next activation: 1270571900 (in 99989 ms) action -> InfobarExtensions extensions action -> WizardActions down nr_read 215 nr_write 46 sum 261 prev_sum 259 hdd was accessed since previous check! [IDLE] 0 600 False action -> DirectionActions downUp unknown action DirectionActions/downUp! typo in keymap? action -> WizardActions down action -> DirectionActions downUp unknown action DirectionActions/downUp! typo in keymap? action -> WizardActions down action -> DirectionActions downUp unknown action DirectionActions/downUp! typo in keymap? action -> WizardActions down action -> DirectionActions downUp unknown action DirectionActions/downUp! typo in keymap? action -> WizardActions down action -> DirectionActions downUp unknown action DirectionActions/downUp! typo in keymap? action -> WizardActions down action -> DirectionActions downUp unknown action DirectionActions/downUp! typo in keymap? action -> WizardActions ok Looking for embedded skin action -> OkCancelActions ok Screen ((), {}): Traceback (most recent call last): File "/usr/lib/enigma2/python/mytest.py", line 229, in create return screen(self, *arguments, **kwargs) File "/build/tmbinc/opendreambox/1.5/dm8000/release/build/tmp/work/enigma2-plugins-2.8cvs20100402-r0/image/usr/lib/enigma2/python/Plugins/Extensions/Podcast/plugin.py", line 408, in __init__ File "", line 45, in parse File "", line 32, in parse SyntaxError: not well-formed (invalid token): line 45, column 131 Traceback (most recent call last): File "/usr/lib/enigma2/python/Components/ActionMap.py", line 46, in action res = self.actions[action]() File "/build/tmbinc/opendreambox/1.5/dm8000/release/build/tmp/work/enigma2-plugins-2.8cvs20100402-r0/image/usr/lib/enigma2/python/Plugins/Extensions/Podcast/plugin.py", line 995, in ok File "/usr/lib/enigma2/python/mytest.py", line 303, in open dlg.isTmp = True AttributeError: 'NoneType' object has no attribute 'isTmp' (PyObject_CallObject(>,('OkCancelActions', 'ok')) failed) ]]>