=~=~=~=~=~=~=~=~=~=~=~= PuTTY log 2010.02.12 21:50:29 =~=~=~=~=~=~=~=~=~=~=~= init 4 root@dm8000:~# enigma2.sh PYTHONPATH: /usr/lib/enigma2/python + (1) Background File Eraser + (8) graphics acceleration manager + (9) gLCDDC found OLED display! + (9) GFBDC 16384k video mem - double buffering available! 13144kB available for acceleration surfaces. resolution: 720 x 576 x 32 (stride: 2880) + (9) Font Render Class [FONT] initializing lib... [FONT] loading fonts... [FONT] Intializing font cache, using max. 4MB... + (10) gRC RC thread created successfully + (15) eWindowStyleManager + (20) DVB-CI UI + (20) misc options + (20) UHF Modulator couldnt open /dev/rfmod0!!!! + (20) AVSwitch Driver + (20) RC Input layer + (21) Console RC Driver + (21) input device driver Input device "dreambox front panel" is not a keyboard. Input device "dreambox remote control (native)" is not a keyboard. Input device "dreambox advanced remote control (native)" is not a keyboard. EVIOCGRAB: Invalid argument Input device "dreambox ir keyboard" is a keyboard. Input device "dreambox ir mouse" is not a keyboard. Found 5 input devices! + (30) eActionMap + (35) CI Slots scanning for common interfaces.. CI Slot 0 setSource(0) CI Slot 1 setSource(0) CI Slot 2 setSource(0) CI Slot 3 setSource(0) eDVBCIInterfaces->setInputSource(0, 0) eDVBCIInterfaces->setInputSource(1, 1) eDVBCIInterfaces->setInputSource(2, 2) eDVBCIInterfaces->setInputSource(3, 3) done, found 4 common interface slots + (40) eServiceCenter settings instance. + (41) eServiceFactoryFS + (41) eServiceFactoryDVB + (41) eServiceFactoryMP3 reached rl 70 ---- opening lame channel db reading services (version 4) loaded 3503 services scanning for frontends.. opening frontend 0 detected satellite frontend close frontend 0 opening frontend 1 detected satellite frontend close frontend 1 found 1 adapter, 2 frontends(2 sim) and 5 demux, boxtype 3 Use valid Linux Time :) (RTC?) [EPGC] Initialized EPGCache [EPGC] time updated.. start EPG Mainloop before: 1 after: 1 Loading spinners... found 6 spinner! executing main setIoPrio best-effort level 3 ok /proc/stb/fp/lnb_sense0 is 0 enumerating block devices... found block device 'sde': no medium found block device 'sdd': no medium found block device 'sdc': no medium found block device 'sdb': ok, removable=True, cdrom=False, partitions=['sdb1'], device=sdb using cached result using cached result found block device 'sda': no medium found block device 'sr0': no medium found block device 'mtdblock6': blacklisted found block device 'mtdblock5': blacklisted found block device 'mtdblock4': blacklisted found block device 'mtdblock3': blacklisted found block device 'mtdblock2': blacklisted found block device 'mtdblock1': blacklisted found block device 'mtdblock0': blacklisted found block device 'hdc':main thread is non-idle! display spinner! ok, removable=False, cdrom=False, partitions=['hdc1'], device=hdc couldn't read model: [Errno 2] No such file or directory: '/sys/devices/pci0000:01/0000:01:00.0/ide1/1.0/model' using cached result new Harddisk hdc -> /dev/hdc -> /dev/hdc [ePopen] command: ('hdparm', 'hdparm', '-S0', '/dev/hdc') couldn't read model: [Errno 2] No such file or directory: '/sys/devices/pci0000:01/0000:01:00.0/ide1/1.0/model' using cached result found block device 'loop7': blacklisted found block device 'loop6': blacklisted found block device 'loop5': blacklisted found block device 'loop4': blacklisted found block device 'loop3': blacklisted found block device 'loop2': blacklisted found block device 'loop1': blacklisted found block device 'loop0': blacklisted Preferred tag editor set to None Reading satellites.xml main thread is non-idle! display spinner! using cached result sec config cleared setSlotInfo for dvb frontend 0 to slotid 0, descr BCM4501 (internal), need rotorworkaround Yes, enabled Yes, DVB-S2 Yes setSlotInfo for dvb frontend 1 to slotid 1, descr BCM4501 (internal), need rotorworkaround Yes, enabled Yes, DVB-S2 Yes using cached result slot: 0 configmode: simple diseqcmode: diseqc_a_b using cached result slot: 1 configmode: simple diseqcmode: diseqc_a_b using cached result using cached result sec config completed loading bouquet... /etc/enigma2/bouquets.tv loading bouquet... /etc/enigma2/userbouquet.favourites.tv 75 entries in Bouquet userbouquet.favourites.tv loading bouquet... /etc/enigma2/userbouquet.dbe00.tv 7 entries in Bouquet userbouquet.dbe00.tv 2 entries in Bouquet bouquets.tv loading bouquet... /etc/enigma2/bouquets.radio loading bouquet... /etc/enigma2/userbouquet.favourites.radio 14 entries in Bouquet userbouquet.favourites.radio 1 entries in Bouquet bouquets.radio [eDVBLocalTimeHandler] enable sync local time with transponder time! add dreampackage scanner plugin added - double buffering available! 9184kB available for acceleration surfaces. resolution: 1280 x 720 x 32 (stride: 5120) [FONT] adding font /usr/share/fonts/ds_digital.ttf...OK (LCD) [FONT] adding font /usr/share/fonts/nmsbd.ttf...OK (Regular) [FONT] adding font /usr/share/fonts/ae_AlMateen.ttf...OK (Replacement) [FONT] adding font /usr/share/fonts/tuxtxt.ttf...OK (Console) [FONT] adding font /usr/share/fonts/nmsbd.ttf...OK (LCD_NN) --> setting scaler_sharpness to: 0000000D couldn't open /proc/stb/misc/12V_output [ePopen] command: ip -o addr [ePopen] command: ip -o addr setLCDBrightness 25 setLCDBrightness 127 Activating keymap: Keyboard Englisch [ePopen] command: loadkmap < /usr/share/keymaps/eng.kmap Activating language German language set to de_DE It's now Fri Feb 12 21:50:58 2010 [timer.py] next activation: 1266007958 (in 99695 ms) [WebInterface] set language to de [WebInterface] set language to de [WebInterface] fallback to default translation for Webinterface using cached result getModeList for port DVI-PC using cached result getModeList for port YPbPr getModeList for port Scart getModeList for port DVI-PC getModeList for port DVI hotplug on dvi -> setting aspect, policy, policy2, wss 16:9 panscan letterbox auto -> setting aspect, policy, policy2, wss 16:9 panscan letterbox auto -> setting aspect, policy, policy2, wss 16:9 panscan letterbox auto -> setting aspect, policy, policy2, wss 16:9 panscan letterbox auto setMode - port: DVI mode: 1080i rate: 50Hz -> setting aspect, policy, policy2, wss 16:9 panscan letterbox auto --> setting contrast to: 00008000 --> setting saturation to: 00008000 --> setting hue to: 00008000 --> setting brightness to: 00008000 --> setting block_noise_reduction to: 00000001 --> setting mosquito_noise_reduction to: 00000000 --> setting digital_contour_removal to: 00000002 --> setting splitmode to: off --> setting sharpness to: 00000000 --> setting auto_flesh to: 00000000 --> setting green_boost to: 00000000 --> setting blue_boost to: 00000000 --> setting dynamic_contrast to: 00000015 --> applying pep values [NetworkBrowser] set language to de [NetworkBrowser] set language to de NFSMOUNT {'username': False, 'sharedir': 'c/RaNas_Movie', 'ip': '10.18.0.11', 'hdd_replacement': 'False', 'isMounted': False, 'sharename': 'RANAS', 'active': 'True', 'password': False, 'options': 'rw,nolock', 'mounttype': 'nfs'} [AutoMount.py] -getAutoMountPoints:self.automounts --> {'RANAS': {'username': False, 'sharedir': 'c/RaNas_Movie', 'ip': '10.18.0.11', 'hdd_replacement': 'False', 'isMounted': False, 'sharename': 'RANAS', 'active': 'True', 'password': False, 'options': 'rw,nolock', 'mounttype': 'nfs'}} [AutoMount.py] CheckMountPoint [AutoMount.py] activeMounts:---> 1 [AutoMount.py] CheckMountPointFinished [AutoMount.py] result None [AutoMount.py] retval None LEN 0 PATH im CheckMountPointFinished /media/net/RANAS using cached result callback InitUsageConfig got mounted_partitions [('/autofs/28988577-da10-48b2-bad2-a1bbaba878b7/', 'Back, lower USB Slot '), ('/media/hdd/', 'HDD'), ('/', 'FLASH'), ('/picons/', 'PICONS')] 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 Fri Feb 12 21:51:01 2010 [timer.py] next activation: 1266007961 (in 99145 ms) [TIMER] record time changed, start prepare is now: Sat Feb 13 12:21:40 2010 sanitycheck check checkTimerlist recording service: 1:0:1:6DCC:44D:1:C00000:0:0:0: record: 0 [Timer] Record ProcessRepeated It's now Fri Feb 12 21:51:01 2010 next real activation is Sat Feb 13 12:21:40 2010 [timer.py] next activation: 1266007961 (in 99120 ms) [TIMER] record time changed, start prepare is now: Sat Feb 13 15:26:40 2010 sanitycheck check checkTimerlist recording service: 1:0:1:6DCC:44D:1:C00000:0:0:0: record: 0 recording service: 1:0:1:6D66:437:1:C00000:0:0:0: record: 0 [Timer] Record ProcessRepeated It's now Fri Feb 12 21:51:01 2010 next real activation is Sat Feb 13 12:21:40 2010 [timer.py] next activation: 1266007961 (in 99099 ms) [TIMER] record time changed, start prepare is now: Sat Feb 13 16:11:40 2010 sanitycheck check checkTimerlist recording service: 1:0:1:6DCC:44D:1:C00000:0:0:0: record: 0 recording service: 1:0:1:6D66:437:1:C00000:0:0:0: record: 0 recording service: 1:0:1:6D66:437:1:C00000:0:0:0: record: 0 [Timer] Record ProcessRepeated It's now Fri Feb 12 21:51:01 2010 next real activation is Sat Feb 13 12:21:40 2010 [timer.py] next activation: 1266007961 (in 99075 ms) [TIMER] record time changed, start prepare is now: Sun Feb 14 01:01:40 2010 sanitycheck check checkTimerlist recording service: 1:0:1:6DCC:44D:1:C00000:0:0:0: record: 0 recording service: 1:0:1:6D66:437:1:C00000:0:0:0: record: 0 recording service: 1:0:1:6D66:437:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B70:3F3:1:C00000:0:0:0: record: 0 [Timer] Record ProcessRepeated It's now Fri Feb 12 21:51:01 2010 next real activation is Sat Feb 13 12:21:40 2010 [timer.py] next activation: 1266007961 (in 99046 ms) [TIMER] record time changed, start prepare is now: Sun Feb 14 13:59:40 2010 sanitycheck check checkTimerlist recording service: 1:0:1:6DCC:44D:1:C00000:0:0:0: record: 0 recording service: 1:0:1:6D66:437:1:C00000:0:0:0: record: 0 recording service: 1:0:1:6D66:437:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B70:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445F:453:1:C00000:0:0:0: record: 0 [Timer] Record ProcessRepeated It's now Fri Feb 12 21:51:01 2010 next real activation is Sat Feb 13 12:21:40 2010 [timer.py] next activation: 1266007961 (in 99008 ms) [TIMER] record time changed, start prepare is now: Mon Feb 15 02:53:40 2010 sanitycheck check checkTimerlist recording service: 1:0:1:6DCC:44D:1:C00000:0:0:0: record: 0 recording service: 1:0:1:6D66:437:1:C00000:0:0:0: record: 0 recording service: 1:0:1:6D66:437:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B70:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445F:453:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445F:453:1:C00000:0:0:0: record: 0 [Timer] Record ProcessRepeated It's now Fri Feb 12 21:51:02 2010 next real activation is Sat Feb 13 12:21:40 2010 [timer.py] next activation: 1266007962 (in 99966 ms) [TIMER] record time changed, start prepare is now: Mon Feb 15 12:14:40 2010 sanitycheck check checkTimerlist recording service: 1:0:1:6DCC:44D:1:C00000:0:0:0: record: 0 recording service: 1:0:1:6D66:437:1:C00000:0:0:0: record: 0 recording service: 1:0:1:6D66:437:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B70:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445F:453:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445F:453:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445E:453:1:C00000:0:0:0: record: 0 [Timer] Record ProcessRepeated It's now Fri Feb 12 21:51:02 2010 next real activation is Sat Feb 13 12:21:40 2010 [timer.py] next activation: 1266007962 (in 99914 ms) [TIMER] record time changed, start prepare is now: Mon Feb 15 12:43:40 2010 sanitycheck check checkTimerlist recording service: 1:0:1:6DCC:44D:1:C00000:0:0:0: record: 0 recording service: 1:0:1:6D66:437:1:C00000:0:0:0: record: 0 recording service: 1:0:1:6D66:437:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B70:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445F:453:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445F:453:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445E:453:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445E:453:1:C00000:0:0:0: record: 0 [Timer] Record ProcessRepeated It's now Fri Feb 12 21:51:02 2010 next real activation is Sat Feb 13 12:21:40 2010 [timer.py] next activation: 1266007962 (in 99863 ms) [TIMER] record time changed, start prepare is now: Mon Feb 15 14:11:40 2010 sanitycheck check checkTimerlist recording service: 1:0:1:6DCC:44D:1:C00000:0:0:0: record: 0 recording service: 1:0:1:6D66:437:1:C00000:0:0:0: record: 0 recording service: 1:0:1:6D66:437:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B70:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445F:453:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445F:453:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445E:453:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445E:453:1:C00000:0:0:0: record: 0 recording service: 1:0:1:6D66:437:1:C00000:0:0:0: record: 0 [Timer] Record ProcessRepeated It's now Fri Feb 12 21:51:02 2010 next real activation is Sat Feb 13 12:21:40 2010 [timer.py] next activation: 1266007962 (in 99806 ms) [TIMER] record time changed, start prepare is now: Mon Feb 15 16:57:40 2010 sanitycheck check checkTimerlist recording service: 1:0:1:6DCC:44D:1:C00000:0:0:0: record: 0 recording service: 1:0:1:6D66:437:1:C00000:0:0:0: record: 0 recording service: 1:0:1:6D66:437:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B70:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445F:453:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445F:453:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445E:453:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445E:453:1:C00000:0:0:0: record: 0 recording service: 1:0:1:6D66:437:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445E:453:1:C00000:0:0:0: record: 0 [Timer] Record ProcessRepeated It's now Fri Feb 12 21:51:02 2010 next real activation is Sat Feb 13 12:21:40 2010 [timer.py] next activation: 1266007962 (in 99747 ms) [TIMER] record time changed, start prepare is now: Mon Feb 15 17:24:40 2010 sanitycheck check checkTimerlist recording service: 1:0:1:6DCC:44D:1:C00000:0:0:0: record: 0 recording service: 1:0:1:6D66:437:1:C00000:0:0:0: record: 0 recording service: 1:0:1:6D66:437:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B70:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445F:453:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445F:453:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445E:453:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445E:453:1:C00000:0:0:0: record: 0 recording service: 1:0:1:6D66:437:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445E:453:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445E:453:1:C00000:0:0:0: record: 0 [Timer] Record ProcessRepeated It's now Fri Feb 12 21:51:02 2010 next real activation is Sat Feb 13 12:21:40 2010 [timer.py] next activation: 1266007962 (in 99679 ms) [TIMER] record time changed, start prepare is now: Tue Feb 16 14:11:40 2010 sanitycheck check checkTimerlist recording service: 1:0:1:6DCC:44D:1:C00000:0:0:0: record: 0 recording service: 1:0:1:6D66:437:1:C00000:0:0:0: record: 0 recording service: 1:0:1:6D66:437:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B70:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445F:453:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445F:453:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445E:453:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445E:453:1:C00000:0:0:0: record: 0 recording service: 1:0:1:6D66:437:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445E:453:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445E:453:1:C00000:0:0:0: record: 0 recording service: 1:0:1:6D66:437:1:C00000:0:0:0: record: 0 [Timer] Record ProcessRepeated It's now Fri Feb 12 21:51:02 2010 next real activation is Sat Feb 13 12:21:40 2010 [timer.py] next activation: 1266007962 (in 99607 ms) [TIMER] record time changed, start prepare is now: Wed Feb 17 14:11:40 2010 sanitycheck check checkTimerlist recording service: 1:0:1:6DCC:44D:1:C00000:0:0:0: record: 0 recording service: 1:0:1:6D66:437:1:C00000:0:0:0: record: 0 recording service: 1:0:1:6D66:437:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B70:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445F:453:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445F:453:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445E:453:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445E:453:1:C00000:0:0:0: record: 0 recording service: 1:0:1:6D66:437:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445E:453:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445E:453:1:C00000:0:0:0: record: 0 recording service: 1:0:1:6D66:437:1:C00000:0:0:0: record: 0 recording service: 1:0:1:6D66:437:1:C00000:0:0:0: record: 0 [Timer] Record ProcessRepeated It's now Fri Feb 12 21:51:02 2010 next real activation is Sat Feb 13 12:21:40 2010 [timer.py] next activation: 1266007962 (in 99532 ms) [TIMER] record time changed, start prepare is now: Thu Feb 18 14:11:40 2010 sanitycheck check checkTimerlist recording service: 1:0:1:6DCC:44D:1:C00000:0:0:0: record: 0 recording service: 1:0:1:6D66:437:1:C00000:0:0:0: record: 0 recording service: 1:0:1:6D66:437:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B70:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445F:453:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445F:453:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445E:453:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445E:453:1:C00000:0:0:0: record: 0 recording service: 1:0:1:6D66:437:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445E:453:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445E:453:1:C00000:0:0:0: record: 0 recording service: 1:0:1:6D66:437:1:C00000:0:0:0: record: 0 recording service: 1:0:1:6D66:437:1:C00000:0:0:0: record: 0 recording service: 1:0:1:6D66:437:1:C00000:0:0:0: record: 0 [Timer] Record ProcessRepeated It's now Fri Feb 12 21:51:02 2010 next real activation is Sat Feb 13 12:21:40 2010 [timer.py] next activation: 1266007962 (in 99444 ms) [TIMER] record time changed, start prepare is now: Thu Feb 18 18:54:40 2010 sanitycheck check checkTimerlist recording service: 1:0:1:6DCC:44D:1:C00000:0:0:0: record: 0 recording service: 1:0:1:6D66:437:1:C00000:0:0:0: record: 0 recording service: 1:0:1:6D66:437:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B70:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445F:453:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445F:453:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445E:453:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445E:453:1:C00000:0:0:0: record: 0 recording service: 1:0:1:6D66:437:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445E:453:1:C00000:0:0:0: record: 0 recording service: 1:0:1:445E:453:1:C00000:0:0:0: record: 0 recording service: 1:0:1:6D66:437:1:C00000:0:0:0: record: 0 recording service: 1:0:1:6D66:437:1:C00000:0:0:0: record: 0 recording service: 1:0:1:6D66:437:1:C00000:0:0:0: record: 0 recording service: 1:0:1:132F:3EF:1:C00000:0:0:0: record: 0 [Timer] Record ProcessRepeated It's now Fri Feb 12 21:51:02 2010 next real activation is Sat Feb 13 12:21:40 2010 [timer.py] next activation: 1266007962 (in 99355 ms) It's now Fri Feb 12 21:51:02 2010 [timer.py] next activation: 1266007962 (in 99296 ms) begin_date: 20100213 1222 service_name: hr-fernsehen name: c't magazin description: Computer & Technik [TIMER] Filename calculated as: '/hdd/movie/20100213 1222 - hr-fernsehen - c't magazin' begin_date: 20100213 1527 service_name: ZDF name: Die Kinder-Küchenschlacht description: [TIMER] Filename calculated as: '/hdd/movie/20100213 1527 - ZDF - Die Kinder-Küchenschlacht' begin_date: 20100213 1612 service_name: ZDF name: Lafer!Lichter!Lecker! description: [TIMER] Filename calculated as: '/hdd/movie/20100213 1612 - ZDF - Lafer!Lichter!Lecker!' begin_date: 20100214 0102 service_name: arte HD name: Japan-Bondage description: Die Kunst des Fesselns - Dokumentation Frankreich 2006 [TIMER] Filename calculated as: '/hdd/movie/20100214 0102 - arte HD - Japan-Bondage' begin_date: 20100214 1400 service_name: N24 name: Doku: Angkor Wat - Das versunkene Herz Kambodschas description: Doku: Angkor Wat - Das versunkene Herz Kambodschas [TIMER] Filename calculated as: '/hdd/movie/20100214 1400 - N24 - Doku_ Angkor Wat - Das versunkene Herz Kambodschas' begin_date: 20100215 0254 service_name: N24 name: Doku: Angkor Wat - Das versunkene Herz Kambodschas description: Doku: Angkor Wat - Das versunkene Herz Kambodschas [TIMER] Filename calculated as: '/hdd/movie/20100215 0254 - N24 - Doku_ Angkor Wat - Das versunkene Herz Kambodschas' begin_date: 20100215 1215 service_name: kabel eins name: Two and a Half Men description: Two and a Half Men [TIMER] Filename calculated as: '/hdd/movie/20100215 1215 - kabel eins - Two and a Half Men' begin_date: 20100215 1244 service_name: kabel eins name: Two and a Half Men description: Two and a Half Men [TIMER] Filename calculated as: '/hdd/movie/20100215 1244 - kabel eins - Two and a Half Men' begin_date: 20100215 1412 service_name: ZDF name: Die Küchenschlacht description: Horst Lichter sucht den Spitzenkoch [TIMER] Filename calculated as: '/hdd/movie/20100215 1412 - ZDF - Die Küchenschlacht' begin_date: 20100215 1658 service_name: kabel eins name: Two and a Half Men description: Two and a Half Men [TIMER] Filename calculated as: '/hdd/movie/20100215 1658 - kabel eins - Two and a Half Men' begin_date: 20100215 1725 service_name: kabel eins name: Two and a Half Men description: Two and a Half Men [TIMER] Filename calculated as: '/hdd/movie/20100215 1725 - kabel eins - Two and a Half Men' begin_date: 20100216 1412 service_name: ZDF name: Die Küchenschlacht description: Horst Lichter sucht den Spitzenkoch [TIMER] Filename calculated as: '/hdd/movie/20100216 1412 - ZDF - Die Küchenschlacht' begin_date: 20100217 1412 service_name: ZDF name: Die Küchenschlacht description: Horst Lichter sucht den Spitzenkoch [TIMER] Filename calculated as: '/hdd/movie/20100217 1412 - ZDF - Die Küchenschlacht' begin_date: 20100218 1412 service_name: ZDF name: Die Küchenschlacht description: Horst Lichter sucht den Spitzenkoch [TIMER] Filename calculated as: '/hdd/movie/20100218 1412 - ZDF - Die Küchenschlacht' begin_date: 20100218 1855 service_name: ORF1 HD name: Mein cooler Onkel Charlie description: Geh von meinen Haaren runter [TIMER] Filename calculated as: '/hdd/movie/20100218 1855 - ORF1 HD - Mein cooler Onkel Charlie' allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! warning, skin is missing element DescriptionBorder in warning, skin is missing element FileSize in [EPGRefresh] Timer added >)> ProcessRepeated It's now Fri Feb 12 21:51:03 2010 [timer.py] next activation: 1266007894 (in 30636 ms) Repeated: 1 Repeated: 3 Repeated: 7 Repeated: 15 Repeated: 31 Repeated: 63 Repeated: 127 ProcessRepeated localrepeatedbegindate: Fri Feb 12 04:00:00 2010 localbegin: Fri Feb 12 04:00:00 2010 localend: Fri Feb 12 04:00:00 2010 localnow: Fri Feb 12 21:51:04 2010 Day: 0 Day: 1 Day: 2 Day: 3 Day: 4 Day: 5 Day: 6 localbegin after addOneDay: Sat Feb 13 04:00:00 2010 localend after addOneDay: Sat Feb 13 04:00:00 2010 ProcessRepeated result Sat Feb 13 04:00:00 2010 Sat Feb 13 04:00:01 2010 It's now Fri Feb 12 21:51:03 2010 [timer.py] next activation: 1266007894 (in 30618 ms) using cached result Looking for embedded skin allocating new converter! Looking for embedded skin port changed to DVI mode changed to 1080i getModeList for port DVI default ('1080i', 'default') preferedmodes ['720p', '576p', '480p', '576i', '480i', ('1080i', 'default')] [CrashlogAutoSubmit] - autostart [CrashlogAutoSubmit] - not starting CrashlogAutoSubmit NewNigma2: [TimerCleanup] Cleaning old Timers... No skin to read... No skin to read... warning, skin is missing element lb in No skin to read... warning, skin is missing element videosize in not showing fine-tuning wizard, config variable doesn't exist showtestcard is false Looking for embedded skin setValue 60 cannot open /proc/stb/audio/j1_mute(No such file or directory) Setvolume: 100 100 (raw) Setvolume: 0 0 (-1db) Setvolume: 60 60 (raw) Setvolume: 26 26 (-1db) lookup for events with 'Lanz kocht' in title(ignore case) lookup for events with 'chenschlacht' in title(ignore case) lookup for events with 'Kocharena' in title(ignore case) lookup for events with 'Inas Nacht' in title(ignore case) lookup for events with 'kambod' in title(ignore case) lookup for events with 'poletto' in title(ignore case) lookup for events with 'Lafer!Lichter!Lecker!' in title(ignore case) lookup for events with 'c't magazin' as title(case sensitive) lookup for events with 'Two and a Half Men' in title(ignore case) lookup for events with 'Two and a Half Men' as title(case sensitive) lookup for events with 'Anthony Bourdain' in title(ignore case) lookup for events with 'Der Himmel ' in title(ignore case) lookup for events with 'Mein cooler Onkel Charlie' in title(ignore case) lookup for events with 'Wir sind Kaiser' in title(ignore case) lookup for events with 'Willkommen' in title(ignore case) lookup for events with 'Dorfers Donnerstalk' as title(case sensitive) 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 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! 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! reused converter! valign must be either top, center or bottom! playing 1:0:1:2EE3:441:1:C00000:0:0:0: NewNigma2: [Picon Renderer] RTL TELEVISION not found in cache NewNigma2: [Picon Renderer] RTL TELEVISION not found in cache not pauseable. RemovePopup, id = ZapError allocate channel.. 0441:0001 opening frontend 0 [eDVBCAService] new channel 0x10cae410! (0)tune RotorCmd ffffffff, lastRotorCmd ffffffff prepare_sat System 0 Freq 12187500 Pol 0 SR 27500000 INV 2 FEC 3 orbpos 192 system 0 modulation 1 pilot 2, rolloff 0 tuning to 1587 mhz OURSTATE: tuning allocate Channel: res 0 [eDVBCIInterfaces] addPMTHandler 1:0:1:2EE3:441:1:C00000:0:0:0: allocate demux [SEC] set static current limiting set sequence pos 3 set sequence pos 4 [SEC] setVoltage 1 [SEC] sleep 200ms CI Slot 1: reset requested ci flush ci inserted in slot 1 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) child has terminated pipes closed poll: unhandled POLLERR/HUP/NVAL for fd 45(17) [SEC] invalidate current switch params [SEC] sendDiseqc: e00000(DiSEqC reset) [SEC] sleep 50ms child has terminated pipes closed 10.0.0. 0.0.0.0 poll: unhandled POLLERR/HUP/NVAL for fd 39(16) [SEC] sendDiseqc: e00003(DiSEqC peripherial power on) [SEC] sleep 150ms child has terminated pipes closed nameservers: [[213, 129, 232, 1], [213, 129, 226, 2]] read configured interfac: {'lo': {'dhcp': False}, 'ath0': {'dhcp': True}, 'eth0': {'dhcp': False}} 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': [10, 18, 0, 222], 'up': True, 'mac': '00:09:34:1c:2d:f0', 'dhcp': False, 'netmask': [255, 0, 0, 0], 'gateway': [10, 0, 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 10.18.0.222:80 auth= False ssl= False [Webinterface] started on 10.18.0.222: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) [SEC] sendDiseqc: e01038f3 [SEC] sleep 50ms set sequence pos 3 set sequence pos 3 [SEC] update current switch params [SEC] startTuneTimeout 5000 [SEC] setFrontend 1 setting frontend 0 [SEC] sleep 500ms (0)fe event: status 0, inversion off, m_tuning 1 (0)fe event: status 1, inversion off, m_tuning 2 (0)fe event: status 1f, inversion off, m_tuning 3 OURSTATE: ok [eDVBCAService] channel 0x10cae410 running [eDVBLocalTimerHandler] channel 0x10cae410 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 0x10cae410 running stop release channel timer no version filtering 0012: 4e 2e e3 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) (00a3), and 1 audio stream(s) (0068), and the pcr pid is 00a3, and the text pid is 0069 allocate demux disable teletext subtitles decoder state: play, vpid=163, apid=104 DMX_SET_PES_FILTER(0xa3) - pcr - ok DEMUX_START - pcr - ok DMX_SET_PES_FILTER(0x68) - 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(0xa3) - video - ok DEMUX_START - video - ok VIDEO_FREEZE - ok VIDEO_PLAY - ok DMX_SET_PES_FILTER(0x69) - 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. [AutoRes] service changed VIDEO_GET_EVENT - ok [AutoRes] got event evVideoSizeChanged VIDEO_GET_EVENT - ok [AutoRes] got event evVideoProgressiveChanged [SEC] set dynamic current limiting + 1/1 TID 00 done! no version filtering 002c: 02 2e e3 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 VIDEO_GET_EVENT - ok [AutoRes] got event evVideoSizeChanged sdt update done! + 1/1 TID 02 done! eventNewProgramInfo 0 0 have 1 video stream(s) (00a3), and 2 audio stream(s) (0068, 006a), and the pcr pid is 00a3, and the text pid is 0069 decoder state: play, vpid=163, apid=104 [eDVBCAService] new service 1:0:1:2EE3:441:1:C00000:0:0:0: [eDVBCAService] add demux 0 to slot 0 service 1:0:1:2EE3:441:1:C00000:0:0:0: [eDVBCIInterfaces] gotPMT demux 0 mask 01 prevhash 00000000 [eDVBCAService] send 59 bytes 9f 80 32 37 03 2e e3 0f 00 13 01 81 08 00 c0 00 00 04 41 00 01 82 02 01 00 84 02 00 2c 02 00 a3 00 00 03 00 68 00 00 05 00 6c 00 00 06 00 69 00 00 06 00 6a 00 00 0b 00 6b 00 00 doing version filtering 002c: 02 2e e3 0f 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 -+ 1/2 TID 4e VIDEO_GET_EVENT - ok [AutoRes] got event evVideoProgressiveChanged [AutoRes] determineContent [AutoRes] switch deinterlacer mode to auto [AutoRes] new content is 720x576i25 [AutoRes] determined videomode 1080i ++ 2/2 TID 4e done! doing version filtering 0012: 4e 2e e3 05 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 [EPGC] start caching events(1266007868) ci inserted in slot 1 slot: 0x1009c330 91 04 00 01 00 41 RESOURCE MANAGER new session nb 1 0x10d2d668 sendOpenSessionResponse slot: 0x1009c330 90 02 00 01 9f 80 11 00 SESSION(1) 9f 80 11: mein cam kann: nichts slot: 0x1009c330 90 02 00 01 9f 80 10 00 SESSION(1) 9f 80 10: cam fragt was ich kann. slot: 0x1009c330 91 04 00 02 00 41 APPLICATION MANAGER new session nb 2 0x10d3fa00 sendOpenSessionResponse slot: 0x1009c330 90 02 00 02 9f 80 21 0e 01 05 00 05 00 08 56 69 61 63 63 65 73 73 SESSION(2)/APP 9f 80 21: 01 05 00 05 00 08 56 69 61 63 63 65 73 73 application info: len: 14 application_type: 1 application_manufacturer: 00 05 manufacturer_code: 00 05 menu string: Viaccess in final state. slot: 0x1009c330 91 04 00 03 00 41 CA MANAGER new session nb 3 0x10d46458 sendOpenSessionResponse slot: 0x1009c330 90 02 00 03 9f 80 31 02 05 00 SESSION(3)/CA 9f 80 31: 05 00 ca info: 0500 Slot 1 plugged slot: 0x1009c330 91 04 00 24 00 41 DATE-TIME new session nb 4 0x10d56ab8 sendOpenSessionResponse slot: 0x1009c330 90 02 00 04 9f 84 40 01 0a SESSION(4)/DATETIME 9f 84 40: 0a [EPGC] abort non avail schedule other reading [EPGC] abort non avail viasat reading [EPGC] abort non avail mhw reading [EPGC] nownext finished(1266007875) [EPGC] schedule finished(1266007877) [EPGC] stop caching events(1266007877) [EPGC] next update in 60 min nr_read 707 nr_write 1796 sum 2503 prev_sum 0 hdd was accessed since previous check! [IDLE] 0 300 False no ancillary data in audio stream... abort radiotext pes parser [eDVBLocalTimerHandler] diff is 0 [eDVBLocalTimerHandler] diff < 120 .. use Transponder Time [eDVBLocalTimerHandler] not changed It's now Fri Feb 12 21:51:34 2010 [EPGRefresh] Not in timespan, ending timer next real activation is Sat Feb 13 04:00:01 2010 [timer.py] next activation: 1266007994 (in 99996 ms) action -> InfobarActions showMovies main thread is non-idle! display spinner! [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 486730 bytes for cache used nr_read 1704 nr_write 1820 sum 3524 prev_sum 2503 hdd was accessed since previous check! [IDLE] 0 300 False child has terminated pipes closed ERROR reading PES (fd=44) - Value too large for defined data type poll: unhandled POLLERR/HUP/NVAL for fd 44(8) poll: unhandled POLLERR/HUP/NVAL for fd 59(16) action -> PluginMovieSelectionActions bDownUp action -> PluginMovieSelectionActions bOK not pauseable. RemovePopup, id = ZapError ignore request to play already running service reused converter! reused converter! reused converter! allocating new converter! allocating new converter! reused converter! allocating new converter! reused converter! reused converter! reused converter! reused converter! reused converter! reused converter! valign must be either top, center or bottom! valign must be either top, center or bottom! NewNigma2: Using ourMoviePlayerSummary_SummaryPiconOnly Skin reused converter! allocating new converter! allocating new converter! playing 1:0:0:0:0:0:0:0:0:0:/hdd/movie/20100209 1726 - kabel eins - Two and a Half Men.ts [eDVBCAService] free slot 0 demux 0 for service 1:0:1:2EE3:441:1:C00000:0:0:0: [eDVBCAService] free service 1:0:1:2EE3:441:1:C00000:0:0:0: decoder state: play, vpid=-1, apid=-1 DEMUX_STOP - pcr - ok DEMUX_STOP - video - ok VIDEO_STOP - ok AUDIO_STOP - ok DEMUX_STOP - audio - ok AUDIO_CONTINUE - ok DEMUX_STOP - ttx - ok start release channel timer alloc PVR [eDVBCAService] remove channel 0x10cae410 [eDVBLocalTimerHandler] remove channel 0x10cae410 [eEPGCache] remove channel 0x10cae410 loading streaminfo for /hdd/movie/20100209 1726 - kabel eins - Two and a Half Men.ts loading cuts.. 3 entries 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 eventNewProgramInfo 0 0 have 1 video stream(s) (02ff), and 1 audio stream(s) (0300), and the pcr pid is 02ff, and the text pid is 0022 disable teletext subtitles decoder state: play, vpid=767, apid=768 DMX_SET_PES_FILTER(0x300) - audio - ok DEMUX_START - audio - ok AUDIO_SET_BYPASS(1) - ok AUDIO_PAUSE - ok AUDIO_PLAY - getNextSourceSpan, current offset is 00000000, m_skipmode_m = 0! NO CUESHEET. (00000000, 10485700) ok Video Device: /dev/dvb/adapter0/video0 demux device: /dev/dvb/adapter0/demux4 VIDEO_SET_STREAMTYPE 0 - ok DMX_SET_PES_FILTER(0x2ff) - video - ok DEMUX_START - video - ok VIDEO_FREEZE - ok VIDEO_PLAY - ok DMX_SET_PES_FILTER(0x22) - ttx - ok DEMUX_START - ttx - ok VIDEO_SLOWMOTION(0) - ok VIDEO_FAST_FORWARD(0) - ok VIDEO_CONTINUE - ok AUDIO_CONTINUE - ok eDVBServicePlay::seekTo: jump 0 seek. stopping thread. FILEPUSH THREAD STOP thread joined 0 AUDIO_CLEAR_BUFFER - ok VIDEO_CLEAR_BUFFER - ok before: 1 after: 1 setIoPrio best-effort level 0 ok FILEPUSH THREAD START getNextSourceSpan, current offset is 0000ff90, m_skipmode_m = 0! getOffset for pts 0x0 ok, resolved skip (rel: 0, diff 0), now at 00000000 NO CUESHEET. (00000000, 10485700) NewNigma2: [Picon Renderer] TWO AND A HALF MEN not found in cache [Picon Renderer] not found: /autofs/28988577-da10-48b2-bad2-a1bbaba878b7/piconHD/TWO AND A HALF MEN.png [Picon Renderer] not found: /autofs/28988577-da10-48b2-bad2-a1bbaba878b7/piconHD/1_0_0_0_0_0_0_0_0_0.png [Picon Renderer] Sorry, i give up! NewNigma2: [Picon Renderer] TWO AND A HALF MEN not found in cache [Picon Renderer] not found: /autofs/28988577-da10-48b2-bad2-a1bbaba878b7/piconlcd/TWO AND A HALF MEN.png [Picon Renderer] not found: /autofs/28988577-da10-48b2-bad2-a1bbaba878b7/piconlcd/1_0_0_0_0_0_0_0_0_0.png [Picon Renderer] Sorry, i give up! new service started! trying to download cuts! RemovePopup, id = ZapError resolved to PLAY eDVBServicePlay::unpause eDVBServicePlay::seekTo: jump 0 seek. stopping thread. FILEPUSH THREAD STOP thread joined 0 AUDIO_CLEAR_BUFFER - ok VIDEO_CLEAR_BUFFER - ok before: 1 after: 1 setIoPrio best-effort level 0 ok FILEPUSH THREAD START getNextSourceSpan, current offset is 0002feb0, m_skipmode_m = 0! getOffset for pts 0x0 ok, resolved skip (rel: 0, diff 0), now at 00000000 NO CUESHEET. (00000000, 10485700) + 1/1 TID 00 done! no version filtering 0062: 02 44 5e 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 doing version filtering 0000: 00 00 00 2d 00 00 mask: ff 00 00 3f 00 00 mode: 00 00 00 3e 00 00 VIDEO_GET_EVENT - ok [AutoRes] got event evVideoSizeChanged + 1/1 TID 02 done! eventNewProgramInfo 0 0 have 1 video stream(s) (02ff), and 1 audio stream(s) (0300), and the pcr pid is 02ff, and the text pid is 0022 decoder state: play, vpid=767, apid=768 [AutoRes] service changed doing version filtering 0062: 02 44 5e 0f 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 [AutoRes] determineContent [AutoRes] switch deinterlacer mode to auto [AutoRes] new content is 720x576i25 [AutoRes] determined videomode 1080i close frontend 0 timeout 0012! action: unPauseService action -> InfobarSeekActions unPauseService unpause action -> InfobarShowHideActions toggleShow main thread is non-idle! display spinner! action: unPauseService action -> InfobarSeekActions unPauseService unpause action -> InfobarShowHideActions toggleShow action: unPauseService action -> InfobarSeekActions unPauseService unpause action -> InfobarShowHideActions toggleShow action: unPauseService action -> InfobarSeekActions unPauseService unpause action -> InfobarShowHideActions toggleShow ERROR reading PES (fd=40) - Value too large for defined data type poll: unhandled POLLERR/HUP/NVAL for fd 40(8) getNextSourceSpan, current offset is 009fffc4, m_skipmode_m = 0! NO CUESHEET. (009fffc4, 10485700) action -> PluginPlayerActions leavePlayer playing 1:0:1:2EE3:441:1:C00000:0:0:0: stopping thread. FILEPUSH THREAD STOP thread joined 0 service end! resolved to PLAY eDVBServicePlay::unpause decoder state: play, vpid=-1, apid=-1 DEMUX_STOP - video - ok VIDEO_STOP - ok AUDIO_STOP - ok DEMUX_STOP - audio - ok AUDIO_CONTINUE - ok DEMUX_STOP - ttx - ok NewNigma2: [Picon Renderer] RTL TELEVISION found in cache NewNigma2: [Picon Renderer] RTL TELEVISION found in cache not pauseable. new service started! trying to download cuts! download failed, no cuesheet interface RemovePopup, id = ZapError allocate channel.. 0441:0001 opening frontend 0 [eDVBCAService] new channel 0x10db97e0! (0)tune RotorCmd ffffffff, lastRotorCmd ffffffff prepare_sat System 0 Freq 12187500 Pol 0 SR 27500000 INV 2 FEC 3 orbpos 192 system 0 modulation 1 pilot 2, rolloff 0 tuning to 1587 mhz OURSTATE: tuning allocate Channel: res 0 [eDVBCIInterfaces] addPMTHandler 1:0:1:2EE3:441:1:C00000:0:0:0: allocate demux ignore request to play already running service [SEC] set static current limiting set sequence pos 3 set sequence pos 4 [SEC] setVoltage 1 [SEC] sleep 200ms [SEC] invalidate current switch params [SEC] sendDiseqc: e00000(DiSEqC reset) [SEC] sleep 50ms child has terminated pipes closed poll: unhandled POLLERR/HUP/NVAL for fd 37(16) [SEC] sendDiseqc: e00003(DiSEqC peripherial power on) [SEC] sleep 150ms child has terminated pipes closed poll: unhandled POLLERR/HUP/NVAL for fd 40(16) [SEC] sendDiseqc: e01038f3 [SEC] sleep 50ms set sequence pos 3 set sequence pos 3 [SEC] update current switch params [SEC] startTuneTimeout 5000 [SEC] setFrontend 1 setting frontend 0 [SEC] sleep 500ms (0)fe event: status 0, inversion off, m_tuning 1 action -> PluginMovieSelectionActions bDownUp (0)fe event: status 1, inversion off, m_tuning 2 (0)fe event: status 1f, inversion off, m_tuning 3 OURSTATE: ok [eDVBCAService] channel 0x10db97e0 running [eDVBLocalTimerHandler] channel 0x10db97e0 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 0x10db97e0 running stop release channel timer no version filtering 0012: 4e 2e e3 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) (00a3), and 1 audio stream(s) (0068), and the pcr pid is 00a3, and the text pid is 0069 allocate demux disable teletext subtitles decoder state: play, vpid=163, apid=104 DMX_SET_PES_FILTER(0xa3) - pcr - ok DEMUX_START - pcr - ok DMX_SET_PES_FILTER(0x68) - audio - ok DEMUX_START - audio - ok AUDIO_SET_BYPASS(1) - ok AUDIO_PAUSE - ok AUDIO_PLAY - [EPGC] next update in 58 min ok Video Device: /dev/dvb/adapter0/video0 demux device: /dev/dvb/adapter0/demux0 VIDEO_SET_STREAMTYPE 0 - ok DMX_SET_PES_FILTER(0xa3) - video - ok DEMUX_START - video - ok VIDEO_FREEZE - ok VIDEO_PLAY - ok DMX_SET_PES_FILTER(0x69) - ttx - ok DEMUX_START - ttx - ok VIDEO_SLOWMOTION(0) - ok VIDEO_FAST_FORWARD(0) - ok VIDEO_CONTINUE - ok AUDIO_CONTINUE - ok [AutoRes] service changed [SEC] set dynamic current limiting nr_read 4205 nr_write 1890 sum 6095 prev_sum 3524 hdd was accessed since previous check! [IDLE] 0 300 False +- 1/2 TID 4e + 1/1 TID 00 done! no version filtering 002c: 02 2e e3 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 VIDEO_GET_EVENT - ok [AutoRes] got event evVideoSizeChanged + 1/1 TID 02 done! eventNewProgramInfo 0 0 have 1 video stream(s) (00a3), and 2 audio stream(s) (0068, 006a), and the pcr pid is 00a3, and the text pid is 0069 decoder state: play, vpid=163, apid=104 [eDVBCAService] new service 1:0:1:2EE3:441:1:C00000:0:0:0: [eDVBCAService] add demux 0 to slot 0 service 1:0:1:2EE3:441:1:C00000:0:0:0: [eDVBCIInterfaces] gotPMT demux 0 mask 01 prevhash 00000000 [eDVBCAService] send 59 bytes 9f 80 32 37 03 2e e3 0f 00 13 01 81 08 00 c0 00 00 04 41 00 01 82 02 01 00 84 02 00 2c 02 00 a3 00 00 03 00 68 00 00 05 00 6c 00 00 06 00 69 00 00 06 00 6a 00 00 0b 00 6b 00 00 doing version filtering 002c: 02 2e e3 0f 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 [AutoRes] determineContent [AutoRes] switch deinterlacer mode to auto [AutoRes] new content is 720x576i25 [AutoRes] determined videomode 1080i action -> PluginMovieSelectionActions bOK not pauseable. RemovePopup, id = ZapError ignore request to play already running service reused converter! reused converter! reused converter! allocating new converter! allocating new converter! reused converter! allocating new converter! reused converter! reused converter! reused converter! reused converter! reused converter! reused converter! valign must be either top, center or bottom! valign must be either top, center or bottom! NewNigma2: Using ourMoviePlayerSummary_SummaryPiconOnly Skin reused converter! allocating new converter! allocating new converter! playing 1:0:0:0:0:0:0:0:0:0:/hdd/movie/20100209 1412 - ZDF - Die Küchenschlacht.ts [eDVBCAService] free slot 0 demux 0 for service 1:0:1:2EE3:441:1:C00000:0:0:0: [eDVBCAService] free service 1:0:1:2EE3:441:1:C00000:0:0:0: decoder state: play, vpid=-1, apid=-1 DEMUX_STOP - pcr - ok DEMUX_STOP - video - ok VIDEO_STOP - ok AUDIO_STOP - ok DEMUX_STOP - audio - ok AUDIO_CONTINUE - ok DEMUX_STOP - ttx - ok start release channel timer alloc PVR [eDVBCAService] remove channel 0x10db97e0 [eDVBLocalTimerHandler] remove channel 0x10db97e0 [eEPGCache] remove channel 0x10db97e0 loading streaminfo for /hdd/movie/20100209 1412 - ZDF - Die Küchenschlacht.ts loading cuts.. 3 entries 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 eventNewProgramInfo 0 0 have 1 video stream(s) (006e), and 1 audio stream(s) (0078), and the pcr pid is 006e, and the text pid is 0082 disable teletext subtitles decoder state: play, vpid=110, apid=120 DMX_SET_PES_FILTER(0x78) - audio - ok DEMUX_START - audio - ok AUDIO_SET_BYPASS(1) - ok AUDIO_PAUSE - ok AUDIO_PLAY - getNextSourceSpan, current offset is 00000000, m_skipmode_m = 0! NO CUESHEET. (00000000, 10485700) ok Video Device: /dev/dvb/adapter0/video0 demux device: /dev/dvb/adapter0/demux4 VIDEO_SET_STREAMTYPE 0 - ok DMX_SET_PES_FILTER(0x6e) - video - ok DEMUX_START - video - ok VIDEO_FREEZE - ok VIDEO_PLAY - ok DMX_SET_PES_FILTER(0x82) - ttx - ok DEMUX_START - ttx - ok VIDEO_SLOWMOTION(0) - ok VIDEO_FAST_FORWARD(0) - ok VIDEO_CONTINUE - ok AUDIO_CONTINUE - ok eDVBServicePlay::seekTo: jump 0 seek. stopping thread. FILEPUSH THREAD STOP thread joined 0 AUDIO_CLEAR_BUFFER - ok VIDEO_CLEAR_BUFFER - ok before: 1 after: 1 setIoPrio best-effort level 0 ok FILEPUSH THREAD START start dvb subtitles on pid 0x0083 with composition_page_id 1 and ancillary_page_id 1 getNextSourceSpan, current offset is 0000ff90, m_skipmode_m = 0! getOffset for pts 0x0 ok, resolved skip (rel: 0, diff 0), now at 00000000 NO CUESHEET. (00000000, 10485700) NewNigma2: [Picon Renderer] DIE KüCHENSCHLACHT not found in cache [Picon Renderer] not found: /autofs/28988577-da10-48b2-bad2-a1bbaba878b7/piconHD/DIE KüCHENSCHLACHT.png [Picon Renderer] not found: /autofs/28988577-da10-48b2-bad2-a1bbaba878b7/piconHD/1_0_0_0_0_0_0_0_0_0.png [Picon Renderer] Sorry, i give up! NewNigma2: [Picon Renderer] DIE KüCHENSCHLACHT not found in cache [Picon Renderer] not found: /autofs/28988577-da10-48b2-bad2-a1bbaba878b7/piconlcd/DIE KüCHENSCHLACHT.png [Picon Renderer] not found: /autofs/28988577-da10-48b2-bad2-a1bbaba878b7/piconlcd/1_0_0_0_0_0_0_0_0_0.png [Picon Renderer] Sorry, i give up! new service started! trying to download cuts! RemovePopup, id = ZapError resolved to PLAY eDVBServicePlay::unpause eDVBServicePlay::seekTo: jump 0 seek. stopping thread. FILEPUSH THREAD STOP thread joined 0 AUDIO_CLEAR_BUFFER - ok VIDEO_CLEAR_BUFFER - ok before: 1 after: 1 setIoPrio best-effort level 0 ok FILEPUSH THREAD START getNextSourceSpan, current offset is 000ff900, m_skipmode_m = 0! getOffset for pts 0x0 ok, resolved skip (rel: 0, diff 0), now at 00000000 NO CUESHEET. (00000000, 10485700) + 1/1 TID 00 done! DVB service failed to tune - error 3 RemovePopup, id = ZapError AddPopup, id = ZapError doing version filtering 0000: 00 00 00 2d 00 00 mask: ff 00 00 3f 00 00 mode: 00 00 00 3e 00 00 ERROR reading PES (fd=41) - Value too large for defined data type + 1/1 TID 00 done! no version filtering 0064: 02 6d 66 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 doing version filtering 0000: 00 00 00 1b 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) (006e), and 3 audio stream(s) (0078, 0079, 007d), and the pcr pid is 006e, and the text pid is 0082 decoder state: play, vpid=110, apid=120 [AutoRes] service changed doing version filtering 0064: 02 6d 66 29 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 disable dvb subtitles disable teletext subtitles start dvb subtitles on pid 0x0083 with composition_page_id 1 and ancillary_page_id 1 [AutoRes] determineContent [AutoRes] switch deinterlacer mode to auto [AutoRes] new content is 720x576i25 [AutoRes] determined videomode 1080i action -> MsgBoxActions ok close frontend 0 child has terminated pipes closed poll: unhandled POLLERR/HUP/NVAL for fd 62(16) timeout 0012! action: unPauseService action -> InfobarSeekActions unPauseService unpause action -> InfobarShowHideActions toggleShow getNextSourceSpan, current offset is 009fffc4, m_skipmode_m = 0! NO CUESHEET. (009fffc4, 10485700) It's now Fri Feb 12 21:52:42 2010 [timer.py] next activation: 1266008062 (in 99998 ms) It's now Fri Feb 12 21:52:42 2010 next real activation is Sat Feb 13 12:21:40 2010 [timer.py] next activation: 1266008062 (in 99995 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 486730 bytes for cache used set wakeup time to 2010/02/13 03:56 stopService stopping thread. FILEPUSH THREAD STOP thread joined 0 service end! resolved to PLAY eDVBServicePlay::unpause decoder state: play, vpid=-1, apid=-1 DEMUX_STOP - video - ok VIDEO_STOP - ok AUDIO_STOP - ok DEMUX_STOP - audio - ok AUDIO_CONTINUE - ok DEMUX_STOP - ttx - ok [AutoTimer] No changes in configuration, won't parse [EPGRefresh] Stopping Timer [CrashlogAutoSubmit] - autostart ---- saving lame channel db saved 176 channels and 3503 services! release cached channel (timer timeout) [EPGC] 1877 events written to /hdd/epg.dat thread joined 0 set RTC to previous valid time - (41) eServiceFactoryFS - (41) eServiceFactoryDVB - (41) eServiceFactoryMP3 - (41) eServiceFactoryDVD - (40) eServiceCenter - (35) CI Slots - (30) eActionMap - (21) Console RC Driver - (21) input device driver - (20) DVB-CI UI - (20) misc options - (20) UHF Modulator - (20) AVSwitch Driver - (20) RC Input layer - (15) eWindowStyleManager - (10) gRC waiting for gRC thread shutdown gRC thread has finished - (9) gLCDDC - (9) GFBDC - (9) Font Render Class - (8) graphics acceleration manager - (1) Background File Eraser reached rl -1 root@dm8000:~# re