=~=~=~=~=~=~=~=~=~=~=~= PuTTY log 2013.11.16 00:20:22 =~=~=~=~=~=~=~=~=~=~=~= BCM74130011 012 K1 K2 K3 K4 K5 Shmoo Version=3.8 DDR Freq=0x0000018C %00000001% RC1=00000007 WC1=FFFFFFEC RC2=00000018 WC2=00000032 RC3=0000000F WC3=FFFFFFEA RC4=0000000F WC4=00000035 NWC=0000000F RC5=00000007 WC5=0000000F RC6=00000018 WC6=0000000F NRC=0000000F RW=00000012 WW=0000004C G=00000000 R=0000000F W=0000000F BL=00000000 RC1=00000003 RC2=00000017 BL=00000001 RC1=00000005 RC2=00000019 BL=00000002 RC1=00000004 RC2=00000015 BL=00000003 RC1=00000009 RC2=00000018 BL=00000004 RC1=00000001 RC2=00000015 BL=00000005 RC1=00000008 RC2=0000001D BL=00000006 RC1=00000003 RC2=00000019 BL=00000007 RC1=00000006 RC2=0000001F 3 COPY CODE COMPARE CODE 4567 (c) 2007,2008 Dream Multimedia GmbH. All rights reserved. Dreambox DM500HDv2 FIRST STAGE 1.3/400 {BO23456} 2ND STAGE OK, build #88 (2013-05-01) 0.000 - BCM board setup 0.002 - fp init 0.002 - ca init 0.497 - load config 0.523 - config loaded. * press [S] to enter setup lcd: BOOT #88 P23 detected! detected 2K pagesize, 128K blocksize - read config file: /boot/secondstage.conf detected jffs2 blocksize: 128kb +++++++++++++++++++++++++UUUUUUUUUUUUUUUUUUUUUUUUUUUUUUU dreamupd initialized Scanning JFFS2 FS: . | / - \ | / - \ | / - \ done. find_inode failed for name=secondstage.conf load: Failed to find inode - failed to open /boot/secondstage.conf lcd: /boot/bootlogo-dm500hdv2.elf.gz bootlogo size: 38051 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_640x480p_CVT DVI_800x600p DVI_1024x768p !DVI_1280x768p !DVI_1280x768p_Red !DVI_1280x720p_50Hz !DVI_1280x720p !DVI_1280x720p_Red !DVI_640x480p_66Hz !DVI_640x480p_70Hz !DVI_640x480p_72Hz !DVI_640x480p_75Hz !DVI_640x480p_85Hz !DVI_1280x720p_70Hz !DVI_1280x720p_72Hz !DVI_1280x720p_75Hz !DVI_1280x720p_85Hz !DVI_1280x768p_75Hz !DVI_1360x768p_60Hz !DVI_1920x1080p_60Hz_Red !Custom0 !Custom1 best supported mode is 25 using 1920x1080i (50.00 Hz) HDMI using colorspace: 1 create surface 1920 1080 Using the Small jpeg decoder library, Copyright (c) 2006, Luc Saillard parsing JPEG header.. Virtual FB Size: 1280x720 lcd: /boot/vmlinux-3.2-dm500hdv2.gz [ 0.000000] Linux version 3.2-dm500hdv2 (newnigma2@nn2build.newnigma2.to) (gcc version 4.6.4 20120303 (prerelease) (GCC) ) #1 SMP Sun Oct 6 13:41:16 CEST 2013 [ 0.000000] Fetching vars from bootloader... [ 0.000000] Early serial console at MMIO32 0x10400b00 (options '1000000n8') [ 0.000000] bootconsole [uart0] enabled [ 0.000000] Options: sata=1 enet=1 emac_1=0 no_mdio=0 docsis=0 pci=1 smp=1 moca=0 usb=1 [ 0.000000] Using 512 MB RAM (from straps) [ 0.000000] Fetch var 'memsize' = '64' [ 0.000000] CPU revision is: 0002a044 (Brcm4380) [ 0.000000] FPU revision is: 00130001 [ 0.000000] Determined physical RAM map: [ 0.000000] memory: 10000000 @ 00000000 (usable) [ 0.000000] memory: 10000000 @ 20000000 (usable) [ 0.000000] bmem: adding 58 MB LINUX region at 5 MB (0x03a0b000@0x005f5000) [ 0.000000] bmem: adding 192 MB RESERVED region at 64 MB (0x0c000000@0x04000000) [ 0.000000] bmem: adding 256 MB LINUX region at 512 MB (0x10000000@0x20000000) [ 0.000000] Zone PFN ranges: [ 0.000000] Normal 0x00000000 -> 0x00030000 [ 0.000000] Movable zone start PFN for each node [ 0.000000] early_node_map[2] active PFN ranges [ 0.000000] 0: 0x00000000 -> 0x00010000 [ 0.000000] 0: 0x00020000 -> 0x00030000 [ 0.000000] On node 0 totalpages: 131072 [ 0.000000] Normal zone: 1536 pages used for memmap [ 0.000000] Normal zone: 0 pages reserved [ 0.000000] Normal zone: 129536 pages, LIFO batch:31 [ 0.000000] PERCPU: Embedded 7 pages/cpu @81407000 s5440 r8192 d15040 u32768 [ 0.000000] pcpu-alloc: s5440 r8192 d15040 u32768 alloc=8*4096 [ 0.000000] pcpu-alloc: [0] 0 [0] 1 [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 129536 [ 0.000000] Kernel command line: ubi.mtd=root root=ubi0:rootfs rootfstype=ubifs rw console=ttyS0,115200 debug bmem=192M@64M [ 0.000000] PID hash table entries: 2048 (order: 1, 8192 bytes) [ 0.000000] Dentry cache hash table entries: 65536 (order: 6, 262144 bytes) [ 0.000000] Inode-cache hash table entries: 32768 (order: 5, 131072 bytes) [ 0.000000] Primary instruction cache 32kB, VIPT, 2-way, linesize 64 bytes. [ 0.000000] Primary data cache 64kB, 4-way, VIPT, cache aliases, linesize 64 bytes [ 0.000000] Memory: 316996k/524288k available (4740k kernel code, 207292k reserved, 1006k data, 224k init, 0k highmem) [ 0.000000] Hierarchical RCU implementation. [ 0.000000] NR_IRQS:128 [ 0.000000] Measuring MIPS counter frequency... [ 0.000000] Detected MIPS clock frequency: 405 MHz (202.505 MHz counter) [ 0.000000] Console: colour dummy device 80x25 [ 0.000000] Calibrating delay loop... 401.40 BogoMIPS (lpj=200704) [ 0.011000] pid_max: default: 32768 minimum: 301 [ 0.012000] Mount-cache hash table entries: 512 [ 0.014000] SMP: Booting CPU1... [ 0.015000] CPU revision is: 0002a044 (Brcm4380) [ 0.015000] FPU revision is: 00130001 [ 0.015000] Primary instruction cache 32kB, VIPT, 2-way, linesize 64 bytes. [ 0.015000] Primary data cache 64kB, 4-way, VIPT, cache aliases, linesize 64 bytes [ 0.026000] SMP: CPU1 is running [ 0.026000] Brought up 2 CPUs [ 0.027000] devtmpfs: initialized [ 0.031000] NET: Registered protocol family 16 [ 0.033000] PCI2.3->SDRAM window: 512 MB [ 0.040000] bio: create slab at 0 [ 0.042000] SCSI subsystem initialized [ 0.042000] libata version 3.00 loaded. [ 0.043000] usbcore: registered new interface driver usbfs [ 0.043000] usbcore: registered new interface driver hub [ 0.044000] usbcore: registered new device driver usb [ 0.045000] Advanced Linux Sound Architecture Driver Version 1.0.24. [ 0.046000] pci 0000:01:00.0: [14e4:8602] type 0 class 0x000101 [ 0.047000] PCI: found device 14e4:8602 on SATA bus, slot 0 (irq 42) [ 0.047000] pci 0000:01:00.0: reg 24: [mem 0x00000000-0x00000fff] [ 0.048000] pci 0000:01:00.0: reg 30: [mem 0x00000000-0x000007ff pref] [ 0.049000] pci 0000:01:00.0: BAR 5: assigned [mem 0x10510000-0x10510fff] [ 0.050000] pci 0000:01:00.0: BAR 5: set to [mem 0x10510000-0x10510fff] (PCI address [0x10510000-0x10510fff]) [ 0.051000] pci 0000:01:00.0: BAR 6: assigned [mem 0x10511000-0x105117ff pref] [ 0.052000] Switching to clocksource upg [ 0.065000] NET: Registered protocol family 2 [ 0.066000] IP route cache hash table entries: 4096 (order: 2, 16384 bytes) [ 0.068000] TCP established hash table entries: 16384 (order: 5, 131072 bytes) [ 0.069000] TCP bind hash table entries: 16384 (order: 5, 131072 bytes) [ 0.071000] TCP: Hash tables configured (established 16384 bind 16384) [ 0.072000] TCP reno registered [ 0.072000] UDP hash table entries: 256 (order: 1, 8192 bytes) [ 0.073000] UDP-Lite hash table entries: 256 (order: 1, 8192 bytes) [ 0.074000] NET: Registered protocol family 1 [ 0.075000] RPC: Registered named UNIX socket transport module. [ 0.076000] RPC: Registered udp transport module. [ 0.077000] RPC: Registered tcp transport module. [ 0.078000] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.079000] PCI: CLS 0 bytes, default 64 [ 0.082000] JFFS2 version 2.2. (NAND) (SUMMARY) © 2001-2006 Red Hat, Inc. [ 0.084000] SGI XFS with security attributes, large block/inode numbers, no debug enabled [ 0.086000] msgmni has been set to 619 [ 0.088000] io scheduler noop registered [ 0.089000] io scheduler cfq registered (default) [ 0.090000] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled ÿ[ 0.112000] serial8250.0: ttyS0 at MMIO 0x10400b00 (irq = 22) is a 16550A [ 0.113000] console [ttyS0] enabled, bootconsole disabled [ 0.113000] console [ttyS0] enabled, bootconsole disabled [ 0.134000] serial8250.0: ttyS1 at MMIO 0x10400b80 (irq = 67) is a 16550A [ 0.141000] loop: module loaded [ 0.141000] sata_brcmstb 0000:01:00.0: version 4.0 [ 0.142000] brcm-pm: enabling sata clocks [ 0.143000] PCI: Enabling device 0000:01:00.0 (0000 -> 0003) [ 0.143000] PCI: Setting latency timer of device 0000:01:00.0 to 64 [ 0.341000] scsi0 : sata_brcmstb [ 0.342000] scsi1 : sata_brcmstb [ 0.343000] ata1: SATA max UDMA7 mmio m4096@0x10510000 port 0x10510000 irq 42 [ 0.344000] ata2: SATA max UDMA7 mmio m4096@0x10510000 port 0x10510100 irq 42 [ 0.346000] Broadcom STB NAND controller (BrcmNand Controller) [ 0.346000] bcmemac: Broadcom STB 10/100 EMAC driver v3.0 [ 0.350000] bcmemac: registered interface #0 at 0x10080000 as 'eth0' (00:09:34:2e:93:3d) [ 0.351000] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver [ 0.352000] brcm-pm: enabling usb clocks [ 0.352000] ehci-brcm ehci-brcm.0: Broadcom STB EHCI [ 0.353000] ehci-brcm ehci-brcm.0: new USB bus registered, assigned bus number 1 [ 0.385000] ehci-brcm ehci-brcm.0: irq 62, io mem 0x10480300 [ 0.391000] ehci-brcm ehci-brcm.0: USB 0.0 started, EHCI 1.00 [ 0.392000] hub 1-0:1.0: USB hub found [ 0.393000] hub 1-0:1.0: 2 ports detected [ 0.393000] ehci-brcm ehci-brcm.1: Broadcom STB EHCI [ 0.394000] ehci-brcm ehci-brcm.1: new USB bus registered, assigned bus number 2 [ 0.426000] ehci-brcm ehci-brcm.1: irq 57, io mem 0x10480500 [ 0.432000] ehci-brcm ehci-brcm.1: USB 0.0 started, EHCI 1.00 [ 0.433000] hub 2-0:1.0: USB hub found [ 0.433000] hub 2-0:1.0: 2 ports detected [ 0.434000] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver [ 0.435000] ohci-brcm ohci-brcm.0: Broadcom STB OHCI [ 0.436000] ohci-brcm ohci-brcm.0: new USB bus registered, assigned bus number 3 [ 0.437000] ohci-brcm ohci-brcm.0: irq 63, io mem 0x10480400 [ 0.502000] hub 3-0:1.0: USB hub found [ 0.503000] hub 3-0:1.0: 2 ports detected [ 0.504000] ohci-brcm ohci-brcm.1: Broadcom STB OHCI [ 0.504000] ohci-brcm ohci-brcm.1: new USB bus registered, assigned bus number 4 [ 0.505000] ohci-brcm ohci-brcm.1: irq 64, io mem 0x10480600 [ 0.571000] hub 4-0:1.0: USB hub found [ 0.572000] hub 4-0:1.0: 2 ports detected [ 0.573000] Initializing USB Mass Storage driver... [ 0.573000] usbcore: registered new interface driver usb-storage [ 0.574000] USB Mass Storage support registered. [ 0.575000] i2c /dev entries driver [ 0.575000] ALSA device list: [ 0.576000] No soundcards found. [ 0.576000] TCP cubic registered [ 0.577000] NET: Registered protocol family 17 [ 0.577000] Registering the dns_resolver key type [ 0.578000] EBI CS1: setting up NAND flash (primary) [ 0.580000] mtd->oobsize=0, mtd->eccOobSize=0 [ 0.580000] NAND_CS_NAND_XOR=00000000 [ 0.581000] B4: NandSelect=40000202, nandConfig=18152300, chipSelect=1 [ 0.581000] brcmnand_read_id: CS1: dev_id=ecd35195 [ 0.582000] After: NandSelect=40000202, nandConfig=18152300 [ 0.583000] Block size=00020000, erase shift=17 [ 0.583000] NAND Config: Reg=18152300, chipSize=1024 MB, blockSize=128K, erase_shift=11 [ 0.584000] busWidth=1, pageSize=2048B, page_shift=11, page_mask=000007ff [ 0.585000] timing1 not adjusted: 5363444f [ 0.585000] timing2 not adjusted: 00000fc6 [ 0.586000] eccLevel=15, 1Ksector=0, oob=16 [ 0.586000] nbrBitsPerCell=2, cellinfo=0, chip->cellinfo=00000000 [ 0.587000] <--brcmnand_set_acccontrol: acc b4: f7ff1010, after: f7ff1010 [ 0.588000] BrcmNAND mfg ec d3 Samsung K9F8G08U0M 1024MB on CS1 [ 0.589000] [ 0.589000] Found NAND on CS1: ACC=f7ff1010, cfg=18152300, flashId=ecd35195, tim1=5363444f, tim2=00000fc6 [ 0.590000] BrcmNAND version = 0x0302 1024MB @00000000 [ 0.591000] B4: NandSelect=40000202, nandConfig=18152300, chipSelect=1 [ 0.591000] brcmnand_read_id: CS1: dev_id=ecd35195 [ 0.592000] After: NandSelect=40000202, nandConfig=18152300 [ 0.593000] Found NAND flash on Chip Select 1, chipSize=1024MB, usable size=1024MB, base=0 [ 0.594000] brcmnand_scan: B4 nand_select = 40000202 [ 0.594000] brcmnand_scan: After nand_select = 40000202 [ 0.595000] page_shift=11, bbt_erase_shift=17, chip_shift=30, phys_erase_shift=17 [ 0.596000] Brcm NAND controller version = 3.2 NAND flash size 1024MB @00000000 [ 0.597000] ECC layout=brcmnand_oob_bch4_4k [ 0.597000] brcmnand_scan: mtd->oobsize=64 [ 0.598000] brcmnand_scan: oobavail=50, eccsize=512, writesize=2048 [ 0.598000] brcmnand_scan, eccsize=512, writesize=2048, eccsteps=4, ecclevel=15, eccbytes=3 [ 0.599000] -->brcmnand_default_bbt [ 0.600000] brcmnand_default_bbt: bbt_td = bbt_main_descr [ 0.601000] Bad block table Bbt0 found at page 0007ffc0, version 0x01 for chip on CS1 [ 0.602000] Bad block table 1tbB found at page 0007ff80, version 0x01 for chip on CS1 [ 0.603000] nand_read_bbt: Bad block at 0x2c0e0000 [ 0.604000] brcmnandCET: Did not find CET, recreating [ 0.608000] brcmnandCET: Status -> Deferred [ 0.608000] Adjust partition complete size from 40000000 to 3ff80000 to avoid overlap with BBT reserved space [ 0.610000] Adjust partition root size from 3f800000 to 3f780000 to avoid overlap with BBT reserved space [ 0.611000] Creating 4 MTD partitions on "brcmnand.0": [ 0.612000] 0x000000000000-0x00003ff80000 : "complete" [ 0.621000] 0x000000000000-0x000000100000 : "loader" [ 0.623000] 0x000000100000-0x000000800000 : "boot" [ 0.625000] 0x000000800000-0x00003ff80000 : "root" [ 0.636000] UBI: attaching mtd3 to ubi0 [ 0.637000] UBI: physical eraseblock size: 131072 bytes (128 KiB) [ 0.638000] UBI: logical eraseblock size: 126976 bytes [ 0.638000] UBI: smallest flash I/O unit: 2048 [ 0.639000] UBI: VID header offset: 2048 (aligned 2048) [ 0.640000] UBI: data offset: 4096 [ 0.653000] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [ 0.657000] ata1.00: ATA-8: , 02.10103, max UDMA/100 [ 0.658000] ata1.00: 59047936 sectors, multi 0: LBA [ 0.661000] ata1.00: configured for UDMA/100 [ 0.662000] scsi 0:0:0:0: Direct-Access ATA 02.1 PQ: 0 ANSI: 5 [ 0.664000] sd 0:0:0:0: [sda] 59047936 512-byte logical blocks: (30.2 GB/28.1 GiB) [ 0.665000] sd 0:0:0:0: [sda] Write Protect is off [ 0.666000] sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00 [ 0.666000] sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA [ 0.674000] sda: sda1 sda2 [ 0.677000] sd 0:0:0:0: [sda] Attached SCSI disk [ 0.706000] hub 1-0:1.0: over-current condition on port 1 [ 0.909000] hub 1-0:1.0: over-current condition on port 2 [ 0.991000] ata2: SATA link down (SStatus 4 SControl 300) [ 1.112000] hub 2-0:1.0: over-current condition on port 1 [ 1.714000] hub 3-0:1.0: over-current condition [ 2.316000] hub 4-0:1.0: over-current condition [ 5.232000] UBI: max. sequence number: 434 [ 5.265000] UBI: attached mtd3 to ubi0 [ 5.266000] UBI: MTD device name: "root" [ 5.267000] UBI: MTD device size: 1015 MiB [ 5.267000] UBI: number of good PEBs: 8123 [ 5.268000] UBI: number of bad PEBs: 1 [ 5.268000] UBI: number of corrupted PEBs: 0 [ 5.269000] UBI: max. allowed volumes: 128 [ 5.269000] UBI: wear-leveling threshold: 4096 [ 5.270000] UBI: number of internal volumes: 1 [ 5.270000] UBI: number of user volumes: 2 [ 5.271000] UBI: available PEBs: 0 [ 5.271000] UBI: total number of reserved PEBs: 8123 [ 5.272000] UBI: number of PEBs reserved for bad PEB handling: 81 [ 5.273000] UBI: max/mean erase counter: 2/0 [ 5.273000] UBI: image sequence number: 1271005849 [ 5.274000] UBI: background thread "ubi_bgt0d" started, PID 51 [ 5.314000] UBIFS: recovery needed [ 5.479000] UBIFS: recovery completed [ 5.479000] UBIFS: mounted UBI device 0, volume 0, name "rootfs" [ 5.480000] UBIFS: file system size: 420163584 bytes (410316 KiB, 400 MiB, 3309 LEBs) [ 5.481000] UBIFS: journal size: 9023488 bytes (8812 KiB, 8 MiB, 72 LEBs) [ 5.482000] UBIFS: media format: w4/r0 (latest is w4/r0) [ 5.482000] UBIFS: default compressor: lzo [ 5.483000] UBIFS: reserved for root: 0 bytes (0 KiB) [ 5.484000] VFS: Mounted root (ubifs filesystem) on device 0:13. [ 5.486000] devtmpfs: mounted [ 5.487000] Freeing unused kernel memory: 224k freed INIT: version 2.88 booting Displaying bootlogo. Starting udev [ 6.058000] udevd[76]: starting version 182 [ 6.584000] stb_core: module license 'Proprietary' taints kernel. [ 6.585000] Disabling lock debugging due to kernel taint [ 8.016000] enter base init, xvd 20100413, vdc 20100413, rap 20100719, xpt 20110228 [ 8.029000] 8:28018064 SMCA: controller reset timed out [ 9.907000] register adapter [ 9.908000] register adapter [ 9.914000] register adapter [ 9.915000] register adapter [ 9.925000] FP Version 1 [ 9.926000] input: dreambox front panel as /devices/virtual/input/input0 [ 9.934000] set sb to 3(2) [ 9.935000] set fb to 2(-1) [ 9.935000] set input to 0 [ 9.936000] set fb to 2(-1) [ 9.942000] bcm_video_analog_port_setup (fmt=7) [ 9.942000] SET FORMAT: display[1], format=7 [ 9.943000] display 0 uses vbi path 1 [ 9.944000] display 1 uses vbi path 0 [ 9.945000] HDMI: now connected [ 9.978000] HDMI: EDID read ok [ 9.978000] HDMI: initial mode set! [ 9.979000] using 50.00Hz as MonitorRefreshRate [ 9.979000] SET FORMAT: display[0], format=37 [ 9.980000] HDMI mode [ 9.980000] use EDID to detect colorspace [ 9.980000] using colorspace: 1 [ 10.007000] HDMI: use logical CEC address 3 [ 10.036000] set fb to 2(0) [ 10.036000] bcm_video_analog_port_setup (fmt=7) [ 10.036000] SET FORMAT: display[1], format=7 [ 10.042000] disable wss on display 0 [ 10.042000] disable wss on display 1 [ 10.043000] bcmfb: creating surface with pixel format 0x07e48888 (BPXL_eA8_R8_G8_B8) [ 10.145000] CEC send ok! [ 10.180000] enable mad [ 10.222000] VIDEO0: set fallback framerate to 60000 [ 10.222000] VIDEO0: set progressive override mode to 1 [ 10.223000] VIDEO0: set streamtype! [ 10.224000] set MPEG2 [ 10.224000] sw rave disabled! [ 10.226000] enable mad [ 10.226000] VIDEO1: set fallback framerate to 60000 [ 10.227000] VIDEO1: set progressive override mode to 1 [ 10.228000] VIDEO1: set streamtype! [ 10.228000] set MPEG2 [ 10.228000] sw rave disabled! [ 10.232000] sync is off so we enable it [ 10.233000] playback! [ 10.233000] total video delay: 0 (0 ms) [ 10.237000] VIDEO0: start decode [ 10.237000] flush video decoder [ 10.237000] VIDEO0 got pts failed !!!! (ret 0) [ 11.636000] CEC recv ok! [ 11.636000] set ac3 to downmix [ 11.636000] set ac3plus to use_hdmi_caps [ 11.636000] set aac to downmix [ 11.636000] init ALSA! [ 11.638000] CEC recv ok! [ 11.661000] VIDEO0: first pts 0x0 [ 11.695000] DVB: registering new adapter (BCM7405) [ 11.713000] autodetecting NIMs... [ 11.714000] Initializing adapter 0 (BCM4505-DVB-S2) [ 11.780000] bcm4506: found 4505, revision 0(b0) [ 11.781000] bcm4506: bcm_initAP [ 11.788000] bcm4506: upload & start firmware [ 11.812000] enable tsm0 [ 13.828000] bcm4506: bcm4506: ap not running - start now [ 13.882000] bcm4506: uCode 0x61 [ 13.899000] bcm4506: no bcm3445 detected [ 13.912000] DVB: registering adapter 0 frontend 0 (bcm4506)... [ 15.101000] VIDEO0: stop decode [ 15.102000] no decoder left in sync handling so disable xpt_sync [ 15.105000] registered vtuner misc/vtuner0, minor 58 [ 15.107000] registered vtuner misc/vtuner1, minor 57 [ 15.107000] IR-TX init! [ 15.239000] VIDEO0: set blank to 0 [ 15.240000] sync is off so we enable it [ 15.241000] playback! [ 15.241000] total video delay: 0 (0 ms) [ 15.245000] VIDEO0: start decode [ 15.246000] flush video decoder [ 15.281000] VIDEO0: first pts 0x0 [ 15.282000] VIDEO0: framerate changed 3 [ 15.282000] VIDEO0: resolution changed (1280 720) [ 15.283000] VIDEO0: aspect changed 3 [ 15.341000] set current avs auto aspect to 16:9 [ 15.342000] disable wss on display 0 [ 15.342000] disable wss on display 1 [ 15.343000] set current avs auto aspect to 16:9 [ 15.343000] disable wss on display 0 [ 15.344000] disable wss on display 1 [ 15.344000] set sb to 3(1) [ 15.402000] VIDEO0: set blank to 0 [ 15.403000] VIDEO0: stop decode [ 15.404000] VIDEO0: set blank to 0 [ 15.404000] no decoder left in sync handling so disable xpt_sync [ 18.152000] input: dreambox remote control (native) as /devices/virtual/input/input1 [ 18.156000] input: dreambox advanced remote control (native) as /devices/virtual/input/input2 [ 18.169000] input: dreambox ir keyboard as /devices/virtual/input/input3 [ 18.174000] input: dreambox ir mouse as /devices/virtual/input/input4 mkdir /dev/shm..... [ 18.398000] CEC recv ok! [ 18.451000] CEC recv ok! [ 18.592000] CEC recv ok! [ 18.844000] UBIFS: recovery needed [ 18.874000] UBIFS: recovery completed [ 18.875000] UBIFS: mounted UBI device 0, volume 1, name "data" [ 18.876000] UBIFS: file system size: 597041152 bytes (583048 KiB, 569 MiB, 4702 LEBs) [ 18.876000] UBIFS: journal size: 29839360 bytes (29140 KiB, 28 MiB, 235 LEBs) [ 18.877000] UBIFS: media format: w4/r0 (latest is w4/r0) [ 18.878000] UBIFS: default compressor: lzo [ 18.879000] UBIFS: reserved for root: 4952683 bytes (4836 KiB) [ 18.890000] kjournald starting. Commit interval 5 seconds [ 18.891000] EXT3-fs (sda1): using internal journal [ 18.892000] EXT3-fs (sda1): mounted filesystem with writeback data mode Configuring network interfaces... done. rdate: current time matches remote time Starting rdate timesync...: Sync donenet.ipv4.conf.default.rp_filter = 1 net.ipv4.conf.all.rp_filter = 1 Starting tpmd. INIT: Entering runlevel: 3 Starting system message bus: dbus. Starting Dropbear SSH server: dropbear. Starting automounter: loading autofs4 kernel module, done. Starting dbttcd. Starting default emu. Starting syslogd/klogd: done Starting internet superserver: xinetd. * Starting Avahi mDNS/DNS-SD Daemon: avahi-daemon ...done. * starting eDaemon: eDaemon... done. [SCRIPT] start: OScam unstable #8779 [ 22.434000] VIDEO0: set blank to 0 [ 22.437000] sync is off so we enable it [ 22.437000] playback! [ 22.437000] total video delay: 0 (0 ms) [ 22.442000] VIDEO0: start decode [ 22.443000] flush video decoder [ 22.482000] VIDEO0: first pts 0x0 [ 22.600000] VIDEO0: set blank to 0 [ 22.602000] VIDEO0: stop decode [ 22.602000] VIDEO0: set blank to 0 [ 22.603000] no decoder left in sync handling so disable xpt_sync Enigma2 v4.0.0 (revision: tarball-20131001-0-gc2bc732, date: 2013-10-01) 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. enigma2 is the main pvr application... adjust oom score! PYTHONPATH: /usr/lib/enigma2/python + (1) Background File Eraser before: 1 after: 1 setIoPrio best-effort level 7 ok + (8) graphics acceleration manager + (9) GFBDC 16384k video mem [ 27.400000] bcmfb: enable manual blit [ 27.419000] 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 couldn't open LCD - load lcd.o! lcd buffer 0x8680e8 8448 bytes, stride 132 + (9) Font Render Class [FONT] initializing lib... [FONT] loading fonts... [FONT] Intializing font cache, using max. 4MB... + (10) gRC RC thread created successfully + (15) eWindowStyleManager + (20) DVB-CI UI + (20) UHF Modulator couldnt open /dev/rfmod0!!!! + (20) RC Input layer + (20) misc options + (20) HDMI CEC Subsystem attached: hdmi attached attached: hdmi cec address acknowledged my physical: 1.0.0.0 logical 3 + (20) AVSwitch Driver couldnt open /dev/dbox/fp0 to monitor vcr scart slow blanking changed! + (21) input device driver Input device "dreambox front panel" is a remotecontrol Input device "dreambox remote control (native)" is a remotecontrol Input device "dreambox advanced remote control (native)" is a remotecontrol Input device "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.. cannot open /proc/stb/tsmux/input0 cannot open /proc/stb/tsmux/input1 done, found 0 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 4129 services scanning for frontends.. opening frontend 0 [ 28.292000] bcm4506: channel 0 is in normale mode now detected satellite frontend (0)setTone Off (0)setVoltage 0V close frontend 0 scanning for demux.. scanning for decoders.. scanning for descramblers.. [ 28.305000] bcm4506: channel 0 is sleeping now found 1 adapter, 1 frontends(1 sim) and 5 demux, boxtype 6 [eDVBLocalTimeHandler] Use valid Linux Time 'Sat Nov 16 00:20:51 2013' :) (RTC?) [EPGC] Initialized EPGCache (wait for setCacheFile call now) Loading spinners... found 6 spinners! executing main setIoPrio best-effort level 6 ok main thread is non-idle! display spinner! couldn't open fp [setupConfigEntries] initial_call for stored uuid: d941b336-6b95-46a6-ab0f-23d3f176a823 {'device_info': 'eSATA', 'device_description': 'ATA- (30.232 GB)'} [setupConfigEntries] initial_call for stored uuid: 8eebf952-20ce-42a3-8cdf-71c55f64341e {'mountpoint': '/media/hdd', 'device_info': 'eSATA', 'device_description': 'ATA- (30.232 GB)', 'enabled': 'true'} enumerating block devices... found block device 'loop0': blacklisted found block device 'loop1': blacklisted found block device 'loop2': blacklisted found block device 'loop3': blacklisted found block device 'loop4': blacklisted found block device 'loop5': blacklisted found block device 'loop6': blacklisted found block device 'loop7': 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', 'sda2'] 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' [ 30.669000] fuse init (API version 7.17) Harddisk.py: failed to read /sys/block/sda1/removable found block device 'sda1': error querying properties [addDevicePartition] device:'sda1' with UUID:'8eebf952-20ce-42a3-8cdf-71c55f64341e' Harddisk.py: failed to read /sys/block/sda2/removable found block device 'sda2': error querying properties [addDevicePartition] device:'sda2' with UUID:'d941b336-6b95-46a6-ab0f-23d3f176a823' [setupConfigEntries] new device add for 'sda2' with uuid:'d941b336-6b95-46a6-ab0f-23d3f176a823' main thread is non-idle! display spinner! [enumerateBlockDevices] devices_scanned_on_init: [('sda', False, False, True)] Reading satellites.xml sec config cleared setSlotInfo for dvb frontend 0 to slotid 0, descr BCM4505, need rotorworkaround No, enabled Yes, DVB-S2 Yes slot: 0 configmode: simple diseqcmode: diseqc_a_b_c_d sec config completed not loading user skin: [Errno 2] No such file or directory: '/etc/enigma2/skin_user.xml' Preferred tag editor set to None [ 33.913000] CEC recv ok! [ 33.966000] CEC recv ok! [ 34.096000] CEC recv ok! loading bouquet... /etc/enigma2/bouquets.tv loading bouquet... /etc/enigma2/userbouquet.favourites.tv 89 entries in Bouquet userbouquet.favourites.tv loading bouquet... /etc/enigma2/userbouquet.kinder__tv_.tv 10 entries in Bouquet userbouquet.kinder__tv_.tv loading bouquet... /etc/enigma2/userbouquet.sdsender__tv_.tv 14 entries in Bouquet userbouquet.sdsender__tv_.tv loading bouquet... /etc/enigma2/userbouquet.erotik__tv_.tv 15 entries in Bouquet userbouquet.erotik__tv_.tv 4 entries in Bouquet bouquets.tv loading bouquet... /etc/enigma2/bouquets.radio loading bouquet... /etc/enigma2/userbouquet.favourites.radio 0 entries in Bouquet userbouquet.favourites.radio 1 entries in Bouquet bouquets.radio [eDVBLocalTimeHandler] enable sync local time with transponder time! APIs: ['api', 'api.enigma2', 'api.enigma2.systeminfo', 'api.enigma2.servicedata'] Functions: ['api._API__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.getAllTransponderList', 'api.enigma2.servicedata.getRadioProviders', 'api.enigma2.servicedata.getServicePIDs', 'api.enigma2.servicedata.convertTransponderInfoHumanReadable', 'api.enigma2.servicedata.getRadioServices', 'api.enigma2.servicedata.getTVProviders', 'api.enigma2.servicedata._API__needsSession', 'api.enigma2.servicedata.getTransponderList', 'api.enigma2.servicedata.getTransponderInfo', 'api.enigma2.servicedata.getSatList', 'api.enigma2.servicedata.getServiceList', 'api.enigma2.servicedata.getServiceName', 'api.enigma2.servicedata.getTVServices', 'api.enigma2.servicedata.getAllServices', 'api.enigma2.servicedata._API__session', 'api.enigma2.servicedata.getCurrentService', 'api.enigma2.servicedata.playService', 'api.enigma2.servicedata.getTVBouquets', 'api.enigma2.servicedata.getRadioBouquets'] [ePopen] command: ip -o addr show dev eth0 [ResourceManager] adding: iNetwork add dreampackage scanner plugin added [FONT] adding font /usr/share/fonts/nmsbd.ttf...OK (Display) [ 37.414000] 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/fonts/nmsbd.ttf...OK (Arial) [FONT] adding font /usr/share/enigma2/DMConcinnity-HD/fonts/HandelGotDBol.ttf...OK (Regular) [ 37.842000] set current avs auto aspect to 4:3 [ 37.842000] disable wss on display 0 [ 37.843000] disable wss on display 1 [ 37.843000] set sb to 3(2) [ 37.882000] set current avs auto aspect to 4:3 [ 37.882000] disable wss on display 0 [ 37.883000] disable wss on display 1 [ 37.883000] set sb to 3(2) [ 37.886000] disable wss on display 0 [ 37.886000] set wss 8 on display 1 [ 37.923000] set input to 0 [ 37.923000] set fb to 2(0) [ 37.924000] set current avs auto aspect to 4:3 [ 37.924000] disable wss on display 0 [ 37.925000] set wss 8 on display 1 [ 37.926000] set sb to 3(2) [ 37.930000] set ac3 to downmix [ 37.936000] set ac3plus to use_hdmi_caps --> setting scaler_sharpness to: 0000000D Activating keymap: Dreambox Keyboard Deutsch [ePopen] command: loadkmap < /usr/share/keymaps/dream-de.kmap Activating language German language set to de_DE [WebInterface] set language to de [WebInterface] set language to de [WebInterface] set language to de [Foreca Ver. 3.0.8] Debug disabled [Foreca Ver. 3.0.8] Collating sequence undeterminable; default used [Foreca Ver. 3.0.8] Setup... [WebInterface] fallback to default translation for Webinterface [TeleText] set language to [de] [TeleText] set language to [de] [TeleText] fallback to default translation for bilinear [TeleText] plugins [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 [ 48.121000] set current avs auto aspect to 16:9 [ 48.122000] disable wss on display 0 [ 48.123000] set wss 7 on display 1 [ 48.123000] set sb to 3(1) [ 48.162000] set current avs auto aspect to 16:9 [ 48.162000] disable wss on display 0 [ 48.163000] set wss 7 on display 1 [ 48.163000] set sb to 3(1) [ 48.165000] disable wss on display 0 [ 48.165000] set wss 7 on display 1 [ 48.167000] set current avs auto aspect to 16:9 [ 48.168000] disable wss on display 0 [ 48.168000] set wss 7 on display 1 [ 48.169000] set sb to 3(1) -> setting aspect, policy, policy2, wss 16:9 bestfit bestfit auto [ 48.174000] set current avs auto aspect to 16:9 [ 48.175000] disable wss on display 0 [ 48.175000] set wss 7 on display 1 [ 48.176000] set sb to 3(1) [ 48.178000] set current avs auto aspect to 16:9 [ 48.178000] disable wss on display 0 [ 48.179000] set wss 7 on display 1 [ 48.179000] set sb to 3(1) [ 48.181000] disable wss on display 0 [ 48.182000] set wss 7 on display 1 [ 48.185000] set current avs auto aspect to 16:9 [ 48.186000] disable wss on display 0 [ 48.186000] set wss 7 on display 1 [ 48.187000] set sb to 3(1) -> setting aspect, policy, policy2, wss 16:9 bestfit bestfit auto [ 48.192000] set current avs auto aspect to 16:9 [ 48.193000] disable wss on display 0 [ 48.193000] set wss 7 on display 1 [ 48.194000] set sb to 3(1) [ 48.196000] set current avs auto aspect to 16:9 [ 48.196000] disable wss on display 0 [ 48.197000] set wss 7 on display 1 [ 48.197000] set sb to 3(1) [ 48.199000] disable wss on display 0 [ 48.200000] set wss 7 on display 1 [ 48.202000] set current avs auto aspect to 16:9 [ 48.202000] disable wss on display 0 [ 48.203000] set wss 7 on display 1 [ 48.203000] set sb to 3(1) -> setting aspect, policy, policy2, wss 16:9 bestfit bestfit auto [ 48.209000] set current avs auto aspect to 16:9 [ 48.209000] disable wss on display 0 [ 48.210000] set wss 7 on display 1 [ 48.210000] set sb to 3(1) [ 48.212000] set current avs auto aspect to 16:9 [ 48.213000] disable wss on display 0 [ 48.213000] set wss 7 on display 1 [ 48.214000] set sb to 3(1) [ 48.216000] disable wss on display 0 [ 48.216000] set wss 7 on display 1 [ 48.218000] set current avs auto aspect to 16:9 [ 48.219000] disable wss on display 0 [ 48.219000] set wss 7 on display 1 [ 48.219000] set sb to 3(1) setMode - port: DVI mode: 1080i rate: multi [ 48.242000] using 50.00Hz as MonitorRefreshRate [ 48.361000] SET FORMAT: display[0], format=27 [ 48.362000] HDMI mode [ 48.362000] use EDID to detect colorspace [ 48.363000] using colorspace: 1 [ 48.443000] bcm_video_analog_port_setup (fmt=7) [ 48.562000] SET FORMAT: display[1], format=7 [ 48.682000] set current avs auto aspect to 16:9 [ 48.682000] disable wss on display 0 [ 48.683000] set wss 7 on display 1 [ 48.684000] set sb to 3(1) [ 48.686000] set current avs auto aspect to 16:9 [ 48.686000] disable wss on display 0 [ 48.687000] set wss 7 on display 1 [ 48.687000] set sb to 3(1) -> setting aspect, policy, policy2, wss 16:9 bestfit bestfit auto [ 48.694000] set current avs auto aspect to 16:9 [ 48.695000] disable wss on display 0 [ 48.695000] set wss 7 on display 1 [ 48.696000] set sb to 3(1) [ 48.698000] set current avs auto aspect to 16:9 [ 48.699000] disable wss on display 0 [ 48.699000] set wss 7 on display 1 [ 48.700000] set sb to 3(1) [ 48.701000] disable wss on display 0 [ 48.701000] set wss 7 on display 1 [ 48.703000] set current avs auto aspect to 16:9 [ 48.704000] disable wss on display 0 [ 48.704000] set wss 7 on display 1 [ 48.705000] set sb to 3(1) sh: fpupgrade: not found /usr/share/enigma2/ [OSD preference] did not found: /usr/share/enigma2/DMConcinnity-HD/icons/beta_g.png [FONT] adding font /usr/share/fonts/nmsbd.ttf...OK (LCD_NN) [ 49.590000] CEC recv ok! [ 49.644000] CEC recv ok! [ 49.774000] CEC recv ok! [eCamdCtrl] starting cmd 5 [eCamdCtrl] executing /usr/bin/camdctrl current [TeleText] autostart(0, {}) [CrashlogAutoSubmit] - autostart starting hotplug handler couldn't open /proc/stb/misc/12V_output [WebInterface] set language to de [WebInterface] set language to de [WebInterface] set language to de [TeleText] set language to [de] [TeleText] set language to [de] [AudioSync] set language to de [AudioSync] set language to de It's now Sat Nov 16 00:21:13 2013 [timer.py] next activation: 1384557773 (in 99039 ms) It's now Sat Nov 16 00:21:13 2013 [timer.py] next activation: 1384557773 (in 99032 ms) [Elektro] Starting up Version 3.4.5b [Elektro] add standby notification [Elektro] Set up sleep timer Looking for embedded skin [TeleText] ----- sessionstart(<__main__.Session instance at 0x1a55fd0>) ----- [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 [ResourceManager] adding: NetworkAdapterSelection [ResourceManager] adding: AdapterSetup [CrashlogAutoSubmit] - autostart [CrashlogAutoSubmit] - getMailExchange [AutomaticTimerlistCleanUp] Starting AutomaticTimerlistCleanUp... [AutomaticTimerlistCleanUp] Cleaning up timerlist-entries older than Sat Nov 16 00:21:14 2013 [AutomaticTimerlistCleanUp] Next automatic timerlist cleanup at Sun Nov 17 00:21:14 2013 [InstallerUpdateCheck] timer changed [InstallerUpdateCheck] next check at Sat Nov 23 00:21:14 2013 [InstallerUpdateCheck] Check... [CamdresetEveryDay] next reset: Sat Nov 16 23:45:13 2013 No skin to read... [StartService] is on No skin to read... Looking for embedded skin [Toplevel.importExternalModules] Imported external module: Example [Toplevel.importExternalModules] Could NOT import external module: EPGRefresh [Toplevel.importExternalModules] Exception Caught No module named EPGRefresh.EPGRefreshResource [HTTPRootResource}.__init__ [Webinterface] started on 0.0.0.0:80 auth=False ssl=False [WebInterface.registerBonjourService] No module named Bonjour.Bonjour [HTTPRootResource}.__init__ [Webinterface] started on 0.0.0.0:443 auth=True ssl=True [WebInterface.registerBonjourService] No module named Bonjour.Bonjour [EPGC] set outdated epg timespan to 0 hours... [EPGC] set cache timespan to 28 days! [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 setValue 50 [ 53.121000] 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: 50 50 (raw) Setvolume: 32 32 (-1db) [EPGC] 2921 events read from /media/hdd/epg.dat [EPGC] load 4133 descriptors...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! finished [EPGC] start cleanloop allocating new converter! allocating new converter! [EPGC] stop cleanloop [EPGC] 647475 bytes for cache used [Picon Renderer] Exception caught here warning, skin is missing element UnhandledKeyPixmap in allocating new converter! allocating new converter! allocating new converter! reused converter! RemovePopup, id = ZapError [HbbTV] connecting callbacks [HbbTV] disconnecting callbacks [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! 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! reused 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! 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! reused converter! allocating new converter! allocating new converter! reused converter! reused converter! reused converter! reused converter! reused converter! allocating new converter! allocating new converter! allocating new converter! [NotificationQueue::popNotification] domain default deferred_callable: False enter standby [ 54.640000] set mute 1 (000) 1 cannot open /proc/stb/audio/j1_mute(No such file or directory) stopService [ 54.643000] set input to 1 [ 54.643000] set fb to 2(0) [ 54.662000] set sb to 3(0) allocating new converter! reused converter! reused converter! reused converter! [Picon Renderer] Exception caught here [Cec] power off [FanControl]: setting fan values (standby mode): fanid = 0, voltage = 5, pwm = 0 cec event! attached: hdmi attached attached: hdmi cec address acknowledged my physical: 1.0.0.0 logical 3 child has terminated pipes closed [ePopen] command: route -n | grep eth0 child has terminated pipes closed child has terminated pipes closed poll: unhandled POLLERR/HUP/NVAL for fd 38(16) poll: unhandled POLLERR/HUP/NVAL for fd 39(16) poll: unhandled POLLERR/HUP/NVAL for fd 42(16) child has terminated pipes closed poll: unhandled POLLERR/HUP/NVAL for fd 54(16) child has terminated pipes closed poll: unhandled POLLERR/HUP/NVAL for fd 64(16) cec event! handle message 0 -> 3 : 89 01 Vendor Command child has terminated pipes closed 0.0.0.0 169.254 192.168 nameservers: [[8, 8, 8, 8], [8, 8, 4, 4]] read configured interface: {'lo': {'dhcp': False}, 'eth0': {'dhcp': False, 'netmask': [255, 255, 255, 0], 'gateway': [192, 168, 178, 1], 'address': [192, 168, 178, 24]}} self.ifaces after loading: {'eth0': {'preup': False, 'predown': False, 'ip': [192, 168, 178, 24], 'up': True, 'dns-nameservers': '\tdns-nameservers 8.8.8.8 8.8.4.4\n', 'broadcast': '\tbroadcast 192.168.178.255\n', 'mac': '00:09:34:2e:93:3d', 'dhcp': False, 'bcast': [192, 168, 178, 255], 'netmask': [255, 255, 255, 0], 'gateway': [192, 168, 178, 1]}} poll: unhandled POLLERR/HUP/NVAL for fd 65(16) cec event! send 3 -> 0 : 00 89 00 [CrashlogAutoSubmit] gotMXServer: 82.149.226.184 [CrashlogAutoSubmit] - mxServerFound --> 82.149.226.184 [CrashlogAutoSubmit] - no crashlogs found. [ 55.199000] CEC send ok! child has terminated pipes closed [InstallerUpdateCheck] No updates available [InstallerUpdateCheck] next check at Sat Nov 23 00:21:19 2013 poll: unhandled POLLERR/HUP/NVAL for fd 37(16) nr_read 859 nr_write 5 sum 864 prev_sum 0 hdd was accessed since previous check! [IDLE] 0 60 False action -> StandbyActions power libpagecache exists... drop caches now! leave standby [ 62.595000] set input to 0 [ 62.596000] set fb to 2(0) [ 62.596000] using 50.00Hz as MonitorRefreshRate [ 62.702000] SET FORMAT: display[0], format=27 [ 62.702000] HDMI mode [ 62.703000] use EDID to detect colorspace [ 62.703000] using colorspace: 1 [ 62.782000] bcm_video_analog_port_setup (fmt=7) [ 62.902000] SET FORMAT: display[1], format=7 [ 63.021000] set current avs auto aspect to 16:9 [ 63.022000] disable wss on display 0 [ 63.023000] set wss 7 on display 1 [ 63.024000] set sb to 3(1) [ 63.025000] set mute 0 (000) 1 cannot open /proc/stb/audio/j1_mute(No such file or directory) [Cec] power on [FanControl]: setting fan values: fanid = 0, voltage = 15, pwm = 0 playing 1:0:19:283D:3FB:1:C00000:0:0:0: realpath /etc/enigma2/virtsubmapping.txt: No such file or directory can't open /etc/enigma2/virtsubmapping.txt: No such file or directory [Picon Renderer] not found: /picons/piconHD/DAS ERSTE HD.png [TeleText] service started not pauseable. RemovePopup, id = ZapError allocate channel.. 03fb:0001:00c00000 opening frontend 0 [ 63.168000] bcm4506: channel 0 is in normale mode now [eDVBCAService] new channel 0x6ff7a298! (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 0x6ff5e574 1:0:19:283D:3FB:1:C00000:0:0:0: allocate demux [HbbTV].aitInvalidated [ 63.249000] bcm4506: signal_strength -289.87dbm nr_read 860 nr_write 9 sum 869 prev_sum 864 hdd was accessed since previous check! [IDLE] 0 60 False cec event! send 3 -> 0 : 04 playing 1:0:19:EF10:421:1:C00000:0:0:0: recheckPMTHAndlers() [ 63.338000] CEC send ok! [TeleText] service stopped [TeleText] send array('B', [1, 0, 0, 0]) [ExtendedInfoBar] __evEnd: self.timer.stop start release channel timer [Picon Renderer] not found: /picons/piconHD/RTL HD.png [TeleText] service started [ZaptoService] was called unnecessary! not pauseable. RemovePopup, id = ZapError [eDVBCAService] remove channel 0x6ff7a298 [eDVBLocalTimeHandler] remove channel 0x6ff7a298 [eEPGCache] remove channel 0x6ff7a298 (0) preClose allocate channel.. 0421:0001:00c00000 [eDVBCAService] new channel 0x6ff78ad8! (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 0x6ff5e574 1:0:19:EF10:421:1:C00000:0:0:0: allocate demux [HbbTV].aitInvalidated cec event! send 3 -> f : 82 10 00 [SEC] lock 0 [SEC] set static current limiting [SEC] setVoltage 2 (0)setVoltage 18V [SEC] sleep 400ms [ 63.665000] CEC send ok! [SEC] invalidate current switch params [SEC] sendDiseqc: e01003(DiSEqC peripherial power on) [SEC] sleep 150ms [SEC] sendDiseqc: e01038f2 [SEC] sleep 50ms [ 64.266000] bcm4506: signal_strength -289.87dbm [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 [ExtendedInfoBar] CAIDs: ['0000', '1830', '1843', '1860'] [ExtendedInfoBar] SID: EF10 [ 64.654000] CEC recv ok! cec event! handle message 0 -> 3 : 89 01 Vendor Command cec event! send 3 -> 0 : 00 89 00 (0)fe event: status 0, freq 1082250, inversion off, m_tuning 2 N [ 64.765000] CEC send ok! [SEC] set dynamic current limiting (0)fe event: status 1f, freq 1083156, inversion off, m_tuning 3 N OURSTATE: ok [eDVBCAService] channel 0x6ff78ad8 running [eDVBLocalTimeHandler] channel 0x6ff78ad8 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 0x6ff78ad8 running stop release channel timer [EPGC] next update in 2 sec no version filtering 0012: 4e ef 10 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 ok ... now we start!! no version filtering 0000: 00 00 00 00 00 00 mask: ff 00 00 00 00 00 mode: 00 00 00 00 00 00 eventNewProgramInfo 0 0 have 1 video stream(s) (00ff), and 1 audio stream(s) (0103), and the 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 [ 64.941000] start pcr0 on dmx 3 pid:ff index 5 - ok DMX_SET_PES_FILTER(0x103) - audio - ok DEMUX_START - audio - ok AUDIO_SET_BYPASS(0) - [ 64.945000] start audio on dmx 3 pid:103 [ 64.946000] audio xpt start [ 64.946000] sync is off so we enable it [ 64.946000] demux-index 3 pcr0pid ff [ 64.947000] using 5 as pcr0 pidchannel [ 64.948000] AC3 [ 64.948000] audio: streamtype set 1 [ 64.949000] audio: streamtype_set: stop rave [ 64.949000] decode [ 64.950000] audio: streamtype_set: restart rave [ 64.951000] set mute 0 (111) 1 ok AUDIO_PAUSE - ok AUDIO_PLAY - [ 64.953000] audio: decoder start 2 [ 64.956000] video delay 0 (0 ms) [ 64.956000] total video delay: 0 (0 ms) ok Video Device: /dev/dvb/adapter0/video0 demux de[ 64.958000] VIDEO0: set streamtype! vice: /dev/dvb/a[ 64.959000] set H264 dapter0/demux3 [ 64.959000] sw rave disabled! VIDEO_SET_STREAM[ 64.959000] audio delay 18000 (200 ms) TYPE 1 - [ 64.960000] total video delay: 18000 (200 ms) ok DMX_SET_PES_FILTER(0xff) - video - ok DEMUX_START - video - [ 64.963000] start video0 on dmx 3 pid:ff [ 64.963000] total video delay: 18000 (200 ms) ok VIDEO_FREEZE - ok VIDEO_PLAY - [ 64.967000] VIDEO0: start decode 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 AUDIO_CHANNEL_SELECT(0) - ok not pauseable. [ 65.043000] bcm4506: signal_strength -117.54dbm [ 65.050000] bcm4506: signal_strength -117.54dbm [ 65.054000] bcm4506: signal_strength -117.54dbm [TeleText] serviceInfoChanged [TeleText] TXT PID 32 DEMUX 3 [TeleText] send array('B', [1, 0, 32, 3]) + 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 0f 00 00 mask: ff 00 00 3f 00 00 mode: 00 00 00 3e 00 00 VIDEO_GET_EVENT - ok VIDEO_GET_EVENT - ok [ 65.281000] bcm4506: signal_strength -116.79dbm [ 65.287000] bcm4506: signal_strength -116.79dbm [ 65.291000] bcm4506: signal_strength -116.79dbm + 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 436 bytes 9f 80 32 82 01 ae 03 ef 10 03 01 8a 01 81 08 00 c0 00 00 04 21 00 01 82 02 08 03 84 02 00 60 09 6f 18 30 fc cc 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 7b 18 43 f9 cc 8c 75 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 01 00 2c 8c 13 00 80 11 08 02 18 43 20 0a 09 38 59 00 0d 7a 59 00 0d 7a aa 15 03 80 11 5d 00 0b b8 00 03 03 21 00 00 02 18 43 5d 00 0b b8 00 09 04 09 c4 fb cc 09 04 09 8c fa cc 09 7b 18 60 fe cc 8c 75 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 01 00 2c 8c 13 00 80 11 08 02 18 60 20 0a 09 38 59 00 0d 7a 59 00 0d 7a aa 15 03 80 11 5d 00 0b b8 00 03 03 21 00 00 02 18 60 5d 00 0b b8 00 06 00 20 00 00 1b 00 ff 00 00 06 01 03 00 00 05 01 05 00 00 0b 01 06 00 00 0c 01 07 00 00 recheckPMTHAndlers() recheck 0x6ff5e574 1:0:19:EF10:421:1:C00000:0:0:0: HBBTV broadcast data on pid 0106 [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 HBBTV broadcast data on pid 0106 [ 65.499000] bcm4506: signal_strength -116.23dbm [ 65.505000] bcm4506: signal_strength -116.23dbm [ 65.509000] bcm4506: signal_strength -116.23dbm [TeleText] serviceInfoChanged [TeleText] TXT PID 32 DEMUX 3 [TeleText] send array('B', [1, 0, 32, 3]) doing version filtering 0060: 02 ef 10 03 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 +- 1/2 TID 4e [ 65.615000] RAP first pts 0x1eb8d9dc6, stc 0x1680c83b6, pcr valid [ 65.617000] audio_cdb_itb_error_isr! underflow [ 65.621000] audio_cdb_itb_error_isr! underflow [ 65.625000] audio_cdb_itb_error_isr! underflow [ 65.629000] audio_cdb_itb_error_isr! underflow [ 65.633000] audio_cdb_itb_error_isr! underflow [ 65.637000] audio_cdb_itb_error_isr! underflow [ 65.641000] audio_cdb_itb_error_isr! underflow [ 65.645000] audio_cdb_itb_error_isr! underflow [ 65.649000] audio_cdb_itb_error_isr! underflow [ 65.653000] audio_cdb_itb_error_isr! underflow [ 65.712000] CEC recv ok! cec event! handle message 0 -> f : 87 00 e0 91 Device Vendor ID 00e091 [ 65.765000] CEC recv ok! cec event! handle message 0 -> 3 : [ 65.806000] ch0: lock [ 65.906000] CEC recv ok! cec event! handle message 0 -> 3 : 89 01 Vendor Command cec event! send 3 -> 0 : 00 89 00 + 1/1 TID 74 done! [eHbbtv] aitChanged pid=0x105 [eOipfApplication] Profile 0000, Version 1.1.1 [eOipfApplication] deu:Clipfish Comedy [eHbbtv] New Application: Clipfish Comedy (orgid=33, appid=106, urlBase=http://comedy.hbbtv.clipfish.de/, initalPath=index.php, controlCode=2, visibility=2) [eHbbtv] Resolving Application Locator: dvb://current.ait/33.106 [eHbbtv] We have 1 app(s) for service 1.1057.61200 [eHbbtv] 'dvb://current.ait/33.106' resolved to 'http://comedy.hbbtv.clipfish.de/index.php' [eOipfApplication] Profile 0000, Version 1.1.1 [eOipfApplication] deu:Clipfish Music [eHbbtv] New Application: Clipfish Music (orgid=33, appid=103, urlBase=http://hbbtv.clipfish.de/, initalPath=index.php, controlCode=2, visibility=2) [eHbbtv] Resolving Application Locator: dvb://current.ait/33.103 [eHbbtv] We have 2 app(s) for service 1.1057.61200 [eHbbtv] 'dvb://current.ait/33.103' resolved to 'http://hbbtv.clipfish.de/index.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://cdn.digitaltext.rtl.de/, initalPath=index.html?teletext=1, controlCode=2, visibility=2) [eHbbtv] Resolving Application Locator: dvb://current.ait/33.101 [eHbbtv] We have 3 app(s) for service 1.1057.61200 [eHbbtv] 'dvb://current.ait/33.101' resolved to 'http://cdn.digitaltext.rtl.de/index.html?teletext=1' [eOipfApplication] Profile 0000, Version 1.1.1 [eOipfApplication] deu:RTL Kochbar [eHbbtv] New Application: RTL Kochbar (orgid=33, appid=104, urlBase=http://hbbtv.kochbar.de/, initalPath=start.php, controlCode=2, visibility=2) [eHbbtv] Resolving Application Locator: dvb://current.ait/33.104 [eHbbtv] We have 4 app(s) for service 1.1057.61200 [eHbbtv] 'dvb://current.ait/33.104' resolved to 'http://hbbtv.kochbar.de/start.php' [eOipfApplication] Profile 0000, Version 1.1.1 [eOipfApplication] deu:RTL Digitaltext [eHbbtv] New Application: RTL Digitaltext (orgid=33, appid=105, urlBase=http://cdn.digitaltext.rtl.de/, initalPath=index.html, controlCode=2, visibility=2) [eHbbtv] Resolving Application Locator: dvb://current.ait/33.105 [eHbbtv] We have 5 app(s) for service 1.1057.61200 [eHbbtv] 'dvb://current.ait/33.105' resolved to 'http://cdn.digitaltext.rtl.de/index.html' [eOipfApplication] Profile 0000, Version 1.1.1 [eOipfApplication] deu:_RTL Startleiste [eHbbtv] New Application: _RTL Startleiste (orgid=33, appid=100, urlBase=http://cdn.digitaltext.rtl.de/launchbar/, initalPath=index.html, controlCode=1, visibility=2) [eHbbtv] Resolving Application Locator: dvb://current.ait/33.100 [eHbbtv] We have 6 app(s) for service 1.1057.61200 [eHbbtv] 'dvb://current.ait/33.100' resolved to 'http://cdn.digitaltext.rtl.de/launchbar/index.html' [eOipfApplication] Profile 0000, Version 1.1.1 [eOipfApplication] deu:RTL Specials (CDN) [eHbbtv] New Application: RTL Specials (CDN) (orgid=33, appid=112, urlBase=http://cdn.specials.digitaltext.rtl.de/, initalPath=index.html, controlCode=2, visibility=2) [eHbbtv] Resolving Application Locator: dvb://current.ait/33.112 [eHbbtv] We have 7 app(s) for service 1.1057.61200 [eHbbtv] 'dvb://current.ait/33.112' resolved to 'http://cdn.specials.digitaltext.rtl.de/index.html' [eOipfApplication] Profile 0000, Version 1.1.1 [eOipfApplication] deu:RTL NOW overview [eHbbtv] New Application: RTL NOW overview (orgid=33, appid=121, urlBase=http://hbbtv.rtlnow.de/, initalPath=hbbtv/overview.php, controlCode=2, visibility=2) [eHbbtv] Resolving Application Locator: dvb://current.ait/33.121 [eHbbtv] We have 8 app(s) for service 1.1057.61200 [eHbbtv] 'dvb://current.ait/33.121' resolved to 'http://hbbtv.rtlnow.de/hbbtv/overview.php' [eOipfApplication] Profile 0000, Version 1.1.1 [eOipfApplication] deu:RTL NOW index [eHbbtv] New Application: RTL NOW index (orgid=33, appid=120, urlBase=http://hbbtv.rtlnow.de/, initalPath=hbbtv/index.php, controlCode=2, visibility=2) [eHbbtv] Resolving Application Locator: dvb://current.ait/33.120 [eHbbtv] We have 9 app(s) for service 1.1057.61200 [eHbbtv] 'dvb://current.ait/33.120' resolved to 'http://hbbtv.rtlnow.de/hbbtv/index.php' [HbbTV].readButtonApplicationReady, appid=33.100 [HbbTV].textApplicationReady, appid=33.100 doing version filtering 0105: 74 00 00 03 00 00 mask: ff 00 00 3f 00 00 mode: 00 00 00 3e 00 00 [ 66.017000] CEC send ok! [ 66.295000] bcm4506: signal_strength -115.59dbm sdt update done! ++ 2/2 TID 4e done! doing version filtering 0012: 4e ef 10 1f 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 [EPGC] start caching events(1384557689) [ 67.082000] VIDEO0: first pts 0x1680f2988 [ 67.082000] VIDEO0: resolution changed (1920 1080) VIDEO_GET_EVENT - ok [ 67.233000] enable tsm0 [ 67.260000] bcm4506: signal_strength -117.48dbm [ 67.273000] bcm4506: signal_strength -117.48dbm [ 67.319000] bcm4506: signal_strength -115.53dbm [eDVBLocalTimeHandler] Receiver time is 'Sat Nov 16 00:21:30 2013' [eDVBLocalTimeHandler] Transponder time is 'Sat Nov 16 00:21:28 2013' [eDVBLocalTimeHandler] diff is -2 [eDVBLocalTimeHandler] diff < 120 .. use Transponder Time [eDVBLocalTimeHandler] update RTC [eDVBLocalTimeHandler] time_difference is -2 [eDVBLocalTimeHandler] update Linux Time [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 647475 bytes for cache used [ 68.022000] VIDEO0: progressive changed (0) VIDEO_GET_EVENT - ok [ 68.344000] bcm4506: signal_strength -117.57dbm nr_read 860 nr_write 9 sum 869 prev_sum 869 hdd IDLE! [IDLE] 3.82748603821 60 False [EPGC] abort non avail schedule other reading [EPGC] abort non avail viasat reading [EPGC] nownext finished(1384557695) nr_read 860 nr_write 9 sum 869 prev_sum 869 hdd IDLE! [IDLE] 9.82742810249 60 False action -> GlobalActions volumeUp Setvolume: 55 55 (raw) Setvolume: 29 29 (-1db) setValue 55 action -> GlobalActions volumeUp Setvolume: 60 60 (raw) Setvolume: 26 26 (-1db) setValue 60 [EPGC] schedule finished(1384557697) [EPGC] stop caching events(1384557697) [EPGC] next update in 60 min action -> InfobarChannelSelection switchChannelUp reused converter! reused converter! allocating new converter! allocating new converter! reused converter! reused converter! reused converter! reused converter! [Picon Renderer] Exception caught here [Picon Renderer] not found: /picons/piconHD/ORF2 HD.png nr_read 860 nr_write 9 sum 869 prev_sum 869 hdd IDLE! [IDLE] 15.8280501366 60 False [ 81.299000] CEC recv ok! cec event! handle message 0 -> f : 87 00 e0 91 Device Vendor ID 00e091 [ 81.353000] CEC recv ok! cec event! handle message 0 -> 3 : [ 81.485000] CEC recv ok! cec event! handle message 0 -> 3 : 89 01 Vendor Command cec event! send 3 -> 0 : 00 89 00 [ 81.596000] CEC send ok! action -> OkCancelActions cancel [Picon Renderer] not found: /picons/piconHD/DAS ERSTE HD.png no ancillary data in audio stream... abort radiotext pes parser action -> InfobarChannelSelection zapDown playing 1:0:19:2B66:3F3:1:C00000:0:0:0: [eDVBCAService] free slot 0 demux 3 for service 1:0:19:EF10:421:1:C00000:0:0:0: [eDVBCAService] free service 1:0:19:EF10:421:1:C00000:0:0:0: recheckPMTHAndlers() [TeleText] service stopped [TeleText] send array('B', [1, 0, 0, 0]) decoder state: play, vpid=-1, ap[ 85.814000] stop pcr0 on dmx 3 pid:ff id=-1 DEMUX_STOP - pcr - ok DEMUX_STOP - vid[ 85.816000] stop video0 on dmx 3 pid:ff eo - [ 85.820000] VIDEO0: stop decode ok VIDEO_STOP - [ 85.821000] VIDEO0: set blank to 1 ok AUDIO_STOP - [ 85.823000] audio: decoder stop ok DEMUX_STOP - aud[ 85.824000] stop audio on dmx 3 pid:103 io - [ 85.825000] audio: xpt stop(3) [ 85.825000] no decoder left in sync handling so disable xpt_sync [ 85.826000] bcm_audio_channel_stop(3) done ok AUDIO_CONTINUE - ok DEMUX_STOP - ttx - ok start release channel timer [Picon Renderer] not found: /picons/piconHD/ZDF HD.png [TeleText] service started [ZaptoService] was called unnecessary! not pauseable. RemovePopup, id = ZapError [eDVBCAService] remove channel 0x6ff78ad8 [eDVBLocalTimeHandler] remove channel 0x6ff78ad8 [eEPGCache] remove channel 0x6ff78ad8 (0) preClose allocate channel.. 03f3:0001:00c00000 [eDVBCAService] new channel 0x1ca5b70! (0)tune RotorCmd ffffffff, lastRotorCmd ffffffff prepare_sat System 1 Freq 11361750 Pol 0 SR 22000000 INV 2 FEC 2 orbpos 192 system 1 modulation 2 pilot 2, rolloff 0 tuning to 1611 mhz OURSTATE: tuning allocate Channel: res 0 [eDVBCIInterfaces] addPMTHandler 1:0:19:2B66:3F3:1:C00000:0:0:0: recheckPMTHAndlers() recheck 0x1ca548c 1:0:19:2B66:3F3:1:C00000:0:0:0: allocate demux [HbbTV].aitInvalidated [SEC] lock 0 [SEC] set static current limiting [SEC] update current switch params [SEC] startTuneTimeout 5000 [SEC] setFrontend 1 (0)setting frontend (0)fe event: status 0, freq 1611750, inversion off, m_tuning 1 F [SEC] unlock [SEC] sleep 500ms (0)fe event: status 1, freq 1611750, inversion off, m_tuning 1 N (0)fe event: status 0, freq 1611750, inversion off, m_tuning 2 N [SEC] set dynamic current limiting (0)fe event: status 1f, freq 1612643, inversion off, m_tuning 3 N OURSTATE: ok [eDVBCAService] channel 0x1ca5b70 running [eDVBLocalTimeHandler] channel 0x1ca5b70 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 0x1ca5b70 running stop release channel timer no version filtering 0012: 4e 2b 66 00 00 00 mask: ff ff 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: ff 00 00 00 00 00 mode: 00 00 00 00 00 00 eventNewProgramInfo 0 0 have 1 video stream(s) (17de), and 1 audio stream(s) (17ea), and the pcr pid is 17de, and the text pid is 17f2 allocate demux disable teletext subtitles decoder state: play, vpid=6110, apid=6122 DMX_SET_PES_FILTER(0x17de) - pcr - ok[ 86.637000] start pcr0 on dmx 3 pid:17de index 5 DEMUX_START - pcr - ok DMX_SET_PES_FILTER(0x17ea) - audio - ok DEMUX_START - audio - ok AUDIO_SET_BYPASS(0) - [ 86.639000] start audio on dmx 3 pid:17ea [ 86.639000] audio xpt start [ 86.640000] sync is off so we enable it [ 86.640000] demux-index 3 pcr0pid 17de [ 86.641000] using 5 as pcr0 pidchannel [ 86.643000] AC3 ok AUDIO_PAUSE - ok AUDIO_PLAY - [ 86.643000] audio: decoder start 0 [ 86.646000] audio delay 18000 (200 ms) [ 86.647000] total video delay: 18000 (200 ms) ok Video Device: /dev/dvb/adapter0/video0 demux device: /dev/dvb/adapter0/demux3 VIDEO_SET_STREAMTYPE 1 - ok DMX[ 86.649000] start video0 on dmx 3 pid:17de _SET_PES_FILTER(0x17de) - video [ 86.650000] total video delay: 18000 (200 ms) - ok DEMUX_START - video - ok VIDEO_FREEZE - ok VIDEO_PLAY - [ 86.654000] VIDEO0: start decode ok DMX_SET_PES_FILTER(0x17f2) - ttx - ok DEMUX_START - ttx - ok VIDEO_SLOWMOTION(0) - ok VIDEO_FAST_FORWARD(0) - ok VIDEO_CONTINUE - ok AUDIO_CONTINUE - ok not pauseable. [ 86.690000] ch0: lock [ 86.691000] audio_sampling_rate_info_isr: 39 callbacks suppressed [ 86.691000] RAP sampling rate info isr (48000) [ 86.692000] eModeChange Isr.. set source_changed_event! [ 86.710000] bcm4506: signal_strength -112.95dbm [ 86.724000] RAP first pts 0xddf5ee20, stc 0xddf5dc64, pcr valid [ 86.726000] audio_cdb_itb_error_isr! underflow [ 86.730000] audio_cdb_itb_error_isr! underflow [ 86.734000] audio_cdb_itb_error_isr! underflow [ 86.738000] audio_cdb_itb_error_isr! underflow [ 86.742000] audio_cdb_itb_error_isr! underflow [ 86.746000] audio_cdb_itb_error_isr! underflow [ 86.750000] audio_cdb_itb_error_isr! underflow [TeleText] serviceInfoChanged [ 86.754000] audio_cdb_itb_error_isr! underflow [TeleText] TXT PID 6130 DEMUX 3 [TeleText] send array('B', [1, 23, 242, 3]) + 1/1 TID 00 done! PATready use pmtpid 17d4 for service_id 2b66 no version filtering 17d4: 02 2b 66 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 doing version filtering 0000: 00 00 00 05 00 00 mask: ff 00 00 3f 00 00 mode: 00 00 00 3e 00 00 sdt update done! + 1/1 TID 02 done! [eDVBCAService] new service 1:0:19:2B66:3F3:1:C00000:0:0:0: [eDVBCAService] add demux 3 to slot 0 service 1:0:19:2B66:3F3:1:C00000:0:0:0: demux 3 mask 08 prevhash 00000000 [eDVBCAService] send 74 bytes 9f 80 32 46 03 2b 66 13 00 13 01 81 08 00 c0 00 00 03 f3 00 01 82 02 08 03 84 02 17 d4 1b 17 de 00 00 03 17 e8 00 00 03 17 e9 00 00 03 17 eb 00 00 06 17 ea 00 00 06 17 f2 00 00 06 17 f3 00 00 06 17 f4 00 00 05 18 1a 00 00 recheckPMTHAndlers() recheck 0x1ca548c 1:0:19:2B66:3F3:1:C00000:0:0:0: dvb subtitle PID 17f3 with wrong subtitling type (24)... force 0x10!! [eDVBCIInterfaces] gotPMT eventNewProgramInfo 0 0 start ait on pid 181a no version filtering 181a: 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) (17de), and 4 audio stream(s) (17e8, 17e9, 17eb, 17ea), and the pcr pid is 17de, and the text pid is 17f2 decoder state: play, vpid=6110, apid=6122 dvb subtitle PID 17f3 with wrong subtitling type (24)... force 0x10!! [ 86.924000] bcm4506: signal_strength -108.90dbm [TeleText] serviceInfoChanged [TeleText] TXT PID 6130 DEMUX 3 [TeleText] send array('B', [1, 23, 242, 3]) doing version filtering 17d4: 02 2b 66 13 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 [ 86.982000] bcm4506: signal_strength -108.90dbm nr_read 860 nr_write 9 sum 869 prev_sum 869 hdd IDLE! [IDLE] 21.8274531364 60 False [ 87.182000] VIDEO0: first pts 0xddf719c8 [ 87.182000] VIDEO0: framerate changed 6 [ 87.182000] VIDEO0: resolution changed (1280 720) [ 87.184000] set current avs auto aspect to 16:9 [ 87.184000] disable wss on display 0 [ 87.185000] set wss 7 on display 1 [ 87.185000] set sb to 3(1) VIDEO_GET_EVENT - ok +- 1/2 TID 4e VIDEO_GET_EVENT - ok ++ 2/2 TID 4e done! [ 87.335000] enable tsm0 doing version filtering 0012: 4e 2b 66 19 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 + 1/1 TID 74 done! [eHbbtv] aitChanged pid=0x181a [eOipfApplication] Profile 0000, Version 1.1.1 [eOipfApplication] deu:ZDF start [eHbbtv] New Application: ZDF start (orgid=17, appid=1, urlBase=http://hbbtv.zdf.de/zdfstart/, initalPath=index.php, controlCode=1, visibility=2) [eHbbtv] Resolving Application Locator: dvb://current.ait/17.1 [eHbbtv] We have 1 app(s) for service 1.1011.11110 [eHbbtv] 'dvb://current.ait/17.1' resolved to 'http://hbbtv.zdf.de/zdfstart/index.php' [eOipfApplication] Profile 0000, Version 1.1.1 [eOipfApplication] deu:ZDF mediathek [eHbbtv] New Application: ZDF mediathek (orgid=17, appid=2, urlBase=http://hbbtv.zdf.de/zdfmediathek/, initalPath=index.php, controlCode=2, visibility=2) [eHbbtv] Resolving Application Locator: dvb://current.ait/17.2 [eHbbtv] We have 2 app(s) for service 1.1011.11110 [eHbbtv] 'dvb://current.ait/17.2' resolved to 'http://hbbtv.zdf.de/zdfmediathek/index.php' [eOipfApplication] Profile 0000, Version 1.1.1 [eOipfApplication] deu:ZDF heutejournal [eHbbtv] New Application: ZDF heutejournal (orgid=17, appid=3, urlBase=http://hbbtv.zdf.de/zdfhjplus/, initalPath=index.php, controlCode=2, visibility=2) [eHbbtv] Resolving Application Locator: dvb://current.ait/17.3 [eHbbtv] We have 3 app(s) for service 1.1011.11110 [eHbbtv] 'dvb://current.ait/17.3' resolved to 'http://hbbtv.zdf.de/zdfhjplus/index.php' [HbbTV].readButtonApplicationReady, appid=17.1 doing version filtering 181a: 74 00 00 03 00 00 mask: ff 00 00 3f 00 00 mode: 00 00 00 3e 00 00 [ 88.005000] bcm4506: signal_strength -111.88dbm [eDVBLocalTimeHandler] Receiver time is 'Sat Nov 16 00:21:49 2013' [eDVBLocalTimeHandler] Transponder time is 'Sat Nov 16 00:21:51 2013' [eDVBLocalTimeHandler] diff is 2 [eDVBLocalTimeHandler] diff < 120 .. use Transponder Time [eDVBLocalTimeHandler] update RTC [eDVBLocalTimeHandler] time_difference is 2 [eDVBLocalTimeHandler] update Linux Time [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 647475 bytes for cache used [EPGC] start caching events(1384557711) [ 88.682000] VIDEO0: progressive changed (1) VIDEO_GET_EVENT - ok [ 89.028000] bcm4506: signal_strength -113.50dbm [ 90.054000] bcm4506: signal_strength -115.21dbm action -> InfobarChannelSelection zapDown playing 1:0:19:EF10:421:1:C00000:0:0:0: [eDVBCAService] free slot 0 demux 3 for service 1:0:19:2B66:3F3:1:C00000:0:0:0: [eDVBCAService] free service 1:0:19:2B66:3F3:1:C00000:0:0:0: recheckPMTHAndlers() [TeleText] service stopped [TeleText] send array('B', [1, 0, 0, 0]) decoder state: play, vpid=-1, ap[ 91.200000] stop pcr0 on dmx 3 pid:17de id=-1 DEMUX_STOP - pcr - ok DEMUX_STOP - video - [ 91.202000] stop video0 on dmx 3 pid:17de [ 91.214000] VIDEO0: stop decode ok VIDEO_STOP - [ 91.215000] VIDEO0: set blank to 1 ok AUDIO_STOP - [ 91.216000] audio: decoder stop ok DEMUX_STOP - aud[ 91.217000] stop audio on dmx 3 pid:17ea io - [ 91.218000] audio: xpt stop(3) [ 91.218000] no decoder left in sync handling so disable xpt_sync [ 91.219000] bcm_audio_channel_stop(3) done ok AUDIO_CONTINUE - ok DEMUX_STOP - ttx - ok start release channel timer [TeleText] service started [ZaptoService] was called unnecessary! not pauseable. RemovePopup, id = ZapError [eDVBCAService] remove channel 0x1ca5b70 [eDVBLocalTimeHandler] remove channel 0x1ca5b70 [eEPGCache] remove channel 0x1ca5b70 [EPGC] abort caching events !! (0) preClose allocate channel.. 0421:0001:00c00000 [eDVBCAService] new channel 0x1ca5b70! (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 0x1ca548c 1:0:19:EF10:421:1:C00000:0:0:0: allocate demux [HbbTV].aitInvalidated [SEC] lock 0 [SEC] set static current limiting [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 1083185, inversion off, m_tuning 3 N OURSTATE: ok [eDVBCAService] channel 0x1ca5b70 running [eDVBLocalTimeHandler] channel 0x1ca5b70 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 0x1ca5b70 running stop release channel timer [EPGC] next update in 59 min no version filtering 0012: 4e ef 10 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 ok ... now we start!! no version filtering 0000: 00 00 00 00 00 00 mask: ff 00 00 00 00 00 mode: 00 00 00 00 00 00 eventNewProgramInfo 0 0 have 1 video stream(s) (00ff), and 1 audio stream(s) (0103), and the 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 DE[ 92.024000] start pcr0 on dmx 3 pid:ff index 5 MUX_START - pcr - ok DMX_SET_PES_FILTER(0x103) - audio - ok DEMUX_START - audio - ok AUDIO_SET_BYPASS(0) - [ 92.026000] start audio on dmx 3 pid:103 [ 92.026000] audio xpt start [ 92.027000] sync is off so we enable it [ 92.027000] demux-index 3 pcr0pid ff [ 92.028000] using 5 as pcr0 pidchannel [ 92.028000] AC3 ok AUDIO_PAUSE - ok AUDIO_PLAY - [ 92.029000] audio: decoder start 0 [ 92.032000] audio delay 18000 (200 ms) [ 92.032000] total video delay: 18000 (200 ms) ok Video Device: /dev/dvb/adapter0/video0 demux device: /dev/dvb/adapter0/demux3 VIDEO_SET_STREAMTYPE 1 - ok DMX[ 92.034000] start video0 on dmx 3 pid:ff _SET_PES_FILTER(0xff) - video - [ 92.035000] total video delay: 18000 (200 ms) ok DEMUX_START - video - ok VIDEO_FREEZE - ok VIDEO_PLAY - [ 92.039000] VIDEO0: start decode 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. [ 92.089000] bcm4506: signal_strength -117.33dbm [ 92.094000] bcm4506: signal_strength -117.33dbm [ 92.098000] bcm4506: signal_strength -117.33dbm [TeleText] serviceInfoChanged [TeleText] TXT PID 32 DEMUX 3 [TeleText] send array('B', [1, 0, 32, 3]) +- 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 0f 00 00 mask: ff 00 00 3f 00 00 mode: 00 00 00 3e 00 00 [ExtendedInfoBar] CAIDs: ['0000', '1830', '1843', '1860'] [ExtendedInfoBar] SID: EF10 [ 92.336000] bcm4506: signal_strength -116.83dbm + 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 436 bytes 9f 80 32 82 01 ae 03 ef 10 03 01 8a 01 81 08 00 c0 00 00 04 21 00 01 82 02 08 03 84 02 00 60 09 6f 18 30 fc cc 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 7b 18 43 f9 cc 8c 75 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 01 00 2c 8c 13 00 80 11 08 02 18 43 20 0a 09 38 59 00 0d 7a 59 00 0d 7a aa 15 03 80 11 5d 00 0b b8 00 03 03 21 00 00 02 18 43 5d 00 0b b8 00 09 04 09 c4 fb cc 09 04 09 8c fa cc 09 7b 18 60 fe cc 8c 75 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 01 00 2c 8c 13 00 80 11 08 02 18 60 20 0a 09 38 59 00 0d 7a 59 00 0d 7a aa 15 03 80 11 5d 00 0b b8 00 03 03 21 00 00 02 18 60 5d 00 0b b8 00 06 00 20 00 00 1b 00 ff 00 00 06 01 03 00 00 05 01 05 00 00 0b 01 06 00 00 0c 01 07 00 00 recheckPMTHAndlers() recheck 0x1ca548c 1:0:19:EF10:421:1:C00000:0:0:0: HBBTV broadcast data on pid 0106 [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 HBBTV broadcast data on pid 0106 [ 92.440000] bcm4506: signal_strength -116.83dbm [ 92.446000] bcm4506: signal_strength -116.83dbm [ 92.450000] bcm4506: signal_strength -116.83dbm [TeleText] serviceInfoChanged [TeleText] TXT PID 32 DEMUX 3 [TeleText] send array('B', [1, 0, 32, 3]) doing version filtering 0060: 02 ef 10 03 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 sdt update done! [eDVBLocalTimeHandler] Receiver time is 'Sat Nov 16 00:21:55 2013' [eDVBLocalTimeHandler] Transponder time is 'Sat Nov 16 00:21:53 2013' [eDVBLocalTimeHandler] diff is -2 [eDVBLocalTimeHandler] diff < 120 .. use Transponder Time [eDVBLocalTimeHandler] update RTC [eDVBLocalTimeHandler] time_difference is -2 [eDVBLocalTimeHandler] update Linux Time [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 730698 bytes for cache used [ 92.655000] RAP first pts 0x16831b882, stc 0x16831a5f8, pcr valid [ 92.657000] audio_cdb_itb_error_isr! underflow [ 92.661000] audio_cdb_itb_error_isr! underflow [ 92.665000] audio_cdb_itb_error_isr! underflow [ 92.669000] audio_cdb_itb_error_isr! underflow [ 92.673000] audio_cdb_itb_error_isr! underflow [ 92.677000] audio_cdb_itb_error_isr! underflow [ 92.681000] audio_cdb_itb_error_isr! underflow [ 92.685000] audio_cdb_itb_error_isr! underflow [ 92.686000] ch0: lock [ 92.686000] RAP sampling rate info isr (48000) [ 92.687000] eModeChange Isr.. set source_changed_event! nr_read 860 nr_write 18 sum 878 prev_sum 869 hdd was accessed since previous check! [IDLE] 0 60 False + 1/1 TID 74 done! [eHbbtv] aitChanged pid=0x105 [eOipfApplication] Profile 0000, Version 1.1.1 [eOipfApplication] deu:Clipfish Comedy [eHbbtv] New Application: Clipfish Comedy (orgid=33, appid=106, urlBase=http://comedy.hbbtv.clipfish.de/, initalPath=index.php, controlCode=2, visibility=2) [eHbbtv] Resolving Application Locator: dvb://current.ait/33.106 [eHbbtv] We have 1 app(s) for service 1.1057.61200 [eHbbtv] 'dvb://current.ait/33.106' resolved to 'http://comedy.hbbtv.clipfish.de/index.php' [eOipfApplication] Profile 0000, Version 1.1.1 [eOipfApplication] deu:Clipfish Music [eHbbtv] New Application: Clipfish Music (orgid=33, appid=103, urlBase=http://hbbtv.clipfish.de/, initalPath=index.php, controlCode=2, visibility=2) [eHbbtv] Resolving Application Locator: dvb://current.ait/33.103 [eHbbtv] We have 2 app(s) for service 1.1057.61200 [eHbbtv] 'dvb://current.ait/33.103' resolved to 'http://hbbtv.clipfish.de/index.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://cdn.digitaltext.rtl.de/, initalPath=index.html?teletext=1, controlCode=2, visibility=2) [eHbbtv] Resolving Application Locator: dvb://current.ait/33.101 [eHbbtv] We have 3 app(s) for service 1.1057.61200 [eHbbtv] 'dvb://current.ait/33.101' resolved to 'http://cdn.digitaltext.rtl.de/index.html?teletext=1' [eOipfApplication] Profile 0000, Version 1.1.1 [eOipfApplication] deu:RTL Kochbar [eHbbtv] New Application: RTL Kochbar (orgid=33, appid=104, urlBase=http://hbbtv.kochbar.de/, initalPath=start.php, controlCode=2, visibility=2) [eHbbtv] Resolving Application Locator: dvb://current.ait/33.104 [eHbbtv] We have 4 app(s) for service 1.1057.61200 [eHbbtv] 'dvb://current.ait/33.104' resolved to 'http://hbbtv.kochbar.de/start.php' [eOipfApplication] Profile 0000, Version 1.1.1 [eOipfApplication] deu:RTL Digitaltext [eHbbtv] New Application: RTL Digitaltext (orgid=33, appid=105, urlBase=http://cdn.digitaltext.rtl.de/, initalPath=index.html, controlCode=2, visibility=2) [eHbbtv] Resolving Application Locator: dvb://current.ait/33.105 [eHbbtv] We have 5 app(s) for service 1.1057.61200 [eHbbtv] 'dvb://current.ait/33.105' resolved to 'http://cdn.digitaltext.rtl.de/index.html' [eOipfApplication] Profile 0000, Version 1.1.1 [eOipfApplication] deu:_RTL Startleiste [eHbbtv] New Application: _RTL Startleiste (orgid=33, appid=100, urlBase=http://cdn.digitaltext.rtl.de/launchbar/, initalPath=index.html, controlCode=1, visibility=2) [eHbbtv] Resolving Application Locator: dvb://current.ait/33.100 [eHbbtv] We have 6 app(s) for service 1.1057.61200 [eHbbtv] 'dvb://current.ait/33.100' resolved to 'http://cdn.digitaltext.rtl.de/launchbar/index.html' [eOipfApplication] Profile 0000, Version 1.1.1 [eOipfApplication] deu:RTL Specials (CDN) [eHbbtv] New Application: RTL Specials (CDN) (orgid=33, appid=112, urlBase=http://cdn.specials.digitaltext.rtl.de/, initalPath=index.html, controlCode=2, visibility=2) [eHbbtv] Resolving Application Locator: dvb://current.ait/33.112 [eHbbtv] We have 7 app(s) for service 1.1057.61200 [eHbbtv] 'dvb://current.ait/33.112' resolved to 'http://cdn.specials.digitaltext.rtl.de/index.html' [eOipfApplication] Profile 0000, Version 1.1.1 [eOipfApplication] deu:RTL NOW overview [eHbbtv] New Application: RTL NOW overview (orgid=33, appid=121, urlBase=http://hbbtv.rtlnow.de/, initalPath=hbbtv/overview.php, controlCode=2, visibility=2) [eHbbtv] Resolving Application Locator: dvb://current.ait/33.121 [eHbbtv] We have 8 app(s) for service 1.1057.61200 [eHbbtv] 'dvb://current.ait/33.121' resolved to 'http://hbbtv.rtlnow.de/hbbtv/overview.php' [eOipfApplication] Profile 0000, Version 1.1.1 [eOipfApplication] deu:RTL NOW index [eHbbtv] New Application: RTL NOW index (orgid=33, appid=120, urlBase=http://hbbtv.rtlnow.de/, initalPath=hbbtv/index.php, controlCode=2, visibility=2) [eHbbtv] Resolving Application Locator: dvb://current.ait/33.120 [eHbbtv] We have 9 app(s) for service 1.1057.61200 [eHbbtv] 'dvb://current.ait/33.120' resolved to 'http://hbbtv.rtlnow.de/hbbtv/index.php' [HbbTV].readButtonApplicationReady, appid=33.100 [HbbTV].textApplicationReady, appid=33.100 doing version filtering 0105: 74 00 00 03 00 00 mask: ff 00 00 3f 00 00 mode: 00 00 00 3e 00 00 [ 93.342000] bcm4506: signal_strength -117.90dbm [ 93.351000] bcm4506: signal_strength -117.90dbm [ 93.358000] bcm4506: signal_strength -117.90dbm ++ 2/2 TID 4e done! doing version filtering 0012: 4e ef 10 1f 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 [ 93.502000] VIDEO0: first pts 0x168336ac8 [ 93.502000] VIDEO0: framerate changed 3 [ 93.502000] VIDEO0: resolution changed (1920 1080) [ 93.502000] VIDEO0: progressive changed (0) [ 93.504000] set current avs auto aspect to 16:9 [ 93.505000] disable wss on display 0 [ 93.505000] set wss 7 on display 1 [ 93.506000] set sb to 3(1) VIDEO_GET_EVENT - ok VIDEO_GET_EVENT - ok VIDEO_GET_EVENT - ok [ 93.656000] enable tsm0 action -> InfobarChannelSelection switchChannelDown reused converter! reused converter! allocating new converter! allocating new converter! reused converter! reused converter! reused converter! reused converter! [Picon Renderer] not found: /picons/piconHD/DAS ERSTE HD.png [Picon Renderer] not found: /picons/piconHD/PROSIEBEN HD.png action -> OkCancelActions ok playing 1:0:19:EF75:3F9:1:C00000:0:0:0: [eDVBCAService] free slot 0 demux 3 for service 1:0:19:EF10:421:1:C00000:0:0:0: [eDVBCAService] free service 1:0:19:EF10:421:1:C00000:0:0:0: recheckPMTHAndlers() [TeleText] service stopped [TeleText] send array('B', [1, 0, 0, 0]) decoder state: play, vpid=-1, ap[ 95.748000] stop pcr0 on dmx 3 pid:ff id=-1 DEMUX_STOP - pcr - ok DEMUX_STOP - vid[ 95.749000] stop video0 on dmx 3 pid:ff eo - [ 95.751000] VIDEO0: stop decode ok VIDEO_STOP - [ 95.752000] VIDEO0: set blank to 1 ok AUDIO_STOP - [ 95.754000] audio: decoder stop ok DEMUX_STOP - aud[ 95.755000] stop audio on dmx 3 pid:103 io - [ 95.756000] audio: xpt stop(3) [ 95.756000] no decoder left in sync handling so disable xpt_sync [ 95.757000] bcm_audio_channel_stop(3) done ok AUDIO_CONTINUE - ok DEMUX_STOP - ttx - ok start release channel timer [Picon Renderer] not found: /picons/piconHD/PROSIEBEN HD.png [TeleText] service started [ZaptoService] was called unnecessary! not pauseable. RemovePopup, id = ZapError [eDVBCAService] remove channel 0x1ca5b70 [eDVBLocalTimeHandler] remove channel 0x1ca5b70 [eEPGCache] remove channel 0x1ca5b70 (0) preClose allocate channel.. 03f9:0001:00c00000 [eDVBCAService] new channel 0x6ff78ad8! (0)tune RotorCmd ffffffff, lastRotorCmd ffffffff prepare_sat System 1 Freq 11464250 Pol 0 SR 22000000 INV 2 FEC 2 orbpos 192 system 1 modulation 2 pilot 2, rolloff 0 tuning to 1714 mhz OURSTATE: tuning allocate Channel: res 0 [eDVBCIInterfaces] addPMTHandler 1:0:19:EF75:3F9:1:C00000:0:0:0: recheckPMTHAndlers() recheck 0x6ff7c76c 1:0:19:EF75:3F9:1:C00000:0:0:0: allocate demux [HbbTV].aitInvalidated [SEC] lock 0 [ 95.898000] bcm4506: signal_strength -116.07dbm [ 95.926000] bcm4506: signal_strength -117.10dbm [ 95.931000] bcm4506: signal_strength -117.10dbm [SEC] set static current limiting [SEC] update current switch params [SEC] startTuneTimeout 5000 [SEC] setFrontend 1 (0)setting frontend (0)fe event: status 0, freq 1714250, inversion off, m_tuning 1 F [SEC] unlock [SEC] sleep 500ms (0)fe event: status 1, freq 1714250, inversion off, m_tuning 1 N (0)fe event: status 0, freq 1714250, inversion off, m_tuning 2 N [SEC] set dynamic current limiting (0)fe event: status 1f, freq 1715131, inversion off, m_tuning 3 N OURSTATE: ok [eDVBCAService] channel 0x6ff78ad8 running [eDVBLocalTimeHandler] channel 0x6ff78ad8 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 0x6ff78ad8 running stop release channel timer [EPGC] next update in 2 sec no version filtering 0012: 4e ef 75 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 ok ... now we start!! no version filtering 0000: 00 00 00 00 00 00 mask: ff 00 00 00 00 00 mode: 00 00 00 00 00 00 eventNewProgramInfo 0 0 have 1 video stream(s) (01ff), and 1 audio stream(s) (0203), and the pcr pid is 01ff, and the text pid is 0021 allocate demux disable teletext subtitles decoder state: play, vpid=511, apid=515 DMX_SET_PES_FILTER(0x1ff) - pcr - ok D[ 96.608000] start pcr0 on dmx 3 pid:1ff index 5 EMUX_START - pcr - ok DMX_SET_PES_FILTER(0x203) - audio - ok DEMUX_START - audio - ok AUDIO_SET_BYPA[ 96.610000] start audio on dmx 3 pid:203 SS(0) - [ 96.611000] audio xpt start [ 96.611000] sync is off so we enable it [ 96.612000] demux-index 3 pcr0pid 1ff [ 96.612000] using 5 as pcr0 pidchannel [ 96.614000] AC3 ok AUDIO_PAUSE - ok AUDIO_PLAY - [ 96.614000] audio: decoder start 0 [ 96.617000] audio delay 18000 (200 ms) [ 96.618000] total video delay: 18000 (200 ms) ok Video Device: /dev/dvb/adapter0/video0 demux device: /dev/dvb/adapter0/demux3 VIDEO_SET_STREAMTYPE 1 - ok DMX_SET_PES_FILTER(0x1ff) - video -[ 96.621000] start video0 on dmx 3 pid:1ff ok DEMUX_START - video - [ 96.622000] total video delay: 18000 (200 ms) ok VIDEO_FREEZE - ok VIDEO_PLAY - [ 96.627000] VIDEO0: start decode ok DMX_SET_PES_FILTER(0x21) - ttx - ok DEMUX_START - ttx - ok VIDEO_SLOWMOTION(0) - ok VIDEO_FAST_FORWARD(0) - ok VIDEO_CONTINUE - ok AUDIO_CONTINUE - ok not pauseable. [ 96.661000] RAP first pts 0x58fc712a, stc 0x1b095c924, pcr valid [ 96.676000] bcm4506: signal_strength -112.03dbm [ 96.681000] bcm4506: signal_strength -112.03dbm [ 96.685000] bcm4506: signal_strength -112.03dbm [TeleText] serviceInfoChanged [TeleText] TXT PID 33 DEMUX 3 [TeleText] send array('B', [1, 0, 33, 3]) + 1/1 TID 00 done! PATready use pmtpid 0061 for service_id ef75 no version filtering 0061: 02 ef 75 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 doing version filtering 0000: 00 00 00 11 00 00 mask: ff 00 00 3f 00 00 mode: 00 00 00 3e 00 00 -+ 1/2 TID 4e [ExtendedInfoBar] CAIDs: ['0000', '1830', '1843', '1860'] [ExtendedInfoBar] SID: EF75 [ 96.828000] CEC recv ok! cec event! handle message 0 -> f : 87 00 e0 91 Device Vendor ID 00e091 + 1/1 TID 02 done! [eDVBCAService] new service 1:0:19:EF75:3F9:1:C00000:0:0:0: [eDVBCAService] add demux 3 to slot 0 service 1:0:19:EF75:3F9:1:C00000:0:0:0: demux 3 mask 08 prevhash 00000000 [eDVBCAService] send 426 bytes 9f 80 32 82 01 a4 03 ef 75 09 01 8a 01 81 08 00 c0 00 00 03 f9 00 01 82 02 08 03 84 02 00 61 09 6f 18 30 fc ec 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 7b 18 43 f9 ec 8c 75 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 01 00 2c 8c 13 00 80 11 08 02 18 43 20 0a 09 38 59 00 0d 7a 59 00 0d 7a aa 15 03 80 11 5d 00 0b b8 00 03 03 21 00 00 02 18 43 5d 00 0b b8 00 09 04 09 c4 fb ec 09 04 09 8c fa ec 09 7b 18 60 fe ec 8c 75 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 01 00 2c 8c 13 00 80 11 08 02 18 60 20 0a 09 38 59 00 0d 7a 59 00 0d 7a aa 15 03 80 11 5d 00 0b b8 00 03 03 21 00 00 02 18 60 5d 00 0b b8 00 06 00 21 00 00 1b 01 ff 00 00 06 02 03 00 00 05 02 05 00 00 recheckPMTHAndlers() recheck 0x6ff7c76c 1:0:19:EF75:3F9:1:C00000:0:0:0: [eDVBCIInterfaces] gotPMT eventNewProgramInfo 0 0 start ait on pid 0205 no version filtering 0205: 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) (01ff), and 1 audio stream(s) (0203), and the pcr pid is 01ff, and the text pid is 0021 decoder state: play, vpid=511, apid=515 [ 96.882000] CEC recv ok! [ 96.943000] bcm4506: signal_strength -110.67dbm [ 96.949000] bcm4506: signal_strength -110.67dbm [ 96.953000] bcm4506: signal_strength -110.67dbm [TeleText] serviceInfoChanged [TeleText] TXT PID 33 DEMUX 3 [TeleText] send array('B', [1, 0, 33, 3]) doing version filtering 0061: 02 ef 75 09 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 [ 97.001000] bcm4506: signal_strength -110.67dbm cec event! handle message 0 -> 3 : [ 97.023000] CEC recv ok! cec event! handle message 0 -> 3 : 89 01 Vendor Command cec event! send 3 -> 0 : 00 89 00 [ 97.134000] CEC send ok! [ 97.141000] ch0: lock ++ 2/2 TID 4e done! doing version filtering 0012: 4e ef 75 1d 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 + 1/1 TID 74 done! [eHbbtv] aitChanged pid=0x205 [eOipfApplication] Profile 0000, Version 1.1.1 [eOipfApplication] deu:Pro7 [eHbbtv] New Application: Pro7 (orgid=96, appid=2, urlBase=http://hbbtv.prosieben.de/service/, initalPath=redbutton_p7.php, controlCode=1, visibility=2) [eHbbtv] Resolving Application Locator: dvb://current.ait/96.2 [eHbbtv] We have 1 app(s) for service 1.1017.61301 [eHbbtv] 'dvb://current.ait/96.2' resolved to 'http://hbbtv.prosieben.de/service/redbutton_p7.php' [HbbTV].readButtonApplicationReady, appid=96.2 doing version filtering 0205: 74 00 00 09 00 00 mask: ff 00 00 3f 00 00 mode: 00 00 00 3e 00 00 [ 97.957000] bcm4506: signal_strength -112.89dbm [ 97.965000] bcm4506: signal_strength -112.89dbm [ 98.007000] bcm4506: signal_strength -112.89dbm [ 98.202000] VIDEO0: first pts 0x1b099c0ea [ 98.353000] enable tsm0 sdt update done! [EPGC] start caching events(1384557719) [eDVBLocalTimeHandler] Receiver time is 'Sat Nov 16 00:21:59 2013' [eDVBLocalTimeHandler] Transponder time is 'Sat Nov 16 00:21:59 2013' [eDVBLocalTimeHandler] diff is 0 [eDVBLocalTimeHandler] diff < 120 .. use Transponder Time [eDVBLocalTimeHandler] not changed [ 99.030000] bcm4506: signal_strength -112.42dbm nr_read 860 nr_write 18 sum 878 prev_sum 878 hdd IDLE! [IDLE] 5.99983119965 60 False [ 99.958000] bcm4506: signal_strength -110.52dbm [ 99.966000] bcm4506: signal_strength -110.52dbm [ 100.035000] bcm4506: signal_strength -110.52dbm nr_read 860 nr_write 18 sum 878 prev_sum 878 hdd IDLE! [IDLE] 12.0001261234 60 False [EPGC] abort non avail schedule other reading [EPGC] abort non avail viasat reading [EPGC] nownext finished(1384557726) [EPGC] schedule finished(1384557729) [EPGC] stop caching events(1384557729) [EPGC] next update in 60 min nr_read 860 nr_write 18 sum 878 prev_sum 878 hdd IDLE! [IDLE] 18.0000929832 60 False [Elektro] Profile: 1 [Elektro] Nextday: 18:00:00 [Elektro] Current time: 00:22:00 [Elektro] Wakeup time: 20:00:00 [Elektro] Sleep time: 09:00:00 [ 112.361000] CEC recv ok! cec event! handle message 0 -> f : 87 00 e0 91 Device Vendor ID 00e091 [ 112.414000] CEC recv ok! cec event! handle message 0 -> 3 : [ 112.546000] CEC recv ok! cec event! handle message 0 -> 3 : 89 01 Vendor Command cec event! send 3 -> 0 : 00 89 00 [ 112.657000] CEC send ok! no ancillary data in audio stream... abort radiotext pes parser nr_read 860 nr_write 18 sum 878 prev_sum 878 hdd IDLE! [IDLE] 24.0002090931 60 False nr_read 860 nr_write 18 sum 878 prev_sum 878 hdd IDLE! [IDLE] 30.0001440048 60 False