TEIL 1 ====> Timer erstellen und ausschalten.... [eleText] service stopped [TeleText] send array('B', [1, 0, 0, 0]) : coder state: play, vpid=-1, ap[ 113.223000] stop pcr0 on dmx 3 pid:8b6 id=-1 DEMUX_STOP - pcr - ok DEMUX_STOP - vid[ 113.225000] stop video0 on dmx 3 pid:8b6 eo - [ 113.226000] VIDEO0: stop decode ok VIDEO_STOP - [ 113.227000] VIDEO0: set blank to 1 ok AUDIO_STOP - [ 113.229000] audio: decoder stop ok DEMUX_STOP - aud[ 113.230000] stop audio on dmx 3 pid:8b7 [ 113.231000] audio: xpt stop(3) [ 113.231000] no decoder left in sync handling so disable xpt_sync [ 113.232000] bcm_audio_channel_stop(3) done io - ok AUDIO_CONTINUE - ok DEMUX_STOP - ttx - ok start release channel timer teleText] service started bt pauseable. removePopup, id = ZapError [eDVBCAService] remove channel 0x7149a0c0 [eDVBLocalTimeHandler] remove channel 0x7149a0c0 [eEPGCache] remove channel 0x7149a0c0 [EPGC] abort caching events !! (0) preClose allocate channel.. 6590:00de:ffff0000 [eDVBCAService] new channel 0x22f27f8! (0)tune tuning to 778000 khz, sr 6900000, fec 9, modulation 5, inversion 2 OURSTATE: tuning allocate Channel: res 0 [eDVBCIInterfaces] addPMTHandler 1:0:1:4E8C:6590:DE:FFFF0000:0:0:0: recheckPMTHAndlers() recheck 0x22a0fbc 1:0:1:4E8C:6590:DE:FFFF0000:0:0:0: check Slot 0 check Slot 1 allocate demux [SEC] startTuneTimeout 5000 [SEC] setFrontend 1 (0)setting frontend t.)fe event: status 0, freq 778000000, inversion off, m_tuning 1 F al)fe event: status 1f, freq 778000000, inversion off, m_tuning 1 N OURSTATE: ok [eDVBCAService] channel 0x22f27f8 running [eDVBLocalTimeHandler] channel 0x22f27f8 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 0x22f27f8 running stop release channel timer [EPGC] next update in 59 min no version filtering 0012: 4e 4e 8c 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 ffffffff allocate demux disable teletex[ 113.435000] dvb_demux_feed_del: feed not in list (type=0 state=0 pid=ffff) t subtitles PES filter: DMX_SET_PES_FILTER - In[ 113.437000] start pcr0 on dmx 3 pid:2ff index 4 valid argument decoder state: play, vpid=767, apid=768 DMX_SET[ 113.439000] start audio on dmx 3 pid:300 _PES_FILTER(0x2f[ 113.439000] audio xpt start [ 113.440000] sync is off so we enable it [ 113.440000] demux-index 3 pcr0pid 2ff [ 113.441000] using 4 as pcr0 pidchannel [ 113.441000] MPEG f) - pcr - ok DEMUX_START - pcr[ 113.442000] audio: decoder start 0 - ok DMX_SET_PES_FILTER(0x300) - audio - ok DEMUX_START - audio - ok AUDIO_SET_BYPASS(1) - ok AUDIO_PAUSE -[ 113.445000] audio delay 4500 (50 ms) [ 113.445000] total video delay: 0 (0 ms) ok AUDIO_PLAY - ok Video Device: /dev/dvb/adapter0/video0 demux device: /dev/dvb/adapter0/demux3 VIDEO_SET_STREAMTYPE 0 - ok DMX[ 113.448000] start video0 on dmx 3 pid:2ff _SET_PES_FILTER([ 113.448000] total video delay: 0 (0 ms) 0x2ff) - video - ok DEMUX_START - video - ok VIDEO_FREEZE - ok VIDEO_PLAY - [ 113.453000] VIDEO0: start decode ok VIDEO_SLOWMOTION(0) - ok VIDEO_FAST_FORWARD(0) - ok VIDEO_CONTINUE - ok AUDIO_CONTINUE - ok not pauseable. [TeleText] serviceInfoChanged [TeleText] TXT PID -1 DEMUX 3 FE_READ_BER failed (Resource temporarily unavailable) + 1/1 TID 00 done! PATready use pmtpid 0062 for service_id 4e8c no version filtering 0062: 02 4e 8c 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 doing version filtering 0000: 00 00 00 2f 00 00 mask: ff 00 00 3f 00 00 mode: 00 00 00 3e 00 00 [ 113.585000] RAP first pts 0x1175fbde6, stc 0xa42ebc4, pcr valid [ 113.586000] audio_cdb_itb_error_isr! underflow [ 113.590000] audio_cdb_itb_error_isr! underflow [ 113.594000] audio_cdb_itb_error_isr! underflow + 1/1 TID 02 done! [eDVBCAService] new service 1:0:1:4E8C:6590:DE:FFFF0000:0:0:0: [eDVBCAService] add demux 3 to slot 0 service 1:0:1:4E8C:6590:DE:FFFF0000:0:0:0: demux 3 mask 08 prevhash 00000000 [eDVBCAService] send 50 bytes 9f 80 32 2e 03 4e 8c 07 00 19 01 81 08 ff ff 00 00 65 90 00 de 82 02 08 03 84 02 00 62 09 04 0b 00 f1 87 02 [ 113.609000] dvb_demux_feed_del: feed not in list (type=0 state=0 pid=ffff) 02 ff 00 00 03 03 00 00 00 03 03 01 00 00 recheckPMTHAndlers() recheck 0x22a0fbc 1:0:1:4E8C:6590:DE:FFFF0000:0:0:0: check Slot 0 check Slot 1 [eDVBCIInterfaces] gotPMT eventNewProgramInfo 0 0 have 1 video stream(s) (02ff), and 2 audio stream(s) (0300, 0301), and the pcr pid is 02ff, and the text pid is ffffffff PES filter: DMX_SET_PES_FILTER - Invalid argument decoder state: play, vpid=767, apid=768 VIDEO_SLOWMOTION(0) - ok VIDEO_FAST_FORWARD(0) - ok VIDEO_CONTINUE - ok AUDIO_CONTINUE - ok coeleText] serviceInfoChanged udeleText] 45T PID -1 DEMUX 3 .6ing version filtering 0062: 02 4e 8c 07 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 b/a[/2 TID 4e 0] 113.797000] ch0: lock id 114.200000] VIDEO0: first pts 0xa446648 [ 114.200000] VIDEO0: resolution changed (480 576) VIDEO_GET_EVENT - ok b691m[ExtendedInfoBar] CAIDs: ['0B00'] [ExtendedInfoBar] SID: 4E8C .6 114.352000] enable tsm0 e o/2 TID 4e done! TEing version filtering 0012: 4e 4e 8c 39 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 DEt update done! A_READ_BER failed (Resource temporarily unavailable) eItion -> InfobarEPGActions showEventInfo 3 TS hide IBTS hide ayTS tunerHide 8TS-Plugin: Erasing stranded timeshift pts_livebuffer.1 before: 1 after: 1 o d thread joined 0 before: 1 before: 1 00tIoPrio best-effort level 7 ok eBackgroundFileEraser '/media/swap//pts_livebuffer.1' finished eBackgroundFileEraser '/media/swap//pts_livebuffer.1.meta' finished eBackgroundFileEraser '/media/swap//pts_livebuffer.1.eit' finished :0tion -> EventViewActions nextEvent sart timeshift! recording to /media/swap//timeshift.CubEUF before: 1 after: 1 eRecordFileThread START setIoPrio realtime level 7 ok 07ITSave] query epg event id 65001, 1:0:1:4E8C:6590:DE:FFFF0000:0:0:0: [EITSave] found event.. store to disc 00tion -> EventViewActions nextEvent ection -> EventViewActions prevEvent 0:tion -> EventViewActions timerAdd [TIMER] record time changed, start prepare is now: Sat Oct 20 13:19:40 2012 avtion -> SetupActions ok , nished add sanitycheck check checkTimerlist ecording service: 1:0:1:4E8C:6590:DE:FFFF0000:0:0:0: record: 0 recording service: 1:0:1:4E8C:6590:DE:FFFF0000:0:0:0: record: 0 recording service: 1:0:1:4E25:2B6E:1:FFFF024A:0:0:0: record: 0 recording service: 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: record: 0 recording service: 1:0:1:4E22:2B6E:1:FFFF024A:0:0:0: record: 0 recording service: 1:0:1:4E8C:6590:DE:FFFF0000:0:0:0: record: 0 recording service: 1:0:1:4E8C:6590:DE:FFFF0000:0:0:0: record: 0 recording service: 1:0:1:B86:2AF8:14D:FFFF0000:0:0:0: record: 0 recording service: 1:0:1:2EE3:28A0:14D:FFFF0000:0:0:0: record: 0 [Timer] Record ProcessRepeated It's now Sat Oct 20 11:49:45 2012 next real activation is Sat Oct 20 13:19:40 2012 [timer.py] next activation: 1350726685 (in 99500 ms) ] 126.828000] CEC recv ok! cec event! handle message 0 -> 3 : /2tion -> OkCancelActions cancel irTS show 17TS show [ _READ_BER failed (Resource temporarily unavailable) DETS tunerShow- okTS updateNextTimer able ancillary data in audio stream... abort radiotext pes parser -_READ_BER failed (Resource temporarily unavailable) _READ_BER failed (Resource temporarily unavailable) odDVBLocalTimeHandler] Receiver time is 'Sat Oct 20 11:49:55 2012' [eDVBLocalTimeHandler] Transponder time is 'Sat Oct 20 11:49:56 2012' [eDVBLocalTimeHandler] diff is 1 [eDVBLocalTimeHandler] diff < 120 .. use Transponder Time [eDVBLocalTimeHandler] update RTC [eDVBLocalTimeHandler] time_difference is 1 [eDVBLocalTimeHandler] update Linux Time [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 4003419 bytes for cache used 00TS hide r0TS hide pTS tunerHide Dtion -> InfobarMenuActions mainMenu loading mainmenu XML... 0 merEdit TimerEditList [ uginBrowser PluginBrowser eclocating new converter! 11locating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! 10locating new converter! allocating new converter! ftlocating new converter! allocating new converter! ] locating new converter! allocating new converter! allocating new converter! allocating new converter! tlocating new converter! allocating new converter! molocating new converter! allocating new converter! ellocating new converter! allocating new converter! allocating new converter! allocating new converter! C]locating new converter! (_read 313 nr_write 12 sum 325 prev_sum 321 hdd was accessed since previous check! [IDLE] 0 300 False nr_read 465 nr_write 161 sum 626 prev_sum 528 hdd was accessed since previous check! [IDLE] 0 300 False eD 141.828000] CEC recv ok! cec event! handle message 0 -> 3 : rtion -> OkCancelActions ok okbuttonClick :4PTY: 0 :NABLE: 1 DISABLE: 2 CLEANUP: 3 DELETE: 4 key_red_choice: 0 [Stion -> OkCancelActions cancel setion -> OkCancelActions cancel (tion -> InfobarMenuActions mainMenu loading mainmenu XML... FmerEdit TimerEditList f,uginBrowser PluginBrowser oflocating new converter! : locating new converter! allocating new converter! Lolocating new converter! allocating new converter! n locating new converter! allocating new converter! 0locating new converter! allocating new converter! allocating new converter! allocating new converter! C]locating new converter! allocating new converter! 4locating new converter! allocating new converter! 0 locating new converter! w locating new converter! ltlocating new converter! allocating new converter! allocating new converter! allocating new converter! 0locating new converter! allocating new converter! s)locating new converter! istion -> OkCancelActions ok okbuttonClick e eepTimerEdit SleepTimerEdit Standby Standby Standby TryQuitMainloop standby TryQuitMainloop ffandby TryQuitMainloop telocating new converter! n[locating new converter! on 156.838000] CEC recv ok! cec event! handle message 0 -> 3 : =7tion -> OkCancelActions ok okbuttonClick dioking for embedded skin FIt wakeup time to 2012/10/20 13:15 taopService 44opping thread. eRecordFileThread STOP thread joined 0 remove timeshift file before: 1 [eDVBCAService] free slot 0 demux 3 for service 1:0:1:4E8C:6590:DE:FFFF0000:0:0:0: [eDVBCAService] free service 1:0:1:4E8C:6590:DE:FFFF0000:0:0:0: recheckPMTHAndlers() UXeleText] service stopped [TeleText] send array('B', [1, 0, 0, 0]) 45coder state: play, vpid=-1, ap[ 157.963000] stop pcr0 on dmx 3 pid:2ff id=-1 DEMUX_STOP - pcr - ok DEMUX_STOP - vid[ 157.964000] stop video0 on dmx 3 pid:2ff eo - [ 157.966000] VIDEO0: stop decode ok VIDEO_STOP - [ 157.967000] VIDEO0: set blank to 1 ok AUDIO_STOP - [ 157.969000] audio: decoder stop ok DEMUX_STOP - aud[ 157.970000] stop audio on dmx 3 pid:300 [ 157.971000] audio: xpt stop(3) [ 157.971000] no decoder left in sync handling so disable xpt_sync [ 157.972000] bcm_audio_channel_stop(3) done io - ok AUDIO_CONTINUE - ok start release channel timer TutoTimer] No changes in configuration, won't parse orPGRefresh] Stopping Timer [TeleText] autostart(1, {}) mtrashlogAutoSubmit] - autostart vec] power off g -- saving lame channel db maved 32 channels and 408 services! release cached channel (timer timeout) [eDVBCAService] remove channel 0x22f27f8 [eDVBLocalTimeHandler] remove channel 0x22f27f8 [eEPGCache] remove channel 0x22f27f8 stop release channel timer (0) preClose [EPGC] store epg to realpath '/media/swap/epg.dat' tbPGC] 57696 events written to /media/swap/epg.dat b_read joined 0 rfin thread is non-idle! display spinner! nt RTC to previous valid time FF(41) eHbbtv - (41) eServiceFactoryBludisc - (41) eServiceFactoryM2TS - (41) eServiceFactoryMP3 - (41) eServiceFactoryFS - (41) eServiceFactoryDVB - (41) eServiceFactoryDVD - (40) eServiceCenter - (35) CI Slots - (30) eActionMap - (21) input device driver 7 (21) Console RC Driver - (20) DVB-CI UI - (20) UHF Modulator - (20) RC Input layer - (20) misc options - (20) HDMI CEC Subsystem - ([ 161.396000] bcmfb: creating surface with pixel format 0x07e48888 (BPXL_eA8_R8_G8_B8) 20) AVSwitch Driver - (15) eWindowStyleManager - (10) gRC waiting for gRC thread shutdown gRC thread has finished - (9) GFB[ 161.403000] bcmfb: disable manual blit DC - (9) gLCDDC - (9) Font Render Class - (8) graphics acceleration manager - (1) Background File Eraser thread joined 0 reached rl -1 (0ception TypeError: TypeError('list indices must be integers, not NoneType',) in ignored ] repareClose] no mainloop [SEC] lock 1 [SEC] delayed close frontend close frontend 0 [SEC] unlock NIT: Switching to runlevel: 0 INIT: Sending processes the TERM signal VIopping Dropbear SSH server: /bin/true found; none killed chmounting remote filesystems... -opping dbttcdte deopping system message bus: m us. 1mopping default emu. : opping syslogd/klogd: 0]opped syslogd (pid 378) 4eopped klogd (pid 380) done inopping internet superserver: xinetd f fmounting remote filesystems... e configuring network interfaces... ERbd: no process found orbd: no process found tine. nding all processes the TERM signal... dending all processes the KILL signal... Eactivating swap... shmounting local filesystems... 171.836000] CEC recv ok! 0 173.426000] sd 0:0:0:0: [sda] Synchronizing SCSI cache e 173.481000] sd 0:0:0:0: [sda] Stopping disk fe 173.896000] Power down. [ 173.897000] fp_power_off li Teil2====> Start und Aufnahme BCM74130011 012 K1 K2 K3 K4 K5 Shmoo Version=3.8 DDR Freq=0x0000018C %00000001% RC1=00000005 WC1=FFFFFFEC RC2=00000013 WC2=0000003D RC3=0000000C WC3=FFFFFFEC RC4=0000000C WC4=0000003D NWC=00000014 RC5=00000005 WC5=00000014 RC6=00000013 WC6=00000014 NRC=0000000C RW=0000000F WW=00000052 G=00000000 R=0000000C W=00000014 BL=00000000 RC1=00000002 RC2=00000015 BL=00000001 RC1=00000005 RC2=00000019 BL=00000002 RC1=00000002 RC2=00000010 BL=00000003 RC1=00000005 RC2=00000011 BL=00000004 RC1=00000000 RC2=00000010 BL=00000005 RC1=00000005 RC2=00000019 BL=00000006 RC1=00000004 RC2=00000017 BL=00000007 RC1=00000006 RC2=0000001A 3 COPY CODE COMPARE CODE 4567 (c) 2007,2008 Dream Multimedia GmbH. All rights reserved. Dreambox DM7020HD FIRST STAGE 1.1/400 {BO23456}  2ND STAGE OK, build #86 (2012-02-14) 0.000 - BCM board setup 0.002 - fp init FP version 3 detected 0.003 - ca init 0.493 - load config 0.520 - config loaded. * press [S] to enter setup OLED found! lcd: BOOT #86 P23 detected! - read config file: /boot/secondstage.conf Device: USB Disk unit 0 - Sectors: 312581808 - Size: 152627 MiB skipping non-DOS partition 0 P 00 0 0 < 312581808 partition 1 is invalid! assuming wholedisk partition Device 0: No valid FAT fs found - failed to open /boot/secondstage.conf - failed to open /cf/autorun.bat - failed to open /boot/autoexec_dm7020hd.bat detected jffs2 blocksize: 256kb ++++++++++++++++++++++++++++ dreamupd initialized Scanning JFFS2 FS: | / - . \ | / - \ | / - \ | / - \ | / - \ | / - \ | / -  done. lcd: /boot/bootlogo-dm7020hd.elf.gz bootlogo size: 35879 Supported modes: NTSC !NTSC_J !NTSC_443 !PAL_B !PAL_B1 !PAL_D !PAL_D1 PAL_G !PAL_H !PAL_K !PAL_I !PAL_M !PAL_N !PAL_NC !PAL_60 !SECAM_L !SECAM_B !SECAM_G !SECAM_D !SECAM_K !SECAM_H 1080i !1080p 720p 480p 1080i_50Hz !1080p_50Hz !1250i_50Hz 720p_50Hz 576p_50Hz DVI_640x480p !DVI_640x480p_CVT !DVI_1280x720p_50Hz !DVI_1280x720p !DVI_1280x720p_Red !DVI_640x480p_66Hz !DVI_640x480p_70Hz !DVI_640x480p_72Hz !DVI_640x480p_75Hz !DVI_640x480p_85Hz !DVI_1280x720p_70Hz !DVI_1280x720p_72Hz !DVI_1280x720p_75Hz !DVI_1280x720p_85Hz !DVI_1920x1080p_60Hz_Red !Custom0 !Custom1 best supported mode is 25 using 1920x1080i (50.00 Hz) HDMI using colorspace: 1 create surface 1920 1080 Using the Small jpeg decoder library, Copyright (c) 2006, Luc Saillard parsing JPEG header.. Virtual FB Size: 1280x720 lcd: /boot/vmlinux-3.2-dm7020hd.gz [ 0.000000] Linux version 3.2-dm7020hd (dev@vs35) (gcc version 4.6.4 20120303 (prerelease) (GCC) ) #1 SMP Mon Oct 15 14:39:39 CEST 2012 [ 0.000000] Fetching vars from bootloader... [ 0.000000] Early serial console at MMIO32 0x10400b00 (options '1000000n8') [ 0.000000] bootconsole [uart0] enabled [ 0.000000] Options: sata=1 enet=1 emac_1=0 no_mdio=0 docsis=0 pci=1 smp=1 moca=0 usb=1 [ 0.000000] Using 512 MB RAM (from straps) [ 0.000000] Fetch var 'memsize' = '64' [ 0.000000] CPU revision is: 0002a044 (Brcm4380) [ 0.000000] FPU revision is: 00130001 [ 0.000000] Determined physical RAM map: [ 0.000000] memory: 10000000 @ 00000000 (usable) [ 0.000000] memory: 10000000 @ 20000000 (usable) [ 0.000000] bmem: adding 58 MB LINUX region at 5 MB (0x03a11000@0x005ef000) [ 0.000000] bmem: adding 192 MB RESERVED region at 64 MB (0x0c000000@0x04000000) [ 0.000000] bmem: adding 256 MB LINUX region at 512 MB (0x10000000@0x20000000) [ 0.000000] Zone PFN ranges: [ 0.000000] Normal 0x00000000 -> 0x00030000 [ 0.000000] Movable zone start PFN for each node [ 0.000000] early_node_map[2] active PFN ranges [ 0.000000] 0: 0x00000000 -> 0x00010000 [ 0.000000] 0: 0x00020000 -> 0x00030000 [ 0.000000] On node 0 totalpages: 131072 [ 0.000000] Normal zone: 1536 pages used for memmap [ 0.000000] Normal zone: 0 pages reserved [ 0.000000] Normal zone: 129536 pages, LIFO batch:31 [ 0.000000] PERCPU: Embedded 7 pages/cpu @81407000 s5440 r8192 d15040 u32768 [ 0.000000] pcpu-alloc: s5440 r8192 d15040 u32768 alloc=8*4096 [ 0.000000] pcpu-alloc: [0] 0 [0] 1 [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 129536 [ 0.000000] Kernel command line: root=/dev/mtdblock3 rootfstype=jffs2 rw console=ttyS0,115200 debug bmem=192M@64M [ 0.000000] PID hash table entries: 2048 (order: 1, 8192 bytes) [ 0.000000] Dentry cache hash table entries: 65536 (order: 6, 262144 bytes) [ 0.000000] Inode-cache hash table entries: 32768 (order: 5, 131072 bytes) [ 0.000000] Primary instruction cache 32kB, VIPT, 2-way, linesize 64 bytes. [ 0.000000] Primary data cache 64kB, 4-way, VIPT, cache aliases, linesize 64 bytes [ 0.000000] Memory: 317020k/524288k available (4713k kernel code, 207268k reserved, 1009k data, 224k init, 0k highmem) [ 0.000000] Hierarchical RCU implementation. [ 0.000000] NR_IRQS:128 [ 0.000000] Measuring MIPS counter frequency... [ 0.000000] Detected MIPS clock frequency: 405 MHz (202.507 MHz counter) [ 0.000000] Console: colour dummy device 80x25 [ 0.000000] Calibrating delay loop... 403.45 BogoMIPS (lpj=201728) [ 0.011000] pid_max: default: 32768 minimum: 301 [ 0.012000] Mount-cache hash table entries: 512 [ 0.014000] SMP: Booting CPU1... [ 0.015000] CPU revision is: 0002a044 (Brcm4380) [ 0.015000] FPU revision is: 00130001 [ 0.015000] Primary instruction cache 32kB, VIPT, 2-way, linesize 64 bytes. [ 0.015000] Primary data cache 64kB, 4-way, VIPT, cache aliases, linesize 64 bytes [ 0.026000] SMP: CPU1 is running [ 0.026000] Brought up 2 CPUs [ 0.027000] devtmpfs: initialized [ 0.031000] NET: Registered protocol family 16 [ 0.033000] PCI2.3->SDRAM window: 512 MB [ 0.040000] bio: create slab at 0 [ 0.042000] SCSI subsystem initialized [ 0.042000] libata version 3.00 loaded. [ 0.043000] usbcore: registered new interface driver usbfs [ 0.043000] usbcore: registered new interface driver hub [ 0.044000] usbcore: registered new device driver usb [ 0.045000] Advanced Linux Sound Architecture Driver Version 1.0.24. [ 0.046000] pci 0000:01:00.0: [14e4:8602] type 0 class 0x000101 [ 0.047000] PCI: found device 14e4:8602 on SATA bus, slot 0 (irq 42) [ 0.047000] pci 0000:01:00.0: reg 24: [mem 0x00000000-0x00000fff] [ 0.048000] pci 0000:01:00.0: reg 30: [mem 0x00000000-0x000007ff pref] [ 0.049000] pci 0000:01:00.0: BAR 5: assigned [mem 0x10510000-0x10510fff] [ 0.050000] pci 0000:01:00.0: BAR 5: set to [mem 0x10510000-0x10510fff] (PCI address [0x10510000-0x10510fff]) [ 0.051000] pci 0000:01:00.0: BAR 6: assigned [mem 0x10511000-0x105117ff pref] [ 0.052000] Switching to clocksource upg [ 0.065000] NET: Registered protocol family 2 [ 0.066000] IP route cache hash table entries: 4096 (order: 2, 16384 bytes) [ 0.068000] TCP established hash table entries: 16384 (order: 5, 131072 bytes) [ 0.069000] TCP bind hash table entries: 16384 (order: 5, 131072 bytes) [ 0.071000] TCP: Hash tables configured (established 16384 bind 16384) [ 0.072000] TCP reno registered [ 0.072000] UDP hash table entries: 256 (order: 1, 8192 bytes) [ 0.073000] UDP-Lite hash table entries: 256 (order: 1, 8192 bytes) [ 0.075000] NET: Registered protocol family 1 [ 0.076000] RPC: Registered named UNIX socket transport module. [ 0.076000] RPC: Registered udp transport module. [ 0.077000] RPC: Registered tcp transport module. [ 0.078000] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.079000] PCI: CLS 0 bytes, default 64 [ 0.082000] JFFS2 version 2.2. (NAND) (SUMMARY) © 2001-2006 Red Hat, Inc. [ 0.084000] SGI XFS with security attributes, large block/inode numbers, no debug enabled [ 0.086000] msgmni has been set to 619 [ 0.088000] io scheduler noop registered [ 0.089000] io scheduler cfq registered (default) [ 0.090000] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled ˙[ 0.112000] serial8250.0: ttyS0 at MMIO 0x10400b00 (irq = 22) is a 16550A [ 0.113000] console [ttyS0] enabled, bootconsole disabled [ 0.113000] console [ttyS0] enabled, bootconsole disabled [ 0.134000] serial8250.0: ttyS1 at MMIO 0x10400b80 (irq = 67) is a 16550A [ 0.137000] loop: module loaded [ 0.138000] sata_brcmstb 0000:01:00.0: version 4.0 [ 0.139000] brcm-pm: enabling sata clocks [ 0.139000] PCI: Enabling device 0000:01:00.0 (0000 -> 0003) [ 0.140000] PCI: Setting latency timer of device 0000:01:00.0 to 64 [ 0.338000] scsi0 : sata_brcmstb [ 0.339000] scsi1 : sata_brcmstb [ 0.339000] ata1: SATA max UDMA7 mmio m4096@0x10510000 port 0x10510000 irq 42 [ 0.340000] ata2: SATA max UDMA7 mmio m4096@0x10510000 port 0x10510100 irq 42 [ 0.342000] Broadcom STB NAND controller (BrcmNand Controller) [ 0.343000] bcmemac: Broadcom STB 10/100 EMAC driver v3.0 [ 0.346000] bcmemac: registered interface #0 at 0x10080000 as 'eth0' (00:09:34:2d:c6:b4) [ 0.347000] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver [ 0.348000] brcm-pm: enabling usb clocks [ 0.349000] ehci-brcm ehci-brcm.0: Broadcom STB EHCI [ 0.349000] ehci-brcm ehci-brcm.0: new USB bus registered, assigned bus number 1 [ 0.382000] ehci-brcm ehci-brcm.0: irq 62, io mem 0x10480300 [ 0.388000] ehci-brcm ehci-brcm.0: USB 0.0 started, EHCI 1.00 [ 0.389000] hub 1-0:1.0: USB hub found [ 0.389000] hub 1-0:1.0: 2 ports detected [ 0.390000] ehci-brcm ehci-brcm.1: Broadcom STB EHCI [ 0.391000] ehci-brcm ehci-brcm.1: new USB bus registered, assigned bus number 2 [ 0.423000] ehci-brcm ehci-brcm.1: irq 57, io mem 0x10480500 [ 0.429000] ehci-brcm ehci-brcm.1: USB 0.0 started, EHCI 1.00 [ 0.430000] hub 2-0:1.0: USB hub found [ 0.430000] hub 2-0:1.0: 2 ports detected [ 0.431000] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver [ 0.432000] ohci-brcm ohci-brcm.0: Broadcom STB OHCI [ 0.433000] ohci-brcm ohci-brcm.0: new USB bus registered, assigned bus number 3 [ 0.434000] ohci-brcm ohci-brcm.0: irq 63, io mem 0x10480400 [ 0.499000] hub 3-0:1.0: USB hub found [ 0.500000] hub 3-0:1.0: 2 ports detected [ 0.501000] ohci-brcm ohci-brcm.1: Broadcom STB OHCI [ 0.501000] ohci-brcm ohci-brcm.1: new USB bus registered, assigned bus number 4 [ 0.502000] ohci-brcm ohci-brcm.1: irq 64, io mem 0x10480600 [ 0.568000] hub 4-0:1.0: USB hub found [ 0.569000] hub 4-0:1.0: 2 ports detected [ 0.570000] Initializing USB Mass Storage driver... [ 0.570000] usbcore: registered new interface driver usb-storage [ 0.571000] USB Mass Storage support registered. [ 0.572000] i2c /dev entries driver [ 0.572000] ALSA device list: [ 0.573000] No soundcards found. [ 0.573000] TCP cubic registered [ 0.574000] NET: Registered protocol family 17 [ 0.574000] Registering the dns_resolver key type [ 0.575000] EBI CS1: setting up NAND flash (primary) [ 0.576000] mtd->oobsize=0, mtd->eccOobSize=0 [ 0.577000] NAND_CS_NAND_XOR=00000000 [ 0.577000] B4: NandSelect=40000202, nandConfig=48252300, chipSelect=1 [ 0.578000] brcmnand_read_id: CS1: dev_id=ecd310a6 [ 0.579000] After: NandSelect=40000202, nandConfig=48252300 [ 0.579000] Block size=00040000, erase shift=18 [ 0.580000] NAND Config: Reg=48252300, chipSize=1024 MB, blockSize=256K, erase_shift=12 [ 0.581000] busWidth=1, pageSize=4096B, page_shift=12, page_mask=00000fff [ 0.582000] timing1 not adjusted: 5363444f [ 0.582000] timing2 not adjusted: 00000fc6 [ 0.583000] eccLevel=15, 1Ksector=0, oob=16 [ 0.583000] nbrBitsPerCell=2, cellinfo=0, chip->cellinfo=00000000 [ 0.584000] <--brcmnand_set_acccontrol: acc b4: f7ff1010, after: f7ff1010 [ 0.585000] BrcmNAND mfg ec d3 Samsung K9F8G08U0M 1024MB on CS1 [ 0.585000] [ 0.585000] Found NAND on CS1: ACC=f7ff1010, cfg=48252300, flashId=ecd310a6, tim1=5363444f, tim2=00000fc6 [ 0.587000] BrcmNAND version = 0x0302 1024MB @00000000 [ 0.587000] B4: NandSelect=40000202, nandConfig=48252300, chipSelect=1 [ 0.588000] brcmnand_read_id: CS1: dev_id=ecd310a6 [ 0.589000] After: NandSelect=40000202, nandConfig=48252300 [ 0.589000] Found NAND flash on Chip Select 1, chipSize=1024MB, usable size=1024MB, base=0 [ 0.590000] brcmnand_scan: B4 nand_select = 40000202 [ 0.591000] brcmnand_scan: After nand_select = 40000202 [ 0.592000] page_shift=12, bbt_erase_shift=18, chip_shift=30, phys_erase_shift=18 [ 0.593000] Brcm NAND controller version = 3.2 NAND flash size 1024MB @00000000 [ 0.593000] ECC layout=brcmnand_oob_128 [ 0.594000] brcmnand_scan: mtd->oobsize=128 [ 0.594000] brcmnand_scan: oobavail=102, eccsize=512, writesize=4096 [ 0.595000] brcmnand_scan, eccsize=512, writesize=4096, eccsteps=8, ecclevel=15, eccbytes=3 [ 0.596000] -->brcmnand_default_bbt [ 0.597000] brcmnand_default_bbt: bbt_td = bbt_main_descr [ 0.598000] Bad block table Bbt0 found at page 0003ffc0, version 0x01 for chip on CS1 [ 0.599000] Bad block table 1tbB found at page 0003ff80, version 0x01 for chip on CS1 [ 0.601000] nand_read_bbt: Bad block at 0x03740000 [ 0.601000] nand_read_bbt: Bad block at 0x1e5c0000 [ 0.602000] nand_read_bbt: Bad block at 0x26000000 [ 0.603000] nand_read_bbt: Bad block at 0x2f840000 [ 0.603000] nand_read_bbt: Bad block at 0x3b200000 [ 0.604000] brcmnandCET: Status -> Loaded [ 0.605000] Adjust partition complete size from 40000000 to 3ff00000 to avoid overlap with BBT reserved space [ 0.606000] Creating 4 MTD partitions on "brcmnand.0": [ 0.607000] 0x000000000000-0x00003ff00000 : "complete" [ 0.612000] 0x000000000000-0x000000100000 : "loader" [ 0.614000] 0x000000100000-0x000000800000 : "boot partition" [ 0.616000] 0x000000800000-0x000010000000 : "root partition" [ 0.648000] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [ 0.708000] usb 1-2: new high-speed USB device number 2 using ehci-brcm [ 0.708000] ata1.00: ATA-9: WDC WD30EZRX-00DC0B0, 80.00A80, max UDMA/133 [ 0.708000] ata1.00: 5860533168 sectors, multi 0: LBA48 NCQ (depth 0/32) [ 0.711000] ata1.00: configured for UDMA/133 [ 0.712000] scsi 0:0:0:0: Direct-Access ATA WDC WD30EZRX-00D 80.0 PQ: 0 ANSI: 5 [ 0.714000] sd 0:0:0:0: [sda] 5860533168 512-byte logical blocks: (3.00 TB/2.72 TiB) [ 0.715000] sd 0:0:0:0: [sda] 4096-byte physical blocks [ 0.716000] sd 0:0:0:0: [sda] Write Protect is off [ 0.717000] sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00 [ 0.718000] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA [ 0.788000] sda: sda1 [ 0.790000] sd 0:0:0:0: [sda] Attached SCSI disk [ 0.826000] hub 1-2:1.0: USB hub found [ 0.827000] hub 1-2:1.0: 4 ports detected [ 1.040000] ata2: SATA link down (SStatus 4 SControl 300) [ 1.110000] usb 1-2.2: new high-speed USB device number 3 using ehci-brcm [ 1.201000] usb-storage 1-2.2:1.0: Quirks match for vid 152d pid 2329: 8020 [ 1.202000] scsi2 : usb-storage 1-2.2:1.0 [ 2.247000] scsi 2:0:0:0: Direct-Access Hitachi HTS545016B9A300 PQ: 0 ANSI: 2 CCS [ 2.253000] sd 2:0:0:0: [sdb] 312581808 512-byte logical blocks: (160 GB/149 GiB) [ 2.255000] sd 2:0:0:0: [sdb] Write Protect is off [ 2.255000] sd 2:0:0:0: [sdb] Mode Sense: 28 00 00 00 [ 2.257000] sd 2:0:0:0: [sdb] No Caching mode page present [ 2.257000] sd 2:0:0:0: [sdb] Assuming drive cache: write through [ 2.261000] sd 2:0:0:0: [sdb] No Caching mode page present [ 2.262000] sd 2:0:0:0: [sdb] Assuming drive cache: write through [ 2.293000] sdb: sdb1 [ 2.296000] sd 2:0:0:0: [sdb] No Caching mode page present [ 2.297000] sd 2:0:0:0: [sdb] Assuming drive cache: write through [ 2.298000] sd 2:0:0:0: [sdb] Attached SCSI disk [ 2.825000] VFS: Mounted root (jffs2 filesystem) on device 31:3. [ 2.828000] devtmpfs: mounted [ 2.829000] Freeing unused kernel memory: 224k freed INIT: version 2.88 booting Displaying bootlogo. Starting udev [ 4.970000] udevd[82]: starting version 182 [ 5.564000] stb_core: module license 'Proprietary' taints kernel. [ 5.565000] Disabling lock debugging due to kernel taint [ 8.243000] enter base init, xvd 20100413, vdc 20100413, rap 20100719, xpt 20100825 [ 8.712000] 8:711008751 SMCA: controller reset timed out [ 8.723000] 8:722017221 SMCB: controller reset timed out [ 9.364000] register adapter [ 9.365000] register adapter [ 9.366000] register adapter [ 9.370000] register adapter [ 9.380000] FP Version 3 [ 9.381000] input: dreambox front panel as /devices/virtual/input/input0 [ 9.392000] fpga init [ 9.397000] keys c7 [ 10.724000] done OK 0 [ 10.725000] using fpga version 47 [ 10.725000] tsmux set tsports reg 00 to val 00 [ 10.726000] tsmux set tsports reg 01 to val 01 [ 10.726000] tsmux set tsports reg 02 to val 02 [ 10.727000] tsmux set tsports reg 03 to val 03 [ 10.728000] tsmux set tsports reg 04 to val 04 [ 10.729000] tsmux set tsports reg 05 to val 05 [ 10.729000] tsmux set ciclk reg 34 to val 00 [ 10.730000] tsmux set cisource reg 06 to val 00 [ 10.731000] tsmux set ciclk reg 34 to val 00 [ 10.731000] tsmux set cisource reg 07 to val 01 [ 10.733000] set sb to 3(2) [ 10.733000] set fb to 2(-1) [ 10.734000] set input to 0 [ 10.734000] set fb to 2(-1) [ 10.739000] bcm_video_analog_port_setup (fmt=7) [ 10.740000] SET FORMAT: display[1], format=7 [ 10.741000] display 0 uses vbi path 1 [ 10.741000] display 1 uses vbi path 0 [ 10.742000] HDMI: now powered down [ 10.771000] HDMI: EDID read ok [ 10.771000] HDMI: initial mode set! [ 10.772000] using 50.00Hz as MonitorRefreshRate [ 10.772000] SET FORMAT: display[0], format=37 [ 10.773000] HDMI mode [ 10.773000] use EDID to detect colorspace [ 10.773000] using colorspace: 1 [ 10.806000] HDMI: use logical CEC address 3 [ 10.829000] set fb to 2(0) [ 10.829000] bcm_video_analog_port_setup (fmt=7) [ 10.830000] SET FORMAT: display[1], format=7 [ 10.835000] disable wss on display 0 [ 10.835000] disable wss on display 1 [ 10.836000] bcmfb: creating surface with pixel format 0x07e48888 (BPXL_eA8_R8_G8_B8) [ 10.943000] CEC send ok! [ 10.975000] enable mad [ 11.035000] VIDEO0: set fallback framerate to 60000 [ 11.035000] VIDEO0: set progressive override mode to 1 [ 11.036000] VIDEO0: set streamtype! [ 11.037000] set MPEG2 [ 11.037000] sw rave disabled! [ 11.039000] enable mad [ 11.039000] VIDEO1: set fallback framerate to 60000 [ 11.040000] VIDEO1: set progressive override mode to 1 [ 11.041000] VIDEO1: set streamtype! [ 11.041000] set MPEG2 [ 11.042000] sw rave disabled! [ 11.046000] sync is off so we enable it [ 11.046000] playback! [ 11.046000] total video delay: 0 (0 ms) [ 11.050000] VIDEO0: start decode [ 11.050000] flush video decoder [ 11.051000] VIDEO0 got pts failed !!!! (ret 0) [ 12.308000] set ac3 to downmix [ 12.309000] set aac to downmix [ 12.309000] init ALSA! [ 12.334000] VIDEO0: first pts 0x0 [ 12.367000] DVB: registering new adapter (BCM7405) [ 12.388000] autodetecting NIMs... [ 12.389000] ret: 2, feid: 15 [ 12.390000] Found: Slot A, ID: 15 (by CA) [ 12.397000] ret: 2, feid: 15 [ 12.398000] Found: Slot B, ID: 15 (by CA) [ 12.398000] Initializing adapter 0 (CXD1981-(null)) [ 12.413000] DVB: registering adapter 0 frontend 0 (CXD1981)... [ 12.444000] Initializing adapter 1 (CXD1981-(null)) [ 12.461000] DVB: registering adapter 0 frontend 1 (CXD1981)... [ 12.500000] enable tsm0 [ 13.704000] VIDEO0: stop decode [ 13.704000] no decoder left in sync handling so disable xpt_sync [ 13.718000] CI stopped... [ 13.719000] CI stopped... [ 13.720000] registered vtuner misc/vtuner0, minor 51 [ 13.721000] registered vtuner misc/vtuner1, minor 50 [ 13.722000] IR-TX init! [ 13.885000] VIDEO0: set blank to 0 [ 13.886000] sync is off so we enable it [ 13.886000] playback! [ 13.887000] total video delay: 0 (0 ms) [ 13.890000] VIDEO0: start decode [ 13.891000] flush video decoder [ 13.934000] VIDEO0: first pts 0x0 [ 13.935000] VIDEO0: framerate changed 3 [ 13.935000] VIDEO0: resolution changed (1280 720) [ 13.936000] VIDEO0: aspect changed 3 [ 13.995000] set current avs auto aspect to 16:9 [ 13.995000] disable wss on display 0 [ 13.996000] disable wss on display 1 [ 13.996000] set current avs auto aspect to 16:9 [ 13.997000] disable wss on display 0 [ 13.997000] disable wss on display 1 [ 13.998000] set sb to 3(1) [ 14.048000] VIDEO0: set blank to 0 [ 14.049000] VIDEO0: stop decode [ 14.049000] VIDEO0: set blank to 0 [ 14.050000] no decoder left in sync handling so disable xpt_sync [ 16.730000] input: dreambox remote control (native) as /devices/virtual/input/input1 [ 16.732000] input: dreambox advanced remote control (native) as /devices/virtual/input/input2 [ 16.749000] input: dreambox ir keyboard as /devices/virtual/input/input3 [ 16.752000] input: dreambox ir mouse as /devices/virtual/input/input4 [ 16.779000] 4011746 ms: [ 16.873000] 94 ms: 12 mkdir /dev/shm..... [ 17.027000] XFS (sda1): Mounting Filesystem [ 17.286000] XFS (sda1): Ending clean mount [ 17.344000] XFS (sdb1): Mounting Filesystem [ 17.772000] XFS (sdb1): Ending clean mount [ 17.790000] 916 ms: 14 [ 18.424000] 633 ms: 16 [ 18.485000] 61 ms: 18 [ 18.516000] 30 ms: 20 Configuring network interfaces... done. [ 21.842000] 3326 ms: 22 rdate: current time matches remote time Starting rdate timesync...: Sync done[ 22.148000] 306 ms: 24 Starting rpcbind... rpcbind: cannot create socket for udp6 rpcbind: cannot create socket for tcp6 Mounting /etc/enigma2/automounts.xml... [ 27.194000] JFFS2 warning: (349) jffs2_sum_write_data: Not enough space for summary, padsize = -246 [ 27.246000] 5098 ms: 26 net.ipv4.conf.default.rp_filter = 1 net.ipv4.conf.all.rp_filter = 1 [ 27.319000] 72 ms: 28 Starting tpmd. [ 27.370000] 51 ms: 30 INIT: Entering runlevel: 3 Starting system message bus: dbus. [ 28.152000] 782 ms: 33 Starting Dropbear SSH server: dropbear. [ 28.239000] 87 ms: 34 [ 28.301000] 62 ms: 36 Starting dbttcd. [ 28.355000] 54 ms: 37 Starting default emu. [ 28.412000] 56 ms: 39 Starting syslogd/klogd: done [ 28.510000] 97 ms: 41 Starting internet superserver: xinetd. [ 28.705000] 195 ms: 42 * starting eDaemon: eDaemon... done. [ 28.815000] 110 ms: 44 [SCRIPT] start: OScam unstable #7291 [ 29.051000] 235 ms: 46 [ 29.084000] 32 ms: 47 [ 29.318000] VIDEO0: set blank to 0 [ 29.319000] sync is off so we enable it [ 29.320000] playback! [ 29.320000] total video delay: 0 (0 ms) [ 29.324000] VIDEO0: start decode [ 29.325000] flush video decoder [ 29.354000] VIDEO0: first pts 0x0 /usr/bin/enigma2_pre_start.sh: line 2: /usr/crossepg/crossepg_epgmove.sh: No such file or directory [ 29.482000] VIDEO0: set blank to 0 [ 29.484000] VIDEO0: stop decode [ 29.484000] VIDEO0: set blank to 0 [ 29.485000] no decoder left in sync handling so disable xpt_sync [ 29.556000] 29:555964389 SMCA: invalid ioctl: 0x80047309 [ 30.799000] 30:798862146 SMCA: invalid ioctl: 0x00005407 Enigma2 v4.0.0 (revision: tarball-20120924-0-g1302a2a, date: 2012-09-24) Enigma2 is property of Dream Multimedia GmbH. All copyrights with regard to Enigma2 belong to Dream Multimedia GmbH only. The full license text is available at /usr/share/doc/enigma2/LICENSE. PYTHONPATH: /usr/lib/enigma2/python + (1) Background File Eraser + (8) graphics acceleration manager + (9) GFBDC 16384k video mem [ 39.614000] bcmfb: enable manual blit [ 39.616000] bcmfb: creating surface with pixel format 0x07e48888 (BPXL_eA8_R8_G8_B8) - double buffering not available. 14764kB available for acceleration surfaces. resolution: 720 x 576 x 32 (stride: 2880) + (9) gLCDDC found OLED display! realpath /proc/stb/lcd/xres: No such file or directory lcd buffer 0xab51d8 8448 bytes, stride 132 + (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) UHF Modulator couldnt open /dev/rfmod0!!!! + (20) RC Input layer + (20) misc options + (20) HDMI CEC Subsystem attached: hdmi attached attached: hdmi cec address acknowledged my physical: 1.1.0.0 logical 3 + (20) AVSwitch Driver couldnt open /dev/dbox/fp0 to monitor vcr scart slow blanking changed! + (21) input device driver Input device "dreambox front panel" is a remotecontrol Input device "dreambox remote control (native)" is a remotecontrol Input device "dreambox advanced remote control (native)" is a remotecontrol Input device "d[ 39.713000] tsmux set cisource reg 06 to val 00 reambox ir keyboard" is a keyboard Input device "dreambox ir mouse" is a mouse Found 5 input devices! + (21) [ 39.715000] tsmux set cisource reg 07 to val 00 Console RC Driver + (30) eActionMap + (35) CI Slots scanning [ 39.717000] tsmux set tsports reg 00 to val 00 for common interfaces.. CI Slot 0 has fd 27 CI[ 39.718000] tsmux set tsports reg 01 to val 01 Slot 1 has fd 28 CI Slot 0 setSource(0) CI Slot 1 setSource(0) eDVBCIInterfaces->setInputSource(0, 0) eDVBCIInterfaces->setInputSource(1, 1) eDVBCIInterfaces->setInputSource(2, 2) eDVBCIInterfaces->setInputSource(3, 3) done, found 2 common interface slots + (40) eServiceCenter settings instance. + (41) eHbbtv + (41) eServiceFactoryBludisc + (41) eServiceFactoryM2TS + (41) eServiceFactoryMP3 + (41) eServiceFactoryFS + (41) eServiceFactoryDVB reached rl 70 ---- opening lame channel db reading services (version 4) loaded 408 services scanning for frontends.. opening frontend 0 detected terrestrial frontend (0)setVoltage 0V close frontend 0 opening frontend 1 detected terrestrial frontend (1)setVoltage 0V close frontend 1 scanning for demux.. scanning for decoders.. scanning for descramblers.. found 1 adapter, 2 frontends(2 sim) and 5 demux, boxtype 5 [eDVBLocalTimeHandler] Use valid Linux Time 'Sat Oct 20 13:16:30 2012' :) (RTC?) [EPGC] Initialized EPGCache (wait for setCacheFile call now) Loading spinners... found 12 spinners! executing main setIoPrio best-effort level 6 ok [ 40.771000] 11686 ms: 49 [ 40.840000] 69 ms: 50 /proc/stb/frontend/0/lnb_sense is 0 [setupConfigEntries] initial_call for stored uuid: 5e105413-0f54-4d06-bae3-d26d474ab9d3 {'device_info': 'USB', 'device_description': 'Hitachi-HTS545016B9A300 (160.041 GB)'} [setupConfigEntries] initial_call for stored uuid: 79b7c217-1005-43f5-8b48-c5bca3ad6b10 {'mountpoint': '/media/hdd', 'device_info': 'SATA', 'device_description': 'ATA-WDC WD30EZRX-00D (3000.592 GB)', 'enabled': 'true'} enumerating block devices... found block device 'loop0': blacklisted found block device 'loop1': blacklisted found block device 'mtdblock0': blacklisted found block device 'mtdblock1': blacklisted found block device 'mtdblock2': blacklisted found block device 'mtdblock3': blacklisted found block device 'sda': ok, removable=False, cdrom=False, partitions=['sda1'] Unable to determine structure of /dev fallback to udev new Harddisk sda -> /dev/sda -> /dev/sda [ePopen] command: ('hdparm', 'hdparm', '-S0', '/dev/sda') [addDevicePartition] device:'sda' with UUID:'None' found block device 'sda1': error querying properties [addDevicePartition] device:'sda1' with UUID:'79b7c217-1005-43f5-8b48-c5bca3ad6b10' [enumerateBlockDevices] devices_scanned_on_init: [('sda', False, False, True)] main thread is non-idle! display spinner! found block device 'sdb': ok, removable=False, cdrom=False, partitions=['sdb1'] Unable to determine structure of /dev fallback to udev new Harddisk sdb -> /dev/sdb -> /dev/sdb [ePopen] command: ('sdparm', 'sdparm', '--set=SCT=0', '/dev/sdb') [addDevicePartition] device:'sdb' with UUID:'None' found block device 'sdb1': error querying properties [addDevicePartition] device:'sdb1' with UUID:'5e105413-0f54-4d06-bae3-d26d474ab9d3' [setupConfigEntries] new device add for 'sdb1' with uuid:'5e105413-0f54-4d06-bae3-d26d474ab9d3' [enumerateBlockDevices] devices_scanned_on_init: [('sda', False, False, True), ('sdb', False, False, True)] Reading cables.xml couldn't open /etc/tuxbox/cables.xml!! Reading terrestrial.xml setSlotInfo for dvb frontend 0 to slotid 0, descr CXD1981, need rotorworkaround No, enabled No, DVB-S2 No setSlotInfo for dvb frontend 1 to slotid 1, descr CXD1981, need rotorworkaround No, enabled No, DVB-S2 No opening frontend 0 eDVBFrontend 0 type change to 2[ 42.643000] cxd1981: type changed to DVB-C OK (0) preClose opening frontend 1 eDVBFrontend 1 type change to 2[ 42.679000] cxd1981: type changed to DVB-C OK (1) preClose sec config cleared setSlotInfo for dvb frontend 0 to slotid 0, descr CXD1981, need rotorworkaround No, enabled Yes, DVB-S2 No setSlotInfo for dvb frontend 1 to slotid 1, descr CXD1981, need rotorworkaround No, enabled Yes, DVB-S2 No sec config completed [ 42.749000] 1909 ms: 50 [ 42.757000] 8 ms: 53 [ 42.838000] 80 ms: 53 [ 42.868000] 30 ms: 53 [ 42.870000] 1 ms: 53 [ 42.929000] 58 ms: 53 not loading user skin: [Errno 2] No such file or directory: '/etc/enigma2/skin_user.xml' [ 43.308000] 379 ms: 53 [ 43.469000] 160 ms: 54 [ 43.477000] 8 ms: 54 [ 43.479000] 2 ms: 54 [ 43.481000] 2 ms: 54 main thread is non-idle! display spinner! Preferred tag editor set to None [ 43.919000] 438 ms: 54 [ 43.921000] 2 ms: 55 [ 44.047000] 125 ms: 55 [ 44.431000] 383 ms: 55 [ 44.440000] 9 ms: 56 [ 44.458000] 18 ms: 56 [ 44.460000] 1 ms: 56 [ 44.462000] 1 ms: 56 [ 44.481000] 19 ms: 56 [ 44.504000] 23 ms: 56 [ 45.564000] 1060 ms: 56 [ 45.572000] 8 ms: 58 [ 45.585000] 13 ms: 58 loading bouquet... /etc/enigma2/bouquets.tv loading bouquet... /etc/enigma2/userbouquet.favourites.tv 40 entries in Bouquet userbouquet.favourites.tv 1 entries in Bouquet bouquets.tv loading bouquet... /etc/enigma2/bouquets.radio loading bouquet... /etc/enigma2/userbouquet.favourites.radio 7 entries in Bouquet userbouquet.favourites.radio 1 entries in Bouquet bouquets[ 45.598000] 12 ms: 58 .radio [ 45.624000] 26 ms: 58 [ 45.679000] 55 ms: 58 [ 45.680000] 1 ms: 58 [ 45.684000] 3 ms: 58 [eDVBLocalTimeHandler] enable sync local time wi[ 45.694000] 10 ms: 58 th transponder time! [ 48.580000] 2886 ms: 58 APIs: ['api', 'api.enigma2', 'api.enigma2.systeminfo', 'api.enigma2.servicedata'] Functions: ['api._API__needsSession', 'api._API__session', 'api.enigma2._AP[ 48.644000] 64 ms: 63 I__needsSession', 'api.enigma2._API__session', 'api.enigma2.systeminfo._API__needsSession', 'api.enigma2.systeminfo._API__session', 'api.enigma2.systeminfo.test', 'api.enigma2.servicedata.getTransponderInfo', 'api.enigma2.servicedata.getServiceList', 'api.enigma2.servicedata.playService', 'api.enigma2.servicedata.getRadioServices', 'api.enigma2.servicedata.getTVProviders', 'api.enigma2.servicedata.getTVBouquets', 'api.enigma2.servicedata.getTVServices', 'api.enigma2.servicedata._API__needsSession', 'api.enigma2.servicedata._API__session', 'api.enigma2.servicedata.getRadioProviders', 'api.enigma2.servicedata.getServicePIDs', 'api.enigma2.servicedata.getAllServices', 'api.enigma2.servicedata.getCurrentService', 'api.enigma2.servicedata.getRadioBouquets', 'api.enigma2.servicedata.getServiceName', 'api.enigma2.servicedata.convertTransponderInfoHumanReadable'] [ePopen] command: ip -o addr show dev eth0 [ResourceManager] adding: iNetwork [ 49.069000] 425 ms: 63 add dreampackage scanner plugin added [ 49.219000] 150 ms: 64 [ 49.221000] 1 ms: 64 [ 49.285000] 63 ms: 64 [ 49.289000] 3 ms: 64 [ 49.291000] 2 ms: 64 [ 49.298000] 6 ms: 64 [ 49.315000] 16 ms: 64 [ 49.332000] 16 ms: 64 [ 49.335000] 2 ms: 64 [FONT] adding font /usr/share/fonts/nmsbd.ttf...OK (Display) [ 49.477000] bcmfb: creating surface with pixel format 0x07e48888 (BPXL_eA8_R8_G8_B8) - double buffering not available. 12784kB available for acceleration surfaces. resolution: 1280 x 720 x 32 (stride: 5120) [FONT] adding font /usr/share/fonts/lcd.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) [ 49.830000] 495 ms: 64 [iInputDevices] setRepeat for device event2 to 90 ms [iInputDevices] setDelay for device event2 to 700 ms [ 49.999000] 169 ms: 65 [ 50.055000] set current avs auto aspect to 4:3 [ 50.055000] disable wss on display 0 [ 50.056000] disable wss on display 1 [ 50.056000] set sb to 3(2) [ 50.094000] set current avs auto aspect to 4:3 [ 50.095000] disable wss on display 0 [ 50.096000] disable wss on display 1 [ 50.096000] set sb to 3(2) [ 50.098000] disable wss on display 0 [ 50.099000] set wss 8 on display 1 [ 50.136000] set input to 0 [ 50.136000] set fb to 2(0) [ 50.137000] set current avs auto aspect to 4:3 [ 50.137000] disable wss on display 0 [ 50.138000] set wss 8 on display 1 [ 50.139000] set sb to 3(2) [ 50.143000] set ac3 to downmix --> setting scaler_sharpness to: 0000000A [ 50.196000] 197 ms: 65 [ 50.211000] 15 ms: 66 couldn't open /proc/stb/misc/12V_output [ 50.358000] 147 ms: 66 [ 50.631000] 273 ms: 66 [ 50.635000] 4 ms: 66 setLCDBrightness 25 setLCDBrightness 127 [ 50.670000] 34 ms: 66 Activating keymap: Dreambox Keyboard Deutsch [ePopen] command: loadkmap < /usr/share/keymaps/dream-de.kmap Activating language German language set to de_DE [WebInterface] set language to de It's now Sat Oct 20 13:16:46 2012 [timer.py] next activation: 1350731906 (in 99709 ms) [TeleText] set language to [de] [TeleText] set language to [de] [TeleText] fallback to default translation for bilinear [TeleText] plugins [WebInterface] set language to de [WebInterface] fallback to default translation for Webinterface [MovieCut] set language to de [MovieCut] set language to de [MerlinEPGCenter] fallback to default translation for Prime Time [MerlinEPGCenter] fallback to default translation for Timer [SkinFinder] found skin file /usr/lib/enigma2/python/Plugins/Extensions/MerlinEPGCenter/skins/HD_default.xml [dFlash] Dreambox: !dm7020hd! [dFlash] /tmp/dflash.sh created [WebInterface] set language to de [AudioSync] set language to de [AudioSync] set language to de getModeList for port DVI-PC 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 [ 61.974000] set current avs auto aspect to 16:9 [ 61.975000] disable wss on display 0 [ 61.976000] set wss 7 on display 1 [ 61.976000] set sb to 3(1) [ 62.014000] set current avs auto aspect to 16:9 [ 62.015000] disable wss on display 0 [ 62.016000] set wss 7 on display 1 [ 62.017000] disable wss on display 0 [ 62.018000] set wss 7 on display 1 [ 62.018000] set sb to 3(1) [ 62.020000] set current avs auto aspect to 16:9 [ 62.020000] disable wss on display 0 [ 62.021000] set wss 7 on display 1 [ 62.024000] set sb to 3(1) -> setting aspect, policy, policy2, wss 16:9 panscan letterbox auto [ 62.027000] set current avs auto aspect to 16:9 [ 62.027000] disable wss on display 0 [ 62.028000] set wss 7 on display 1 [ 62.028000] set sb to 3(1) [ 62.030000] set current avs auto aspect to 16:9 [ 62.030000] disable wss on display 0 [ 62.031000] set wss 7 on display 1 [ 62.031000] set sb to 3(1) [ 62.032000] disable wss on display 0 [ 62.033000] set wss 7 on display 1 [ 62.035000] set current avs auto aspect to 16:9 [ 62.035000] disable wss on display 0 [ 62.036000] set wss 7 on display 1 [ 62.036000] set sb to 3(1) -> setting aspect, policy, policy2, wss 16:9 pan[ 62.041000] set current avs auto aspect to 16:9 [ 62.042000] disable wss on display 0 [ 62.042000] set wss 7 on display 1 scan letterbox a[ 62.043000] set sb to 3(1) uto [ 62.044000] set current avs auto aspect to 16:9 [ 62.045000] disable wss on display 0 [ 62.046000] set wss 7 on display 1 [ 62.046000] set sb to 3(1) [ 62.047000] disable wss on display 0 [ 62.048000] set wss 7 on display 1 [ 62.049000] set current avs auto aspect to 16:9 [ 62.050000] disable wss on display 0 [ 62.050000] set wss 7 on display 1 [ 62.051000] set sb to 3(1) -> setting aspect, policy, policy2, wss 16:9 panscan letterbox auto [ 62.056000] set current avs auto aspect to 16:9 [ 62.057000] disable wss on display 0 [ 62.057000] set wss 7 on display 1 [ 62.058000] set sb to 3(1) [ 62.059000] set current avs auto aspect to 16:9 [ 62.060000] disable wss on display 0 [ 62.060000] set wss 7 on display 1 [ 62.061000] set sb to 3(1) [ 62.062000] disable wss on display 0 [ 62.062000] set wss 7 on display 1 [ 62.064000] set current avs auto aspect to 16:9 [ 62.064000] disable wss on display 0 [ 62.065000] set wss 7 on display 1 [ 62.066000] set sb to 3(1) setMode - port: DVI mode: 1080i rate: multi [ 62.075000] using 50.00Hz as MonitorRefreshRate [ 62.195000] SET FORMAT: display[0], format=27 [ 62.195000] HDMI mode [ 62.196000] use EDID to detect colorspace [ 62.196000] using colorspace: 1 [ 62.276000] bcm_video_analog_port_setup (fmt=7) [ 62.395000] SET FORMAT: display[1], format=7 [ 62.514000] set current avs auto aspect to 16:9 [ 62.515000] disable wss on display 0 [ 62.516000] set wss 7 on display 1 [ 62.517000] set sb to 3(1) [ 62.519000] set current avs auto aspect to 16:9 [ 62.519000] disable wss on display 0 [ 62.520000] set wss 7 on display 1 [ 62.521000] set sb to 3(1) -> setting aspect, policy, policy2, wss 16:9 panscan letterbox auto [ 62.527000] set current avs auto aspect to 16:9 [ 62.528000] disable wss on display 0 [ 62.528000] set wss 7 on display 1 [ 62.529000] set sb to 3(1) [ 62.530000] set current avs auto aspect to 16:9 [ 62.531000] disable wss on display 0 [ 62.531000] set wss 7 on display 1 [ 62.532000] set sb to 3(1) [ 62.533000] disable wss on display 0 [ 62.533000] set wss 7 on display 1 [ 62.535000] set current avs auto aspect to 16:9 [ 62.536000] disable wss on display 0 [ 62.536000] set wss 7 on display 1 [ 62.537000] set sb to 3(1) /usr/share/enigma2/ sh: fpupgrade: command not found --> setting contrast to: 00008000 --> setting saturation to: 00008000 --> setting hue to: 00008000 --> setting brightness to: 00008000 --> setting block_noise_reduction to: 00000000 --> setting mosquito_noise_reduction to: 00000000 --> setting digital_contour_removal to: 00000000 --> applying pep values [AutoMount.py] -getAutoMountPoints:self.automounts --> {} [AutoMount.py] self.automounts without mounts {} [OSD preference] found: /usr/share/enigma2/newnigma2-HD/icons/beta_g.png [OSD preference] append "icon" option to list [FONT] adding font /usr/share/fonts/nmsbd.ttf...OK (LCD_NN) [eCamdCtrl] starting cmd 5 [eCamdCtrl] executing /usr/bin/camdctrl current [TeleText] autostart(0, {}) starting hotplug handler [CrashlogAutoSubmit] - autostart [CI_Assignment] activating ci configs: [CI_Activate] FOUND 2 CI Slots [CI_Activate] activate CI0 with following settings: 0 ([], [], [2816]) [CI_Activate] activate CI1 with following settings: 1 ([], [], [2816]) [WebInterface] set language to de [TeleText] set language to [de] [TeleText] set language to [de] [WebInterface] set language to de [MovieCut] set language to de [MovieCut] set language to de EMC: Setting EPG language: de_DE [WebInterface] set language to de [AudioSync] set language to de [AudioSync] set language to de [ 66.680000] 16010 ms: 66 [ 66.694000] 13 ms: 94 [ 66.704000] tsmux set ciclk reg 34 to val 00 [ 66.709000] tsmux set ciclk reg 34 to val 00 FIXME: request for unknown slot FIXME: request for unknown slot [ 66.719000] 24 ms: 94 It's now Sat Oct 20 13:16:57 2012 [timer.py] next activation: 1350731917 (in 99299 ms) [TIMER] record time changed, start prepare is now: Sat Oct 20 13:19:40 2012 sanitycheck check checkTimerlist recording service: 1:0:1:4E8C:6590:DE:FFFF0000:0:0:0: record: 0 [Timer] Record ProcessRepeated It's now Sat Oct 20 13:16:57 2012 next real activation is Sat Oct 20 13:19:40 2012 [timer.py] next activation: 1350731917 (in 99277 ms) [TIMER] record time changed, start prepare is now: Sat Oct 20 14:54:40 2012 sanitycheck check checkTimerlist recording service: 1:0:1:4E8C:6590:DE:FFFF0000:0:0:0: record: 0 recording service: 1:0:1:4E8C:6590:DE:FFFF0000:0:0:0: record: 0 [Timer] Record ProcessRepeated It's now Sat Oct 20 13:16:57 2012 next real activation is Sat Oct 20 13:19:40 2012 [timer.py] next activation: 1350731917 (in 99259 ms) [TIMER] record time changed, start prepare is now: Sat Oct 20 23:04:40 2012 sanitycheck check checkTimerlist recording service: 1:0:1:4E8C:6590:DE:FFFF0000:0:0:0: record: 0 recording service: 1:0:1:4E8C:6590:DE:FFFF0000:0:0:0: record: 0 recording service: 1:0:1:4E25:2B6E:1:FFFF024A:0:0:0: record: 0 [Timer] Record ProcessRepeated It's now Sat Oct 20 13:16:57 2012 next real activation is Sat Oct 20 13:19:40 2012 [timer.py] next activation: 1350731917 (in 99237 ms) [TIMER] record time changed, start prepare is now: Sun Oct 21 00:09:40 2012 sanitycheck check checkTimerlist recording service: 1:0:1:4E8C:6590:DE:FFFF0000:0:0:0: record: 0 recording service: 1:0:1:4E8C:6590:DE:FFFF0000:0:0:0: record: 0 recording service: 1:0:1:4E25:2B6E:1:FFFF024A:0:0:0: record: 0 recording service: 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: record: 0 [Timer] Record ProcessRepeated It's now Sat Oct 20 13:16:57 2012 next real activation is Sat Oct 20 13:19:40 2012 [timer.py] next activation: 1350731917 (in 99213 ms) [TIMER] record time changed, start prepare is now: Sun Oct 21 01:59:40 2012 sanitycheck check checkTimerlist recording service: 1:0:1:4E8C:6590:DE:FFFF0000:0:0:0: record: 0 recording service: 1:0:1:4E8C:6590:DE:FFFF0000:0:0:0: record: 0 recording service: 1:0:1:4E25:2B6E:1:FFFF024A:0:0:0: record: 0 recording service: 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: record: 0 recording service: 1:0:1:4E22:2B6E:1:FFFF024A:0:0:0: record: 0 [Timer] Record ProcessRepeated It's now Sat Oct 20 13:16:57 2012 next real activation is Sat Oct 20 13:19:40 2012 [timer.py] next activation: 1350731917 (in 99185 ms) [TIMER] record time changed, start prepare is now: Sun Oct 21 08:09:40 2012 sanitycheck check checkTimerlist recording service: 1:0:1:4E8C:6590:DE:FFFF0000:0:0:0: record: 0 recording service: 1:0:1:4E8C:6590:DE:FFFF0000:0:0:0: record: 0 recording service: 1:0:1:4E25:2B6E:1:FFFF024A:0:0:0: record: 0 recording service: 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: record: 0 recording service: 1:0:1:4E22:2B6E:1:FFFF024A:0:0:0: record: 0 recording service: 1:0:1:4E8C:6590:DE:FFFF0000:0:0:0: record: 0 [Timer] Record ProcessRepeated It's now Sat Oct 20 13:16:57 2012 next real activation is Sat Oct 20 13:19:40 2012 [timer.py] next activation: 1350731917 (in 99155 ms) [TIMER] record time changed, start prepare is now: Mon Oct 22 04:49:40 2012 sanitycheck check checkTimerlist recording service: 1:0:1:4E8C:6590:DE:FFFF0000:0:0:0: record: 0 recording service: 1:0:1:4E8C:6590:DE:FFFF0000:0:0:0: record: 0 recording service: 1:0:1:4E25:2B6E:1:FFFF024A:0:0:0: record: 0 recording service: 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: record: 0 recording service: 1:0:1:4E22:2B6E:1:FFFF024A:0:0:0: record: 0 recording service: 1:0:1:4E8C:6590:DE:FFFF0000:0:0:0: record: 0 recording service: 1:0:1:4E8C:6590:DE:FFFF0000:0:0:0: record: 0 [Timer] Record ProcessRepeated It's now Sat Oct 20 13:16:57 2012 next real activation is Sat Oct 20 13:19:40 2012 [timer.py] next activation: 1350731917 (in 99120 ms) [TIMER] record time changed, start prepare is now: Mon Oct 22 08:04:40 2012 sanitycheck check checkTimerlist recording service: 1:0:1:4E8C:6590:DE:FFFF0000:0:0:0: record: 0 recording service: 1:0:1:4E8C:6590:DE:FFFF0000:0:0:0: record: 0 recording service: 1:0:1:4E25:2B6E:1:FFFF024A:0:0:0: record: 0 recording service: 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: record: 0 recording service: 1:0:1:4E22:2B6E:1:FFFF024A:0:0:0: record: 0 recording service: 1:0:1:4E8C:6590:DE:FFFF0000:0:0:0: record: 0 recording service: 1:0:1:4E8C:6590:DE:FFFF0000:0:0:0: record: 0 recording service: 1:0:1:B86:2AF8:14D:FFFF0000:0:0:0: record: 0 [Timer] Record ProcessRepeated It's now Sat Oct 20 13:16:57 2012 next real activation is Sat Oct 20 13:19:40 2012 [timer.py] next activation: 1350731917 (in 99083 ms) [TIMER] record time changed, start prepare is now: Mon Oct 22 21:04:40 2012 sanitycheck check checkTimerlist recording service: 1:0:1:4E8C:6590:DE:FFFF0000:0:0:0: record: 0 recording service: 1:0:1:4E8C:6590:DE:FFFF0000:0:0:0: record: 0 recording service: 1:0:1:4E25:2B6E:1:FFFF024A:0:0:0: record: 0 recording service: 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: record: 0 recording service: 1:0:1:4E22:2B6E:1:FFFF024A:0:0:0: record: 0 recording service: 1:0:1:4E8C:6590:DE:FFFF0000:0:0:0: record: 0 recording service: 1:0:1:4E8C:6590:DE:FFFF0000:0:0:0: record: 0 recording service: 1:0:1:B86:2AF8:14D:FFFF0000:0:0:0: record: 0 recording service: 1:0:1:2EE3:28A0:14D:FFFF0000:0:0:0: record: 0 [Timer] Record ProcessRepeated It's now Sat Oct 20 13:16:57 2012 next real activation is Sat Oct 20 13:19:40 2012 [timer.py] next activation: 1350731917 (in 99043 ms) RecordTimer.TryQuitMainloop RecordTimer.staticGotRecordEvent(iRecordableService.evEnd) another recording starts in 162.033004999 seconds... do not shutdown yet It's now Sat Oct 20 13:16:57 2012 [timer.py] next activation: 1350731917 (in 99029 ms) InfoBarTunerState start Looking for embedded skin Repeated: 1 Repeated: 3 Repeated: 7 Repeated: 15 Repeated: 31 Repeated: 63 Repeated: 127 ProcessRepeated localrepeatedbegindate: Sat Oct 20 19:00:00 2012 localbegin: Sat Oct 20 19:00:00 2012 localend: Sat Oct 20 19:00:00 2012 localnow: Sat Oct 20 13:16:59 2012 Day: 0 Day: 1 Day: 2 Day: 3 Day: 4 Day: 5 Day: 6 ProcessRepeated result Sat Oct 20 19:00:00 2012 Sat Oct 20 19:00:01 2012 It's now Sat Oct 20 13:16:58 2012 next real activation is Sat Oct 20 19:00:01 2012 [timer.py] next activation: 1350731918 (in 99812 ms) [TeleText] ----- sessionstart(<__main__.Session instance at 0x208b5d0>) ----- [TeleText] [favorites] reading accel 496000 bytes accel memstat: used=0 kB, free 12784 kB, s 0 kB accel memory: 0 Looking for embedded skin [TeleText] __layoutFinished [dFlash] autostart EMC: +++ EMC V3.0.0beta708 startup begin_date: 20121020 1320 service_name: AXN name: Die Flut - Eine Stadt versinkt: Teil 2 description: [TIMER] Filename calculated as: '/hdd/movie/20121020 1320 - AXN - Die Flut - Eine Stadt versinkt_ Teil 2' begin_date: 20121020 1455 service_name: AXN name: ANIMAX 3D Vorzocker description: [TIMER] Filename calculated as: '/hdd/movie/Dokus/20121020 1455 - AXN - ANIMAX 3D Vorzocker' begin_date: 20121020 2305 service_name: SAT.1 A name: Sleepy Hollow description: Horrormärchen, USA 1999, 95/120 Min. [TIMER] Filename calculated as: '/hdd/movie/20121020 2305 - SAT_1 A - Sleepy Hollow' begin_date: 20121021 0010 service_name: ORF eins HD name: Roter Drache description: Horrorthriller, USA 2002, 115 Min. [TIMER] Filename calculated as: '/hdd/movie/20121021 0010 - ORF eins HD - Roter Drache' begin_date: 20121021 0200 service_name: ProSieben Austria name: Tränen der Sonne description: Tränen der Sonne [TIMER] Filename calculated as: '/hdd/movie/20121021 0200 - ProSieben Austria - Tränen der Sonne' begin_date: 20121021 0810 service_name: AXN name: ANIMAX 3D Vorzocker description: [TIMER] Filename calculated as: '/hdd/movie/Dokus/20121021 0810 - AXN - ANIMAX 3D Vorzocker' begin_date: 20121022 0450 service_name: AXN name: ANIMAX 3D Vorzocker description: [TIMER] Filename calculated as: '/hdd/movie/Dokus/20121022 0450 - AXN - ANIMAX 3D Vorzocker' begin_date: 20121022 0805 service_name: Kinowelt name: Runaway Jury description: Als eine junge Frau nach dem Mord an ihrem Mann den Waffenhersteller verklagt, ist Juryberater Fitch in seinem Element: Um die Waffenindustrie vor einem Milliardenschaden zu bewahren, schreckt er weder vor Erpressung noch vor Manipulati [TIMER] Filename calculated as: '/hdd/movie/20121022 0805 - Kinowelt - Runaway Jury' begin_date: 20121022 2105 service_name: RTL Austria name: Bauer sucht Frau description: [TIMER] Filename calculated as: '/hdd/movie/TV-Serien/20121022 2105 - RTL Austria - Bauer sucht Frau' Looking for embedded skin 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! warning, skin is missing element Video in [ResourceManager] adding: NetworkAdapterSelection [ResourceManager] adding: AdapterSetup [CrashlogAutoSubmit] - autostart [CrashlogAutoSubmit] - not starting CrashlogAutoSubmit [VideoColorSpace] startup... [VideoColorSpace] current hdmi_colorspace: Edid(Auto) [VideoColorSpace] set hdmi_colorspace: Hdmi_Rgb [ 68.815000] using 50.00Hz as MonitorRefreshRate [ 68.935000] SET FORMAT: display[0], format=27 [ 68.935000] HDMI mode [ 68.936000] force colorspace to 0 [ 69.016000] bcm_video_analog_port_setup (fmt=7) [ 69.135000] SET FORMAT: display[1], format=7 [ 69.254000] set current avs auto aspect to 16:9 [ 69.255000] disable wss on display 0 [ 69.256000] set wss 7 on display 1 [ 69.257000] set sb to 3(1) [Cec] power on [TimerCleanup] Cleaning old Timers... [CamdresetEveryDay] next reset: Sat Oct 20 23:44:59 2012 No skin to read... [InstallerUpdateCheck] timer changed [InstallerUpdateCheck] next check at Sun Oct 21 13:17:00 2012 [InstallerUpdateCheck] Check... Looking for embedded skin [Toplevel.importExternalModules] Imported external module: EPGRefresh [Toplevel.importExternalModules] Imported external module: Example [Webinterface] started on 0.0.0.0:80 auth=True ssl=False [WebInterface.registerBonjourService] No module named Bonjour.Bonjour [WebInterface.unregisterBonjourService] No module named Bonjour.Bonjour [ 69.820000] 3101 ms: 94 [EPGC] setCacheFile read/write epg data from/to '/media/swap/epg.dat' [EPGC] time updated.. start EPG Mainloop before: 1 after: 1 not showing fine-tuning wizard, config variable doesn't exist showtestcard is false Looking for embedded skin [ 69.908000] 88 ms: 99 setValue 30 [ 69.961000] set mute 0 (000) 1 cannot open /proc/stb/audio/j1_mute(No such file or directory) Setvolume: 100 100 (raw) Setvolume: 0 0 (-1db) Setvolume: 30 30 (raw) Setvolu[ 69.964000] 56 ms: 99 me: 45 45 (-1db) [ 69.992000] 27 ms: 99 [prepareClose] running mainloop [prepareClose] running mainloop EMC: Setting EPG language: de_DE 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! 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! 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! reused converter! allocating new converter! allocating new converter! reused converter! allocating new converter! allocating new converter! reused converter! allocating new converter! allocating new converter! reused converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! reused converter! reused converter! reused converter! reused converter! reused converter! reused converter! reused converter! reused converter! reused converter! reused converter! reused converter! reused converter! reused converter! reused converter! allocating new converter! allocating new converter! allocating new converter! [NotificationQueue::popNotification] domain RecordTimer deferred_callable: False RecordTimer.stopTryQuitMainloop IBTS hide cec event! attached: hdmi attached attached: hdmi cec address acknowledged my physical: 1.1.0.0 logical 3 CISlot 0 what 2 CISlot 1 what 2 child has terminated pipes closed child has terminated pipes closed child has terminated pipes closed [ePopen] command: route -n | grep eth0 poll: unhandled POLLERR/HUP/NVAL for fd 41(16) child has terminated pipes closed poll: unhandled POLLERR/HUP/NVAL for fd 44(17) poll: unhandled POLLERR/HUP/NVAL for fd 47(16) poll: unhandled POLLERR/HUP/NVAL for fd 50(16) child has terminated pipes closed poll: unhandled POLLERR/HUP/NVAL for fd 57(16) [SEC] lock 0 [SEC] lock 0 playing 1:0:1:4E8C:6590:DE:FFFF0000:0:0:0: main thread is non-idle! display spinner! [EPGC] 57696 events read from /media/swap/epg.dat [EPGC] start cleanloop [TeleText] service started not pauseable. RemovePopup, id = ZapError allocate channel.. 6590:00de:ffff0000 [eDVBCAService] new channel 0x251b080! (0)tune tuning to 778000 khz, sr 6900000, fec 9, modulation 5, inversion 2 OURSTATE: tuning allocate Channel: res 0 [eDVBCIInterfaces] addPMTHandler 1:0:1:4E8C:6590:DE:FFFF0000:0:0:0: recheckPMTHAndlers() recheck 0x232f8dc 1:0:1:4E8C:6590:DE:FFFF0000:0:0:0: check Slot 0 check Slot 1 allocate demux IBTS tunerHide FE_READ_BER failed (Resource temporarily unavailable) cec event! send 3 -> 0 : 04 child has terminated pipes closed 0.0.0.0 169.254 [EPGC] stop cleanloop [EPGC] 3923232 bytes for cache used 192.168 nameservers: [[212, 33, 55, 5], [212, 33, 32, 160]] read configured interface: {'lo': {'dhcp': False}, 'eth0': {'dhcp': False, 'netmask': [255, 255, 255, 0], 'gateway': [192, 168, 1, 1], 'address': [192, 168, 1, 10]}} self.ifaces after loading: {'eth0': {'preup': False, 'predown': False, 'ip': [192, 168, 1, 10], 'up': True, 'dns-nameservers': '\tdns-nameservers 212.33.55.5 212.33.32.160\n', 'broadcast': '\tbroadcast 192.168.1.255\n', 'mac': '00:09:34:2d:c6:b4', 'dhcp': False, 'bcast': [192, 168, 1, 255], 'netmask': [255, 255, 255, 0], 'gateway': [192, 168, 1, 1]}} poll: unhandled POLLERR/HUP/NVAL for fd 40(16) [ 74.550000] CEC send ok! [SEC] delayed close frontend close frontend 1 FE_READ_BER failed (Resource temporarily unavailable) [SEC] startTuneTimeout 5000 cec event! send 3 -> f : 82 11 00 [SEC] unlock [SEC] setFrontend 1 (0)setting frontend (0)fe event: status 0, freq 778000000, inversion off, m_tuning 1 F (0)fe event: status 1f, freq 778000000, inversion off, m_tuning 1 N OURSTATE: ok [eDVBCAService] channel 0x251b080 running [eDVBLocalTimeHandler] channel 0x251b080 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 0x251b080 running stop release channel timer no version filtering [EPGC] next update in 2 sec 0012: 4e 4e 8c 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 ffffffff allocate demux disable teletext subtitles [ 74.669000] dvb_demux_feed_del: feed not in list (type=0 state=0 pid=ffff) PES filter: DMX_SET_PES_FILTER - Invalid argument decoder state[ 74.671000] start pcr0 on dmx 3 pid:2ff index 4 : play, vpid=767, apid=768 DMX_SET_PES_FILTER(0x2ff) - pcr - ok DEMUX_START - [ 74.674000] start audio on dmx 3 pid:300 [ 74.674000] audio xpt start [ 74.675000] sync is off so we enable it [ 74.676000] demux-index 3 pcr0pid 2ff [ 74.676000] using 4 as pcr0 pidchannel pcr - ok DMX_SE[ 74.677000] MPEG [ 74.677000] audio: streamtype set 0 [ 74.678000] audio: streamtype_set: stop rave [ 74.679000] audio: streamtype_set: restart rave [ 74.680000] CEC send ok! [ 74.680000] set mute 0 (111) 1 [ 74.681000] audio: decoder start 2 T_PES_FILTER(0x3[ 74.685000] audio delay 4500 (50 ms) 00) - audio - ok[ 74.685000] total video delay: 0 (0 ms) DEMUX_START - audio - ok AUDIO_SET_BYPASS(1) - ok AUDIO_PAUSE - ok AUDIO_PL[ 74.688000] start video0 on dmx 3 pid:2ff [ 74.688000] total video delay: 0 (0 ms) AY - ok Video Device: /dev/dvb/adapter0/video0 demux device: /dev/dvb/adapter0/demux3 VIDEO_SET_STREAMTYPE 0 - ok DMX_SET_PES_FILTER(0x2ff) - video - ok DEMUX_START - video - ok VIDEO_FREEZE - ok VIDEO_PLAY - [ 74.693000] VIDEO0: start decode ok VIDEO_SLOWMOTION(0) - ok VIDEO_FAST_FORWARD(0) - ok VIDEO_CONTINUE - ok AUDIO_CONTINUE - ok AUDIO_CHANNEL_SELECT(0) - ok not pauseable. [TeleText] serviceInfoChanged [TeleText] TXT PID -1 DEMUX 3 VIDEO_GET_EVENT - ok VIDEO_GET_EVENT - ok + 1/1 TID 00 done! PATready use pmtpid 0062 for service_id 4e8c no version filtering 0062: 02 4e 8c 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 doing version filtering 0000: 00 00 00 2f 00 00 mask: ff 00 00 3f 00 00 mode: 00 00 00 3e 00 00 [ 74.774000] RAP first pts 0x5e49a08c, stc 0x266d9f06, pcr valid [ 74.776000] audio_cdb_itb_error_isr! underflow [ 74.780000] audio_cdb_itb_error_isr! underflow [ 74.784000] audio_cdb_itb_error_isr! underflow [ 74.789000] audio_cdb_itb_error_isr! underflow [ 74.793000] audio_cdb_itb_error_isr! underflow + 1/1 TID 02[ 74.797000] audio_cdb_itb_error_isr! underflow done! [eDVBCAService] new service 1:0:1:4E8C:6590:DE:FFFF0000:0:0:0: [eDVBCAService] add demux 3 to slot 0 service 1:0:1:4E8C:6590:DE[ 74.801000] audio_cdb_itb_error_isr! underflow :FFFF0000:0:0:0: demux 3 mask 08 prevhash 00000000 [eDVBCAService] send 50 bytes 9f 80 32 2e 03 4e 8c 07 00 19 01 81 08 ff ff 00 00 65 90 00 de 82 02 08 03 84 02 00 62 09 04 0b 00 f1 87 02 02 ff[ 74.805000] audio_cdb_itb_error_isr! underflow 00 00 03 03 00 00 00 03 03 01 00 00 recheckPMTHAndlers() recheck 0x232f8dc 1:0:1:4E8C:6590:DE:FFFF0000:0:0:0: check Slot 0 check Slot 1 [eDVBCIInterfaces] gotPMT event[ 74.809000] audio_cdb_itb_error_isr! underflow NewProgramInfo 0 0 have 1 video stream(s) (02ff), and 2 audio stream(s) (0300, 0301), and the pcr pid is 02ff, [ 74.812000] dvb_demux_feed_del: feed not in list (type=0 state=0 pid=ffff) and the text pid is ffffffff PES filter: DMX_[ 74.813000] audio_cdb_itb_error_isr! underflow SET_PES_FILTER - Invalid argument decoder state: play, vpid=767, apid=768 VIDEO_SLOWMOTION(0) - ok VIDEO_FAST_FORWARD(0) - ok VIDEO_CONTINUE - ok AUDIO_CONTINUE - ok [TeleText] serviceInfoChanged [TeleText] TXT PID -1 DEMUX 3 doing version filtering 0062: 02 4e 8c 07 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 -+ 1/2 TID 4e sdt update done! [ 75.132000] ch0: lock [ExtendedInfoBar] CAIDs: ['0B00'] [ExtendedInfoBar] SID: 4E8C child has terminated pipes closed poll: unhandled POLLERR/HUP/NVAL for fd 72(16) [ 75.735000] VIDEO0: first pts 0x266fd348 [ 75.735000] VIDEO0: resolution changed (480 576) VIDEO_GET_EVENT - ok ++ 2/2 TID 4e done! doing version filtering 0012: 4e 4e 8c 39 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 [ 75.886000] enable tsm0 lookup for events with 'der erste kontakt' in title(ignore case) lookup for events with 'Voyager ' in title(ignore case) [ 76.511000] CEC recv ok! cec event! handle message 8 -> f : 84 10 00 04 Report Physical Address 1.0.0.0 device type 4 (Playback Device) lookup for events with 'District 9' as title(ignore case) lookup for events with 'ANIMAX 3D Vorzocker' as title(case sensitive) [EPGC] start caching events(1350731827) [ 76.668000] CEC recv ok! [ 76.715000] VIDEO0: progressive changed (0) cec event! handle message 5 -> f : 84 10 00 05 Report Physical Address 1.0.0.0 device type 5 (Audio System) VIDEO_GET_EVENT - ok [AutoTimer] Won't modify existing timer because either no modification allowed or repeated timer [AutoTimer] Won't modify existing timer because either no modification allowed or repeated timer [AutoTimer] Won't modify existing timer because either no modification allowed or repeated timer lookup for events with 'Grey's Anatomy' as title(ignore case) [ 77.005000] HDMI: force disconnect! [ 77.005000] HDMI: now disconnected [ 77.006000] HDMI: stop CEC cec event! nothing attached! lookup for events with 'Bauer sucht Frau' as title(case sensitive) [ 77.228000] CEC recv ok! cec event! cec event! handle message 8 -> f : 87 00 00 f0 Device Vendor ID 0000f0 child has terminated pipes closed [InstallerUpdateCheck] No updates available [InstallerUpdateCheck] next check at Sun Oct 21 13:17:08 2012 poll: unhandled POLLERR/HUP/NVAL for fd 73(16) [AutoTimer] Won't modify existing timer because either no modification allowed or repeated timer[ 77.435000] CEC recv ok! cec event! handle message 0 -> f : 87 08 00 46 Device Vendor ID 080046 lookup for events with 'Bedingungslos gehorsam' as title(ignore case) [ 77.603000] CEC recv ok! cec event! handle message 5 -> f : 80 10 00 11 00 Routing Change from 1.0.0.0 to 1.1.0.0 now we are *on air* !!! [ 77.705000] CEC recv ok! cec event! handle message 5 -> f : 72 01 EMC: [MC] LOAD PATH: /hdd/movie EMC: resetInfo PTS-Plugin: Erasing stranded timeshift pts_livebuffer.1 before: 1 after: 1 setIoPrio best-effort level 7 ok before: 1 before: 1 eBackgroundFileEraser '/media/swap//pts_livebuffer.1' finished eBackgroundFileEraser '/media/swap//pts_livebuffer.1.meta' finished eBackgroundFileEraser '/media/swap//pts_livebuffer.1.eit' finished [ 78.863000] HDMI: now connected [ 78.892000] HDMI: EDID read ok [ 78.895000] using 50.00Hz as MonitorRefreshRate [ 79.015000] SET FORMAT: display[0], format=27 [ 79.015000] HDMI mode [ 79.016000] force colorspace to 0 [ 79.095000] bcm_video_analog_port_setup (fmt=7) [ 79.215000] SET FORMAT: display[1], format=7 [ 79.334000] set current avs auto aspect to 16:9 [ 79.335000] disable wss on display 0 [ 79.336000] set wss 7 on display 1 [ 79.336000] HDMI: start CEC [ 79.337000] set sb to 3(1) cec event! attached: hdmi attached [ 79.399000] HDMI: use logical CEC address 3 [ 79.473000] CEC send ok! [ 80.337000] HDMI: force disconnect! [ 80.337000] HDMI: now disconnected [ 80.337000] HDMI: stop CEC cec event! nothing attached! nr_read 306 nr_write 4 sum 310 prev_sum 0 hdd was accessed since previous check! [IDLE] 0 300 False nr_read 464 nr_write 19 sum 483 prev_sum 0 hdd was accessed since previous check! [IDLE] 0 300 False Start timeshift! recording to /media/swap//timeshift.Imoa66 before: 1 after: 1 eRecordFileThread START setIoPrio realtime level 7 ok [EITSave] query epg event id 65001, 1:0:1:4E8C:6590:DE:FFFF0000:0:0:0: [EITSave] found event.. store to disc [ 82.047000] HDMI: now connected [ 82.076000] HDMI: EDID read ok [ 82.095000] using 50.00Hz as MonitorRefreshRate [ 82.215000] SET FORMAT: display[0], format=27 [ 82.216000] HDMI mode [ 82.216000] force colorspace to 0 [ 82.330000] bcm_video_analog_port_setup (fmt=7) [ 82.435000] SET FORMAT: display[1], format=7 [ 82.554000] set current avs auto aspect to 16:9 [ 82.555000] disable wss on display 0 [ 82.556000] set wss 7 on display 1 [ 82.557000] HDMI: start CEC cec event! attached: hdmi a[ 82.558000] set sb to 3(1) ttached [ 82.619000] HDMI: use logical CEC address 3 cec event! attached: hdmi attached attached: hdmi cec address acknowledged my physical: 1.1.0.0 logical 3 [ 82.756000] CEC send ok! [EPGC] abort non avail schedule other reading [EPGC] abort non avail viasat reading [EPGC] nownext finished(1350731834) [EPGC] schedule finished(1350731837) [EPGC] stop caching events(1350731837) [EPGC] next update in 60 min [ 89.754000] CEC recv ok! cec event! attached: hdmi attached attached: hdmi cec address acknowledged my physical: 1.1.0.0 logical 3 cec event! handle message 0 -> f : 84 00 00 00 Report Physical Address 0.0.0.0 device type 0 (TV) [ 89.895000] CEC recv ok! cec event! handle message 0 -> f : 87 08 00 46 Device Vendor ID 080046 [ 90.167000] CEC recv ok! cec event! handle message 0 -> f : a0 08 00 46 00 04 00 01 Vendor Command with ID [ 90.416000] CEC recv ok! cec event! handle message 5 -> f : 72 00 [eDVBLocalTimeHandler] Receiver time is 'Sat Oct 20 13:17:23 2012' [eDVBLocalTimeHandler] Transponder time is 'Sat Oct 20 13:17:22 2012' [eDVBLocalTimeHandler] diff is -1 [eDVBLocalTimeHandler] diff < 120 .. use Transponder Time [eDVBLocalTimeHandler] update RTC [eDVBLocalTimeHandler] time_difference is -1 [eDVBLocalTimeHandler] update Linux Time [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3923232 bytes for cache used [ 92.967000] CEC recv ok! cec event! handle message 0 -> f : 32 67 65 72 Set Menu Language: ger [ 93.453000] CEC recv ok! cec event! handle message 0 -> f : a0 08 00 46 00 13 00 10 00 00 01 00 00 00 00 Vendor Command with ID [ 93.687000] CEC recv ok! cec event! handle message 0 -> 3 : 46 Give OSD Name cec event! send 3 -> 0 : 47 44 72 65 61 6d 62 6f 78 [ 94.097000] CEC send ok! [ 94.159000] CEC recv ok! cec event! handle message 0 -> 3 : 8c Give Device Vendor ID cec event! send 3 -> f : 87 00 09 34 [ 94.294000] CEC send ok! [ 94.596000] CEC recv ok! cec event! handle message 0 -> f : a0 08 00 46 00 08 00 00 Vendor Command with ID no ancillary data in audio stream... abort radiotext pes parser [ 95.302000] CEC recv ok! cec event! handle message 0 -> 3 : [ 95.700000] CEC recv ok! cec event! handle message 8 -> f : 84 10 00 04 Report Physical Address 1.0.0.0 device type 4 (Playback Device) [ 96.071000] CEC recv ok! cec event! handle message 5 -> f : 84 10 00 05 Report Physical Address 1.0.0.0 device type 5 (Audio System) [ 96.373000] CEC recv ok! cec event! handle message 0 -> 3 : 83 Get Physical Address cec event! send 3 -> f : 84 11 00 03 [ 96.508000] CEC send ok! [ 97.650000] CEC recv ok! cec event! handle message 8 -> f : 87 00 00 f0 Device Vendor ID 0000f0 [ 97.861000] CEC recv ok! cec event! handle message 5 -> f : 87 00 00 f0 Device Vendor ID 0000f0 [ 103.073000] CEC recv ok! cec event! handle message 0 -> 3 : nr_read 306 nr_write 4 sum 310 prev_sum 310 hdd IDLE! [IDLE] 28.9995210171 300 False nr_read 464 nr_write 158 sum 622 prev_sum 483 hdd was accessed since previous check! [IDLE] 0 300 False