enigma2 crashed on Tue Jan 16 23:21:33 2007 enigma2 CVS TAG: D2006.11.08.23.00.00 enigma2 checked out from :pserver:anonymous@dreamboxupdate.com:/cvs please email this file to crashlog@dream-multimedia-tv.de timer no version filtering 0012: 4e 6d cc 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) (012d), and 1 audio stream(s) (012e), and the pcr pid is 012d, and the text pid is 0130 allocate demux disable teletext subtitles VIDEO CHANGED (to 012d) new video Video Device: /dev/dvb/adapter0/video0 demux device: /dev/dvb/adapter0/demux0 video: VIDEO_SET_STREAMTYPE: Operation not supported no version filtering 0011: 42 00 00 00 00 00 mask: ff 00 00 00 00 00 mode: 00 00 00 00 00 00 [EPGC] next update in 2 sec + 1/1 TID 00 done! no version filtering 012c: 02 6d cc 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 doing version filtering 0000: 00 00 00 21 00 00 mask: ff 00 00 3f 00 00 mode: 00 00 00 3e 00 00 + 1/1 TID 02 done! eventNewProgramInfo 0 0 have 1 video stream(s) (012d), and 1 audio stream(s) (012e), and the pcr pid is 012d, and the text pid is 0130 [eDVBCAService] new service 1:0:1:6DCC:44D:1:C00000:0:0:0: [eDVBCAService] add demux 2 to slot 0 service 1:0:1:6DCC:44D:1:C00000:0:0:0: [eDVBCAService] add demux 0 to slot 1 service 1:0:1:6DCC:44D:1:C00000:0:0:0: [eDVBCIInterfaces] gotPMT demux 2 mask 05 prevhash 00000000 [eDVBCAService] send 59 bytes 9f 80 32 37 03 6d cc 03 00 13 01 81 08 00 c0 00 00 04 4d 00 01 82 02 05 02 84 02 01 2c 02 01 2d 00 00 04 01 2e 00 00 05 08 1a 00 00 06 01 30 00 00 0b 08 18 00 00 0b 08 1b 00 00 doing version filtering 012c: 02 6d cc 03 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 [eDVBLocalTimerHandler] diff is 0 [eDVBLocalTimerHandler] diff < 120 .. use Transponder Time [eDVBLocalTimerHandler] not changed -+ 1/2 TID 4e + 1/1 TID 42 done! sdt update done! ++ 2/2 TID 4e done! doing version filtering 0012: 4e 6d cc 2b 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 [EPGC] start caching events(1168986010) action -> InfobarChannelSelection openServiceList [EPGC] nownext finished(1168986017) [EPGC] schedule finished(1168986019) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 1088274 bytes for cache used It's now Tue Jan 16 23:20:32 2007 [timer.py] next activation: 1168986132 (in 99996 ms) [EPGC] schedule other finished(1168986048) [EPGC] stop caching events(1168986048) [EPGC] next update in 60 min action -> OkCancelActions ok playing 1:0:1:3146:459:1:C00000:0:0:0: [eDVBCAService] free slot 0 demux 2 for service 1:0:1:6DCC:44D:1:C00000:0:0:0: [eDVBCAService] free slot 1 demux 0 for service 1:0:1:6DCC:44D:1:C00000:0:0:0: [eDVBCAService] free service 1:0:1:6DCC:44D:1:C00000:0:0:0: VIDEO CHANGED (to ffffffff) STOP VIDEO_STOP start release channel timer [eDVBLocalTimerHandler] remove channel 0x10ef2a20 [eEPGCache] remove channel 0x10ef2a20 (0)tune prepare_sat System 0 Freq 12633250 Pol 0 SR 22000000 INV 2 FEC 4 orbpos 192 tuning to 2033 mhz OURSTATE: tuning allocate Channel: res 0 [eDVBCIInterfaces] addPMTHandler 1:0:1:3146:459:1:C00000:0:0:0: allocate demux 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. 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 0x10ef2a20 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 0x10ef2a20 running stop release channel timer no version filtering 0012: 4e 31 46 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) (00d0), and 1 audio stream(s) (0134), and the pcr pid is 00d0, and the text pid is 01fc allocate demux disable teletext subtitles VIDEO CHANGED (to 00d0) new video Video Device: /dev/dvb/adapter0/video0 demux device: /dev/dvb/adapter0/demux0 video: VIDEO_SET_STREAMTYPE: Operation not supported no version filtering 0011: 42 00 00 00 00 00 mask: ff 00 00 00 00 00 mode: 00 00 00 00 00 00 [EPGC] next update in 2 sec + 1/1 TID 00 done! no version filtering 006c: 02 31 46 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 doing version filtering 0000: 00 00 00 3d 00 00 mask: ff 00 00 3f 00 00 mode: 00 00 00 3e 00 00 + 1/1 TID 02 done! eventNewProgramInfo 0 0 have 1 video stream(s) (00d0), and 1 audio stream(s) (0134), and the pcr pid is 00d0, and the text pid is 01fc [eDVBCAService] new service 1:0:1:3146:459:1:C00000:0:0:0: [eDVBCAService] add demux 2 to slot 0 service 1:0:1:3146:459:1:C00000:0:0:0: [eDVBCAService] add demux 0 to slot 1 service 1:0:1:3146:459:1:C00000:0:0:0: [eDVBCIInterfaces] gotPMT demux 2 mask 05 prevhash 00000000 [eDVBCAService] send 44 bytes 9f 80 32 28 03 31 46 03 00 13 01 81 08 00 c0 00 00 04 59 00 01 82 02 05 02 84 02 00 6c 02 00 d0 00 00 04 01 34 00 00 06 01 fc 00 00 doing version filtering 006c: 02 31 46 03 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 + 1/1 TID 42 done! sdt update done! action -> InfobarChannelSelection openServiceList [EPGC] start caching events(1168986064) timeout! [EPGC] abort non avail schedule reading [EPGC] abort non avail schedule_other reading [EPGC] nownext finished(1168986071) [EPGC] stop caching events(1168986071) [EPGC] next update in 60 min action -> OkCancelActions ok playing 1:0:1:6E42:431:1:C00000:0:0:0: stopService [eDVBCAService] free slot 0 demux 2 for service 1:0:1:3146:459:1:C00000:0:0:0: [eDVBCAService] free slot 1 demux 0 for service 1:0:1:3146:459:1:C00000:0:0:0: [eDVBCAService] free service 1:0:1:3146:459:1:C00000:0:0:0: VIDEO CHANGED (to ffffffff) STOP VIDEO_STOP start release channel timer [eDVBLocalTimerHandler] diff is -36 [eDVBLocalTimerHandler] diff < 120 .. use Transponder Time [eDVBLocalTimerHandler] time update to 23:20:45 [eDVBLocalTimerHandler] m_time_difference is -23 [eDVBLocalTimerHandler] update RTC [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 1261496 bytes for cache used release cached channel (timer timeout) [eDVBLocalTimerHandler] remove channel 0x10ef2a20 [eEPGCache] remove channel 0x10ef2a20 stop release channel timer playing 1:0:1:6E42:431:1:C00000:0:0:0: (0)tune prepare_sat System 0 Freq 12109500 Pol 0 SR 27500000 INV 2 FEC 3 orbpos 192 tuning to 1509 mhz OURSTATE: tuning allocate Channel: res 0 [eDVBCIInterfaces] addPMTHandler 1:0:1:6E42:431:1:C00000:0:0:0: allocate demux 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. 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 0x10ef2a20 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 0x10ef2a20 running stop release channel timer no version filtering 0012: 4e 6e 42 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 no version filtering 0011: 42 00 00 00 00 00 mask: ff 00 00 00 00 00 mode: 00 00 00 00 00 00 [EPGC] next update in 2 sec [eDVBLocalTimerHandler] diff is 36 [eDVBLocalTimerHandler] diff < 120 .. use Transponder Time [eDVBLocalTimerHandler] time update to 23:21:22 [eDVBLocalTimerHandler] m_time_difference is 13 [eDVBLocalTimerHandler] update RTC [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 1261496 bytes for cache used +- 1/2 TID 4e + 1/1 TID 00 done! no version filtering 0a28: 02 6e 42 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 ++ 2/2 TID 4e done! doing version filtering 0012: 4e 6e 42 35 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 + 1/1 TID 02 done! eventNewProgramInfo 0 0 have 1 video stream(s) (0961), and 1 audio stream(s) (0962), and the pcr pid is 0961, and the text pid is 0964 allocate demux disable teletext subtitles VIDEO CHANGED (to 0961) new video Video Device: /dev/dvb/adapter0/video0 demux device: /dev/dvb/adapter0/demux0 video: VIDEO_SET_STREAMTYPE: Operation not supported [eDVBCAService] new service 1:0:1:6E42:431:1:C00000:0:0:0: [eDVBCAService] add demux 2 to slot 0 service 1:0:1:6E42:431:1:C00000:0:0:0: [eDVBCAService] add demux 0 to slot 1 service 1:0:1:6E42:431:1:C00000:0:0:0: [eDVBCIInterfaces] gotPMT demux 2 mask 05 prevhash 00000000 [eDVBCAService] send 54 bytes 9f 80 32 32 03 6e 42 01 00 13 01 81 08 00 c0 00 00 04 31 00 01 82 02 05 02 84 02 0a 28 02 09 61 00 00 03 09 62 00 00 05 08 16 00 00 06 09 64 00 00 0b 08 18 00 00 doing version filtering 0a28: 02 6e 42 01 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 + 1/1 TID 42 done! sdt update done! [EPGC] start caching events(1168986084) action -> InfobarActions showMovies getService failed! getService failed! getService failed! getService failed! ERROR reading section - Value too large for defined data type getService failed! action -> OkCancelActions ok playing 1:0:0:0:0:0:0:0:0:0:/hdd/movie/20070116 1925 - PREMIERE 2.ts stopService service end! [eDVBCAService] free slot 0 demux 2 for service 1:0:1:6E42:431:1:C00000:0:0:0: [eDVBCAService] free slot 1 demux 0 for service 1:0:1:6E42:431:1:C00000:0:0:0: [eDVBCAService] free service 1:0:1:6E42:431:1:C00000:0:0:0: VIDEO CHANGED (to ffffffff) STOP VIDEO_STOP start release channel timer allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! ERROR reading section - Value too large for defined data type ERROR reading section - Value too large for defined data type release cached channel (timer timeout) [eDVBLocalTimerHandler] remove channel 0x10ef2a20 [eEPGCache] remove channel 0x10ef2a20 [EPGC] abort caching events !! stop release channel timer playing 1:0:0:0:0:0:0:0:0:0:/hdd/movie/20070116 1925 - PREMIERE 2.ts getService failed! alloc PVR before: 1 after: 1 setIoPrio best-effort level 0 ok FILEPUSH THREAD START allocate demux no version filtering 0012: 4e 00 00 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 getNextSourceSpan, no decoding demux. forcing normal play loading cuts.. 1 entries source span: 0 .. 16ea3470, translated to 0..873bf5f4 self.isSeekable True self.timeshift_enabled False timeshift activate: False new service started! trying to download cuts! self.isSeekable True self.timeshift_enabled False timeshift activate: False seekable status changed! seekable seekable status changed! seekable + 1/1 TID 00 done! no version filtering 0067: 02 00 0b 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 doing version filtering 0000: 00 00 00 23 00 00 mask: ff 00 00 3f 00 00 mode: 00 00 00 3e 00 00 + 1/1 TID 02 done! eventNewProgramInfo 0 0 have 1 video stream(s) (06ff), and 3 audio stream(s) (0700, 0701, 0703), and the pcr pid is 06ff, and the text pid is 0020 disable teletext subtitles VIDEO CHANGED (to 06ff) new video Video Device: /dev/dvb/adapter0/video0 demux device: /dev/dvb/adapter0/demux0 video: VIDEO_SET_STREAMTYPE: Operation not supported eDVBServicePlay::seekTo: jump 0 seek. FILEPUSH THREAD STOP thread joined 0 before: 1 after: 1 setIoPrio best-effort level 0 ok FILEPUSH THREAD START doing version filtering 0067: 02 00 0b 39 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 getNextSourceSpan, current offset is 00260000! ok, resolved skip (rel: 0, diff 0), now at 00000000 HIT, 0 < 0 < 2268853748, size: 10485760 action -> MsgBoxActions ok eDVBServicePlay::seekTo: jump 61035657 seek. FILEPUSH THREAD STOP thread joined 0 before: 1 after: 1 setIoPrio best-effort level 0 ok FILEPUSH THREAD START getNextSourceSpan, current offset is 00330000! ok, resolved skip (rel: 0, diff 61035657), now at 1497618c HIT, 0 < 345465228 < 2268853748, size: 10485760 close frontend 0 timeout! action -> InfobarSeekActions seekFwd action -> InfobarSeekActions seekFwd action -> InfobarSeekActions seekFwd action -> InfobarSeekActions seekFwd setting cue skipmode to 32 skipmode ratio is 2880000:90000, bitrate is 4250494 bit/s resolved to: 1800000 524288 FILEPUSH THREAD STOP thread joined 0 before: 1 after: 1 setIoPrio best-effort level 0 ok FILEPUSH THREAD START skipmode 1800000:524288 getNextSourceSpan, current offset is 150c618c! ok, resolved skip (rel: 1, diff 61820457), now at 14e3deec HIT, 0 < 350478060 < 2268853748, size: 524288 skipmode 1800000:524288 getNextSourceSpan, current offset is 14ebdeec! HIT, 0 < 352802348 < 2268853748, size: 524288 skipmode 1800000:524288 getNextSourceSpan, current offset is 150f562c! HIT, 0 < 355126636 < 2268853748, size: 524288 skipmode 1800000:524288 getNextSourceSpan, current offset is 1532cd6c! HIT, 0 < 357450924 < 2268853748, size: 524288 skipmode 1800000:524288 getNextSourceSpan, current offset is 155644ac! HIT, 0 < 359775212 < 2268853748, size: 524288 skipmode 1800000:524288 getNextSourceSpan, current offset is 1579bbec! HIT, 0 < 362099500 < 2268853748, size: 524288 action -> InfobarSeekActions seekFwd setting cue skipmode to 64 skipmode ratio is 5760000:90000, bitrate is 4250494 bit/s resolved to: 3600000 524288 FILEPUSH THREAD STOP thread joined 0 before: 1 after: 1 setIoPrio best-effort level 0 ok FILEPUSH THREAD START skipmode 3600000:524288 getNextSourceSpan, current offset is 1599332c! ok, resolved skip (rel: 1, diff 63364857), now at 1573942c HIT, 0 < 359896108 < 2268853748, size: 524288 skipmode 3600000:524288 getNextSourceSpan, current offset is 157b942c! HIT, 0 < 364020396 < 2268853748, size: 524288 skipmode 3600000:524288 getNextSourceSpan, current offset is 15ba82ac! HIT, 0 < 368144684 < 2268853748, size: 524288 skipmode 3600000:524288 getNextSourceSpan, current offset is 15f9712c! HIT, 0 < 372268972 < 2268853748, size: 524288 skipmode 3600000:524288 getNextSourceSpan, current offset is 16385fac! HIT, 0 < 376393260 < 2268853748, size: 524288 skipmode 3600000:524288 getNextSourceSpan, current offset is 16774e2c! HIT, 0 < 380517548 < 2268853748, size: 524288 skipmode 3600000:524288 getNextSourceSpan, current offset is 16b63cac! HIT, 0 < 384641836 < 2268853748, size: 524288 skipmode 3600000:524288 getNextSourceSpan, current offset is 16f52b2c! HIT, 0 < 388766124 < 2268853748, size: 524288 skipmode 3600000:524288 getNextSourceSpan, current offset is 173419ac! HIT, 0 < 392890412 < 2268853748, size: 524288 skipmode 3600000:524288 getNextSourceSpan, current offset is 1773082c! HIT, 0 < 397014700 < 2268853748, size: 524288 skipmode 3600000:524288 getNextSourceSpan, current offset is 17b1f6ac! HIT, 0 < 401138988 < 2268853748, size: 524288 skipmode 3600000:524288 getNextSourceSpan, current offset is 17f0e52c! HIT, 0 < 405263276 < 2268853748, size: 524288 action -> InfobarSeekActions unPauseService unpause setting cue skipmode to 0 skipmode ratio is 0, normal play FILEPUSH THREAD STOP thread joined 0 before: 1 after: 1 setIoPrio best-effort level 0 ok FILEPUSH THREAD START getNextSourceSpan, current offset is 1828d3ac! ok, resolved skip (rel: 1, diff 69369657), now at 17b01074 HIT, 0 < 397414516 < 2268853748, size: 10485760 action -> MoviePlayerActions leavePlayer action -> MsgBoxActions ok playing 1:0:1:6E42:431:1:C00000:0:0:0: stopService service end! FILEPUSH THREAD STOP thread joined 0 VIDEO CHANGED (to ffffffff) STOP VIDEO_STOP Traceback (most recent call last): File "/usr/lib/enigma2/python/mytest.py", line 156, in processDelay callback(*retval) File "/usr/lib/enigma2/python/Screens/InfoBar.py", line 118, in leavePlayerConfirmed self.close() File "/usr/lib/enigma2/python/Screens/Screen.py", line 97, in close self.session.close(self, *retval) File "/usr/lib/enigma2/python/mytest.py", line 295, in close assert screen == self.current_dialog AssertionError