=~=~=~=~=~=~=~=~=~=~=~= PuTTY log 2012.11.15 19:23:28 =~=~=~=~=~=~=~=~=~=~=~= [ 223.432000] JFFS2 notice: (146) check_node_data: wrong data CRC in data node at 0x099a3760: read 0x184fd22a, calculated 0x4a013e36. [ BCM97400 AB FFFFFFFF 1s Sync=0 LLMB=0 L2=0 RAC_I=0 RAC_D=0 Copy Code...34TUCV (c) 2007,2008 Dream Multimedia GmbH. All rights reserved. Dreambox DM8000 FIRST STAGE 1.00 {BO23456}  2ND STAGE OK, build #84 (2011-09-01) 0.000 - BCM board setup Configure MEMC1_2........ Done 0.039 - fp init FP version 7 detected 0.106 - ca init 0.822 - load config 1.401 - config loaded. * press [S] to enter setup OLED found! lcd: BOOT #84 - NAND PROBE: 2c da 80 95 (normal) - read config file: /boot/secondstage.conf detected jffs2 blocksize: 128kb +++++++++++++++++++++++++++UUUUUUUUUUUUUUUUUUUUUUUUUUUUU dreamupd initialized Scanning JFFS2 FS: . | / - \ | / - \ | / - \ |  done. find_inode failed for name=secondstage.conf load: Failed to find inode - failed to open /boot/secondstage.conf - failed to open /cf/autorun.bat lcd: /boot/bootlogo-dm8000.elf.gz bootlogo size: 170039 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_24Hz 1080p_25Hz 1080p_30Hz !1080p_50Hz !1250i_50Hz 720p_50Hz 576p_50Hz DVI_640x480p DVI_800x600p DVI_1024x768p !DVI_1280x720p_50Hz !DVI_1280x720p !DVI_1280x720p_ReducedBlank !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 !Custom2 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-dm8000.gz [ 0.000000] Linux version 3.2-dm8000 (oe@porky.dream-property.net) (gcc version 4.6.4 20120303 (prerelease) (GCC) ) #1 SMP Thu Oct 11 13:26:30 UTC 2012 [ 0.000000] Fetching vars from bootloader... [ 0.000000] Early serial console at MMIO32 0x10400b00 (options '115200n8') [ 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 256 MB RAM (from straps) [ 0.000000] Fetch var 'memsize' = '154' [ 0.000000] CPU revision is: 0002a042 (Brcm4380) [ 0.000000] FPU revision is: 00130001 [ 0.000000] Determined physical RAM map: [ 0.000000] memory: 10000000 @ 00000000 (usable) [ 0.000000] bmem: adding 102 MB RESERVED region at 154 MB (0x06600000@0x09a00000) [ 0.000000] Zone PFN ranges: [ 0.000000] Normal 0x00000000 -> 0x00010000 [ 0.000000] Movable zone start PFN for each node [ 0.000000] early_node_map[1] active PFN ranges [ 0.000000] 0: 0x00000000 -> 0x00010000 [ 0.000000] PERCPU: Embedded 7 pages/cpu @81203000 s5440 r8192 d15040 u32768 [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 65024 [ 0.000000] Kernel command line: console=ttyS0,115200 root=/dev/mtdblock3 rootfstype=jffs2 rw bmem=102M@154M [ 0.000000] PID hash table entries: 1024 (order: 0, 4096 bytes) [ 0.000000] Dentry cache hash table entries: 32768 (order: 5, 131072 bytes) [ 0.000000] Inode-cache hash table entries: 16384 (order: 4, 65536 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: 149372k/262144k available (4674k kernel code, 112772k reserved, 978k data, 220k init, 0k highmem) [ 0.000000] Hierarchical RCU implementation. [ 0.000000] NR_IRQS:128 [ 0.000000] Detected MIPS clock frequency: 405 MHz (202.508 MHz counter) [ 0.000000] Console: colour dummy device 80x25 [ 0.001000] Calibrating delay loop... 403.45 BogoMIPS (lpj=201728) [ 0.013000] pid_max: default: 32768 minimum: 301 [ 0.014000] Mount-cache hash table entries: 512 [ 0.017000] SMP: Booting CPU1... [ 0.018000] CPU revision is: 0002a042 (Brcm4380) [ 0.018000] FPU revision is: 00130001 [ 0.018000] Primary instruction cache 32kB, VIPT, 2-way, linesize 64 bytes. [ 0.018000] Primary data cache 64kB, 4-way, VIPT, cache aliases, linesize 64 bytes [ 0.029000] SMP: CPU1 is running [ 0.029000] Brought up 2 CPUs [ 0.030000] devtmpfs: initialized [ 0.034000] NET: Registered protocol family 16 [ 0.036000] PCI2.3->SDRAM window: 256 MB [ 0.043000] bio: create slab at 0 [ 0.045000] SCSI subsystem initialized [ 0.046000] usbcore: registered new interface driver usbfs [ 0.047000] usbcore: registered new interface driver hub [ 0.048000] usbcore: registered new device driver usb [ 0.049000] Advanced Linux Sound Architecture Driver Version 1.0.24. [ 0.050000] PCI: found device 168c:001a on PCI2.3 bus, slot 1 (irq 33) [ 0.051000] pci 0000:00:01.0: BAR 0: assigned [mem 0xd0000000-0xd000ffff] [ 0.052000] pci 0000:00:01.0: BAR 0: set to [mem 0xd0000000-0xd000ffff] (PCI address [0xd0000000-0xd000ffff]) [ 0.053000] PCI: found device 14e4:8602 on SATA bus, slot 0 (irq 42) [ 0.054000] pci 0000:01:00.0: BAR 5: assigned [mem 0x10510000-0x10510fff] [ 0.055000] pci 0000:01:00.0: BAR 5: set to [mem 0x10510000-0x10510fff] (PCI address [0x10510000-0x10510fff]) [ 0.056000] pci 0000:01:00.0: BAR 6: assigned [mem 0x10511000-0x105117ff pref] [ 0.057000] Switching to clocksource upg [ 0.071000] NET: Registered protocol family 2 [ 0.076000] IP route cache hash table entries: 2048 (order: 1, 8192 bytes) [ 0.084000] TCP established hash table entries: 8192 (order: 4, 65536 bytes) [ 0.091000] TCP bind hash table entries: 8192 (order: 4, 65536 bytes) [ 0.098000] TCP: Hash tables configured (established 8192 bind 8192) [ 0.105000] TCP reno registered [ 0.108000] UDP hash table entries: 128 (order: 0, 4096 bytes) [ 0.114000] UDP-Lite hash table entries: 128 (order: 0, 4096 bytes) [ 0.121000] NET: Registered protocol family 1 [ 0.126000] RPC: Registered named UNIX socket transport module. [ 0.132000] RPC: Registered udp transport module. [ 0.137000] RPC: Registered tcp transport module. [ 0.142000] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.152000] JFFS2 version 2.2. (NAND) (SUMMARY) © 2001-2006 Red Hat, Inc. [ 0.160000] SGI XFS with security attributes, large block/inode numbers, no debug enabled [ 0.170000] msgmni has been set to 291 [ 0.175000] io scheduler noop registered [ 0.179000] io scheduler cfq registered (default) [ 0.184000] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled [ 0.212000] serial8250.0: ttyS0 at MMIO 0x10400b00 (irq = 69) is a 16550A [ 0.219000] console [ttyS0] enabled, bootconsole disabled [ 0.219000] console [ttyS0] enabled, bootconsole disabled [ 0.233000] loop: module loaded [ 0.236000] brcm-pm: enabling sata clocks [ 0.240000] PCI: Enabling device 0000:01:00.0 (0000 -> 0003) [ 0.443000] scsi0 : sata_brcmstb [ 0.447000] scsi1 : sata_brcmstb [ 0.450000] ata1: SATA max UDMA7 mmio m4096@0x10510000 port 0x10510000 irq 42 [ 0.458000] ata2: SATA max UDMA7 mmio m4096@0x10510000 port 0x10510100 irq 42 [ 0.686000] 4545 kb/s [ 0.688000] - NAND PROBE: 2c da 80 95 [ 0.692000] ONFI flash detected [ 0.696000] ONFI param page 0 valid [ 0.699000] NAND device: Manufacturer ID: 0x2c, Chip ID: 0xda (Micron MT29F2G08AAD) [ 0.707000] Scanning device for bad blocks [ 1.334000] Creating 4 MTD partitions on "MT29F2G08AAD": [ 1.335000] 0x000000000000-0x000010000000 : "complete" [ 1.356000] ata1: SATA link down (SStatus 4 SControl 300) [ 1.363000] 0x000000000000-0x000000100000 : "loader" [ 1.369000] 0x000000100000-0x000000800000 : "boot partition" [ 1.376000] 0x000000800000-0x000010000000 : "root partition" [ 1.384000] bcmemac: Broadcom STB 10/100 EMAC driver v3.0 [ 1.392000] bcmemac: registered interface #0 at 0x10080000 as 'eth0' (00:09:34:1c:2f:c2) [ 1.400000] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver [ 1.407000] brcm-pm: enabling usb clocks [ 1.411000] ehci-brcm ehci-brcm.0: Broadcom STB EHCI [ 1.416000] ehci-brcm ehci-brcm.0: new USB bus registered, assigned bus number 1 [ 1.455000] ehci-brcm ehci-brcm.0: irq 62, io mem 0x10480300 [ 1.466000] ehci-brcm ehci-brcm.0: USB 0.0 started, EHCI 1.00 [ 1.472000] hub 1-0:1.0: USB hub found [ 1.476000] hub 1-0:1.0: 2 ports detected [ 1.480000] ehci-brcm ehci-brcm.1: Broadcom STB EHCI [ 1.485000] ehci-brcm ehci-brcm.1: new USB bus registered, assigned bus number 2 [ 1.524000] ehci-brcm ehci-brcm.1: irq 57, io mem 0x10480500 [ 1.535000] ehci-brcm ehci-brcm.1: USB 0.0 started, EHCI 1.00 [ 1.541000] hub 2-0:1.0: USB hub found [ 1.545000] hub 2-0:1.0: 2 ports detected [ 1.549000] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver [ 1.556000] ohci-brcm ohci-brcm.0: Broadcom STB OHCI [ 1.561000] ohci-brcm ohci-brcm.0: new USB bus registered, assigned bus number 3 [ 1.568000] ohci-brcm ohci-brcm.0: irq 63, io mem 0x10480400 [ 1.639000] hub 3-0:1.0: USB hub found [ 1.643000] hub 3-0:1.0: 2 ports detected [ 1.648000] ohci-brcm ohci-brcm.1: Broadcom STB OHCI [ 1.653000] ohci-brcm ohci-brcm.1: new USB bus registered, assigned bus number 4 [ 1.660000] ohci-brcm ohci-brcm.1: irq 64, io mem 0x10480600 [ 1.732000] hub 4-0:1.0: USB hub found [ 1.735000] hub 4-0:1.0: 2 ports detected [ 1.740000] Initializing USB Mass Storage driver... [ 1.745000] usbcore: registered new interface driver usb-storage [ 1.751000] USB Mass Storage support registered. [ 1.756000] i2c /dev entries driver [ 1.759000] ALSA device list: [ 1.762000] No soundcards found. [ 1.766000] TCP cubic registered [ 1.770000] NET: Registered protocol family 17 [ 1.774000] Registering the dns_resolver key type [ 1.786000] usb 1-1: new high-speed USB device number 2 using ehci-brcm [ 1.872000] ata2: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [ 1.908000] hub 1-1:1.0: USB hub found [ 1.912000] hub 1-1:1.0: 3 ports detected [ 1.922000] ata2.00: ATA-8: WDC WD20EADS-32S2B0, 01.00A01, max UDMA/133 [ 1.928000] ata2.00: 3907029168 sectors, multi 0: LBA48 NCQ (depth 0/32) [ 1.954000] ata2.00: configured for UDMA/133 [ 1.959000] scsi 1:0:0:0: Direct-Access ATA WDC WD20EADS-32S 01.0 PQ: 0 ANSI: 5 [ 1.968000] sd 1:0:0:0: [sda] 3907029168 512-byte logical blocks: (2.00 TB/1.81 TiB) [ 1.976000] sd 1:0:0:0: [sda] Write Protect is off [ 1.981000] sd 1:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA [ 1.996000] sda: sda1 [ 2.000000] sd 1:0:0:0: [sda] Attached SCSI disk [ 2.019000] usb 1-2: new high-speed USB device number 3 using ehci-brcm [ 2.180000] scsi2 : usb-storage 1-2:1.0 [ 2.252000] usb 1-1.3: new high-speed USB device number 4 using ehci-brcm [ 2.370000] scsi3 : usb-storage 1-1.3:1.0 [ 3.191000] scsi 2:0:0:0: Direct-Access Generic USB SD Reader 1.00 PQ: 0 ANSI: 0 [ 3.201000] scsi 2:0:0:1: Direct-Access Generic USB CF Reader 1.01 PQ: 0 ANSI: 0 [ 3.211000] scsi 2:0:0:2: Direct-Access Generic USB SM Reader 1.02 PQ: 0 ANSI: 0 [ 3.220000] scsi 2:0:0:3: Direct-Access Generic USB MS Reader 1.03 PQ: 0 ANSI: 0 [ 3.381000] scsi 3:0:0:0: Direct-Access Ut165 USB2FlashStorage 0.00 PQ: 0 ANSI: 2 [ 3.404000] sd 3:0:0:0: [sdf] 15794176 512-byte logical blocks: (8.08 GB/7.53 GiB) [ 3.413000] sd 3:0:0:0: [sdf] Write Protect is off [ 3.420000] sd 3:0:0:0: [sdf] Asking for cache data failed [ 3.426000] sd 3:0:0:0: [sdf] Assuming drive cache: write through [ 3.444000] sd 3:0:0:0: [sdf] Asking for cache data failed [ 3.450000] sd 3:0:0:0: [sdf] Assuming drive cache: write through [ 3.741000] sdf: sdf1 [ 4.072000] sd 3:0:0:0: [sdf] Asking for cache data failed [ 4.078000] sd 3:0:0:0: [sdf] Assuming drive cache: write through [ 4.085000] sd 3:0:0:0: [sdf] Attached SCSI removable disk [ 5.746000] VFS: Mounted root (jffs2 filesystem) on device 31:3. [ 5.787000] devtmpfs: mounted [ 33.830000] usb 1-2: reset high-speed USB device number 3 using ehci-brcm [ 44.057000] usb 1-2: reset high-speed USB device number 3 using ehci-brcm [ 60.281000] usb 1-2: reset high-speed USB device number 3 using ehci-brcm [ 60.506000] usb 1-2: reset high-speed USB device number 3 using ehci-brcm [ 70.734000] usb 1-2: reset high-speed USB device number 3 using ehci-brcm [ 70.856000] sd 2:0:0:0: Device offlined - not ready after error recovery [ 70.863000] sd 2:0:0:0: rejecting I/O to offline device [ 70.868000] sd 2:0:0:0: rejecting I/O to offline device [ 70.874000] sd 2:0:0:0: rejecting I/O to offline device [ 70.879000] sd 2:0:0:0: [sdb] READ CAPACITY failed [ 70.884000] sd 2:0:0:0: [sdb] Result: hostbyte=0x01 driverbyte=0x00 [ 70.890000] sd 2:0:0:0: [sdb] Sense not available. [ 70.895000] sd 2:0:0:0: rejecting I/O to offline device [ 70.900000] sd 2:0:0:0: [sdb] Write Protect is off [ 70.905000] sd 2:0:0:0: rejecting I/O to offline device [ 70.910000] sd 2:0:0:0: [sdb] Asking for cache data failed [ 70.916000] sd 2:0:0:0: [sdb] Assuming drive cache: write through [ 70.923000] sd 2:0:0:0: [sdb] Attached SCSI removable disk [ 71.502000] sd 2:0:0:1: [sdc] 8027712 512-byte logical blocks: (4.11 GB/3.82 GiB) [ 71.513000] sd 2:0:0:1: [sdc] Write Protect is off [ 71.518000] sd 2:0:0:2: [sdd] Attached SCSI removable disk [ 71.518000] sd 2:0:0:3: [sde] Attached SCSI removable disk [ 71.518000] sd 2:0:0:1: [sdc] No Caching mode page present [ 71.518000] sd 2:0:0:1: [sdc] Assuming drive cache: write through [ 71.523000] sd 2:0:0:1: [sdc] No Caching mode page present [ 71.523000] sd 2:0:0:1: [sdc] Assuming drive cache: write through [ 71.524000] sdc: sdc1 [ 71.559000] sd 2:0:0:1: [sdc] No Caching mode page present [ 71.564000] sd 2:0:0:1: [sdc] Assuming drive cache: write through [ 71.570000] sd 2:0:0:1: [sdc] Attached SCSI removable disk [ 71.576000] Freeing unused kernel memory: 220k freed INIT: version 2.88 booting Displaying bootlogo. Starting udev [ 74.276000] udevd[88]: starting version 182 [ 76.191000] stb_core: module license 'Proprietary' taints kernel. [ 76.198000] Disabling lock debugging due to kernel taint [ 76.461000] ath_hal: 2009-05-08 (AR5210, AR5211, AR5212, AR5416, RF5111, RF5112, RF2413, RF5413, RF2133, RF2425, REGOPS_FUNC, XR) [ 76.706000] wlan: svn r3314 [ 76.866000] ath_pci: svn r3314 [ 76.869000] PCI: Enabling device 0000:00:01.0 (0000 -> 0002) [ 76.875000] Atheros HAL provided by OpenWrt, DD-WRT and MakSat Technologies [ 77.578000] ath_rate_sample: 1.2 (svn r3314) [ 77.648000] wifi0: 11b rates: 1Mbps 2Mbps 5.5Mbps 11Mbps [ 77.654000] wifi0: 11g rates: 1Mbps 2Mbps 5.5Mbps 11Mbps 6Mbps 9Mbps 12Mbps 18Mbps 24Mbps 36Mbps 48Mbps 54Mbps [ 77.665000] wifi0: turboG rates: 6Mbps 12Mbps 18Mbps 24Mbps 36Mbps 48Mbps 54Mbps [ 77.674000] wifi0: H/W encryption support: WEP AES AES_CCM TKIP [ 77.789000] ath_pci: wifi0: Atheros 2413: mem=0xd0000000, irq=33 [ 77.928000] fpga init [ 80.832000] done OK 0 [ 84.868000] enter base init, xvd 20100413, vdc 20100413, rap 20101005, xpt 20100825 [ 84.876000] !!! kernMemSize: 154 MB [ 84.887000] smca set muxes [ 84.890000] smcb set muxes [ 84.893000] smcc set muxes [ 84.906000] 84:905969315 SMCA: controller reset timed out [ 84.923000] 84:922937890 SMCB: controller reset timed out [ 87.207000] register adapter [ 87.211000] register adapter [ 87.224000] register adapter [ 87.348000] register adapter [ 87.362000] register adapter [ 87.530000] FP Version 7 [ 87.534000] input: dreambox front panel as /devices/virtual/input/input0 [ 87.659000] maskffffffff [ 87.662000] using fpga version 2a [ 87.665000] tsmux set tsports reg 02 to val dc [ 87.670000] tsmux set tsports reg 02 to val dc [ 87.674000] tsmux set tsports reg 03 to val fe [ 87.679000] tsmux set tsports reg 03 to val fe [ 87.683000] tsmux set ciclk reg fe to val 00 [ 87.688000] tsmux set cisource reg 00 to val 55 [ 87.692000] tsmux set ciclk reg fe to val 00 [ 87.697000] tsmux set cisource reg 00 to val 55 [ 87.701000] tsmux set ciclk reg fe to val 00 [ 87.706000] tsmux set cisource reg 01 to val 55 [ 87.710000] tsmux set ciclk reg fe to val 00 [ 87.715000] tsmux set cisource reg 01 to val 55 [ 87.721000] set sb to 3(2) [ 87.724000] set fb to 2(-1) [ 87.727000] set input to 0 [ 87.730000] set fb to 2(-1) [ 87.740000] bcm_video_analog_port_setup (fmt=7) [ 87.745000] SET FORMAT: display[1], format=7 [ 87.749000] display 0 uses vbi path 1 [ 87.753000] display 1 uses vbi path 0 [ 87.758000] HDMI: now powered down [ 87.762000] Write AVS: 40 40 00 00 00 00 00 03 00 02 00 00 00 ff [ 87.776000] Write AVS: 40 40 00 00 00 00 18 63 00 02 00 00 00 ff [ 87.791000] set sb to 3(2) [ 87.794000] set sb to 3(2) [ 87.807000] HDMI: EDID read ok [ 87.810000] HDMI: initial mode set! [ 87.814000] using 50.00Hz as MonitorRefreshRate [ 87.818000] SET FORMAT: display[0], format=37 [ 87.823000] HDMI mode [ 87.825000] use EDID to detect colorspace [ 87.829000] using colorspace: 1 [ 87.927000] set fb to 2(0) [ 87.930000] bcm_video_analog_port_setup (fmt=7) [ 87.935000] SET FORMAT: display[1], format=7 [ 87.940000] disable wss on display 0 [ 87.944000] disable wss on display 1 [ 87.949000] bcmfb: creating surface with pixel format 0x07e48888 (BPXL_eA8_R8_G8_B8) [ 88.320000] enable mad [ 88.375000] VIDEO0: set fallback framerate to 60000 [ 88.380000] VIDEO0: set progressive override mode to 1 [ 88.385000] VIDEO0: set streamtype! [ 88.389000] set MPEG2 [ 88.391000] sw rave disabled! [ 88.626000] enable mad [ 88.629000] VIDEO1: set fallback framerate to 60000 [ 88.634000] VIDEO1: set progressive override mode to 1 [ 88.639000] VIDEO1: set streamtype! [ 88.643000] set MPEG2 [ 88.645000] sw rave disabled! [ 88.656000] sync is off so we enable it [ 88.660000] playback! [ 88.662000] total video delay: 0 (0 ms) [ 88.667000] VIDEO0: start decode [ 88.671000] flush video decoder [ 88.674000] VIDEO0 got pts failed !!!! (ret 0) [ 91.792000] set ac3 to downmix [ 91.797000] set aac to downmix [ 91.800000] init ALSA! [ 91.835000] VIDEO0: first pts 0x0 [ 91.869000] DVB: registering new adapter (BCM7400) [ 91.901000] autodetecting NIMs... [ 91.906000] ret: 2, feid: 13 [ 91.909000] Found: Slot C, ID: 13 (by CA) [ 91.923000] ret: 2, feid: 01 [ 91.926000] Found: Slot D, ID: 01 (by CA) [ 91.930000] Initializing adapter 0 (BCM4501 (internal)-DVB-S2) [ 91.951000] bcm4501: found 4501, revision 2(c0) [ 91.956000] bcm4501: bcm_initAP [ 92.001000] bcm4501: upload & start firmware [ 92.029000] enable tsm0 [ 95.281000] bcm4501: ap not running - start now [ 95.299000] bcm4501: uCode 0x72 [ 95.345000] DVB: registering adapter 0 frontend 0 (bcm4501)... [ 95.449000] Initializing adapter 1 (BCM4501 (internal)-DVB-S2) [ 95.494000] DVB: registering adapter 0 frontend 1 (bcm4501)... [ 95.591000] Initializing adapter 2 (BCM4505-DVB-S2) [ 95.731000] bcm4506: found 4505, revision 0(b0) [ 95.736000] bcm4506: bcm_initAP [ 95.746000] bcm4506: upload & start firmware [ 98.476000] bcm4506: bcm4506: ap not running - start now [ 98.531000] bcm4506: uCode 0x61 [ 98.567000] bcm4506: no bcm3445 detected [ 98.584000] DVB: registering adapter 0 frontend 2 (bcm4506)... [ 98.621000] Initializing adapter 3 (Philips CU1216Mk3-DVB-C) [ 98.629000] DVB: registering adapter 0 frontend 3 (CU1216Mk3)... [ 99.726000] VIDEO0: stop decode [ 99.729000] no decoder left in sync handling so disable xpt_sync [ 99.741000] CI stopped... [ 99.745000] CI stopped... [ 99.748000] CI stopped... [ 99.752000] registered vtuner misc/vtuner0, minor 49 [ 99.758000] CI stopped... [ 99.762000] registered vtuner misc/vtuner1, minor 48 [ 99.767000] IR-TX init! [ 99.993000] VIDEO0: set blank to 0 [ 100.091000] sync is off so we enable it [ 100.095000] playback! [ 100.097000] total video delay: 0 (0 ms) [ 100.102000] VIDEO0: start decode [ 100.106000] flush video decoder [ 100.267000] VIDEO0: set blank to 0 [ 100.271000] VIDEO0: stop decode [ 100.274000] VIDEO0: set blank to 0 [ 100.278000] no decoder left in sync handling so disable xpt_sync [ 105.824000] input: dreambox remote control (native) as /devices/virtual/input/input1 [ 105.835000] input: dreambox advanced remote control (native) as /devices/virtual/input/input2 [ 105.857000] input: dreambox ir keyboard as /devices/virtual/input/input3 [ 105.865000] input: dreambox ir mouse as /devices/virtual/input/input4 [ 105.882000] 4100849 ms: [ 105.994000] 109 ms: 12 [ 106.661000] kjournald starting. Commit interval 5 seconds [ 106.746000] EXT3-fs (sda1): using internal journal [ 106.751000] EXT3-fs (sda1): recovery complete [ 106.757000] EXT3-fs (sda1): mounted filesystem with writeback data mode [ 106.786000] 790 ms: 14 [ 107.589000] 801 ms: 16 [ 107.650000] 58 ms: 18 [ 107.680000] 28 ms: 20 Configuring network interfaces... done. [ 112.783000] 5101 ms: 22 Starting portmap daemon... [ 112.884000] 99 ms: 24 [ 112.917000] 31 ms: 26 net.ipv4.conf.default.rp_filter = 1 net.ipv4.conf.all.rp_filter[ 113.003000] 84 ms: 28 = 1 Starting tpmd. [ 113.050000] 45 ms: 30 INIT: Entering runlevel: 3 Starting system message bus: dbus. [ 114.269000] 1217 ms: 33 [ 117.570000] 3298 ms: 34 starting gdaemon... done. [ 117.606000] 34 ms: 35 Starting Dropbear SSH server: dropbear. [ 117.744000] 136 ms: 36 Starting automounter: loading autofs4 kernel module, done. [ 119.576000] 1829 ms: 37 [ 119.630000] 51 ms: 38 starting Busybox Periodic Command Scheduler: crond... done. [ 119.699000] 67 ms: 39 crond[692]: crond: crond (busybox 1.19.4) started, log level 8 [ 119.790000] 89 ms: 40 Starting dbttcd. [ 119.852000] 60 ms: 41 [ 120.389000] 534 ms: 42 creating NFS state directory: done starting 8 nfsd kernel threads: [ 121.019000] Installing knfsd (copyright (C) 1996 okir@monad.swb.de). [ 121.167000] NFSD: Using /var/lib/nfs/v4recovery as the NFSv4 state recovery directory [ 121.175000] NFSD: unable to find recovery directory /var/lib/nfs/v4recovery [ 121.182000] NFSD: starting 90-second grace period done starting mountd: done starting statd: done [ 122.016000] 1624 ms: 43 Starting syslogd/klogd: done [ 122.086000] 68 ms: 44 Starting internet superserver: xinetd. [ 122.212000] 123 ms: 45 * Starting Avahi mDNS/DNS-SD Daemon: avahi-daemon ...done. [ 122.876000] 661 ms: 46 [ 122.892000] 14 ms: 47 [ 123.014000] VIDEO0: set blank to 0 [ 123.019000] sync is off so we enable it [ 123.023000] playback! [ 123.026000] total video delay: 0 (0 ms) [ 123.032000] VIDEO0: start decode [ 123.039000] flush video decoder [ 123.075000] VIDEO0: first pts 0x0 [ 123.078000] VIDEO0: framerate changed 3 [ 123.082000] VIDEO0: resolution changed (1280 720) [ 123.087000] VIDEO0: aspect changed 3 [ 123.175000] set current avs auto aspect to 16:9 [ 123.180000] disable wss on display 0 [ 123.184000] disable wss on display 1 [ 123.189000] set current avs auto aspect to 16:9 [ 123.194000] disable wss on display 0 [ 123.199000] disable wss on display 1 [ 123.204000] set sb to 3(1) [ 123.206000] Write AVS:VIDEO0: set blank to 0 [ 123.209000] 40 40 00 00 00 00 18 61 00 02 00 00 00 ff [ 123.217000] VIDEO0: stop decode [ 123.221000] VIDEO0: set blank to 0 [ 123.224000] no decoder left in sync handling so disable xpt_sync 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 m[ 146.719000] bcmfb: enable manual blit em [ 146.742000] 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! real[ 146.889000] tsmux set cisource reg 00 to val 54 path /proc/stb/lcd/xres: No such[ 146.896000] tsmux set cisource reg 00 to val 44 file or directory lcd buffer 0[ 146.904000] tsmux set cisource reg 01 to val 54 xa8e750 8448 byt[ 146.910000] tsmux set cisource reg 01 to val 44 es, stride 132 + (9) Font Rende[ 146.917000] tsmux set tsports reg 02 to val dc r Class [FONT] [ 146.924000] tsmux set tsports reg 02 to val dc initializing lib[ 146.930000] tsmux set tsports reg 03 to val fe ... [FONT] loading fonts... [F[ 146.937000] tsmux set tsports reg 03 to val fe ONT] 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 no HDMI CEC hardware found! + (20) AVSwitch Driver + (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 "dreambox ir keyboard" is a keyboard Input device "dreambox ir mouse" is a mouse Found 5 input devices! + (21) Console RC Driver + (30) eActionMap + (35) CI Slots scanning for common interfaces.. CI Slot 0 has fd 27 CI Slot 1 has fd 28 CI Slot 2 has fd 29 CI Slot 3 has fd 30 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) eHbbtv + (41) eServiceFactoryBludisc + (41) eServiceFactoryM2TS + (41) eServiceFactoryMP3 + (41) eServiceFactoryFS + (41) eServiceFactoryDVB reached rl 70 ---- opening lame channel db reading services (version 4) loaded 4169 services scanning f[ 148.770000] bcm4501: channel 0 is in normale mode now or frontends.. opening frontend 0 detected satellite frontend (0)setTone Off [ 148.784000] bcm4501: channel 0 is sleeping now (0)setVoltage 0[ 148.789000] bcm4501: channel 1 is in normale mode now V close frontend 0 opening frontend 1 detected satellite frontend (1)setTone[ 148.802000] bcm4501: channel 1 is sleeping now Off (1)setVoltage 0V close frontend 1 openin[ 148.811000] bcm4506: channel 0 is in normale mode now g frontend 2 detected satellite frontend (2)setTone Off (2)setVoltage 0V close frontend 2 opening frontend 3 [ 148.835000] bcm4506: channel 0 is sleeping now main thread is non-idle! display spinner! no spinner DC! [ 149.050000] tda: init complete detected cable frontend close frontend 3 scanning for demux.. scanning for decoders.. scanning for descramblers.. found 1 adapter, 4 frontends(4 sim) and 5 demux, boxtype 4 [eDVBLocalTimeHandler] Use valid Linux Time 'Thu Nov 15 19:25:59 2012' :) (RTC?) [EPGC] Initialized EPGCache (wait for setCacheFile call now) Loading spinners... found 4 spinners! executing main setIoPrio best-effort level 6 ok [ 150.236000] 27342 ms: 48 [ 150.381000] 142 ms: 52 main thread is non-idle! display spinner! /proc/stb/frontend/0/lnb_sense is 0 [setupConfigEntries] initial_call for stored uuid: 976bea5b-f6bb-42f9-9a0c-60d16047c83c {'mountpoint': '/media/USBCFReaderPart1', 'device_info': 'USB', 'device_description': 'Generic-USB CF Reader (4.109 GB)', 'isRemovable': 'true'} [setupConfigEntries] initial_call for stored uuid: b7d87c37-0610-46eb-a6e0-13858e363a76 {'mountpoint': '/media/hdd', 'device_info': 'SATA', 'device_description': 'ATA-WDC WD20EADS-32S (2000.398 GB)', 'enabled': 'true'} [setupConfigEntries] initial_call for stored uuid: 40052127-aebf-4a47-8a18-2a1d2e2c13ae {'mountpoint': '/media/USB2FlashStoragePart1', 'device_info': 'USB', 'device_description': 'Ut165-USB2FlashStorage (8.086 GB)', 'isRemovable': '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:'b7d87c37-0610-46eb-a6e0-13858e363a76' [enumerateBlockDevices] devices_scanned_on_init: [('sda', False, False, True)] found block device 'sdf': ok, removable=True, cdrom=False, partitions=['sdf1'] Unable to determine structure of /dev fallback to udev new Harddisk sdf -> /dev/sdf -> /dev/sdf [addDevicePartition] device:'sdf' with UUID:'None' found block device 'sdf1': error querying properties [addDevicePartition] device:'sdf1' with UUID:'40052127-aebf-4a47-8a18-2a1d2e2c13ae' [setupConfigEntries] new device add for 'sdf1' with uuid:'40052127-aebf-4a47-8a18-2a1d2e2c13ae' [enumerateBlockDevices] devices_scanned_on_init: [('sda', False, False, True), ('sdf', True, False, True)] found block device 'sdb': ok, removable=True, cdrom=False, partitions=[] Unable to determine structure of /dev fallback to udev new Harddisk sdb -> /dev/sdb -> /dev/sdb [addDevicePartition] device:'sdb' with UUID:'None' [enumerateBlockDevices] devices_scanned_on_init: [('sda', False, False, True), ('sdf', True, False, True), ('sdb', True, False, True)] found block device 'sde': no medium [enumerateBlockDevices] devices_scanned_on_init: [('sda', False, False, True), ('sdf', True, False, True), ('sdb', True, False, True), ('sde', True, False, False)] found block device 'sdd': no medium [enumerateBlockDevices] devices_scanned_on_init: [('sda', False, False, True), ('sdf', True, False, True), ('sdb', True, False, True), ('sde', True, False, False), ('sdd', True, False, False)] found block device 'sdc': ok, removable=True, cdrom=False, partitions=['sdc1'] Unable to determine structure of /dev fallback to udev new Harddisk sdc -> /dev/sdc -> /dev/sdc [addDevicePartition] device:'sdc' with UUID:'None' found block device 'sdc1': error querying properties [addDevicePartition] device:'sdc1' with UUID:'976bea5b-f6bb-42f9-9a0c-60d16047c83c' [setupConfigEntries] new device add for 'sdc1' with uuid:'976bea5b-f6bb-42f9-9a0c-60d16047c83c' [enumerateBlockDevices] devices_scanned_on_init: [('sda', False, False, True), ('sdf', True, False, True), ('sdb', True, False, True), ('sde', True, False, False), ('sdd', True, False, False), ('sdc', True, False, True)] Reading satellites.xml main thread is non-idle! display spinner! Reading cables.xml couldn't open /etc/tuxbox/cables.xml!! removing internal link on frontend id 1 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 setSlotInfo for dvb frontend 2 to slotid 2, descr BCM4505, need rotorworkaround No, enabled Yes, DVB-S2 Yes setSlotInfo for dvb frontend 3 to slotid 3, descr Philips CU1216Mk3, need rotorworkaround No, enabled Yes, DVB-S2 No slot: 0 configmode: simple diseqcmode: diseqc_a_b slot: 1 configmode: equal slot: 2 configmode: equal sec config completed [ 153.412000] 3028 ms: 52 [ 153.423000] 8 ms: 56 [ 153.586000] 161 ms: 56 [ 153.644000] 56 ms: 56 [ 153.648000] 2 ms: 56 [ 153.799000] 148 ms: 56 not loading user skin: [Errno 2] No such file or directory: '/etc/enigma2/skin_user.xml' [ 155.648000] 1847 ms: 57 [ 155.842000] 191 ms: 58 [ 155.857000] 12 ms: 58 [ 155.864000] 4 ms: 58 [ 155.868000] 2 ms: 58 Preferred tag editor set to None [ 156.407000] 535 ms: 58 [ 156.411000] 2 ms: 59 [ 156.633000] 219 ms: 59 [ 156.697000] JFFS2 notice: (760) check_node_data: wrong data CRC in data node at 0x099a3760: read 0x184fd22a, calculated 0x4a013e36. [ 157.327000] 689 ms: 59 [ 157.337000] 8 ms: 60 [ 157.375000] 35 ms: 60 [ 157.379000] 2 ms: 60 [ 157.383000] 1 ms: 60 [ 157.424000] 38 ms: 60 [ 157.466000] 40 ms: 60 [ 158.685000] 1216 ms: 60 [ 158.690000] 2 ms: 61 [ 158.715000] 23 ms: 61 loading bouquet... /etc/enigma2/bouquets.tv loading bouquet... /etc/enigma2/userbouquet.favourites.tv 44 entries in Bouquet userbouquet.favourites.tv loading bouquet... /etc/enigma2/userbouquet.alllgemein__tv_.tv 32 entries in Bouquet userbouquet.alllgemein__tv_.tv loading bouquet... /etc/enigma2/userbouquet.dbe03.tv 21 entries in Bouquet userbouquet.dbe03.tv loading bouquet... /etc/enigma2/userbouquet.favourites_hd.tv 53 entries in Bouquet userbouquet.favourites_hd.tv loading bouquet... /etc/enigma2/userbouquet.dbe00.tv 16 entries in Bouquet userbouquet.dbe00.tv loading bouquet... /etc/enigma2/userbouquet.dbe02.tv 19 entries in Bouquet userbouquet.dbe02.tv loading bouquet... /etc/enigma2/userbouquet.dbe04.tv 48 entries in Bouquet userbouquet.dbe04.tv loading bouquet... /etc/enigma2/userbouquet.dbe01.tv 16 entries in Bouquet userbouquet.dbe01.tv loading bouquet... /etc/enigma2/userbouquet.dbe05.tv 11 entries in Bouquet userbouquet.dbe05.tv loading bouquet... /etc/enigma2/userbouquet.dbe0d.tv 21 entries in Bouquet userbouquet.dbe0d.tv loading bouquet... /etc/enigma2/userbouquet.dbe0e.tv 7 entries in Bouquet userbouquet.dbe0e.tv loading bouquet... /etc/enigma2/userbouquet.dbe06.tv 48 entries in Bouquet userbouquet.dbe06.tv loading bouquet... /etc/enigma2/userbouquet.dbe09.tv 22 entries in Bouquet userbouquet.dbe09.tv loading bouquet... /etc/enigma2/userbouquet.dbe07.tv 36 entries in Bouquet userbouquet.dbe07.tv loading bouquet... /etc/enigma2/userbouquet.dbe0c.tv 23 entries in Bouquet userbouquet.dbe0c.tv loading bouquet... /etc/enigma2/userbouquet.dbe08.tv 27 entries in Bouquet userbouquet.dbe08.tv[ 158.870000] 153 ms: 61 loading bouquet... /etc/enigma2/userbouquet.dbe0a.tv 24 entries in Bouquet userbouquet.dbe0a.tv loading bouquet... /etc/enigma2/userbouquet.dbe0b.tv 7 entries in Bouquet userbouquet.dbe0b.tv 18 entries in Bouquet bouquets.tv loading bouquet... /etc/enigma2/bouquets.radio loading bouquet... /etc/enigma2/userbouquet.favourites.radio 65 entries in Bouquet userbouquet.favourites.radio loading bouquet... /etc/enigma2/userbouquet.dbe00.radio 0 entries in Bouquet userbouquet.dbe00.radio loading bouquet... /etc/enigma2/userbouquet.dbe01.radio 48 entries in Bouquet userbouquet.dbe01.radio 3 entries in Bouquet bouquets.radio [ 158.933000] 59 ms: 61 [ 159.033000] 96 ms: 61 [ 159.038000] 1 ms: 61 [ 159.044000] 3 ms: 61 [eDVBLocalTimeHa[ 159.056000] 10 ms: 61 ndler] enable sync local time with transponder time! [ 162.724000] 3665 ms: 61 APIs: ['api', 'api.enigma2', 'api.enigma2.systeminfo', 'api.enigma2.servicedata'] Functions: ['api._A[ 162.809000] 82 ms: 65 PI__needsSession', 'api._API__session', 'api.enigma2._API__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 [ePopen] command: ip -o addr show dev ath0 [ResourceManager] adding: iNetwork [ 163.510000] 698 ms: 65 add dreampackage scanner plugin added [ 163.796000] 284 ms: 65 [ 163.800000] 2 ms: 65 [ 163.933000] 130 ms: 65 [ 163.945000] 9 ms: 66 [ 163.949000] 2 ms: 66 [ 163.964000] 12 ms: 66 [ 163.997000] 31 ms: 66 [ 164.037000] 37 ms: 66 [ 164.042000] 2 ms: 66 [FONT] adding font /usr/share/fonts/nmsbd.ttf...OK (Display) [ 164.281000] 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/ae_AlMateen.ttf...OK (Replacement) [FONT] adding font /usr/share/fonts/tuxtxt.ttf...OK (Console) [FONT] adding font /usr/share/enigma2/Zombi.HD1R3/fonts/georgiaz.ttf...OK (GEORGIAZoff) [FONT] adding font /usr/share/enigma2/Zombi.HD1R3/fonts/HandelGotDBol.ttf...OK (HGDBoff) [FONT] adding font /usr/share/fonts/nmsbd.ttf...OK (Regular) [ 165.049000] 1005 ms: 66 [ 165.181000] 130 ms: 66 [ 165.209000] Write AVS: 40 40 00 00 00 00 00 61 00 02 00 00 00 ff [ 165.260000] set current avs auto aspect to 4:3 [ 165.265000] disable wss on display 0 [ 165.268000] disable wss on display 1 [ 165.272000] set sb to 3(2) [ 165.275000] Write AVS: 40 40 00 00 00 00 00 63 00 02 00 00 00 ff [ 165.374000] set current avs auto aspect to 4:3 [ 165.379000] disable wss on display 0 [ 165.383000] disable wss on display 1 [ 165.387000] set sb to 3(2) [ 165.387000] disable wss on display 0 [ 165.387000] set wss 8 on display 1 [ 165.415000] set input to 0 [ 165.418000] set fb to 2(0) [ 165.421000] set current avs auto aspect to 4:3 [ 165.426000] disable wss on display 0 [ 165.429000] set wss 8 on display 1 [ 165.433000] set sb to 3(2) [ 165.439000] set ac3 to passthrough --> setting scaler_sharpness to:[ 165.450000] 267 ms: 66 0000000D [ 165.466000] 13 ms: 67 couldn't open /proc/stb/misc/12V_output [ 165.695000] 226 ms: 67 [ 165.942000] 244 ms: 67 [ 165.953000] 8 ms: 67 setLCDBrightness 25 setLCDBrightness 127 [ 165.994000] 38 ms: 67 Activating keymap: Keyboard English [ePopen] command: loadkmap < /usr/share/keymaps/eng.kmap Activating language German language set to de_DE geminimain set language to de [gDesktopConfig] Colums=4 Number=12 [gUtils] load Config /etc/enigma2/gemini_plugin.conf [ 168.764000] fuse init (API version 7.17) [CamdUtils] load Camdlist [HWUtils] mount BlockDevice all [HWUtils] search BlockDevice all [HWUtils] PartInfo dev=sdc1 PartType=1 fs=ext3 isMounted=0 [HWUtils] ERROR [HWUtils] PartInfo dev=sdd PartType=0 fs= isMounted=0 [HWUtils] ERROR [HWUtils] PartInfo dev=sde PartType=0 fs= isMounted=0 [HWUtils] ERROR [HWUtils] ERROR [HWUtils] ERROR [HWUtils] ERROR [HWUtils] ERROR [HWUtils] ERROR [HWUtils] ERROR [HWUtils] PartInfo dev=sdf1 PartType=1 fs=ext3 isMounted=0 [HWUtils] PartInfo dev=sda1 PartType=1 fs=ext3 isMounted=1 [ 174.962000] kjournald starting. Commit interval 5 seconds [ 174.963000] EXT3-fs (sdc1): using internal journal [ 174.963000] EXT3-fs (sdc1): mounted filesystem with writeback data mode [HWUtils] mount /dev/sdc1 on /media/cf [HWUtils] PartInfo dev=sdc1 PartType=1 fs=ext3 isMounted=1 [HWUtils] ERROR [HWUtils] PartInfo dev=sdd PartType=0 fs= isMounted=0 [HWUtils] ERROR [HWUtils] PartInfo dev=sde PartType=0 fs= isMounted=0 [ 175.107000] kjournald starting. Commit interval 5 seconds [ 175.107000] EXT3-fs (sdf1): warning: mounting fs with errors, running e2fsck is recommended [ 175.121000] EXT3-fs (sdf1): using internal journal [ 175.126000] EXT3-fs (sdf1): mounted filesystem with writeback data mode [HWUtils] mount /dev/sdf1 on /media/usb [HWUtils] PartInfo dev=sdf1 PartType=1 fs=ext3 isMounted=1 [HWUtils] PartInfo dev=sda1 PartType=1 fs=ext3 isMounted=1 before: 1 after: 1 setIoPrio best-effort level 7 ok [gMain] started [gMain] Dbus Connected path='org.gemini' [gMain] set CamdID=1795 [gMain] start Camd=1795 It's now Thu Nov 15 19:26:41 2012 [timer.py] next activation: 1353004101 (in 99529 ms) [AdvancedMovieSelection] Set tmdb locale to de [AdvancedMovieSelection] Set tvdb locale to de Preferred tag editor changed to [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] set language to de [WebInterface] fallback to default translation for Webinterface [ZombiSkinSwitch] found LANGUAGE= de [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 bestfit bestfit auto [ 200.334000] set current avs auto aspect to 16:9 [ 200.339000] disable wss on display 0 [ 200.343000] set wss 7 on display 1 [ 200.346000] set sb to 3(1) [ 200.349000] Write AVS: 40 40 00 00 00 00 00 61 00 02 00 00 00 ff [ 200.375000] set current avs auto aspect to 16:9 [ 200.379000] disable wss on display 0 [ 200.383000] set wss 7 on display 1 [ 200.387000] set sb to 3(1) [ 200.390000] disable wss on display 0 [ 200.395000] set wss 7 on display 1 [ 200.400000] set current avs auto aspect to 16:9 [ 200.405000] disable wss on display 0 [ 200.408000] set wss 7 on display 1 [ 200.412000] set sb to 3(1) -> setting aspect, policy, polic[ 200.419000] set current avs auto aspect to 16:9 y2, wss 16:9 bes[ 200.425000] disable wss on display 0 tfit bestfit aut[ 200.430000] set wss 7 on display 1 o [ 200.435000] set sb to 3(1) [ 200.439000] set current avs auto aspect to 16:9 [ 200.444000] disable wss on display 0 [ 200.447000] set wss 7 on display 1 [ 200.451000] set sb to 3(1) [ 200.456000] disable wss on display 0 [ 200.460000] set wss 7 on display 1 [ 200.466000] set current avs auto aspect to 16:9 [ 200.471000] disable wss on display 0 [ 200.476000] set wss 7 on display 1 [ 200.480000] set sb to 3(1) -> setting aspect, policy, polic[ 200.487000] set current avs auto aspect to 16:9 y2, wss 16:9 bes[ 200.493000] disable wss on display 0 tfit bestfit aut[ 200.498000] set wss 7 on display 1 o [ 200.503000] set sb to 3(1) [ 200.508000] set current avs auto aspect to 16:9 [ 200.513000] disable wss on display 0 [ 200.517000] set wss 7 on display 1 [ 200.521000] set sb to 3(1) [ 200.525000] disable wss on display 0 [ 200.528000] set wss 7 on display 1 [ 200.533000] set current avs auto aspect to 16:9 [ 200.538000] disable wss on display 0 [ 200.542000] set wss 7 on display 1 [ 200.546000] set sb to 3(1) -> setting aspect, policy, polic[ 200.553000] set current avs auto aspect to 16:9 y2, wss 16:9 bes[ 200.558000] disable wss on display 0 tfit bestfit aut[ 200.563000] set wss 7 on display 1 o [ 200.568000] set sb to 3(1) [ 200.573000] set current avs auto aspect to 16:9 [ 200.578000] disable wss on display 0 [ 200.582000] set wss 7 on display 1 [ 200.585000] set sb to 3(1) [ 200.589000] disable wss on display 0 [ 200.593000] set wss 7 on display 1 [ 200.598000] set current avs auto aspect to 16:9 [ 200.603000] disable wss on display 0 [ 200.606000] set wss 7 on display 1 [ 200.610000] set sb to 3(1) setMode - port: DVI mode: 1080i rate: multi [ 200.635000] using 50.00Hz as MonitorRefreshRate [ 200.734000] SET FORMAT: display[0], format=27 [ 200.739000] HDMI mode [ 200.741000] use EDID to detect colorspace [ 200.745000] using colorspace: 1 [ 200.816000] bcm_video_analog_port_setup (fmt=7) [ 200.955000] SET FORMAT: display[1], format=7 [ 201.074000] set current avs auto aspect to 16:9 [ 201.079000] disable wss on display 0 [ 201.083000] set wss 7 on display 1 [ 201.087000] set sb to 3(1) [ 201.092000] set current avs auto aspect to 16:9 [ 201.096000] disable wss on display 0 [ 201.100000] set wss 7 on display 1 [ 201.104000] set sb to 3(1) -> setting aspect, policy, policy2, wss 16:9 bes[ 201.163000] set current avs auto aspect to 16:9 tfit bestfit aut[ 201.169000] disable wss on display 0 o [ 201.174000] set wss 7 on display 1 [ 201.178000] set sb to 3(1) [ 201.182000] set current avs auto aspect to 16:9 [ 201.187000] disable wss on display 0 [ 201.190000] set wss 7 on display 1 [ 201.194000] set sb to 3(1) [ 201.198000] disable wss on display 0 [ 201.202000] set wss 7 on display 1 [ 201.207000] set current avs auto aspect to 16:9 [ 201.212000] disable wss on display 0 [ 201.216000] set wss 7 on display 1 [ 201.220000] set sb to 3(1) /usr/share/enigma2/ sh: fpupgrade: not found [ResourceManager] adding: software_manager [ResourceManager] adding: software_manager_upgrade --> 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 --> 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: 00000000 --> applying pep values [TeleText] autostart(0, {}) starting hotplug handler add device sdf to bdpoll current state: medium inserted add device sdb to bdpoll current state: medium inserted add device sde to bdpoll current state: medium removed add device sdd to bdpoll current state: medium removed add device sdc to bdpoll current state: medium inserted [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 c[ 205.306000] 39310 ms: 67 onfig file found [CI_Activate_Config_CI3] error parsing xml... geminimain set language to de [TeleText] set language to [de] [TeleText] set language to [de] [WebInterface] set language to de [WebInterface] set language to de [ZombiSkinSwitch] foun[ 205.330000] 20 ms: 97 d LANGUAGE= de [WebInterface] set language to de [AudioSync] set language to [ 205.340000] tsmux set ciclk reg fe to val 00 de [AudioSync] set language to de [ 205.350000] tsmux set ciclk reg fe to val 00 [ 205.359000] tsmux set ciclk reg fe to val 00 [ 205.367000] tsmux set ciclk reg fe to val 00 [ 205.373000] 38 ms: 97 It's now Thu Nov 15 19:26:55 2012 [timer.py] next activation: 1353004115 (in 99270 ms) [TIMER] record time changed, start prepare is now: Fri Nov 16 22:29:40 2012 sanitycheck check checkTimerlist recording service: 1:0:19:1330:3EF:1:C00000:0:0:0: record: 0 [Timer] Record ProcessRepeated It's now Thu Nov 15 19:26:55 2012 next real activation is Fri Nov 16 22:29:40 2012 [timer.py] next activation: 1353004115 (in 99201 ms) [TIMER] record time changed, start prepare is now: Fri Nov 9 23:42:40 2012 sanitycheck check checkTimerlist recording service: 1:0:1:7032:41B:1:C00000:0:0:0: record: 0 recording service: 1:0:19:1330:3EF:1:C00000:0:0:0: record: 0 [Timer] Record ProcessRepeated already passed, skipping shouldSkip: True state == ended False waiting && disabled: 0 [TIMER] record time changed, start prepare is now: Sat Nov 10 17:19:40 2012 sanitycheck check checkTimerlist recording service: 1:0:19:81:6:85:C00000:0:0:0: record: 0 recording service: 1:0:19:1330:3EF:1:C00000:0:0:0: record: 0 [Timer] Record ProcessRepeated already passed, skipping shouldSkip: True state == ended False waiting && disabled: 0 [TIMER] record time changed, start prepare is now: Sat Nov 10 23:47:40 2012 sanitycheck check checkTimerlist recording service: 1:0:1:6D6E:437:1:C00000:0:0:0: record: 0 recording service: 1:0:19:1330:3EF:1:C00000:0:0:0: record: 0 [Timer] Record ProcessRepeated already passed, skipping shouldSkip: True state == ended False waiting && disabled: 0 [TIMER] record time changed, start prepare is now: Sun Nov 11 20:12:40 2012 sanitycheck check checkTimerlist recording service: 1:0:19:2B66:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:19:1330:3EF:1:C00000:0:0:0: record: 0 [Timer] Record ProcessRepeated already passed, skipping shouldSkip: True state == ended False waiting && disabled: 0 [TIMER] record time changed, start prepare is now: Sun Nov 11 20:12:40 2012 sanitycheck check checkTimerlist recording service: 1:0:19:283D:3FB:1:C00000:0:0:0: record: 0 recording service: 1:0:19:1330:3EF:1:C00000:0:0:0: record: 0 [Timer] Record ProcessRepeated already passed, skipping shouldSkip: True state == ended False waiting && disabled: 0 [TIMER] record time changed, start prepare is now: Tue Nov 13 20:13:40 2012 sanitycheck check checkTimerlist recording service: 1:0:19:6EA7:4B1:1:C00000:0:0:0: record: 0 recording service: 1:0:19:1330:3EF:1:C00000:0:0:0: record: 0 [Timer] Record ProcessRepeated already passed, skipping shouldSkip: True state == ended False waiting && disabled: 0 It's now Thu Nov 15 19:26:55 2012 [timer.py] next activation: 1353004115 (in 99082 ms) warning, skin is missing element icon in [AdvancedMovieSelection] Auto empty from wastebasket disabled... [AdvancedMovieSelection] Set tmdb locale to de [AdvancedMovieSelection] Set tvdb locale to de [AdvancedMovieSelection] Set changes locale to de [AdvancedMovieSelection] Set epg extension: True [TeleText] ----- sessionstart(<__main__.Session instance at 0x26578a0>) ----- [AdvancedMovieSelection] Start update recorded movies in location /media/ [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 Looking for embedded skin port changed to DVI mode changed to 1080i getModeList for port DVI default ('1080i', 'Standard') preferedmodes ['720p', '576p', '480p', '576i', '480i', ('1080i', 'Standard')] [ResourceManager] adding: NetworkAdapterSelection [ResourceManager] adding: AdapterSetup [CrashlogAutoSubmit] - autostart [CrashlogAutoSubmit] - not starting CrashlogAutoSubmit [Toplevel.importExternalModules] Imported external module: EPGRefresh [Toplevel.importExternalModules] Imported external module: Example [Webinterface] started on 0.0.0.0:80 auth=False ssl=False [WebInterface.registerBonjourService] No module named Bonjour.Bonjour [Webinterface] started on 0.0.0.0:443 auth=True [ 208.662000] 3286 ms: 97 ssl=True [WebInterface.registerBonjourService] No module named Bonjour.Bonjour [EPGC] setCacheFile read/write epg data from/to '/media/usb/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 [ 208.841000] 176 ms: 99 setValue 100 [ 209.061000] 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: 100 100 (raw) Setvolume: 0 0 (-1db)[ 209.080000] 236 ms: 99 [ 209.184000] 101 ms: 99 open non cdrom failed No such device or address allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! reused converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! reused converter! reused converter! allocating new converter! allocating new converter! allocating new converter! main thread is non-idle! display spinner! [EPGC] 127579 events read from /media/usb/epg.dat [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 6186760 bytes for cache used allocating new converter! allocating new converter! allocating new converter! reused converter! RemovePopup, id = ZapError [HbbTV] connecting callbacks 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! allocating new converter! allocating new converter! allocating new converter! allocating new converter! reused converter! allocating new converter! reused converter! allocating new converter! reused converter! allocating new converter! reused converter! allocating new converter! reused converter! allocating new converter! reused converter! allocating new converter! reused converter! allocating new converter! reused converter! allocating new converter! reused converter! reused converter! reused converter! allocating new converter! reused converter! allocating new converter! reused converter! allocating new converter! allocating new converter! reused converter! allocating new converter! allocating new converter! [NotificationQueue::popNotification] domain default deferred_callable: False CISlot 0 what 2 CISlot 1 what 2 CISlot 2 what 2 CISlot 3 what 2 child has terminated pipes closed [ePopen] command: route -n | grep eth0 child has terminated pipes closed [ePopen] command: route -n | grep ath0 child has terminated pipes closed child has terminated pipes closed poll: unhandled POLLERR/HUP/NVAL for fd 43(16) poll: unhandled POLLERR/HUP/NVAL for fd 44(16) poll: unhandled POLLERR/HUP/NVAL for fd 47(16) poll: unhandled POLLERR/HUP/NVAL for fd 50(16) playing 1:0:1:7032:41B:1:C00000:0:0:0: [TeleText] service started not pauseable. RemovePopup, id [ 220.440000] bcm4501: channel 0 is in normale mode now = ZapError allocate channel.. 041b:0001:00c00000 opening frontend 0 [eDVBCAService] new channel 0x2998a38! (0)tune RotorCmd ffffffff, lastRotorCmd ffffffff prepare_sat System 0 Freq 10743750 Pol 0 SR 22000000 INV 2 FEC 4 orbpos 192 system 0 modulation 1 pilot 2, rolloff 0 tuning to 993 mhz OURSTATE: tuning allocate Channel: res 0 [eDVBCIInterfaces] addPMTHandler 1:0:1:7032:41B:1:C00000:0:0:0: recheckPMTHAndlers() recheck 0x2990cac 1:0:1:7032:41B:1:C00000:0:0:0: allocate demux [HbbTV].aitInvalidated child has terminated pipes closed 0.0.0.0 169.254 192.168 child has terminated pipes closed nameservers: [[192, 168, 0, 1]] read configured interface: {'lo': {'dhcp': False}, 'ath0': {'dhcp': True}, 'eth0': {'dhcp': False}} self.ifaces after loading: {'ath0': {'preup': False, 'predown': False, 'ip': [0, 0, 0, 0], 'up': False, 'dns-nameservers': False, 'broadcast': False, 'mac': '00:0e:8e:20:55:80', 'dhcp': True, 'netmask': [0, 0, 0, 0], 'gateway': [0, 0, 0, 0]}, 'eth0': {'preup': False, 'predown': False, 'ip': [192, 168, 0, 9], 'up': True, 'dns-nameservers': '\tdns-nameservers 192.168.0.1\n', 'broadcast': '\tbroadcast 192.168.0.255\n', 'mac': '00:09:34:1c:2f:c2', 'dhcp': False, 'bcast': [192, 168, 0, 255], 'netmask': [255, 255, 255, 0], 'gateway': [192, 168, 0, 1]}} poll: unhandled POLLERR/HUP/NVAL for fd 47(16) poll: unhandled POLLERR/HUP/NVAL for fd 68(16) [SEC] lock 0 Timeout! open non cdrom failed No such device or address [SEC] set static current limiting [NotificationQueue::popNotification] domain default deferred_callable: False [SEC] setVoltage 2 (0)setVoltage 18V [ 223.818000] OUVF, rewrite. [SEC] sleep 400ms [SEC] invalidate current switch params [SEC] sendDiseqc: e01003(DiSEqC peripherial power on) [SEC] sleep 150ms [SEC] sendDiseqc: e01038f6 [SEC] sleep 50ms [SEC] update current switch params [SEC] startTuneTimeout 5000 [SEC] setFrontend 1 (0)setting frontend (0)fe event: status 0, freq 993750, inversion off, m_tuning 1 F [SEC] unlock [SEC] sleep 500ms (0)fe event: status 1, freq 993750, inversion off, m_tuning 1 N (0)fe event: status 1f, freq 992332, inversion off, m_tuning 2 N OURSTATE: ok [eDVBCAService] channel 0x2998a38 running [eDVBLocalTimeHandler] channel 0x2998a38 running no version filtering 0014: 70 00 00 00 00 00 mask: fc 00 00 00 [ 224.696000] start pcr0 on dmx 3 pid:c9 index 5 00 00 mode: 00 00 00 00 00 00 [ 224.703000] start audio on dmx 3 pid:ce [eEPGCache] cha[ 224.708000] audio xpt start nnel 0x2998a38 r[ 224.712000] sync is off so we enable it unning stop rel[ 224.718000] demux-index 3 pcr0pid c9 ease channel tim[ 224.723000] using 5 as pcr0 pidchannel er no version f[ 224.729000] AC3 iltering 0012: [ 224.731000] audio: streamtype set 1 4e 70 32 00 00 [ 224.737000] audio: streamtype_set: stop rave 00 mask: ff ff[ 224.743000] passthru ff 00 00 00 mode: 00 00 00 00 00 00 [EPGC] next update in 2 sec ok ... now we start!! no version filtering 0000: 00 00 00 00 00 00 mask[ 224.759000] audio: streamtype_set: restart rave : ff 00 00 00 0[ 224.764000] set mute 0 (011) 1 0 00 mode: 00 [ 224.769000] audio: decoder start 2 00 00 00 00 00 eventNewProgramInfo 0 0 have 1 video stream(s) (00c9), and 1 audio stream(s) (00ce), and the pcr pid is 00c9, and the text pid [ 224.785000] video delay 0 (0 ms) is 00cc allocat[ 224.789000] total video delay: 0 (0 ms) e demux disable teletext subtit[ 224.797000] start video0 on dmx 3 pid:c9 les decoder sta[ 224.802000] total video delay: 0 (0 ms) te: play, vpid=201, apid=206 DM[ 224.808000] VIDEO0: start decode X_SET_PES_FILTER(0xc9) - pcr - ok DEMUX_START - pcr - ok DMX_SET_PES_FILTER(0xce) - audio - ok DEMUX_START - audio - ok AUDIO_SET_BYPASS(0) - ok AUDIO_PAUS[ 224.826000] ch0: lock E - ok AUDIO_PLAY - ok Video Device: /dev/dvb/adapter0/video0 demux device: /dev/dvb/adapter0/demux3 VIDEO_SET_STREAMTYPE 0 - ok DMX_SET_PES_FILTER(0xc9) - video - ok DEMUX_START - video - ok VIDEO_FREEZE - ok VIDEO_PLAY - ok DMX_SET_PES_FILTER(0xcc) - ttx - ok DEMUX_START - ttx - ok VIDEO_SLOWMOTION(0) - ok VIDEO_FAST_FORWARD(0) - ok VI[ 224.860000] ch0: lock DEO_CONTINUE - ok AUDIO_CONTINUE - ok AUDIO_CHANNEL_SELECT(0) - ok not pauseable. [TeleText] serviceInfoChanged [TeleText] TXT PID 204 DEMUX 3 [TeleText] send array('B', [1, 0, 204, 3]) [AutoRes] service changed [ 224.892000] ch0: lock VIDEO_GET_EVENT - ok [AutoRes] got event evVideoSizeChanged [ 224.921000] ch0: lock VIDEO_GET_EVENT - ok [AutoRes] got event evFramerateChanged +- 1/2 TID 4e [ 224.955000] ch0: lock [ 224.988000] ch0: lock + 1/1 TID 00 done! PATready use pmtpid 00c8 for service_id 7032 no version filtering 00c8: 02 70 32 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 doing version filtering 0000: 00 00 00 07 0[ 225.020000] ch0: lock 0 00 mask: ff 00 00 3f 00 00 mode: 00 00 00 3e 00 00 [SEC] set dynamic current limiti[ 225.049000] ch0: lock ng [ 225.052000] RAP first pts 0x13cbe0854, stc 0x13cbdf420, pcr valid [ 225.084000] ch0: lock [ 225.115000] ch0: lock [ 225.134000] VIDEO0: first pts 0x13cbe7870 [ 225.134000] VIDEO0: resolution changed (720 576) VIDEO_GET_EVENT [ 225.149000] ch0: lock - ok [AutoRes] got event evVideoSizeChanged [eDVBLocalTimeHandler] Receiver time is 'Thu Nov 15 19:27:15 2012' [eDVBLocalTimeHandler] Transponder time is 'Thu Nov [ 225.178000] ch0: lock 15 19:27:17 2012' [eDVBLocalTimeHandler] diff is 2 [eDVBLocalTimeHandler] diff < 120 .. use Transponder Time [ 225.210000] ch0: lock [eDVBLocalTimeHandler] update RTC [eDVBLocalTimeHandler] time_difference is 2 [eDVBLocalTimeHandler] update Linux Time [EPGC] start cleanloop + 1/1 TID 02 done! [EPGC] stop cleanloop [EPGC] 6186760 bytes for cache used [eDVBCAService] new service 1:0:1:7032:41B:1:[ 225.244000] ch0: lock C00000:0:0:0: [eDVBCAService] add demux 3 to slot 0 service 1:0:1:7032:41B:1:C00000:0:0:0: demux 3 mask 08 prevhash 00000000 [eDVBCAService] send 64 bytes 9f 80 32 3c 03 70 32 2d 00 13 01 81 08 00 c0 00 00 04 1b 00 01 82 02 08 03 84 02 00 c8 02 00 c9 00 00 03 00 ca 00 00 03 00 cb 00 00 06 00 ce 00 00 06 00 cc 00 00[ 225.277000] ch0: lock 05 01 0e 00 00 0b 08 7b 00 00 recheckPMTHAndlers() recheck 0x2990cac 1:0:1:7032:41B:1:C00000:0:0:0: HBBTV broadcast data on pid 087b [eDVBCIInterfaces] gotPMT eventNewPr[ 225.295000] enable tsm0 ogramInfo 0 0 start ait on pid 010e no version filtering 010e: 74 00 00 00 0[ 225.304000] ch0: lock 0 00 mask: ff 00 00 00 00 00 mode: 00 00 00 00 00 00 have 1 video stream(s) (00c9), and 3 audio stream(s) (00ca, 00cb, 00ce), and the pcr pid is 00c9, and the text pid is 00cc decoder state: play, vpid=201, apid=206 HBBTV broadcast data on pid 087b [TeleText] serviceInfoChanged [TeleText] TXT PID 204 DEMUX 3 [TeleText] send array('B', [1, 0, 204, 3]) doing version filtering 00c8: 02 70 32 2d 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 [ 225.444000] RAP sampling rate info isr [ 225.580000] RAP pts error 0 PTS 0x9e5f47aa, STC 0x9e5f56cc, type 1 nr_read 554 nr_write 5 sum 559 prev_sum 0 hdd was accessed since previous check! [IDLE] 0 600 False open non cdrom failed No such device or address ++ 2/2 TID 4e done! [ 225.815000] VIDEO0: progressive changed (0) doing version filtering 0012: 4e 70 32 37 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 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 sdt update done! + 1/1 TID 74 done! [eHbbtv] aitChanged pid=0x10e [eOipfApplication] Profile 0000, Version 1.1.1 [eOipfApplication] deu:HBBTV-Start-DSMCC+Web [eHbbtv] New Application: HBBTV-Start-DSMCC+Web (orgid=19, appid=1, urlBase=http://itv.ard.de/ardstart/, initalPath=index.html, controlCode=1, visibility=2) [eHbbtv] Resolving Application Locator: dvb://current.ait/19.1 [eHbbtv] We have 1 app(s) for service 1.1051.28722 [eHbbtv] 'dvb://current.ait/19.1' resolved to 'http://itv.ard.de/ardstart/index.html' [eOipfApplication] Profile 0000, Version 1.1.1 [eOipfApplication] deu:EPG [eHbbtv] New Application: EPG (orgid=19, appid=2, urlBase=http://itv.ard.de/ardepg/, initalPath=index.php, controlCode=2, visibility=2) [eHbbtv] Resolving Application Locator: dvb://current.ait/19.2 [eHbbtv] We have 2 app(s) for service 1.1051.28722 [eHbbtv] 'dvb://current.ait/19.2' resolved to 'http://itv.ard.de/ardepg/index.php' [eOipfApplication] Profile 0000, Version 1.1.1 [eOipfApplication] deu:HBBTV ARD-Mediathek [eHbbtv] New Application: HBBTV ARD-Mediathek (orgid=19, appid=3, urlBase=http://hbbtv.ardmediathek.de/hbbtv-ard/, initalPath=mediathek/?devicegroup=hbbtv, controlCode=2, visibility=2) [eHbbtv] Resolving Application Locator: dvb://current.ait/19.3 [eHbbtv] We have 3 app(s) for service 1.1051.28722 [eHbbtv] 'dvb://current.ait/19.3' resolved to 'http://hbbtv.ardmediathek.de/hbbtv-ard/mediathek/?devicegroup=hbbtv' [eOipfApplication] Profile 0000, Version 1.1.1 [eOipfApplication] deu:Mediathek DasErste [eHbbtv] New Application: Mediathek DasErste (orgid=19, appid=20, urlBase=http://hbbtv.daserste.de/, initalPath=index.php, controlCode=2, visibility=2) [eHbbtv] Resolving Application Locator: dvb://current.ait/19.20 [eHbbtv] We have 4 app(s) for service 1.1051.28722 [eHbbtv] 'dvb://current.ait/19.20' resolved to 'http://hbbtv.daserste.de/index.php' [eOipfApplication] Profile 0000, Version 1.1.1 [eOipfApplication] deu:Festival-Mediathek [eHbbtv] New Application: Festival-Mediathek (orgid=19, appid=29, urlBase=http://hbbtv.ardmediathek.de/hbbtv-einsfestival/, initalPath=mediathek/?devicegroup=hbbtv, controlCode=2, visibility=2) [eHbbtv] Resolving Application Locator: dvb://current.ait/19.29 [eHbbtv] We have 5 app(s) for service 1.1051.28722 [eHbbtv] 'dvb://current.ait/19.29' resolved to 'http://hbbtv.ardmediathek.de/hbbtv-einsfestival/mediathek/?devicegroup=hbbtv' [eOipfApplication] Profile 0000, Version 1.1.1 [eOipfApplication] deu:HBBTV NDR-Mediathek [eHbbtv] New Application: HBBTV NDR-Mediathek (orgid=19, appid=27, urlBase=http://hbbtv.ndr.de/, initalPath=index.html, controlCode=2, visibility=2) [eHbbtv] Resolving Application Locator: dvb://current.ait/19.27 [eHbbtv] We have 6 app(s) for service 1.1051.28722 [eHbbtv] 'dvb://current.ait/19.27' resolved to 'http://hbbtv.ndr.de/index.html' [eOipfApplication] Profile 0000, Version 1.1.1 [eOipfApplication] deu:HBBTV NightWash [eHbbtv] New Application: HBBTV NightWash (orgid=19, appid=35, urlBase=http://hbbtv.ardmediathek.de/hbbtv-einsfestival/mediathek/content/, initalPath=5193086?documentId=3341592, controlCode=2, visibility=2) [eHbbtv] Resolving Application Locator: dvb://current.ait/19.35 [eHbbtv] We have 7 app(s) for service 1.1051.28722 [eHbbtv] 'dvb://current.ait/19.35' resolved to 'http://hbbtv.ardmediathek.de/hbbtv-einsfestival/mediathek/content/5193086?documentId=3341592' [eOipfApplication] Profile 0000, Version 1.1.1 [eOipfApplication] deu:HBBTV Lindenstrae [eHbbtv] New Application: HBBTV Lindenstrae (orgid=19, appid=36, urlBase=http://hbbtv.ardmediathek.de/hbbtv-einsfestival/mediathek/content/, initalPath=5193086?documentId=7955502, controlCode=2, visibility=2) [eHbbtv] Resolving Application Locator: dvb://current.ait/19.36 [eHbbtv] We have 8 app(s) for service 1.1051.28722 [eHbbtv] 'dvb://current.ait/19.36' resolved to 'http://hbbtv.ardmediathek.de/hbbtv-einsfestival/mediathek/content/5193086?documentId=7955502' [HbbTV].readButtonApplicationReady, appid=19.1 doing version filtering 010e: 74 00 00 11 00 00 mask: ff 00 00 3f 00 00 mode: 00 00 00 3e 00 00 [EPGC] start caching events(1353004039) open non cdrom failed No such device or address [ 229.751000] CIFS: Unknown mount option tcp open non cdrom failed No such device or address [ 230.868000] CIFS VFS: default security mechanism requested. The default security mechanism will be upgraded from ntlm to ntlmv2 in kernel release 3.3 [ 231.030000] Status code returned 0xc000006d NT_STATUS_LOGON_FAILURE [ 231.036000] CIFS VFS: Send error in SessSetup = -13 [ 231.202000] CIFS: Unknown mount option tcp open non cdrom failed No such device or address [EPGC] abort non avail schedule other reading [EPGC] abort non avail viasat reading open non cdrom failed No such device or address open non cdrom failed No such device or address [EPGC] nownext finished(1353004048) Timeout! [NotificationQueue::popNotification] domain default deferred_callable: False open non cdrom failed No such device or address Timeout! [NotificationQueue::popNotification] domain default deferred_callable: False open non cdrom failed No such device or address open non cdrom failed No such device or address Timeout! open non cdrom failed No such device or address no ancillary data in audio stream... abort radiotext pes parser open non cdrom failed No such device or address open non cdrom failed No such device or address open non cdrom failed No such device or address open non cdrom failed No such device or address open non cdrom failed No such device or address [EPGC] schedule finished(1353004068) [EPGC] stop caching events(1353004068) [EPGC] next update in 60 min open non cdrom failed No such device or address open non cdrom failed No such device or address open non cdrom failed No such device or address open non cdrom failed No such device or address open non cdrom failed No such device or address open non cdrom failed No such device or address open non cdrom failed No such device or address open non cdrom failed No such device or address open non cdrom failed No such device or address open non cdrom failed No such device or address open non cdrom failed No such device or address open non cdrom failed No such device or address open non cdrom failed No such device or address open non cdrom failed No such device or address open non cdrom failed No such device or address [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 6210912 bytes for cache used nr_read 934 nr_write 8 sum 942 prev_sum 559 hdd was accessed since previous check! [IDLE] 0 600 False open non cdrom failed No such device or address open non cdrom failed No such device or address open non cdrom failed No such device or address It's now Thu Nov 15 19:28:23 2012 [timer.py] next activation: 1353004203 (in 99998 ms) open non cdrom failed No such device or address open non cdrom failed No such device or address open non cdrom failed No such device or address open non cdrom failed No such device or address open non cdrom failed No such device or address open non cdrom failed No such device or address open non cdrom failed No such device or address It's now Thu Nov 15 19:28:36 2012 [timer.py] next activation: 1353004217 (in 99999 ms) It's now Thu Nov 15 19:28:37 2012 next real activation is Fri Nov 16 22:29:40 2012 [timer.py] next activation: 1353004217 (in 99994 ms) open non cdrom failed No such device or address open non cdrom failed No such device or address open non cdrom failed No such device or address open non cdrom failed No such device or address open non cdrom failed No such device or address open non cdrom failed No such device or address open non cdrom failed No such device or address open non cdrom failed No such device or address open non cdrom failed No such device or address open non cdrom failed No such device or address open non cdrom failed No such device or address open non cdrom failed No such device or address open non cdrom failed No such device or address open non cdrom failed No such device or address open non cdrom failed No such device or address open non cdrom failed No such device or address open non cdrom failed No such device or address open non cdrom failed No such device or address open non cdrom failed No such device or address