enigma2 crashed on Sun Apr 16 11:12:40 2006 enigma2 CVS TAG: D2006.04.13.22.00.00 enigma2 checked out from :pserver:anonymous@dreamboxupdate.com:/cvs please email this file to crashlog@dream-multimedia-tv.de BLocalTimerHandler] diff < 120 .. use Transponder Time [eDVBLocalTimerHandler] not changed [EPGC] nownext finished(1145175629) [EPGC] stop caching events(1145175629) [EPGC] next update in 60 min [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 368953 bytes for cache used It's now Sun Apr 16 10:21:42 2006 [timer.py] next activation: 1145175802 (in 99995 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 368903 bytes for cache used [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 368903 bytes for cache used It's now Sun Apr 16 10:23:22 2006 [timer.py] next activation: 1145175902 (in 99996 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 368744 bytes for cache used It's now Sun Apr 16 10:25:02 2006 [timer.py] next activation: 1145176002 (in 99995 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 366990 bytes for cache used [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 366990 bytes for cache used It's now Sun Apr 16 10:26:42 2006 [timer.py] next activation: 1145176102 (in 99995 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 366990 bytes for cache used [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 366937 bytes for cache used It's now Sun Apr 16 10:28:22 2006 [timer.py] next activation: 1145176202 (in 99995 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 366172 bytes for cache used It's now Sun Apr 16 10:30:02 2006 [timer.py] next activation: 1145176302 (in 99996 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 360387 bytes for cache used [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 360387 bytes for cache used It's now Sun Apr 16 10:31:42 2006 [timer.py] next activation: 1145176402 (in 99995 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 360061 bytes for cache used [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 359921 bytes for cache used It's now Sun Apr 16 10:33:22 2006 [timer.py] next activation: 1145176502 (in 99995 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 359921 bytes for cache used It's now Sun Apr 16 10:35:02 2006 [timer.py] next activation: 1145176602 (in 99996 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 359076 bytes for cache used [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 359076 bytes for cache used It's now Sun Apr 16 10:36:42 2006 [timer.py] next activation: 1145176702 (in 99996 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 358949 bytes for cache used [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 358633 bytes for cache used It's now Sun Apr 16 10:38:22 2006 [timer.py] next activation: 1145176802 (in 99996 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 357730 bytes for cache used It's now Sun Apr 16 10:40:02 2006 [timer.py] next activation: 1145176902 (in 99995 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 356882 bytes for cache used [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 356850 bytes for cache used It's now Sun Apr 16 10:41:42 2006 [timer.py] next activation: 1145177002 (in 99996 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 356850 bytes for cache used [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 356810 bytes for cache used It's now Sun Apr 16 10:43:22 2006 [timer.py] next activation: 1145177102 (in 99994 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 356748 bytes for cache used It's now Sun Apr 16 10:45:02 2006 [timer.py] next activation: 1145177202 (in 99996 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 355172 bytes for cache used [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 355079 bytes for cache used It's now Sun Apr 16 10:46:42 2006 [timer.py] next activation: 1145177302 (in 99996 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 355079 bytes for cache used [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 353022 bytes for cache used It's now Sun Apr 16 10:48:22 2006 [timer.py] next activation: 1145177402 (in 99995 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 352976 bytes for cache used It's now Sun Apr 16 10:50:02 2006 [timer.py] next activation: 1145177502 (in 99995 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 351037 bytes for cache used [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 351037 bytes for cache used It's now Sun Apr 16 10:51:42 2006 [timer.py] next activation: 1145177602 (in 99996 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 350737 bytes for cache used [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 350697 bytes for cache used It's now Sun Apr 16 10:53:22 2006 [timer.py] next activation: 1145177702 (in 99996 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 350697 bytes for cache used It's now Sun Apr 16 10:55:02 2006 [timer.py] next activation: 1145177802 (in 99995 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 350127 bytes for cache used [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 350074 bytes for cache used It's now Sun Apr 16 10:56:42 2006 [timer.py] next activation: 1145177902 (in 99996 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 350041 bytes for cache used [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 350041 bytes for cache used It's now Sun Apr 16 10:58:22 2006 [timer.py] next activation: 1145178002 (in 99995 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 350041 bytes for cache used It's now Sun Apr 16 11:00:02 2006 [timer.py] next activation: 1145178102 (in 99996 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 342471 bytes for cache used [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 342413 bytes for cache used It's now Sun Apr 16 11:01:42 2006 [timer.py] next activation: 1145178202 (in 99995 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 342413 bytes for cache used [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 342370 bytes for cache used It's now Sun Apr 16 11:03:22 2006 [timer.py] next activation: 1145178302 (in 99996 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 342117 bytes for cache used It's now Sun Apr 16 11:05:02 2006 [timer.py] next activation: 1145178402 (in 99996 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 340352 bytes for cache used [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 340240 bytes for cache used It's now Sun Apr 16 11:06:42 2006 [timer.py] next activation: 1145178502 (in 99996 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 340224 bytes for cache used [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 340224 bytes for cache used It's now Sun Apr 16 11:08:22 2006 [timer.py] next activation: 1145178602 (in 99995 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 340182 bytes for cache used It's now Sun Apr 16 11:10:02 2006 [timer.py] next activation: 1145178702 (in 99996 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 339396 bytes for cache used action -> InfobarShowHideActions toggleShow [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 339396 bytes for cache used action -> SetupActions ok playing [eDVBCAService] free slot 0 demux 2 for service 1:0:1:518:3DB8:B0:820000:0:0:0: [eDVBCAService] free slot 1 demux 0 for service 1:0:1:518:3DB8:B0:820000:0:0:0: [eDVBCAService] free service 1:0:1:518:3DB8:B0:820000:0:0:0: start release channel timer VIDEO CHANGED (to ffffffff) STOP VIDEO_STOP [eDVBLocalTimerHandler] remove channel 0x1073af60 [eEPGCache] remove channel 0x1073af60 (0)tune tuning to 1880 mhz OURSTATE: tuning allocate Channel: res 0 self.isSeekable False self.timeshift_enabled False timeshift activate: False self.isSeekable False self.timeshift_enabled False timeshift activate: False seekable status changed! not seekable, return to play not pauseable. [SEC] setTone 0 [SEC] sleep 15ms set sequence pos 4 [SEC] sendDiseqc: e01038f1 [SEC] sleep 50ms [SEC] sendDiseqc: e01038f1 [SEC] sleep 50ms set sequence pos 3 [SEC] setTone 1 [SEC] sleep 15ms [SEC] setFrontend setting frontend 0 (0)fe event: status 0, inversion off (0)fe event: status 1f, inversion off OURSTATE: ok [eDVBLocalTimerHandler] channel 0x106af5b8 running allocate demux 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 0x106af5b8 running stop release channel timer no version filtering 0012: 4e 03 82 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) (00ff), and 1 audio stream(s) (0100), and the pcr pid is 00ff, and the text pid is 0020 allocate demux VIDEO CHANGED (to 00ff) new video Video Device: /dev/dvb/adapter0/video0 demux device: /dev/dvb/adapter0/demux0 [EPGC] next update in 2 sec no version filtering 0064: 02 03 82 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 doing version filtering 0000: 00 00 00 17 00 00 mask: ff 00 00 3f 00 00 mode: 00 00 00 3e 00 00 eventNewProgramInfo 0 0 have 1 video stream(s) (00ff), and 2 audio stream(s) (0100, 0101), and the pcr pid is 00ff, and the text pid is 0020 [eDVBCAService] new service 1:0:1:382:21:85:C00000:0:0:0: [eDVBCAService] add demux 2 to slot 0 service 1:0:1:382:21:85:C00000:0:0:0: [eDVBCAService] add demux 0 to slot 1 service 1:0:1:382:21:85:C00000:0:0:0: [eDVBCIInterfaces] addPMTHandler 1:0:1:382:21:85:C00000:0:0:0: [eDVBCIInterfaces] gotPMT no ca_manager (no CI plugged?) demux 2 mask 05 prevhash 00000000 [eDVBCAService] send 49 bytes 9f 80 32 2d 03 03 82 11 00 13 01 81 08 00 c0 00 00 00 21 00 85 82 02 05 02 84 02 00 64 02 00 ff 00 00 06 00 20 00 00 04 01 00 00 00 06 01 01 00 00 doing version filtering 0064: 02 03 82 11 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 doing version filtering 0012: 4e 03 82 0f 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 [EPGC] start caching events(1145178688) [eDVBLocalTimerHandler] diff is 0 [eDVBLocalTimerHandler] diff < 120 .. use Transponder Time [eDVBLocalTimerHandler] not changed action -> InfobarMenuActions mainMenu loading mainmenu XML... action -> OkCancelActions ok okbuttonClick action -> ShortcutActions green [TIMER] record time changed, start prepare is now: Sun Apr 16 11:04:40 2006 [EPGC] nownext finished(1145178695) [EPGC] schedule finished(1145178698) [EPGC] schedule other finished(1145178705) [EPGC] stop caching events(1145178705) [EPGC] next update in 60 min action -> SetupActions right newConfig ('Timer-Art', ) It's now Sun Apr 16 11:11:42 2006 [timer.py] next activation: 1145178802 (in 99995 ms) action -> SetupActions right newConfig (' ', ) action -> SetupActions right newConfig (' ', ) You pressed number 3 You pressed number 0 action -> SetupActions ok action -> OkCancelActions ok action -> OkCancelActions ok action -> SetupActions save finished add Sanity check passed [TIMER] record time changed, start prepare is now: Sun Apr 16 11:29:40 2006 [Timer] Record ProcessRepeated Sun Apr 16 11:30:00 2006 Sun Apr 16 11:42:00 2006 It's now Sun Apr 16 11:11:59 2006 [timer.py] next activation: 1145178819 (in 99719 ms) action -> ShortcutActions blue action -> MsgBoxActions ok [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 533323 bytes for cache used action -> OkCancelActions ok You pressed number 0 You pressed number 1 action -> SetupActions save finished edit Edited timer Sanity check passed time changed [TIMER] record time changed, start prepare is now: Sun Apr 16 01:29:40 2006 ProcessRepeated Sun Apr 16 01:30:00 2006 Sun Apr 16 11:42:00 2006 It's now Sun Apr 16 11:12:20 2006 [TIMER] activating state 1 [TIMER] prepare ok, waiting for begin [TIMER] activating state 2 [TIMER] zapping playing [eDVBCAService] free slot 0 demux 2 for service 1:0:1:382:21:85:C00000:0:0:0: [eDVBCAService] free slot 1 demux 0 for service 1:0:1:382:21:85:C00000:0:0:0: [eDVBCAService] free service 1:0:1:382:21:85:C00000:0:0:0: start release channel timer VIDEO CHANGED (to ffffffff) STOP VIDEO_STOP [eDVBLocalTimerHandler] remove channel 0x106af5b8 [eEPGCache] remove channel 0x106af5b8 (0)tune tuning to 1626 mhz OURSTATE: tuning allocate Channel: res 0 self.isSeekable False self.timeshift_enabled False timeshift activate: False self.isSeekable False self.timeshift_enabled False timeshift activate: False seekable status changed! not seekable, return to play not pauseable. [timer.py] next activation: 1145178840 (in 99118 ms) [SEC] setTone 0 [SEC] sleep 15ms set sequence pos 4 [SEC] sendDiseqc: e01038f3 [SEC] sleep 50ms [SEC] sendDiseqc: e01038f3 [SEC] sleep 50ms [SEC] setVoltage 2 [SEC] sleep 10ms [SEC] setTone 1 [SEC] sleep 15ms [SEC] setFrontend setting frontend 0 (0)fe event: status 0, inversion off (0)fe event: status 1f, inversion off OURSTATE: ok [eDVBLocalTimerHandler] channel 0x106af5b8 running allocate demux 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 0x106af5b8 running stop release channel timer no version filtering 0012: 4e 79 e0 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) (0065), and 1 audio stream(s) (0067), and the pcr pid is 1ffe, and the text pid is 0066 allocate demux VIDEO CHANGED (to 0065) new video Video Device: /dev/dvb/adapter0/video0 demux device: /dev/dvb/adapter0/demux0 [EPGC] next update in 2 sec no version filtering 0118: 02 79 e0 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 doing version filtering 0000: 00 00 00 0d 00 00 mask: ff 00 00 3f 00 00 mode: 00 00 00 3e 00 00 eventNewProgramInfo 0 0 have 1 video stream(s) (0065), and 1 audio stream(s) (0067), and the pcr pid is 1ffe, and the text pid is 0066 [eDVBCAService] new service 1:0:1:79E0:443:1:C00000:0:0:0: [eDVBCAService] add demux 2 to slot 0 service 1:0:1:79E0:443:1:C00000:0:0:0: [eDVBCAService] add demux 0 to slot 1 service 1:0:1:79E0:443:1:C00000:0:0:0: [eDVBCIInterfaces] addPMTHandler 1:0:1:79E0:443:1:C00000:0:0:0: [eDVBCIInterfaces] gotPMT no ca_manager (no CI plugged?) demux 2 mask 05 prevhash 00000000 [eDVBCAService] send 44 bytes 9f 80 32 28 03 79 e0 19 00 13 01 81 08 00 c0 00 00 04 43 00 01 82 02 05 02 84 02 01 18 02 00 65 00 00 06 00 66 00 00 04 00 67 00 00 doing version filtering 0118: 02 79 e0 19 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 [EPGC] start caching events(1145178754) timeout! [EPGC] abort non avail schedule_other reading [EPGC] nownext finished(1145178761) action -> OkCancelActions ok action -> SetupActions right newConfig ('Wiederholungstyp', ) [EPGC] schedule finished(1145178769) [EPGC] stop caching events(1145178769) [EPGC] next update in 60 min action -> SetupActions save Repeated: 1 Repeated: 3 Repeated: 7 Repeated: 15 Repeated: 31 Repeated: 63 Repeated: 127 finished edit Edited timer Sanity check passed time changed ProcessRepeated Sun Apr 16 01:30:00 2006 Sun Apr 16 11:42:00 2006 Day: 0 Day: 1 Day: 2 Day: 3 Day: 4 Day: 5 Day: 6 Sun Apr 16 11:12:41 2006 Sun Apr 16 01:30:00 2006 Sun Apr 16 11:42:00 2006 6 It's now Sun Apr 16 11:12:40 2006 [timer.py] next activation: 1145178860 (in 99306 ms) Traceback (most recent call last): File "/usr/lib/enigma2/python/mytest.py", line 123, in processDelay callback(*retval) File "/usr/lib/enigma2/python/Screens/TimerEdit.py", line 154, in finishedEdit self.fillTimerList() File "/usr/lib/enigma2/python/Screens/TimerEdit.py", line 89, in fillTimerList self.list.append(TimerEntryComponent(timer, processed=False)) File "/usr/lib/enigma2/python/Components/TimerList.py", line 46, in TimerEntryComponent res.append((eListboxPythonMultiContent.TYPE_TEXT, 0, 50, 400, 20, 1, RT_HALIGN_LEFT|RT_VALIGN_CENTER, repeatedtext + ((" %s "+ _("(ZAP)")) % (FuzzyTime(timer.begin)[1], FuzzyTime(timer.end)[1])))) TypeError: not all arguments converted during string formatting