=~=~=~=~=~=~=~=~=~=~=~= PuTTY log 2012.09.05 21:27:49 =~=~=~=~=~=~=~=~=~=~=~= INIT: Switching to runlevel: 6 Stopping Dropbear SSH server: no /bin/true found; none killed Unmounting remote filesystems... * Stopping Avahi mDNS/DNS-SD Daemon: avahi-daemon ...done. Stopping automounter: done. Stopping dbttcd. Stopping system message bus: dbus. Stopping default emu. stopping statd: done stopping mountd: done stopping nfsd: [ 2768.467000] nfsd: last server has exited, flushing export cache done Stopping syslogd/klogd: stopped syslogd (pid 666) stopped klogd (pid 668) done Stopping internet superserver: xinetd. Unmounting remote filesystems... Deconfiguring network interfaces... Sending all processes the TERM signal... Sending all processes the KILL signal... Deactivating swap... Unmounting local filesystems... Rebooting... [ 2777.072000] sd 1:0:0:0: [sda] Synchronizing SCSI cache [ 2777.079000] Restarting system. [ 2777.083000] fp_restart [ 27÷ð BCM97400 AB FFFFFFFF 1s Sync=1 LLMB=1 L2=1 RAC_I=1 RAC_D=1 Copy Code...34TUCV (c) 2007,2008 Dream Multimedia GmbH. All rights reserved. Dreambox DM8000 FIRST STAGE 1.10 {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.597 - load config 1.177 - 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 ++++++++++++++++++++++++++++++++++++++++++++++++++++++++ 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: 33928 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_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 (dev@vs35) (gcc version 4.6.4 20120303 (prerelease) (GCC) ) #2 SMP Fri Aug 31 23:58:46 CEST 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: 149376k/262144k available (4673k kernel code, 112768k reserved, 977k 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.016000] SMP: Booting CPU1... [ 0.017000] CPU revision is: 0002a042 (Brcm4380) [ 0.017000] FPU revision is: 00130001 [ 0.017000] Primary instruction cache 32kB, VIPT, 2-way, linesize 64 bytes. [ 0.017000] Primary data cache 64kB, 4-way, VIPT, cache aliases, linesize 64 bytes [ 0.028000] SMP: CPU1 is running [ 0.028000] Brought up 2 CPUs [ 0.029000] devtmpfs: initialized [ 0.033000] NET: Registered protocol family 16 [ 0.035000] PCI2.3->SDRAM window: 256 MB [ 0.042000] bio: create slab at 0 [ 0.044000] SCSI subsystem initialized [ 0.045000] usbcore: registered new interface driver usbfs [ 0.046000] usbcore: registered new interface driver hub [ 0.047000] usbcore: registered new device driver usb [ 0.048000] Advanced Linux Sound Architecture Driver Version 1.0.24. [ 0.049000] PCI: found device 168c:001a on PCI2.3 bus, slot 1 (irq 33) [ 0.050000] pci 0000:00:01.0: BAR 0: assigned [mem 0xd0000000-0xd000ffff] [ 0.051000] pci 0000:00:01.0: BAR 0: set to [mem 0xd0000000-0xd000ffff] (PCI address [0xd0000000-0xd000ffff]) [ 0.052000] PCI: found device 14e4:8602 on SATA bus, slot 0 (irq 42) [ 0.053000] pci 0000:01:00.0: BAR 5: assigned [mem 0x10510000-0x10510fff] [ 0.054000] pci 0000:01:00.0: BAR 5: set to [mem 0x10510000-0x10510fff] (PCI address [0x10510000-0x10510fff]) [ 0.055000] pci 0000:01:00.0: BAR 6: assigned [mem 0x10511000-0x105117ff pref] [ 0.056000] Switching to clocksource upg [ 0.068000] NET: Registered protocol family 2 [ 0.073000] IP route cache hash table entries: 2048 (order: 1, 8192 bytes) [ 0.081000] TCP established hash table entries: 8192 (order: 4, 65536 bytes) [ 0.088000] TCP bind hash table entries: 8192 (order: 4, 65536 bytes) [ 0.095000] TCP: Hash tables configured (established 8192 bind 8192) [ 0.102000] TCP reno registered [ 0.105000] UDP hash table entries: 128 (order: 0, 4096 bytes) [ 0.111000] UDP-Lite hash table entries: 128 (order: 0, 4096 bytes) [ 0.118000] NET: Registered protocol family 1 [ 0.123000] RPC: Registered named UNIX socket transport module. [ 0.129000] RPC: Registered udp transport module. [ 0.134000] RPC: Registered tcp transport module. [ 0.139000] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.149000] JFFS2 version 2.2. (NAND) (SUMMARY) © 2001-2006 Red Hat, Inc. [ 0.157000] SGI XFS with security attributes, large block/inode numbers, no debug enabled [ 0.167000] msgmni has been set to 291 [ 0.172000] io scheduler noop registered [ 0.176000] io scheduler cfq registered (default) [ 0.181000] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled [ 0.209000] serial8250.0: ttyS0 at MMIO 0x10400b00 (irq = 69) is a 16550A [ 0.216000] console [ttyS0] enabled, bootconsole disabled [ 0.216000] console [ttyS0] enabled, bootconsole disabled [ 0.229000] loop: module loaded [ 0.233000] brcm-pm: enabling sata clocks [ 0.237000] PCI: Enabling device 0000:01:00.0 (0000 -> 0003) [ 0.440000] scsi0 : sata_brcmstb [ 0.444000] scsi1 : sata_brcmstb [ 0.447000] ata1: SATA max UDMA7 mmio m4096@0x10510000 port 0x10510000 irq 42 [ 0.455000] ata2: SATA max UDMA7 mmio m4096@0x10510000 port 0x10510100 irq 42 [ 0.683000] 4545 kb/s [ 0.686000] - NAND PROBE: 2c da 80 95 [ 0.690000] ONFI flash detected [ 0.693000] ONFI param page 0 valid [ 0.696000] NAND device: Manufacturer ID: 0x2c, Chip ID: 0xda (Micron MT29F2G08AAD) [ 0.704000] Scanning device for bad blocks [ 0.788000] ata1: SATA link down (SStatus 4 SControl 300) [ 0.875000] Creating 4 MTD partitions on "MT29F2G08AAD": [ 0.880000] 0x000000000000-0x000010000000 : "complete" [ 0.887000] 0x000000000000-0x000000100000 : "loader" [ 0.894000] 0x000000100000-0x000000800000 : "boot partition" [ 0.901000] 0x000000800000-0x000010000000 : "root partition" [ 0.908000] bcmemac: Broadcom STB 10/100 EMAC driver v3.0 [ 0.917000] bcmemac: registered interface #0 at 0x10080000 as 'eth0' (00:09:34:1c:b8:00) [ 0.925000] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver [ 0.931000] brcm-pm: enabling usb clocks [ 0.935000] ehci-brcm ehci-brcm.0: Broadcom STB EHCI [ 0.941000] ehci-brcm ehci-brcm.0: new USB bus registered, assigned bus number 1 [ 0.979000] ehci-brcm ehci-brcm.0: irq 62, io mem 0x10480300 [ 0.990000] ehci-brcm ehci-brcm.0: USB 0.0 started, EHCI 1.00 [ 0.996000] hub 1-0:1.0: USB hub found [ 1.000000] hub 1-0:1.0: 2 ports detected [ 1.004000] ehci-brcm ehci-brcm.1: Broadcom STB EHCI [ 1.009000] ehci-brcm ehci-brcm.1: new USB bus registered, assigned bus number 2 [ 1.048000] ehci-brcm ehci-brcm.1: irq 57, io mem 0x10480500 [ 1.059000] ehci-brcm ehci-brcm.1: USB 0.0 started, EHCI 1.00 [ 1.065000] hub 2-0:1.0: USB hub found [ 1.069000] hub 2-0:1.0: 2 ports detected [ 1.073000] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver [ 1.080000] ohci-brcm ohci-brcm.0: Broadcom STB OHCI [ 1.085000] ohci-brcm ohci-brcm.0: new USB bus registered, assigned bus number 3 [ 1.092000] ohci-brcm ohci-brcm.0: irq 63, io mem 0x10480400 [ 1.128000] ata2: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [ 1.152000] ata2.00: ATA-8: WDC WD10EVDS-63U8B1, 01.00A01, max UDMA/133 [ 1.158000] ata2.00: 1953525168 sectors, multi 0: LBA48 NCQ (depth 0/32) [ 1.170000] hub 3-0:1.0: USB hub found [ 1.173000] ata2.00: configured for UDMA/133 [ 1.174000] scsi 1:0:0:0: Direct-Access ATA WDC WD10EVDS-63U 01.0 PQ: 0 ANSI: 5 [ 1.175000] sd 1:0:0:0: [sda] 1953525168 512-byte logical blocks: (1.00 TB/931 GiB) [ 1.175000] sd 1:0:0:0: [sda] Write Protect is off [ 1.175000] sd 1:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA [ 1.208000] hub 3-0:1.0: 2 ports detected [ 1.212000] ohci-brcm ohci-brcm.1: Broadcom STB OHCI [ 1.217000] ohci-brcm ohci-brcm.1: new USB bus registered, assigned bus number 4 [ 1.225000] ohci-brcm ohci-brcm.1: irq 64, io mem 0x10480600 [ 1.257000] sda: sda1 [ 1.261000] sd 1:0:0:0: [sda] Attached SCSI disk [ 1.297000] hub 4-0:1.0: USB hub found [ 1.300000] hub 4-0:1.0: 2 ports detected [ 1.305000] Initializing USB Mass Storage driver... [ 1.310000] usbcore: registered new interface driver usb-storage [ 1.316000] USB Mass Storage support registered. [ 1.321000] i2c /dev entries driver [ 1.324000] ALSA device list: [ 1.327000] No soundcards found. [ 1.331000] TCP cubic registered [ 1.334000] NET: Registered protocol family 17 [ 1.339000] Registering the dns_resolver key type [ 1.402000] usb 1-1: new high-speed USB device number 2 using ehci-brcm [ 1.525000] hub 1-1:1.0: USB hub found [ 1.529000] hub 1-1:1.0: 4 ports detected [ 1.637000] usb 2-1: new high-speed USB device number 2 using ehci-brcm [ 1.767000] scsi2 : usb-storage 2-1:1.0 [ 2.404000] Empty flash at 0x052f9c94 ends at 0x052fa000 [ 2.775000] scsi 2:0:0:0: CD-ROM Optiarc DVD RW AD-7690H 1.00 PQ: 0 ANSI: 0 [ 4.148000] VFS: Mounted root (jffs2 filesystem) on device 31:3. [ 4.176000] devtmpfs: mounted [ 4.180000] Freeing unused kernel memory: 220k freed INIT: version 2.88 booting Displaying bootlogo. Starting udev [ 6.187000] udevd[77]: starting version 182 [ 7.938000] ath_hal: module license 'Proprietary' taints kernel. [ 7.945000] Disabling lock debugging due to kernel taint [ 7.966000] ath_hal: 2009-05-08 (AR5210, AR5211, AR5212, AR5416, RF5111, RF5112, RF2413, RF5413, RF2133, RF2425, REGOPS_FUNC, XR) [ 8.128000] wlan: svn r3314 [ 8.355000] ath_pci: svn r3314 [ 8.358000] PCI: Enabling device 0000:00:01.0 (0000 -> 0002) [ 8.364000] Atheros HAL provided by OpenWrt, DD-WRT and MakSat Technologies [ 8.859000] fpga init [ 8.991000] sr0: scsi3-mmc drive: 24x/24x writer dvd-ram cd/rw xa/form2 cdda caddy [ 8.999000] cdrom: Uniform CD-ROM driver Revision: 3.20 [ 9.114000] ath_rate_sample: 1.2 (svn r3314) [ 9.131000] wifi0: 11b rates: 1Mbps 2Mbps 5.5Mbps 11Mbps [ 9.138000] wifi0: 11g rates: 1Mbps 2Mbps 5.5Mbps 11Mbps 6Mbps 9Mbps 12Mbps 18Mbps 24Mbps 36Mbps 48Mbps 54Mbps [ 9.149000] wifi0: turboG rates: 6Mbps 12Mbps 18Mbps 24Mbps 36Mbps 48Mbps 54Mbps [ 9.158000] wifi0: H/W encryption support: WEP AES AES_CCM TKIP [ 9.323000] ath_pci: wifi0: Atheros 2413: mem=0xd0000000, irq=33 [ 11.369000] done OK 0 [ 13.974000] enter base init, xvd 20100413, vdc 20100413, rap 20101005, xpt 20100825 [ 13.982000] !!! kernMemSize: 154 MB [ 13.987000] smca set muxes [ 13.990000] smcb set muxes [ 13.993000] smcc set muxes [ 14.005000] 14:5005479 SMCA: controller reset timed out [ 14.020000] 14:20006019 SMCB: controller reset timed out [ 15.916000] register adapter [ 15.920000] register adapter [ 15.924000] register adapter [ 15.927000] register adapter [ 15.931000] register adapter [ 16.058000] FP Version 7 [ 16.061000] input: dreambox front panel as /devices/virtual/input/input0 [ 16.162000] maskffffffff [ 16.164000] using fpga version 2a [ 16.168000] tsmux set tsports reg 02 to val dc [ 16.172000] tsmux set tsports reg 02 to val dc [ 16.177000] tsmux set tsports reg 03 to val fe [ 16.181000] tsmux set tsports reg 03 to val fe [ 16.186000] tsmux set ciclk reg fe to val 00 [ 16.190000] tsmux set cisource reg 00 to val 55 [ 16.195000] tsmux set ciclk reg fe to val 00 [ 16.199000] tsmux set cisource reg 00 to val 55 [ 16.204000] tsmux set ciclk reg fe to val 00 [ 16.208000] tsmux set cisource reg 01 to val 55 [ 16.213000] tsmux set ciclk reg fe to val 00 [ 16.217000] tsmux set cisource reg 01 to val 55 [ 16.222000] set sb to 3(2) [ 16.225000] set fb to 2(-1) [ 16.228000] set input to 0 [ 16.231000] set fb to 2(-1) [ 16.238000] bcm_video_analog_port_setup (fmt=7) [ 16.242000] SET FORMAT: display[1], format=7 [ 16.247000] display 0 uses vbi path 1 [ 16.251000] display 1 uses vbi path 0 [ 16.255000] HDMI: now connected [ 16.259000] Write AVS: 40 40 00 00 00 00 00 03 00 02 00 00 00 ff [ 16.273000] Write AVS: 40 40 00 00 00 00 18 63 00 02 00 00 00 ff [ 16.285000] set sb to 3(2) [ 16.288000] set sb to 3(2) [ 16.299000] HDMI: EDID read ok [ 16.302000] HDMI: initial mode set! [ 16.306000] using 50.00Hz as MonitorRefreshRate [ 16.311000] SET FORMAT: display[0], format=37 [ 16.315000] HDMI mode [ 16.317000] use EDID to detect colorspace [ 16.321000] using colorspace: 1 [ 16.397000] set fb to 2(0) [ 16.400000] bcm_video_analog_port_setup (fmt=7) [ 16.404000] SET FORMAT: display[1], format=7 [ 16.409000] disable wss on display 0 [ 16.413000] disable wss on display 1 [ 16.417000] bcmfb: creating surface with pixel format 0x07e48888 (BPXL_eA8_R8_G8_B8) [ 16.571000] enable mad [ 16.626000] VIDEO0: set fallback framerate to 60000 [ 16.631000] VIDEO0: set progressive override mode to 1 [ 16.636000] VIDEO0: set streamtype! [ 16.639000] set MPEG2 [ 16.642000] sw rave disabled! [ 16.776000] enable mad [ 16.778000] VIDEO1: set fallback framerate to 60000 [ 16.783000] VIDEO1: set progressive override mode to 1 [ 16.789000] VIDEO1: set streamtype! [ 16.792000] set MPEG2 [ 16.795000] sw rave disabled! [ 16.802000] sync is off so we enable it [ 16.806000] playback! [ 16.808000] total video delay: 0 (0 ms) [ 16.813000] VIDEO0: start decode [ 16.816000] flush video decoder [ 16.820000] VIDEO0 got pts failed !!!! (ret 0) [ 17.840000] set ac3 to downmix [ 17.843000] set aac to downmix [ 17.847000] init ALSA! [ 17.885000] VIDEO0: first pts 0x0 [ 17.915000] DVB: registering new adapter (BCM7400) [ 17.942000] autodetecting NIMs... [ 17.947000] ret: -145, feid: 00 [ 17.951000] ret: -145, feid: 00 [ 17.955000] Initializing adapter 0 (BCM4501 (internal)-DVB-S2) [ 17.961000] fe_common: retrying i2c transfer [ 17.966000] fe_common: retrying i2c transfer [ 17.971000] fe_common: retrying i2c transfer [ 17.976000] fe_common: retrying i2c transfer [ 17.981000] fe_common: retrying i2c transfer [ 17.986000] fe_common: retrying i2c transfer [ 17.990000] fe_common: retrying i2c transfer [ 17.999000] fe_common: retrying i2c transfer [ 18.010000] fe_common: retrying i2c transfer [ 18.016000] fe_common: retrying i2c transfer [ 18.021000] fe: write ret=-145 [ 18.024000] bcm4501: mbox read error [ 18.029000] attach bcm4501 failed.. try now bcm4506 [ 18.036000] bcm4506: found 4506, revision 0(a1) [ 18.041000] bcm4506: bcm_initAP [ 18.041000] enable tsm0 [ 18.061000] bcm4506: upload & start firmware [ 20.185000] bcm4506: bcm4506: ap not running - start now [ 20.285000] bcm4506: uCode 0x61 [ 20.306000] bcm4506: no bcm3445 detected [ 20.322000] DVB: registering adapter 0 frontend 0 (bcm4506)... [ 20.361000] Initializing adapter 1 (BCM4506 (internal)-DVB-S2) [ 20.378000] bcm4506: no bcm3445 detected [ 20.394000] DVB: registering adapter 0 frontend 1 (bcm4506)... [ 21.273000] VIDEO0: stop decode [ 21.276000] no decoder left in sync handling so disable xpt_sync [ 21.288000] CI stopped... [ 21.291000] CI stopped... [ 21.295000] registered vtuner misc/vtuner0, minor 49 [ 21.300000] CI stopped... [ 21.303000] CI stopped... [ 21.307000] registered vtuner misc/vtuner1, minor 48 [ 21.312000] IR-TX init! [ 21.486000] VIDEO0: set blank to 0 [ 21.490000] sync is off so we enable it [ 21.494000] playback! [ 21.497000] total video delay: 0 (0 ms) [ 21.501000] VIDEO0: start decode [ 21.505000] flush video decoder [ 21.545000] VIDEO0: first pts 0x0 [ 21.549000] VIDEO0: framerate changed 3 [ 21.552000] VIDEO0: resolution changed (1280 720) [ 21.557000] VIDEO0: aspect changed 3 [ 21.645000] set current avs auto aspect to 16:9 [ 21.650000] disable wss on display 0 [ 21.654000] disable wss on display 1 [ 21.657000] set current avs auto aspect to 16:9 [ 21.662000] disable wss on display 0 [ 21.666000] disable wss on display 1 [ 21.670000] set sb to 3(1) [ 21.672000] Write AVS:VIDEO0: set blank to 0 [ 21.677000] 40VIDEO0: stop decode [ 21.681000] 40VIDEO0: set blank to 0 [ 21.684000] no decoder left in sync handling so disable xpt_sync [ 21.691000] 00 00 00 00 18 61 00 02 00 00 00 ff [ 24.681000] input: dreambox remote control (native) as /devices/virtual/input/input1 [ 24.691000] input: dreambox advanced remote control (native) as /devices/virtual/input/input2 [ 24.712000] input: dreambox ir keyboard as /devices/virtual/input/input3 [ 24.731000] input: dreambox ir mouse as /devices/virtual/input/input4 [ 25.033000] NET: Registered protocol family 10 [ 25.047000] 4020014 ms: [ 25.120000] 70 ms: 12 mkdir /dev/shm..... [ 25.340000] Empty flash at 0x00328b60 ends at 0x00329000 [ 25.453000] 331 ms: 14 [ 26.052000] 596 ms: 16 [ 26.114000] 59 ms: 18 [ 26.140000] 24 ms: 20 Configuring network interfaces... udhcpc (v1.19.4) started Sending discover... Sending select for 192.168.178.20... Lease of 192.168.178.20 obtained, lease time 864000 /etc/udhcpc.d/50default: Adding DNS 192.168.178.1 done. [ 27.227000] 1084 ms: 22 rdate: current time matches remote time Starting rdate timesync...: Sync[ 27.605000] 376 ms: 24 doneStarting rpcbind... Mounting /etc/enigma2/automounts.xml... [ 33.375000] 5767 ms: 26 net.ipv4.conf.default.rp_filter = 1 net.ipv4.conf.all.rp_filter = 1 [ 33.442000] 65 ms: 28 Starting tpmd. [ 33.481000] 36 ms: 30 INIT: Entering runlevel: 3 Starting system message bus: dbus. [ 34.282000] 798 ms: 33 Starting Dropbear SSH server: dropbear. [ 34.346000] 62 ms: 34 Starting automounter: loading autofs4 kernel module, done. [ 35.488000] 1139 ms: 35 [ 35.567000] 76 ms: 36 Starting dbttcd. [ 35.625000] 55 ms: 38 Starting default emu. [ 35.663000] 35 ms: 39 creating NFS state directory: done NFSD Modul loaded.... NFSD Mounted.... RPCBIND Running.... starting 8 nfsd kernel threads: [ 36.480000] Installing knfsd (copyright (C) 1996 okir@monad.swb.de). [ 36.587000] NFSD: Using /var/lib/nfs/v4recovery as the NFSv4 state recovery directory [ 36.596000] NFSD: starting 90-second grace period done starting mountd: done starting statd: done [ 37.350000] 1685 ms: 40 Starting syslogd/klogd: done [ 37.422000] 69 ms: 41 Starting internet superserver: xinetd. [ 37.530000] 105 ms: 43 * Starting Avahi mDNS/DNS-SD Daemon: avahi-daemon ...done. [ 38.079000] 547 ms: 44 * starting eDaemon: eDaemon... done. [ 38.128000] 47 ms: 45 [SCRIPT] start: Scam v3.59 [ 38.296000] 165 ms: 46 [ 38.320000] 22 ms: 48 [ 38.489000] VIDEO0: set blank to 0 [ 38.503000] sync is off so we enable it [ 38.508000] playback! [ 38.510000] total video delay: 0 (0 ms) [ 38.517000] VIDEO0: start decode [ 38.526000] flush video decoder [ 38.565000] VIDEO0: first pts 0x0 [ 38.687000] VIDEO0: set blank to 0 [ 38.691000] VIDEO0: stop decode [ 38.701000] VIDEO0: set blank to 0 [ 38.704000] no decoder left in sync handling so disable xpt_sync Enigma2 v4.0.0 (revision: tarball-20120828-0-g1104b04, date: 2012-08-28) 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[ 55.508000] bcmfb: enable manual blit em [ 55.553000] 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[ 55.698000] tsmux set cisource reg 00 to val 54 path /proc/stb/lcd/xres: No such[ 55.706000] tsmux set cisource reg 00 to val 44 file or directo[ 55.712000] tsmux set cisource reg 01 to val 54 ry lcd buffer 0[ 55.718000] tsmux set cisource reg 01 to val 44 xccbbb0 8448 byt[ 55.724000] tsmux set tsports reg 02 to val dc es, stride 132 [ 55.731000] tsmux set tsports reg 02 to val dc + (9) Font Rende[ 55.736000] tsmux set tsports reg 03 to val fe r Class [FONT] initializing lib[ 55.743000] tsmux set tsports reg 03 to val fe ... [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 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 1582 services scanning for frontends.. opening frontend[ 56.727000] bcm4506: channel 0 is in normale mode now 0 detected satellite frontend (0)setTone Off (0)setVoltage 0V close frontend 0 opening frontend 1 [ 56.746000] bcm4506: channel 0 is sleeping now [ 56.754000] bcm4506: channel 1 is in normale mode now detected satellite frontend (1)setTone Off (1)setVoltage 0V close frontend 1 scanning for demux.. scanning for decoders.. scanning for descramblers.. found 1 adapter, 2 frontends(2 sim) [ 56.777000] bcm4506: channel 1 is sleeping now and 5 demux, boxtype 4 [eDVBLocalTimeHandler] Use valid Linux Time 'Wed Sep 5 21:29:08 2012' :) (RTC?) [EPGC] Initialized EPGCache (wait for setCacheFile call now) Loading spinners... found 12 spinners! executing main setIoPrio best-effort level 3 ok main thread is non-idle! display spinner! [ 57.783000] 19461 ms: 49 [ 57.875000] 89 ms: 50 /proc/stb/frontend/0/lnb_sense is 0 [setupConfigEntries] initial_call for stored uuid: 03227bf9-c455-4502-a28f-99c24905ac7d {'mountpoint': '/media/hdd', 'device_info': 'SATA', 'device_description': 'ATA-WDC WD10EVDS-63U (1000.204 GB)', 'enabled': 'true'} [ 58.572000] kjournald starting. Commit interval 5 seconds [ 58.577000] EXT3-fs (sda1): warning: maximal mount count reached, running e2fsck is recommended [ 58.581000] EXT3-fs (sda1): using internal journal [ 58.581000] EXT3-fs (sda1): mounted filesystem with writeback data mode [mountPartitionbyUUID]: mount -t auto /dev/disk/by-uuid/03227bf9-c455-4502-a28f-99c24905ac7d /media/hdd getBlkidPartitionType /dev/sda1: UUID="03227bf9-c455-4502-a28f-99c24905ac7d" TYPE="ext3" 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' [ 59.120000] cdfs 2.6.27 loaded. [ 59.452000] fuse init (API version 7.17) found block device 'sda1': error querying properties [addDevicePartition] device:'sda1' with UUID:'03227bf9-c455-4502-a28f-99c24905ac7d' [enumerateBlockDevices] devices_scanned_on_init: [('sda', False, False, True)] main thread is non-idle! display spinner! found block device 'sr0': no medium [enumerateBlockDevices] devices_scanned_on_init: [('sda', False, False, True), ('sr0', True, True, False)] Reading satellites.xml removing internal link on frontend id 1 sec config cleared setSlotInfo for dvb frontend 0 to slotid 0, descr BCM4506 (internal), need rotorworkaround No, enabled Yes, DVB-S2 Yes setSlotInfo for dvb frontend 1 to slotid 1, descr BCM4506 (internal), need rotorworkaround No, enabled Yes, DVB-S2 Yes slot: 0 configmode: simple diseqcmode: single slot: 1 configmode: equal sec config completed [ 63.961000] 6084 ms: 50 [ 63.972000] 8 ms: 56 [ 64.077000] 102 ms: 56 [ 64.117000] 38 ms: 57 [ 64.121000] 2 ms: 57 [ 64.208000] 85 ms: 57 [ 64.890000] 680 ms: 57 [ 65.045000] 152 ms: 57 [ 65.063000] 15 ms: 58 [ 65.069000] 2 ms: 58 [ 65.074000] 2 ms: 58 Preferred tag editor set to None [ 65.419000] 343 ms: 58 [ 65.424000] 2 ms: 58 [ 65.596000] 169 ms: 58 [ 66.088000] 490 ms: 58 [ 66.092000] 2 ms: 59 [ 66.120000] 26 ms: 59 [ 66.125000] 2 ms: 59 [ 66.131000] 3 ms: 59 [ 66.181000] 48 ms: 59 [ 66.252000] 69 ms: 59 [ 67.384000] 1130 ms: 59 [ 67.396000] 8 ms: 60 [ 67.414000] 16 ms: 60 loading bouquet... /etc/enigma2/bouquets.tv loading bouquet... /etc/enigma2/userbouquet.favourites.tv 168 entries in Bouquet userbouquet.favourites.tv 1 entries in Bouquet bouquets.tv loading bouquet... /etc/enigma2/bouquets.rad[ 67.450000] 33 ms: 60 io loading bouquet... /etc/enigma2/userbouquet.favourites.radio 9 entries in Bouquet userbouquet.favourites.radio 1 entries in Bouquet bouquets.radio [ 67.535000] 81 ms: 60 [ 67.613000] 75 ms: 60 [ 67.618000] 2 ms: 60 [ 67.623000] 3 ms: 60 [eDVBLocalTimeHandler] enable sy[ 67.638000] 12 ms: 60 nc local time with transponder time! [ 71.407000] 3766 ms: 60 APIs: ['api', 'api.enigma2', 'api.enigma2.systeminfo', 'api.enigma2.servicedata'] Functions: ['api._API__needsSession', 'api.[ 71.564000] 154 ms: 64 _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 [ 71.991000] 422 ms: 64 add dreampackage scanner plugin added [ 72.280000] 286 ms: 65 [ 72.287000] 4 ms: 65 [ 72.447000] 157 ms: 65 [ 72.456000] 7 ms: 65 [ 72.463000] 4 ms: 65 [ 72.484000] 17 ms: 65 [ 72.527000] 39 ms: 65 [ 72.577000] 47 ms: 65 [ 72.584000] 5 ms: 65 [FONT] adding font /usr/share/fonts/nmsbd.ttf...OK (Display) [ 72.821000] 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/nmsbd.ttf...OK (Regular) [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/newnigma2.Kerni.PanTV-HD/fonts/num.ttf...OK (NUM) [FONT] adding font /usr/lib/fonts/DejaVuSans.ttf...OK (Narrow) [FONT] adding font /usr/lib/fonts/DejaVuSans-Bold.ttf...OK (Bold) [FONT] adding font /usr/lib/fonts/DejaVuSans-Oblique.ttf...OK (Italic) [FONT] adding font /usr/lib/fonts/DejaVuSans-BoldOblique.ttf...OK (ItalicBold) [FONT] adding font /usr/share/fonts/nmsbd.ttf...OK (Regular) [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/newnigma2.Kerni.PanTV-HD/fonts/num.ttf...OK (NUM) [FONT] adding font /usr/lib/fonts/DejaVuSa[ 73.904000] 1317 ms: 65 ns.ttf...OK (Narrow) [FONT] adding font /usr/lib/fonts/DejaVuSans-Bold.ttf...OK (Bold) [FONT] adding font /usr/lib/fonts/DejaVuSans-Oblique.ttf...OK (Italic) [FONT] adding font /usr/lib/fonts/DejaVuSans-BoldOblique.ttf...OK (ItalicBold) [ 76.031000] 2123 ms: 67 [ 76.071000] Write AVS: 40 40 00 00 00 00 00 61 00 02 00 00 00 ff [ 76.125000] set current avs auto aspect to 4:3 [ 76.130000] disable wss on display 0 [ 76.133000] disable wss on display 1 [ 76.138000] set sb to 3(2) [ 76.140000] Write AVS: 40 40 00 00 00 00 00 63 00 02 00 00 00 ff [ 76.226000] set current avs auto aspect to 4:3 [ 76.230000] disable wss on display 0 [ 76.234000] disable wss on display 1 [ 76.238000] set sb to 3(2) [ 76.242000] disable wss on display 0 [ 76.246000] set wss 8 on display 1 [ 76.287000] set input to 0 [ 76.290000] set fb to 2(0) [ 76.293000] set current avs auto aspect to 4:3 [ 76.298000] disable wss on display 0 [ 76.301000] set wss 8 on display 1 [ 76.305000] set sb to 3(2) [ 76.316000] set ac3 to passthrough --> setting scaler_sharpness to: 0000000D [ 76.337000] 304 ms: 67 [ 76.367000] 28 ms: 67 couldn't open /proc/stb/misc/12V_output [ 76.597000] 228 ms: 67 [ 77.335000] 735 ms: 68 [ 77.350000] 12 ms: 69 setLCDBrightness 25 setLCDBrightness 127 [ 77.418000] 65 ms: 69 Activating keymap: Dreambox Keyboard Deutsch [ePopen] command: loadkmap < /usr/share/keymaps/dream-de.kmap Activating language German language set to de_DE [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 [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 [ 93.165000] set current avs auto aspect to 16:9 [ 93.170000] disable wss on display 0 [ 93.174000] set wss 7 on display 1 [ 93.178000] set sb to 3(1) [ 93.181000] Write AVS: 40 40 00 00 00 00 00 61 00 02 00 00 00 ff [ 93.205000] set current avs auto aspect to 16:9 [ 93.210000] disable wss on display 0 [ 93.214000] set wss 7 on display 1 [ 93.217000] set sb to 3(1) [ 93.221000] disable wss on display 0 [ 93.225000] set wss 7 on display 1 [ 93.230000] set current avs auto aspect to 16:9 [ 93.235000] disable wss on display 0 [ 93.238000] set wss 7 on display 1 [ 93.242000] set sb to 3(1) -> setting aspect, policy, polic[ 93.250000] set current avs auto aspect to 16:9 y2, wss 16:9 pan[ 93.255000] disable wss on display 0 scan letterbox a[ 93.260000] set wss 7 on display 1 uto [ 93.266000] set sb to 3(1) [ 93.271000] set current avs auto aspect to 16:9 [ 93.276000] disable wss on display 0 [ 93.279000] set wss 7 on display 1 [ 93.283000] set sb to 3(1) [ 93.287000] disable wss on display 0 [ 93.291000] set wss 7 on display 1 [ 93.295000] set current avs auto aspect to 16:9 [ 93.300000] disable wss on display 0 [ 93.304000] set wss 7 on display 1 [ 93.307000] set sb to 3(1) -> setting aspect, policy, polic[ 93.314000] set current avs auto aspect to 16:9 y2, wss 16:9 pan[ 93.320000] disable wss on display 0 scan letterbox a[ 93.326000] set wss 7 on display 1 uto [ 93.331000] set sb to 3(1) [ 93.335000] set current avs auto aspect to 16:9 [ 93.340000] disable wss on display 0 [ 93.344000] set wss 7 on display 1 [ 93.348000] set sb to 3(1) [ 93.352000] disable wss on display 0 [ 93.356000] set wss 7 on display 1 [ 93.360000] set current avs auto aspect to 16:9 [ 93.365000] disable wss on display 0 [ 93.369000] set wss 7 on display 1 [ 93.373000] set sb to 3(1) -> setting aspect, policy, polic[ 93.380000] set current avs auto aspect to 16:9 [ 93.386000] disable wss on display 0 y2, wss 16:9 pan[ 93.389000] set wss 7 on display 1 scan letterbox a[ 93.395000] set sb to 3(1) uto [ 93.400000] set current avs auto aspect to 16:9 [ 93.404000] disable wss on display 0 [ 93.408000] set wss 7 on display 1 [ 93.412000] set sb to 3(1) [ 93.416000] disable wss on display 0 [ 93.420000] set wss 7 on display 1 [ 93.425000] set current avs auto aspect to 16:9 [ 93.430000] disable wss on display 0 [ 93.434000] set wss 7 on display 1 [ 93.437000] set sb to 3(1) setMode - port: DVI mode: 1080i rate: multi [ 93.446000] using 50.00Hz as MonitorRefreshRate [ 93.565000] SET FORMAT: display[0], format=27 [ 93.570000] HDMI mode [ 93.572000] use EDID to detect colorspace [ 93.576000] using colorspace: 1 [ 93.647000] bcm_video_analog_port_setup (fmt=7) [ 93.766000] SET FORMAT: display[1], format=7 [ 93.885000] set current avs auto aspect to 16:9 [ 93.890000] disable wss on display 0 [ 93.894000] set wss 7 on display 1 [ 93.898000] set sb to 3(1) [ 93.903000] set current avs auto aspect to 16:9 [ 93.908000] disable wss on display 0 [ 93.911000] set wss 7 on display 1 [ 93.915000] set sb to 3(1) -> setting aspect, policy, polic[ 93.987000] set current avs auto aspect to 16:9 y2, wss 16:9 pan[ 93.992000] disable wss on display 0 scan letterbox a[ 93.997000] set wss 7 on display 1 uto [ 94.002000] set sb to 3(1) [ 94.006000] set current avs auto aspect to 16:9 [ 94.011000] disable wss on display 0 [ 94.015000] set wss 7 on display 1 [ 94.018000] set sb to 3(1) [ 94.022000] disable wss on display 0 [ 94.026000] set wss 7 on display 1 [ 94.031000] set current avs auto aspect to 16:9 [ 94.035000] disable wss on display 0 [ 94.039000] set wss 7 on display 1 [ 94.042000] set sb to 3(1) /usr/share/enigma2/ sh: fpupgrade: not found [AutoMount.py] -getAutoMountPoints:self.automounts --> {} [AutoMount.py] self.automounts without mounts {} [OSD preference] found: /usr/share/enigma2/newnigma2.Kerni.PanTV-HD/icons/beta_g.png [OSD preference] append "icon" option to list sh: /usr/bin/eject: not found Newnigma2 set DVD speed to 9 [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 add device sr0 to bdpoll current state: medium removed [CrashlogAutoSubmit] - autostart [CI_Assignment] activating ci configs: [CI_Activate] FOUND 4 CI Slots [CI_Activate_Config_CI0] no config file found [CI_Activate_Config_CI0] error parsing xml... [CI_Activate_Config_CI1] no config file found [CI_Activate_Config_CI1] error parsing xml... [CI_Activate_Config_CI2] no config file found [CI_Activate_Config_CI2] error parsing xml... [CI_Activate_Config_CI3] no config file found [CI_Activate_C[ 98.473000] 21052 ms: 69 onfig_CI3] error parsing xml... [TeleText] set language to [de] [TeleText] set language to [de] [WebInterface] set language to de [WebInterface] set language to de [WebInterface] set language to de [[ 98.493000] 16 ms: 94 AudioSync] set language to de [AudioSync] set language to de [ 98.502000] tsmux set ciclk reg fe to val 00 [ 98.512000] tsmux set ciclk reg fe to val 00 [ 98.520000] tsmux set ciclk reg fe to val 00 [ 98.529000] tsmux set ciclk reg fe to val 00 [ 98.536000] 39 ms: 94 It's now Wed Sep 5 21:29:50 2012 [timer.py] next activation: 1346873490 (in 99920 ms) It's now Wed Sep 5 21:29:50 2012 [timer.py] next activation: 1346873490 (in 99841 ms) [TeleText] ----- sessionstart(<__main__.Session instance at 0x1714aa8>) ----- [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 [FanControl2] Starting up [FanControl2] ATA-WDC WD10EVDS-63U /dev/sda Mode:auto [FanControl2] HDD supports Temp reading without Spinup [FanControl2] HDD Temp 48C Looking for embedded skin [ResourceManager] adding: NetworkAdapterSelection [ResourceManager] adding: AdapterSetup [CrashlogAutoSubmit] - autostart [CrashlogAutoSubmit] - not starting CrashlogAutoSubmit [CamdresetEveryDay] next reset: Wed Sep 5 23:45:53 2012 No skin to read... [InstallerUpdateCheck] timer changed [InstallerUpdateCheck] is offline [Toplevel.importExternalModules] Could NOT import external module: EPGRefresh [Toplevel.importExternalModules] Exception Caught No module named EPGRefresh.EPGRefreshResource [Toplevel.importExternalModules] Imported external module: Example [Webinterface] started on 0.0.0.0:80 auth=True ssl=False [WebInterface.register[ 103.459000] 4920 ms: 94 BonjourService] No module named Bonjour.Bonjour [WebInterface.unregisterBonjourService] No module named Bonjour.Bonjour [EPGC] setCacheFile read/write epg data from/to '/media/hdd/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 [ 103.525000] 63 ms: 99 setValue 90 [ 103.590000] set mute 0 (000) 1 cannot open /proc/stb/audio/j1_m[ 103.596000] 68 ms: 99 ute(No such file or directory) Setvolume: 100 100 (raw) Setvolume: 0 0 (-1db) Setvolume: 90 90 (raw) Setvolume: 7 7 (-1db) [ 103.617000] 18 ms: 99 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 [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! reused 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! 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! 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! 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! reused converter! allocating new converter! allocating new converter! reused 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! reused converter! reused converter! reused converter! reused converter! reused converter! reused converter! reused converter! reused converter! allocating new converter! reused converter! allocating new converter! reused converter! reused converter! reused converter! reused converter! reused converter! allocating new converter! allocating new converter! allocating new converter! 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) child has terminated pipes closed poll: unhandled POLLERR/HUP/NVAL for fd 57(16) playing 1:0:19:283D:3FB:1:C00000:0:0:0: [Picon Renderer] not found: /picons/piconHD/DAS ERSTE HD.png [Picon Renderer] not found: /picons/piconlcd/DAS ERSTE HD.png [TeleText] service started not pauseable. RemovePopup, id = ZapError allocate channel.. 03fb:0001:00c0000[ 106.559000] bcm4506: channel 0 is in normale mode now 0 opening frontend 0 [eDVBCAService] new channel 0x6f47d808! (0)tune RotorCmd ffffffff, lastRotorCmd ffffffff prepare_sat System 1 Freq 11493750 Pol 0 SR 22000000 INV 2 FEC 2 orbpos 192 system 1 modulation 2 pilot 2, rolloff 0 tuning to 1743 mhz OURSTATE: tuning allocate Channel: res 0 [eDVBCIInterfaces] addPMTHandler 1:0:19:283D:3FB:1:C00000:0:0:0: recheckPMTHAndlers() recheck 0x6f476704 1:0:19:283D:3FB:1:C00000:0:0:0: allocate demux [HbbTV].aitInvalidated [ 106.620000] bcm4506: signal_strength -289.87dbm nr_read 354 nr_write 6 sum 360 prev_sum 0 hdd was accessed since previous check! [IDLE] 0 300 False child has terminated pipes closed 0.0.0.0 169.254 192.168 child has terminated pipes closed nameservers: [[192, 168, 178, 1]] read configured interface: {'lo': {'dhcp': False}, 'eth0': {'dhcp': True}} self.ifaces after loading: {'ath0': {'preup': False, 'predown': False, 'ip': [0, 0, 0, 0], 'up': False, 'dns-nameservers': False, 'broadcast'[ 106.734000] bcm4506: signal_strength -289.87dbm : False, 'mac': '00:23:cd:14:a4:76', 'dhcp': True, 'netmask': [0, 0, 0, 0], 'gateway': [0, 0, 0, 0]}, 'eth0': {'preup': False, 'predown': False, 'ip': [192, 168, 178, 20], 'up': True, 'dns-nameservers': False, 'broadcast': False, 'mac': '00:09:34:1c:b8:00', 'dhcp': True, 'bcast': [192, 168, 178, 255], 'netmask': [255, 255, 255, 0], 'gateway': [192, 168, 178, 1]}} poll: unhandled POLLERR/HUP/NVAL for fd 47(16) poll: unhandled POLLERR/HUP/NVAL for fd 70(16) [SEC] lock 0 [SEC] set static current limiting [SEC] invalidate current switch params [SEC] setVoltage 2 (0)setVoltage 18V [SEC] sleep 10ms [SEC] update current switch params [SEC] startTuneTimeout 5000 [SEC] setFrontend 1 (0)setting frontend (0)fe event: status 0, freq 1743750, inversion off, m_tuning 1 F [SEC] unlock [SEC] sleep 500ms (0)fe event: status 1, freq 1743750, inversion off, m_tuning 1 N (0)fe event: status 0, freq 1743750, inversion off, m_tuning 2 N [SEC] set dynamic current limiting (0)fe event: status 1f, freq 1742851, inversion off, m_tuning 3 N OURSTATE: ok [eDVBCAService] channel 0x6f47d808 running [eDVBLocalTimeHandler] channel 0x6f47d808 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 0x6f47d808 running stop[ 107.464000] start pcr0 on dmx 3 pid:13ed index 5 release channel timer no versi[ 107.472000] start audio on dmx 3 pid:13f2 on filtering 00[ 107.477000] audio xpt start 12: 4e 28 3d 00[ 107.481000] sync is off so we enable it 00 00 mask: f[ 107.487000] demux-index 3 pcr0pid 13ed f ff ff 00 00 00[ 107.492000] using 5 as pcr0 pidchannel mode: 00 00 0[ 107.497000] AC3 0 00 00 00 ok .[ 107.500000] audio: streamtype set 1 .. now we start![ 107.506000] audio: streamtype_set: stop rave ! no version fi[ 107.511000] passthru ltering 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 str[ 107.526000] audio: streamtype_set: restart rave eam(s) (13ed), a[ 107.531000] set mute 0 (011) 1 nd 1 audio strea[ 107.536000] audio: decoder start 2 m(s) (13f2), and the pcr pid is 13ed, and the text pid is 13f0 allocate demux disable teletext subtitles decoder state: play,[ 107.551000] video delay 0 (0 ms) vpid=5101, apid[ 107.554000] total video delay: 0 (0 ms) =5106 DMX_SET_P[ 107.560000] VIDEO0: set streamtype! ES_FILTER(0x13ed[ 107.565000] set H264 ) - pcr - ok DE[ 107.569000] sw rave disabled! MUX_START - pcr [ 107.573000] audio delay 18000 (200 ms) - ok DMX_SET_PE[ 107.578000] total video delay: 18000 (200 ms) S_FILTER(0x13f2)[ 107.585000] start video0 on dmx 3 pid:13ed - audio - ok D[ 107.590000] ch0: lock [ 107.594000] RAP first pts 0x12364184, stc 0x1236373a, pcr valid EMUX_START - aud[ 107.600000] total video delay: 18000 (200 ms) io - ok AUDIO_SET_BYPASS(0) - o[ 107.608000] VIDEO0: start decode k AUDIO_PAUSE - ok AUDIO_PLAY - ok Video Device: /dev/dvb/adapter0/video0 demux device: /dev/dvb/adapter0/demux3 VIDEO_SET_[ 107.622000] ch0: lock STREAMTYPE 1 - ok DMX_SET_PES_FILTER(0x13ed) - video - ok DEMUX_START - video - ok VIDEO_FREEZE - ok VIDEO_PLAY - ok DMX_SET_PES_FILTER(0x13f0) - ttx - ok DEMUX_START - ttx - ok VIDEO_SLOWMOTION(0) - ok VIDEO_FAST_FORWARD(0) - ok VIDEO_CONTINUE - ok AUDIO_CONTINUE - ok AUDIO_CHANNEL_SELECT(0) - ok not pauseable. [ 107.654000] ch0: lock [ 107.690000] ch0: lock [ 107.713000] bcm4506: signal_strength -106.35dbm [ 107.718000] ch0: lock [TeleText] serviceInfoChanged [TeleText] TXT PID 5104 DEMUX 3 [TeleText] send array('B', [1, 19, 240, 3]) [ 107.790000] bcm4506: signal_strength -106.35dbm -+ 1/2 TID 4e + 1/1 TID 00 done! PATready use pmtpid 13ec for service_id 283d no version filtering 13ec: 02 28 3d 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 doing version filtering 0000: 00 00 00 01 00 00 mask: ff 00 00 3f 00 00 mode: 00 00 00 3e 00 00 VIDEO_GET_EVENT - ok VIDEO_GET_EVENT - ok [ 108.030000] RAP sampling rate info isr [ 108.161000] RAP pts error 0 PTS 0x091b4dc2, STC 0x091b7f62, type 0 + 1/1 TID 02 done! [eDVBCAService] new service 1:0:19:283D:3FB:1:C00000:0:0:0: [eDVBCAService] add demux 3 to slot 0 service 1:0:19:283D:3FB:1:C00000:0:0:0: demux 3 mask 08 prevhash 00000000 [eDVBCAService] send 79 bytes 9f 80 32 4b 03 28 3d 19 00 13 01 81 08 00 c0 00 00 03 fb 00 01 82 02 08 03 84 02 13 ec 05 04 92 00 00 0b 08 7b 00 00 0b 08 7c 00 00 1b 13 ed 00 00 03 13 ee 00 00 03 13 ef 00 00 06 13 f0 00 00 06 13 f1 00 00 06 13 f2 00 00 06 1[ 108.246000] VIDEO0: first pts 0x123858c4 [ 108.250000] VIDEO0: framerate changed 6 3 f4 00 00 rec[ 108.255000] set current avs auto aspect to 16:9 heckPMTHAndlers([ 108.260000] disable wss on display 0 ) recheck 0x6f4[ 108.265000] set wss 7 on display 1 76704 1:0:19:283[ 108.271000] set sb to 3(1) D:3FB:1:C00000:0:0:0: HBBTV broadcast data on pid 087b HBBTV broadcast data on pid 087c Rds PID 13f4 detected[ 108.283000] bcm4506: signal_strength -108.57dbm ? ! ? [eDVBCIInterfaces] gotPMT eventNewProgramInfo 0 0 start ait on pid 0492 no version filtering 0492: 74 00 00 00 00 00 mask: ff 00 00 00 00 00 mode: 00 00 00 00 00 00 have 1 video stream(s) (13ed), and 3 audio stream(s) (13ee, 13ef, 13f2), and the pcr pid is 13ed, and the text pid is 13f0 decoder state: play, vpid=5101, apid=5106 HBBTV broadcast data on pid 087b HBBTV broadcast data on pid 087c Rds PID 13f4 detected ? ! ? [TeleText] serviceInfoChanged [TeleText] TXT PID 5104 DEMUX 3 [TeleText] send array('B', [1, 19, 240, 3]) doing version filtering 13ec: 02 28 3d 19 00 00 mask: ff ff [ 108.358000] bcm4506: signal_strength -108.57dbm ff 3f 00 00 mode: 00 00 00 3e 00 00 VIDEO_GET_EVENT - ok [ 108.421000] enable tsm0 ++ 2/2 TID 4e done! doing version filtering 0012: 4e 28 3d 25 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 [ 108.819000] bcm4506: signal_strength -108.08dbm + 1/1 TID 74 done! [eHbbtv] aitChanged pid=0x492 [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.1019.10301 [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.1019.10301 [eHbbtv] 'dvb://current.ait/19.2' resolved to 'http://itv.ard.de/ardepg/index.php' [eOipfApplication] Profile 0000, Version 1.1.1 [eOipfApplication] deu:ARD-Text-DSMCC [eHbbtv] New Application: ARD-Text-DSMCC (orgid=19, appid=4, urlBase=http://itv2.ard.de/ardtext/, initalPath=index.html, controlCode=2, visibility=2) [eHbbtv] Resolving Application Locator: dvb://current.ait/19.4 [eHbbtv] We have 3 app(s) for service 1.1019.10301 [eHbbtv] 'dvb://current.ait/19.4' resolved to 'http://itv2.ard.de/ardtext/index.html' [eOipfApplication] Profile 0000, Version 1.1.1 [eOipfApplication] deu:Tagesschau [eHbbtv] New Application: Tagesschau (orgid=19, appid=5, urlBase=http://www.tagesschau.de/, initalPath=hbbtv, controlCode=2, visibility=2) [eHbbtv] Resolving Application Locator: dvb://current.ait/19.5 [eHbbtv] We have 4 app(s) for service 1.1019.10301 [eHbbtv] 'dvb://current.ait/19.5' resolved to 'http://www.tagesschau.de/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 5 app(s) for service 1.1019.10301 [eHbbtv] 'dvb://current.ait/19.20' resolved to 'http://hbbtv.daserste.de/index.php' [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.1019.10301 [eHbbtv] 'dvb://current.ait/19.27' resolved to 'http://hbbtv.ndr.de/index.html' [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/, controlCode=2, visibility=2) [eHbbtv] Resolving Application Locator: dvb://current.ait/19.3 [eHbbtv] We have 7 app(s) for service 1.1019.10301 [eHbbtv] 'dvb://current.ait/19.3' resolved to 'http://hbbtv.ardmediathek.de/hbbtv-ard/mediathek/' [HbbTV].readButtonApplicationReady, appid=19.1 [HbbTV].textApplicationReady, appid=19.4 doing version filtering 0492: 74 00 00 13 00 00 mask: ff 00 00 3f 00 00 mode: 00 00 00 3e 00 00 [eDVBLocalTimeHandler] Receiver time is 'Wed Sep 5 21:30:00 2012' [eDVBLocalTimeHandler] Transponder time is 'Wed Sep 5 21:30:00 2012' [eDVBLocalTimeHandler] diff is 0 [eDVBLocalTimeHandler] diff < 120 .. use Transponder Time [eDVBLocalTimeHandler] not changed sdt update done! [ 109.731000] bcm4506: signal_strength -108.20dbm [ 109.849000] bcm4506: signal_strength -106.83dbm [EPGC] 27204 events read from /media/hdd/epg.dat [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 2620880 bytes for cache used [EPGC] next update in 2 sec [ 110.881000] bcm4506: signal_strength -106.94dbm [ 111.230000] bcm4506: signal_strength -106.48dbm [EPGC] start caching events(1346873403) [FanControl2] HDD Temp 48C [FanControl2] Fan Reset [FanControl2] Reread [FanControl2] HDD Temp 48C [FanControl2] Fan Reset [FanControl2] Vlt:240 Pwm:80 Fan:4pin - BoxOn HDDon [FanControl2] aktuellRPM:90 zielRPM:1500 Temp:50.0 [EPGC] abort non avail schedule other reading [EPGC] abort non avail viasat reading [EPGC] nownext finished(1346873410) [FanControl2] Vlt:240 Pwm:85 Fan:4pin - BoxOn HDDon [FanControl2] aktuellRPM:750 zielRPM:1500 Temp:50.0 no ancillary data in audio stream... abort radiotext pes parser action -> InfobarChannelSelection switchChannelUp allocating new converter! allocating new converter! allocating new converter! allocating new converter! reused converter! reused converter! reused converter! allocating new converter! [Picon Renderer] Exception caught here [Picon Renderer] not found: /picons/piconlcd/HIGH DEFINITION.png [Picon Renderer] not found: /picons/piconlcd/1_64_7_0_0_0_0_0_0_0.png [Picon Renderer] Sorry, i give up! [Picon Renderer] not found: /picons/piconlcd/ORF2 HD.png [Picon Renderer] not found: /picons/piconlcd/SERVUSTV HD OESTERREICH.png [Picon Renderer] not found: /picons/piconlcd/ANIXE HD.png [Picon Renderer] not found: /picons/piconlcd/SKY HD.png [Picon Renderer] not found: /picons/piconlcd/1_64_10_0_0_0_0_0_0_0.png [Picon Renderer] Sorry, i give up! [Picon Renderer] not found: /picons/piconlcd/SKY SPORT NEWS HD.png [Picon Renderer] not found: /picons/piconlcd/SKY SPORT HD 1.png [FanControl2] Vlt:240 Pwm:90 Fan:4pin - BoxOn HDDon [FanControl2] aktuellRPM:810 zielRPM:1500 Temp:50.0 action -> OkCancelActions ok playing 1:0:19:6C:C:85:C00000:0:0:0: [eDVBCAService] free slot 0 demux 3 for service 1:0:19:283D:3FB:1:C00000:0:0:0: [eDVBCAService] free service 1:0:19:283D:3FB:1:C00000:0:0:0: recheckPMTHAndlers() [TeleText] service stopped [TeleText] send array('B', [1, 0, 0, 0]) decoder state: p[ 135.207000] stop pcr0 on dmx 3 pid:13ed lay, vpid=-1, apid=-1 DEMUX_STO[ 135.214000] stop video0 on dmx 3 pid:13ed P - pcr - ok DE[ 135.220000] VIDEO0: stop decode MUX_STOP - video[ 135.224000] VIDEO0: set blank to 1 - ok VIDEO_STOP - ok [ 135.231000] audio: decoder stop AUDIO_STOP - ok [ 135.250000] stop audio on dmx 3 pid:13f2 DEMUX_STOP - aud[ 135.254000] audio: xpt stop(3) io - [ 135.259000] no decoder left in sync handling so disable xpt_sync [ 135.265000] bcm_audio_channel_stop(3) done ok AUDIO_CONTINUE - ok DEMUX_STOP - ttx - ok start release channel timer [Picon Renderer] not found: /picons/piconHD/SKY SPORT NEWS HD.png [Picon Renderer] not found: /picons/piconlcd/SKY SPORT NEWS HD.png [TeleText] service started not pauseable. RemovePopup, id = ZapError [eDVBCAService] remove channel 0x6f47d808 [eDVBLocalTimeHandler] remove channel 0x6f47d808 [eEPGCache] remove channel 0x6f47d808 [EPGC] abort caching events !! (0) preClose allocate channel.. 000c:0085:00c00000 [eDVBCAService] new channel 0x6f47d808! (0)tune RotorCmd ffffffff, lastRotorCmd ffffffff prepare_sat System 1 Freq 12304500 Pol 0 SR 27500000 INV 2 FEC 9 orbpos 192 system 1 modulation 1 pilot 2, rolloff 0 tuning to 1704 mhz OURSTATE: tuning allocate Channel: res 0 [eDVBCIInterfaces] addPMTHandler 1:0:19:6C:C:85:C00000:0:0:0: recheckPMTHAndlers() recheck 0x6f0e8ee4 1:0:19:6C:C:85:C00000:0:0:0: check Slot 0 check Slot 1 check Slot 2 check Slot 3 allocate demux [HbbTV].aitInvalidated [SEC] lock 0 [ 135.448000] bcm4506: signal_strength -106.97dbm [ 135.482000] bcm4506: signal_strength -106.97dbm [SEC] set static current limiting [SEC] invalidate current switch params [SEC] setTone 1 (0)setTone On [SEC] sleep 10ms [SEC] update current switch params [SEC] startTuneTimeout 5000 [SEC] setFrontend 1 (0)setting frontend (0)fe event: status 0, freq 1704500, inversion off, m_tuning 1 F [SEC] unlock [SEC] sleep 500ms (0)fe event: status 1, freq 1704500, inversion off, m_tuning 1 N (0)fe event: status 1f, freq 1704307, inversion off, m_tuning 2 N OURSTATE: ok [eDVBCAService] channel 0x6f47d808 running [eDVBLocalTimeHandler] channel 0x6f47d808 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 0x6f47d808 running stop release channel timer no version filtering 0012: 4e 00 6c 00[ 135.862000] start pcr0 on dmx 3 pid:3ff index 5 00 00 mask: ff ff ff 00 00 00[ 135.871000] start audio on dmx 3 pid:403 mode: 00 00 0[ 135.875000] audio xpt start 0 00 00 00 [EPG[ 135.879000] sync is off so we enable it C] next update i[ 135.885000] demux-index 3 pcr0pid 3ff n 2 sec ok ... [ 135.891000] using 5 as pcr0 pidchannel now we start!! [ 135.896000] AC3 no version filte[ 135.899000] audio: decoder start 0 ring 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[ 135.914000] audio delay 18000 (200 ms) (s) (03ff), and [ 135.918000] total video delay: 18000 (200 ms) 1 audio stream(s) (0403), and th[ 135.927000] start video0 on dmx 3 pid:3ff e pcr pid is 03f[ 135.931000] total video delay: 18000 (200 ms) f, and the text pid is 0020 all[ 135.939000] VIDEO0: start decode ocate demux disable teletext subtitles decoder state: play, vpid=1023, apid=1027 DMX_SET_PES_FILTER(0x3ff) - pcr - ok DEMUX_START - pcr - ok DMX_SET_PES_FILTER(0x403) - audio - ok DEMUX_START - audio - ok AUDIO_SET_BYPASS(0) - ok AUDIO_PAUSE - ok AUDIO_PLAY - ok Video Device: /dev/dvb/adapter0/video0 demux device: /dev/dvb/adapter0/demux3 VIDEO_SET_STREAMTYPE 1 - ok DMX_SET_PES_FILTER(0x3ff) - video - ok DEMUX_START - video - ok VIDEO_FREEZE - ok VIDEO_PLAY - ok DMX_SET_PES_FILTER(0x20) - ttx - ok DEMUX_START - ttx - ok VIDEO_SLOWMOTION(0) - ok VIDEO_FAST_FORWARD(0) - ok VIDEO_CONTINUE - ok AUDIO_CONTINUE - ok not pauseable. [ 136.020000] bcm4506: signal_strength -108.38dbm [TeleText] serviceInfoChanged [TeleText] TXT PID 32 DEMUX 3 [TeleText] send array('B', [1, 0, 32, 3]) [SEC] set dynamic current limiting + 1/1 TID 00 done! PATready use pmtpid 0063 for service_id 006c no version filtering 0063: 02 00 6c 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 + 1/1 TID 02 done! [eDVBCAService] new service 1:0:19:6C:C:85:C00000:0:0:0: [eDVBCAService] add demux 3 to slot 0 service 1:0:19:6C:C:85:C00000:0:0:0: demux 3 mask 08 prevhash 00000000 [eDVBCAService] send 86 bytes 9f 80 32 52 03 00 6c 2f 00 3d 01 81 08 00 c0 00 00 00 0c 00 85 82 02 08 03 84 02 00 63 09 04 18 33 f8 0f 09 04 18 34 fc 0f 09 04 09 c4 fb 0f 09 04 09 c7 fd 0f 09 04 09 af ff 0f 09 04 09 8c fa 0f 09 04 18 61 f9 0f 06 00 20 00 00 1b 03 ff 00 00 06 04 03 00 00 recheckPMTHAndlers() recheck 0x6f0e8ee4 1:0:19:6C:C:85:C00000:0:0:0: check Slot 0 check Slot 1 check Slot 2 check Slot 3 [eDVBCIInterfaces] gotPMT eventNewProgramInfo 0 0 have 1 video stream(s) (03ff), and 1 audio stream(s) (0403), and the pcr pid is 03ff, and the text pid is 0020 decoder state: play, vpid=1023, apid=1027 [ 136.306000] bcm4506: signal_strength -105.28dbm [TeleText] serviceInfoChanged [TeleText] TXT PID 32 DEMUX 3 [TeleText] send array('B', [1, 0, 32, 3]) doing version filtering 0063: 02 00 6c 2f 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 [ExtendedInfoBar] CAIDs: ['098C', '09AF', '09C4', '09C7', '1833', '1834', '1861'] [ExtendedInfoBar] SID: 006C [ 136.457000] bcm4506: signal_strength -105.28dbm clear buffer Put to buffer: 9f 80 3e 0d 00 6c c1 81 ff ff 81 09 04 09 c4 fb 0f -------- dump ca reply: 9f 80 3e 0d 00 6c c1 81 ff ff 81 09 04 09 c4 fb 0f -------- +- 1/2 TID 4e [ 136.506000] ch0: lock [ 136.509000] RAP first pts 0x1e5e10e6e, stc 0x23f8a276, pcr valid [ 136.515000] RAP pts error 0 PTS 0xf2f08737, STC 0x11fc524c, type 0 [ 136.541000] ch0: lock [ 136.544000] RAP pts error 0 PTS 0xf2f08737, STC 0x11fc575c, type 1 nr_read 382 nr_write 12 sum 394 prev_sum 360 hdd was accessed since previous check! [IDLE] 0 300 False [ 136.570000] ch0: lock [ 136.570000] RAP pts error 0 PTS 0xf2f08737, STC 0x11fc5c7d, type 1 [ 136.604000] ch0: lock [ 136.606000] RAP pts error 0 PTS 0xf2f08737, STC 0x11fc6266, type 1 [ 136.634000] ch0: lock [ 136.936000] RAP sampling rate info isr [ 137.037000] bcm4506: signal_strength -107.67dbm ++ 2/2 TID 4e done! doing version filtering 0012: 4e 00 6c 23 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 [ 137.592000] bcm4506: signal_strength -106.47dbm sdt update done! [EPGC] start caching events(1346873429) [ 138.145000] VIDEO0: first pts 0x23fba02e [ 138.150000] VIDEO0: framerate changed 3 [ 138.153000] VIDEO0: resolution changed (1920 1080) [ 138.159000] set current avs auto aspect to 16:9 [ 138.164000] disable wss on display 0 [ 138.167000] set wss 7 on display 1 VIDEO_GET_EVENT [ 138.171000] set sb to 3(1) - ok VIDEO_GET_EVENT - ok [ 138.321000] enable tsm0 [ 138.540000] bcm4506: signal_strength -106.84dbm [eDVBLocalTimeHandler] Receiver time is 'Wed Sep 5 21:30:30 2012' [eDVBLocalTimeHandler] Transponder time is 'Wed Sep 5 21:30:31 2012' [eDVBLocalTimeHandler] diff is 1 [eDVBLocalTimeHandler] diff < 120 .. use Transponder Time [eDVBLocalTimeHandler] update RTC [eDVBLocalTimeHandler] time_difference is 1 [eDVBLocalTimeHa[ 138.639000] bcm4506: signal_strength -106.84dbm ndler] update Linux Time [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 2639513 bytes for cache used [ 138.985000] VIDEO0: progressive changed (0) VIDEO_GET_EVENT - ok clear buffer Put to buffer: 9f 80 3e 0d 00 6c c1 81 ff ff 81 09 04 09 c4 fb 0f -------- dump ca reply: 9f 80 3e 0d 00 6c c1 81 ff ff 81 09 04 09 c4 fb 0f -------- [ 139.650000] bcm4506: signal_strength -108.04dbm [ 140.040000] bcm4506: signal_strength -107.68dbm action -> InfobarChannelSelection switchChannelUp allocating new converter! allocating new converter! allocating new converter! allocating new converter! reused converter! reused converter! reused converter! allocating new converter! [Picon Renderer] not found: /picons/piconHD/SKY SPORT NEWS HD.png [Picon Renderer] not found: /picons/piconlcd/SKY HD.png [Picon Renderer] not found: /picons/piconlcd/1_64_10_0_0_0_0_0_0_0.png [Picon Renderer] Sorry, i give up! [Picon Renderer] not found: /picons/piconlcd/RTL HD.png [Picon Renderer] not found: /picons/piconlcd/SAT.1 HD.png [Picon Renderer] not found: /picons/piconlcd/SPORT1 HD.png [Picon Renderer] not found: /picons/piconlcd/PROSIEBEN HD.png [Picon Renderer] not found: /picons/piconlcd/VOX HD.png [Picon Renderer] not found: /picons/piconlcd/RTL2 HD.png [Picon Renderer] not found: /picons/piconlcd/KABEL EINS HD.png [EPGC] abort non avail viasat reading [EPGC] nownext finished(1346873437) [Picon Renderer] not found: /picons/piconlcd/TELE 5 HD.png [FanControl2] Vlt:240 Pwm:95 Fan:4pin - BoxOn HDDon [FanControl2] aktuellRPM:840 zielRPM:1500 Temp:50.0 [Picon Renderer] not found: /picons/piconlcd/DMAX HD.png [Picon Renderer] not found: /picons/piconlcd/SIXX HD.png [Picon Renderer] not found: /picons/piconlcd/ORF1 HD.png clear buffer Put to buffer: 9f 80 3e 0d 00 6c c1 81 ff ff 81 09 04 09 c4 fb 0f -------- dump ca reply: 9f 80 3e 0d 00 6c c1 81 ff ff 81 09 04 09 c4 fb 0f -------- [Picon Renderer] not found: /picons/piconlcd/N24 HD.png [EPGC] schedule other finished(1346873440) [EPGC] schedule finished(1346873440) [EPGC] stop caching events(1346873440) [EPGC] next update in 60 min action -> OkCancelActions ok playing 1:0:19:EF10:421:1:C00000:0:0:0: [eDVBCAService] free slot 0 demux 3 for service 1:0:19:6C:C:85:C00000:0:0:0: [eDVBCAService] free service 1:0:19:6C:C:85:C00000:0:0:0: recheckPMTHAndlers() [TeleText] service stopped [TeleText] send array('B', [1, 0, 0, 0]) decoder state: p[ 149.724000] stop pcr0 on dmx 3 pid:3ff lay, vpid=-1, apid=-1 DEMUX_STO[ 149.731000] stop video0 on dmx 3 pid:3ff P - pcr - ok DE[ 149.737000] VIDEO0: stop decode MUX_STOP - video - ok VIDEO_STO[ 149.743000] VIDEO0: set blank to 1 P - ok AUDIO_STOP - [ 149.748000] audio: decoder stop ok [ 149.768000] stop audio on dmx 3 pid:403 DEMUX_STOP - aud[ 149.772000] audio: xpt stop(3) io - [ 149.777000] no decoder left in sync handling so disable xpt_sync [ 149.783000] bcm_audio_channel_stop(3) done ok AUDIO_CONTINUE - ok DEMUX_STOP - ttx - ok start release channel timer [Picon Renderer] not found: /picons/piconHD/RTL HD.png [Picon Renderer] not found: /picons/piconlcd/RTL HD.png [TeleText] service started not pauseable. RemovePopup, id = ZapError [eDVBCAService] remove channel 0x6f47d808 [eDVBLocalTimeHandler] remove channel 0x6f47d808 [eEPGCache] remove channel 0x6f47d808 (0) preClose allocate channel.. 0421:0001:00c00000 [eDVBCAService] new channel 0x6f47d808! (0)tune RotorCmd ffffffff, lastRotorCmd ffffffff prepare_sat System 1 Freq 10832250 Pol 0 SR 22000000 INV 2 FEC 2 orbpos 192 system 1 modulation 2 pilot 2, rolloff 0 tuning to 1082 mhz OURSTATE: tuning allocate Channel: res 0 [eDVBCIInterfaces] addPMTHandler 1:0:19:EF10:421:1:C00000:0:0:0: recheckPMTHAndlers() recheck 0x6f0e8ee4 1:0:19:EF10:421:1:C00000:0:0:0: check Slot 0 check Slot 1 check Slot 2 check Slot 3 allocate demux [HbbTV].aitInvalidated [SEC] lock 0 [ 149.948000] bcm4506: signal_strength -107.26dbm [ 149.979000] bcm4506: signal_strength -107.26dbm [SEC] set static current limiting [SEC] invalidate current switch params [SEC] setTone 0 (0)setTone Off [SEC] sleep 10ms [SEC] update current switch params [SEC] startTuneTimeout 5000 [SEC] setFrontend 1 (0)setting frontend (0)fe event: status 0, freq 1082250, inversion off, m_tuning 1 F [SEC] unlock [SEC] sleep 500ms (0)fe event: status 1, freq 1082250, inversion off, m_tuning 1 N (0)fe event: status 0, freq 1082250, inversion off, m_tuning 2 N [SEC] set dynamic current limiting (0)fe event: status 1f, freq 1081456, inversion off, m_tuning 3 N OURSTATE: ok [eDVBCAService] channel 0x6f47d808 running [eDVBLocalTimeHandler] channel 0x6f47d808 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 0x6f47d808 running stop[ 150.710000] start pcr0 on dmx 3 pid:ff index 5 release channel timer [EPGC] n[ 150.717000] start audio on dmx 3 pid:103 ext update in 2 [ 150.722000] audio xpt start sec no version [ 150.727000] sync is off so we enable it filtering 0012:[ 150.732000] demux-index 3 pcr0pid ff 4e ef 10 00 00[ 150.737000] using 5 as pcr0 pidchannel 00 mask: ff f[ 150.742000] AC3 f ff 00 00 00 m[ 150.746000] audio: decoder start 0 ode: 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 [ 150.762000] audio delay 18000 (200 ms) 00 eventNewProg[ 150.768000] total video delay: 18000 (200 ms) ramInfo 0 0 have 1 video stream[ 150.774000] start video0 on dmx 3 pid:ff (s) (00ff), and [ 150.780000] total video delay: 18000 (200 ms) 1 audio stream(s) (0103), and th[ 150.787000] VIDEO0: start decode e pcr pid is 00ff, and the text pid is 0020 allocate demux disable teletext subtitles decoder state: play, vpid=255, apid=259 DMX_SET_PES_FILTER(0xff) - pcr - ok DEMUX_START - pcr - ok DMX_SET_PES_FILTER(0x103) - audio - ok DEMUX_START - audio - ok AUDIO_SET_BYPASS(0) - ok AUDIO_PAUSE - ok AUDIO_PLAY - ok Video Device: /dev/dvb/adapter0/video0 demux device: /dev/dvb/adapter0/demux3 VIDEO_SET_STREAMTYPE 1 - ok DMX_SET_PES_FILTER(0xff) - video - ok DEMUX_START - video - ok VIDEO_FREEZE - ok VIDEO_PLAY - ok DMX_SET_PES_FILTER(0x20) - ttx - ok DEMUX_START - ttx - ok VIDEO_SLOWMOTION(0) - ok VIDEO_FAST_FORWARD(0) - ok VIDEO_CONTINUE - ok AUDIO_CONTINUE - ok not pauseable. [ 150.864000] bcm4506: signal_strength -109.99dbm [TeleText] serviceInfoChanged [TeleText] TXT PID 32 DEMUX 3 [TeleText] send array('B', [1, 0, 32, 3]) [ExtendedInfoBar] CAIDs: ['0000', '1830', '1843', '1860'] [ExtendedInfoBar] SID: EF10 -+ 1/2 TID 4e + 1/1 TID 00 done! PATready use pmtpid 0060 for service_id ef10 no version filtering 0060: 02 ef 10 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 doing version filtering 0000: 00 00 00 33 00 00 mask: ff 00 00 3f 00 00 mode: 00 00 00 3e[ 150.979000] bcm4506: signal_strength -108.89dbm 00 00 + 1/1 TID 02 done! [eDVBCAService] new service 1:0:19:EF10:421:1:C00000:0:0:0: [eDVBCAService] add demux 3 to slot 0 service 1:0:19:EF10:421:1:C00000:0:0:0: demux 3 mask 08 prevhash 00000000 [eDVBCAService] send 370 bytes 9f 80 32 82 01 6c 03 ef 10 19 01 52 01 81 08 00 c0 00 00 04 21 00 01 82 02 08 03 84 02 00 60 09 7f 18 30 fc cc 86 0e 00 80 11 0f 9f 20 fc 01 80 11 0d 7a 20 fc 8c 69 00 00 3d a3 0d 01 80 11 80 00 02 18 30 01 0f 9f 20 ff aa 15 02 80 11 00 00 00 64 00 03 03 21 00 00 00 02 18 30 00 00 00 64 aa 15 02 80 11 00 00 0b ea 00 03 03 21 00 00 00 02 18 30 00 00 0b ea 01 00 26 a3 0d 01 80 11 80 00 02 18 30 01 0d ab 20 ff aa 15 02 80 11 00 00 0b b8 00 03 03 21 00 00 00 02 18 43 00 00 0b b8 09 5c 18 43 f9 cc 86 0e 00 80 11 0f 9f 20 fc 01 80 11 0d 7a 20 fc 8c 46 00 00 43 8c 13 00 80 11 08 02 18 43 20 0a 09 38 59 00 0f 9f 59 00 0f 9f aa 15 03 80 11 5d 00 00 66 00 03 03 21 00 00 02 18 43 5d 00 00 66 00 aa 15 03 80 11 00 00 0b ea 00 03 03 21 00 00 02 18 43 5d 00 0b ea 00 09 04 09 c4 fb cc 09 04 09 8c fa cc 09 04 06 48 ff cc 09 4c 18 60 fe cc 8c 46 00 00 43 8c 13 00 80 11 08 02 18 60 20 0a 09 38 59 00 0f 9f 59 00 0f 9f aa 15 03 80 11 5d 00 00 68 00 03 03 21 00 00 02 18 60 5d 00 00 68 00 aa 15 03 80 11 00 00 0b ea 00 03 03 21 00 00 02 18 60 5d 00 0b ea 00 06 00 20 00 00 1b 00 ff 00 00 06 01 03 00 00 05 01 05 00 00 recheckPMTHAndlers() recheck 0x6f0e8ee4 [ 151.311000] bcm4506: signal_strength -109.39dbm 1:0:19:EF10:421:1:C00000:0:0:0: check Slot 0 check Slot 1 check Slot 2 check Slot 3 [eDVBCIInterfaces] gotPMT eventNewProgramInfo 0 0 start ait on pid 0105 no version filtering 0105: 74 00 00 00 00 00 mask: ff 00 00 00 00 00 mode: 00 00 00 00 00 00 have 1 video stream(s) (00ff), and 1 audio stream(s) (0103), and the pcr pid is 00ff, and the text pid is 0020 decoder state: play, vpid=255, apid=259 [TeleText] serviceInfoChanged [TeleText] TXT PID 32 DEMUX 3 [TeleText] send array('B', [1, 0, 32, 3]) doing version filtering 0060: 02 ef 10 19 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 ++ 2/2 TID 4e done! doing version filtering 0012: 4e ef 10 07 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 [ 151.559000] bcm4506: signal_strength -107.22dbm clear buffer Put to buffer: 9f 80 3e 0d ef 10 c1 81 ff ff 81[ 151.597000] ch0: lock [ 151.600000] RAP first pts 0x162f13df0, stc 0x17a72d85c, pcr valid [ 151.606000] RAP pts error 0 PTS 0xb1789ef8, STC 0xbd396d45, type 0 09 04 09 c4 fb cc -------- dump ca reply: 9f 80 3e 0d ef 10 c1 81 ff ff 81 09 04 09 c4 fb cc -------- [ 151.632000] ch0: lock [ 151.632000] RAP pts error 0 PTS 0xb1789ef8, STC 0xbd397227, type 1 [ 151.661000] ch0: lock [ 151.661000] RAP pts error 0 PTS 0xb1789ef8, STC 0xbd397747, type 1 [ 151.697000] ch0: lock [ 151.697000] RAP pts error 0 PTS 0xb1789ef8, STC 0xbd397d97, type 1 [ 151.725000] ch0: lock [ 152.008000] bcm4506: signal_strength -107.93dbm [eDVBLocalTimeHandler] Receiver time is 'Wed Sep 5 21:30:44 2012' [eDVBLocalTimeHandler] Transponder time is 'Wed Sep 5 21:30[ 152.027000] RAP sampling rate info isr :45 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] 2646262 bytes for cache used clear buffer Put to buffer: 9f 80 3e 0d ef 10 c1 81 ff ff 81 09 04 09 c4 fb cc -------- dump ca reply: 9f 80 3e 0d ef 10 c1 81 ff ff 81 09 04 09 c4 fb cc -------- [EPGC] start caching events(1346873446) [ 152.885000] VIDEO0: first pts 0x17a74ffe0 sdt update done! [ 153.013000] bcm4506: signal_strength -108.85dbm [ 153.040000] enable tsm0 [ 153.053000] bcm4506: signal_strength -108.85dbm + 1/1 TID 74 done! [eHbbtv] aitChanged pid=0x105 [eOipfApplication] Profile 0000, Version 1.1.1 [eOipfApplication] deu:RTL Digitaltext [eHbbtv] New Application: RTL Digitaltext (orgid=33, appid=100, urlBase=http://digitaltext.rtl.de/, initalPath=start.php, controlCode=1, visibility=2) [eHbbtv] Resolving Application Locator: dvb://current.ait/33.100 [eHbbtv] We have 1 app(s) for service 1.1057.61200 [eHbbtv] 'dvb://current.ait/33.100' resolved to 'http://digitaltext.rtl.de/start.php' [eOipfApplication] Profile 0000, Version 1.1.1 [eOipfApplication] deu:RTL Digitaltext direkt [eHbbtv] New Application: RTL Digitaltext direkt (orgid=33, appid=101, urlBase=http://digitaltext.rtl.de/, initalPath=start.php?teletext=1, controlCode=2, visibility=2) [eHbbtv] Resolving Application Locator: dvb://current.ait/33.101 [eHbbtv] We have 2 app(s) for service 1.1057.61200 [eHbbtv] 'dvb://current.ait/33.101' resolved to 'http://digitaltext.rtl.de/start.php?teletext=1' [eOipfApplication] Profile 0000, Version 1.1.1 [eOipfApplication] eng:Clipfish [eHbbtv] New Application: Clipfish (orgid=33, appid=103, urlBase=http://hbbtv.clipfish.de/, initalPath=start.php, controlCode=2, visibility=2) [eHbbtv] Resolving Application Locator: dvb://current.ait/33.103 [eHbbtv] We have 3 app(s) for service 1.1057.61200 [eHbbtv] 'dvb://current.ait/33.103' resolved to 'http://hbbtv.clipfish.de/start.php' [eOipfApplication] Profile 0000, Version 1.1.1 [eOipfApplication] deu:RTL NOW [eHbbtv] New Application: RTL NOW (orgid=33, appid=102, urlBase=http://hbbtv.rtlnow.de/, initalPath=start.php, controlCode=2, visibility=2) [eHbbtv] Resolving Application Locator: dvb://current.ait/33.102 [eHbbtv] We have 4 app(s) for service 1.1057.61200 [eHbbtv] 'dvb://current.ait/33.102' resolved to 'http://hbbtv.rtlnow.de/start.php' [HbbTV].readButtonApplicationReady, appid=33.100 [HbbTV].textApplicationReady, appid=33.101 doing version filtering 0105: 74 00 00 03 00 00 mask: ff 00 00 3f 00 00 mode: 00 00 00 3e 00 00 [ 154.082000] bcm4506: signal_strength -109.09dbm [ 154.513000] bcm4506: signal_strength -109.63dbm [FanControl2] Vlt:240 Pwm:100 Fan:4pin - BoxOn HDDon [FanControl2] aktuellRPM:900 zielRPM:1452 Temp:49.5 clear buffer Put to buffer: 9f 80 3e 0d ef 10 c1 81 ff ff 81 09 04 09 c4 fb cc -------- dump ca reply: 9f 80 3e 0d ef 10 c1 81 ff ff 81 09 04 09 c4 fb cc -------- [EPGC] abort non avail schedule other reading [EPGC] abort non avail viasat reading [EPGC] nownext finished(1346873453)