BCM74130011 012 K1 K2 K3 K4 K5 Shmoo Version=3.8 DDR Freq=0x0000018C %00000001% RC1=00000005 WC1=FFFFFFEE RC2=00000012 WC2=0000003A RC3=0000000B WC3=FFFFFFEE RC4=0000000B WC4=0000003B NWC=00000014 RC5=00000005 WC5=00000014 RC6=00000012 WC6=00000014 NRC=0000000B RW=0000000E WW=0000004E G=00000000 R=0000000B W=00000014 BL=00000000 RC1=00000002 RC2=00000015 BL=00000001 RC1=00000005 RC2=00000019 BL=00000002 RC1=00000001 RC2=00000010 BL=00000003 RC1=00000005 RC2=00000011 BL=00000004 RC1=00000000 RC2=0000000F BL=00000005 RC1=00000006 RC2=00000018 BL=00000006 RC1=00000004 RC2=00000016 BL=00000007 RC1=00000006 RC2=00000019 3 COPY CODE COMPARE CODE 4567 (c) 2007,2008 Dream Multimedia GmbH. All rights reserved. Dreambox DM7020HD FIRST STAGE 1.1/400 {BO23456} 2ND STAGE OK, build #88 (2013-05-01) 0.000 - BCM board setup 0.002 - fp init FP version 3 detected 0.003 - ca init 0.505 - load config 0.531 - config loaded. * press [S] to enter setup OLED found! lcd: BOOT #88 P23 detected! detected 4K pagesize, 256K blocksize - read config file: /boot/secondstage.conf detected jffs2 blocksize: 256kb ++++++++++++++++++++++++++++ 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-dm7020hd.elf.gz bootlogo size: 35879 Supported modes: NTSC !NTSC_J !NTSC_443 !PAL_B !PAL_B1 !PAL_D !PAL_D1 PAL_G !PAL_H !PAL_K !PAL_I !PAL_M !PAL_N !PAL_NC !PAL_60 !SECAM_L !SECAM_B !SECAM_G !SECAM_D !SECAM_K !SECAM_H 1080i !1080p 720p 480p 1080i_50Hz 1080p_24Hz !1080p_50Hz !1250i_50Hz 720p_50Hz 576p_50Hz DVI_640x480p !DVI_640x480p_CVT DVI_800x600p DVI_1024x768p !DVI_1280x720p_50Hz !DVI_1280x720p !DVI_1280x720p_Red !DVI_640x480p_66Hz !DVI_640x480p_70Hz !DVI_640x480p_72Hz !DVI_640x480p_75Hz !DVI_640x480p_85Hz !DVI_1280x720p_70Hz !DVI_1280x720p_72Hz !DVI_1280x720p_75Hz !DVI_1280x720p_85Hz !DVI_1920x1080p_60Hz_Red !Custom0 !Custom1 best supported mode is 25 using 1920x1080i (50.00 Hz) HDMI using colorspace: 1 create surface 1920 1080 Using the Small jpeg decoder library, Copyright (c) 2006, Luc Saillard parsing JPEG header.. Virtual FB Size: 1280x720 lcd: /boot/vmlinux-3.2-dm7020hd.gz [ 0.000000] Linux version 3.2-dm7020hd (newnigma2@nn2build.newnigma2.to) (gcc version 4.6.4 20120303 (prerelease) (GCC) ) #1 SMP Sat Sep 28 17:20:58 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.504 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.137000] loop: module loaded [ 0.138000] sata_brcmstb 0000:01:00.0: version 4.0 [ 0.139000] brcm-pm: enabling sata clocks [ 0.139000] PCI: Enabling device 0000:01:00.0 (0000 -> 0003) [ 0.140000] PCI: Setting latency timer of device 0000:01:00.0 to 64 [ 0.338000] scsi0 : sata_brcmstb [ 0.339000] scsi1 : sata_brcmstb [ 0.339000] ata1: SATA max UDMA7 mmio m4096@0x10510000 port 0x10510000 irq 42 [ 0.340000] ata2: SATA max UDMA7 mmio m4096@0x10510000 port 0x10510100 irq 42 [ 0.342000] Broadcom STB NAND controller (BrcmNand Controller) [ 0.343000] bcmemac: Broadcom STB 10/100 EMAC driver v3.0 [ 0.347000] bcmemac: registered interface #0 at 0x10080000 as 'eth0' (00:09:34:2d:c6:b4) [ 0.348000] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver [ 0.348000] brcm-pm: enabling usb clocks [ 0.349000] ehci-brcm ehci-brcm.0: Broadcom STB EHCI [ 0.350000] ehci-brcm ehci-brcm.0: new USB bus registered, assigned bus number 1 [ 0.382000] ehci-brcm ehci-brcm.0: irq 62, io mem 0x10480300 [ 0.388000] ehci-brcm ehci-brcm.0: USB 0.0 started, EHCI 1.00 [ 0.389000] hub 1-0:1.0: USB hub found [ 0.390000] hub 1-0:1.0: 2 ports detected [ 0.390000] ehci-brcm ehci-brcm.1: Broadcom STB EHCI [ 0.391000] ehci-brcm ehci-brcm.1: new USB bus registered, assigned bus number 2 [ 0.423000] ehci-brcm ehci-brcm.1: irq 57, io mem 0x10480500 [ 0.429000] ehci-brcm ehci-brcm.1: USB 0.0 started, EHCI 1.00 [ 0.430000] hub 2-0:1.0: USB hub found [ 0.430000] hub 2-0:1.0: 2 ports detected [ 0.431000] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver [ 0.432000] ohci-brcm ohci-brcm.0: Broadcom STB OHCI [ 0.433000] ohci-brcm ohci-brcm.0: new USB bus registered, assigned bus number 3 [ 0.434000] ohci-brcm ohci-brcm.0: irq 63, io mem 0x10480400 [ 0.499000] hub 3-0:1.0: USB hub found [ 0.500000] hub 3-0:1.0: 2 ports detected [ 0.501000] ohci-brcm ohci-brcm.1: Broadcom STB OHCI [ 0.501000] ohci-brcm ohci-brcm.1: new USB bus registered, assigned bus number 4 [ 0.502000] ohci-brcm ohci-brcm.1: irq 64, io mem 0x10480600 [ 0.568000] hub 4-0:1.0: USB hub found [ 0.569000] hub 4-0:1.0: 2 ports detected [ 0.570000] Initializing USB Mass Storage driver... [ 0.570000] usbcore: registered new interface driver usb-storage [ 0.571000] USB Mass Storage support registered. [ 0.572000] i2c /dev entries driver [ 0.572000] ALSA device list: [ 0.573000] No soundcards found. [ 0.573000] TCP cubic registered [ 0.574000] NET: Registered protocol family 17 [ 0.574000] Registering the dns_resolver key type [ 0.575000] EBI CS1: setting up NAND flash (primary) [ 0.576000] mtd->oobsize=0, mtd->eccOobSize=0 [ 0.577000] NAND_CS_NAND_XOR=00000000 [ 0.577000] B4: NandSelect=40000202, nandConfig=48252300, chipSelect=1 [ 0.578000] brcmnand_read_id: CS1: dev_id=ecd310a6 [ 0.579000] After: NandSelect=40000202, nandConfig=48252300 [ 0.579000] Block size=00040000, erase shift=18 [ 0.580000] NAND Config: Reg=48252300, chipSize=1024 MB, blockSize=256K, erase_shift=12 [ 0.581000] busWidth=1, pageSize=4096B, page_shift=12, page_mask=00000fff [ 0.582000] timing1 not adjusted: 5363444f [ 0.582000] timing2 not adjusted: 00000fc6 [ 0.583000] eccLevel=15, 1Ksector=0, oob=16 [ 0.583000] nbrBitsPerCell=2, cellinfo=0, chip->cellinfo=00000000 [ 0.584000] <--brcmnand_set_acccontrol: acc b4: f7ff1010, after: f7ff1010 [ 0.585000] BrcmNAND mfg ec d3 Samsung K9F8G08U0M 1024MB on CS1 [ 0.585000] [ 0.586000] Found NAND on CS1: ACC=f7ff1010, cfg=48252300, flashId=ecd310a6, tim1=5363444f, tim2=00000fc6 [ 0.587000] BrcmNAND version = 0x0302 1024MB @00000000 [ 0.587000] B4: NandSelect=40000202, nandConfig=48252300, chipSelect=1 [ 0.588000] brcmnand_read_id: CS1: dev_id=ecd310a6 [ 0.589000] After: NandSelect=40000202, nandConfig=48252300 [ 0.589000] Found NAND flash on Chip Select 1, chipSize=1024MB, usable size=1024MB, base=0 [ 0.590000] brcmnand_scan: B4 nand_select = 40000202 [ 0.591000] brcmnand_scan: After nand_select = 40000202 [ 0.592000] page_shift=12, bbt_erase_shift=18, chip_shift=30, phys_erase_shift=18 [ 0.593000] Brcm NAND controller version = 3.2 NAND flash size 1024MB @00000000 [ 0.593000] ECC layout=brcmnand_oob_128 [ 0.594000] brcmnand_scan: mtd->oobsize=128 [ 0.594000] brcmnand_scan: oobavail=102, eccsize=512, writesize=4096 [ 0.595000] brcmnand_scan, eccsize=512, writesize=4096, eccsteps=8, ecclevel=15, eccbytes=3 [ 0.596000] -->brcmnand_default_bbt [ 0.597000] brcmnand_default_bbt: bbt_td = bbt_main_descr [ 0.598000] Bad block table Bbt0 found at page 0003ffc0, version 0x01 for chip on CS1 [ 0.599000] Bad block table 1tbB found at page 0003ff80, version 0x01 for chip on CS1 [ 0.601000] nand_read_bbt: Bad block at 0x03740000 [ 0.601000] nand_read_bbt: Bad block at 0x1e5c0000 [ 0.602000] nand_read_bbt: Bad block at 0x26000000 [ 0.603000] nand_read_bbt: Bad block at 0x2f840000 [ 0.603000] nand_read_bbt: Bad block at 0x3b200000 [ 0.604000] brcmnandCET: Did not find CET, recreating [ 0.610000] brcmnandCET: Status -> Deferred [ 0.611000] Adjust partition complete size from 40000000 to 3ff00000 to avoid overlap with BBT reserved space [ 0.612000] Adjust partition root size from 3f800000 to 3f700000 to avoid overlap with BBT reserved space [ 0.613000] Creating 4 MTD partitions on "brcmnand.0": [ 0.614000] 0x000000000000-0x00003ff00000 : "complete" [ 0.620000] 0x000000000000-0x000000100000 : "loader" [ 0.622000] 0x000000100000-0x000000800000 : "boot" [ 0.623000] 0x000000800000-0x00003ff00000 : "root" [ 0.631000] UBI: attaching mtd3 to ubi0 [ 0.632000] UBI: physical eraseblock size: 262144 bytes (256 KiB) [ 0.633000] UBI: logical eraseblock size: 253952 bytes [ 0.633000] UBI: smallest flash I/O unit: 4096 [ 0.634000] UBI: VID header offset: 4096 (aligned 4096) [ 0.635000] UBI: data offset: 8192 [ 0.707000] usb 1-1: new high-speed USB device number 2 using ehci-brcm [ 0.926000] usb 1-2: new high-speed USB device number 3 using ehci-brcm [ 1.043000] hub 1-2:1.0: USB hub found [ 1.044000] hub 1-2:1.0: 4 ports detected [ 3.459000] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [ 3.695000] ata1.00: ATA-9: WDC WD30EZRX-00DC0B0, 80.00A80, max UDMA/133 [ 3.696000] ata1.00: 5860533168 sectors, multi 0: LBA48 NCQ (depth 0/32) [ 3.702000] ata1.00: configured for UDMA/133 [ 3.703000] scsi 0:0:0:0: Direct-Access ATA WDC WD30EZRX-00D 80.0 PQ: 0 ANSI: 5 [ 3.705000] sd 0:0:0:0: [sda] 5860533168 512-byte logical blocks: (3.00 TB/2.72 TiB) [ 3.706000] sd 0:0:0:0: [sda] 4096-byte physical blocks [ 3.707000] sd 0:0:0:0: [sda] Write Protect is off [ 3.708000] sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00 [ 3.709000] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA [ 3.811000] sda: sda1 [ 3.817000] sd 0:0:0:0: [sda] Attached SCSI disk [ 4.429000] ata2: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [ 4.433000] ata2.00: ATA-8: Hitachi HTS545016B9A300, PBBOC64G, max UDMA/133 [ 4.434000] ata2.00: 312581808 sectors, multi 0: LBA48 NCQ (depth 0/32) [ 4.443000] ata2.00: configured for UDMA/133 [ 4.444000] scsi 1:0:0:0: Direct-Access ATA Hitachi HTS54501 PBBO PQ: 0 ANSI: 5 [ 4.445000] sd 1:0:0:0: [sdb] 312581808 512-byte logical blocks: (160 GB/149 GiB) [ 4.447000] sd 1:0:0:0: [sdb] Write Protect is off [ 4.447000] sd 1:0:0:0: [sdb] Mode Sense: 00 3a 00 00 [ 4.448000] sd 1:0:0:0: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA [ 5.001000] UBI: max. sequence number: 475 [ 5.023000] UBI: attached mtd3 to ubi0 [ 5.024000] UBI: MTD device name: "root" [ 5.025000] UBI: MTD device size: 1015 MiB [ 5.025000] UBI: number of good PEBs: 4055 [ 5.026000] UBI: number of bad PEBs: 5 [ 5.026000] UBI: number of corrupted PEBs: 0 [ 5.027000] UBI: max. allowed volumes: 128 [ 5.027000] UBI: wear-leveling threshold: 4096 [ 5.028000] UBI: number of internal volumes: 1 [ 5.028000] UBI: number of user volumes: 2 [ 5.029000] UBI: available PEBs: 0 [ 5.029000] UBI: total number of reserved PEBs: 4055 [ 5.030000] UBI: number of PEBs reserved for bad PEB handling: 40 [ 5.031000] UBI: max/mean erase counter: 2/0 [ 5.031000] UBI: image sequence number: 1009463499 [ 5.032000] UBI: background thread "ubi_bgt0d" started, PID 51 [ 5.975000] sdb: sdb1 [ 5.977000] sd 1:0:0:0: [sdb] Attached SCSI disk [ 6.128000] UBIFS: mounted UBI device 0, volume 0, name "rootfs" [ 6.129000] UBIFS: file system size: 413687808 bytes (403992 KiB, 394 MiB, 1629 LEBs) [ 6.130000] UBIFS: journal size: 9404416 bytes (9184 KiB, 8 MiB, 38 LEBs) [ 6.130000] UBIFS: media format: w4/r0 (latest is w4/r0) [ 6.131000] UBIFS: default compressor: lzo [ 6.132000] UBIFS: reserved for root: 0 bytes (0 KiB) [ 6.135000] VFS: Mounted root (ubifs filesystem) on device 0:13. [ 6.139000] devtmpfs: mounted [ 6.139000] Freeing unused kernel memory: 224k freed INIT: version 2.88 booting Displaying bootlogo. Starting udev [ 7.123000] udevd[78]: starting version 182 [ 7.656000] stb_core: module license 'Proprietary' taints kernel. [ 7.657000] Disabling lock debugging due to kernel taint [ 9.346000] enter base init, xvd 20100413, vdc 20100413, rap 20100719, xpt 20110228 [ 9.812000] 9:811009725 SMCA: controller reset timed out [ 9.822000] 9:821011900 SMCB: controller reset timed out [ 10.460000] register adapter [ 10.461000] register adapter [ 10.462000] register adapter [ 10.463000] register adapter [ 10.475000] FP Version 3 [ 10.476000] input: dreambox front panel as /devices/virtual/input/input0 [ 10.485000] fpga init [ 11.819000] done OK 0 [ 11.819000] using fpga version 47 [ 11.820000] tsmux set tsports reg 00 to val 00 [ 11.820000] tsmux set tsports reg 01 to val 01 [ 11.821000] tsmux set tsports reg 02 to val 02 [ 11.822000] tsmux set tsports reg 03 to val 03 [ 11.822000] tsmux set tsports reg 04 to val 04 [ 11.823000] tsmux set tsports reg 05 to val 05 [ 11.823000] tsmux set ciclk reg 34 to val 00 [ 11.824000] tsmux set cisource reg 06 to val 00 [ 11.824000] tsmux set ciclk reg 34 to val 00 [ 11.825000] tsmux set cisource reg 07 to val 01 [ 11.826000] set sb to 3(2) [ 11.827000] set fb to 2(-1) [ 11.827000] set input to 0 [ 11.828000] set fb to 2(-1) [ 11.832000] keys c7 [ 11.832000] bcm_video_analog_port_setup (fmt=7) [ 11.833000] SET FORMAT: display[1], format=7 [ 11.834000] display 0 uses vbi path 1 [ 11.834000] display 1 uses vbi path 0 [ 11.835000] HDMI: now powered down [ 11.864000] HDMI: EDID read ok [ 11.864000] HDMI: initial mode set! [ 11.865000] using 50.00Hz as MonitorRefreshRate [ 11.865000] SET FORMAT: display[0], format=37 [ 11.866000] HDMI mode [ 11.866000] use EDID to detect colorspace [ 11.866000] using colorspace: 1 [ 11.899000] HDMI: use logical CEC address 3 [ 11.922000] set fb to 2(0) [ 11.922000] bcm_video_analog_port_setup (fmt=7) [ 11.922000] SET FORMAT: display[1], format=7 [ 11.928000] disable wss on display 0 [ 11.928000] disable wss on display 1 [ 11.929000] bcmfb: creating surface with pixel format 0x07e48888 (BPXL_eA8_R8_G8_B8) [ 12.037000] CEC send ok! [ 12.061000] enable mad [ 12.108000] VIDEO0: set fallback framerate to 60000 [ 12.108000] VIDEO0: set progressive override mode to 1 [ 12.109000] VIDEO0: set streamtype! [ 12.109000] set MPEG2 [ 12.110000] sw rave disabled! [ 12.112000] enable mad [ 12.113000] VIDEO1: set fallback framerate to 60000 [ 12.114000] VIDEO1: set progressive override mode to 1 [ 12.114000] VIDEO1: set streamtype! [ 12.115000] set MPEG2 [ 12.115000] sw rave disabled! [ 12.121000] sync is off so we enable it [ 12.122000] playback! [ 12.122000] total video delay: 0 (0 ms) [ 12.126000] VIDEO0: start decode [ 12.126000] flush video decoder [ 12.127000] VIDEO0 got pts failed !!!! (ret 0) [ 13.521000] set ac3 to downmix [ 13.521000] set ac3plus to use_hdmi_caps [ 13.522000] set aac to downmix [ 13.522000] init ALSA! [ 13.547000] VIDEO0: first pts 0x0 [ 13.579000] DVB: registering new adapter (BCM7405) [ 13.601000] autodetecting NIMs... [ 13.609000] ret: 2, feid: 15 [ 13.609000] Found: Slot A, ID: 15 (by CA) [ 13.611000] ret: 2, feid: 15 [ 13.611000] Found: Slot B, ID: 15 (by CA) [ 13.612000] Initializing adapter 0 (CXD1981-(null)) [ 13.632000] DVB: registering adapter 0 frontend 0 (CXD1981)... [ 13.661000] Initializing adapter 1 (CXD1981-(null)) [ 13.679000] DVB: registering adapter 0 frontend 1 (CXD1981)... [ 13.698000] enable tsm0 [ 14.922000] VIDEO0: stop decode [ 14.923000] no decoder left in sync handling so disable xpt_sync [ 14.935000] CI stopped... [ 14.938000] registered vtuner misc/vtuner0, minor 54 [ 14.942000] registered vtuner misc/vtuner1, minor 53 [ 14.943000] IR-TX init! [ 14.943000] CI stopped... [ 15.077000] VIDEO0: set blank to 0 [ 15.078000] sync is off so we enable it [ 15.078000] playback! [ 15.079000] total video delay: 0 (0 ms) [ 15.082000] VIDEO0: start decode [ 15.083000] flush video decoder [ 15.127000] VIDEO0: first pts 0x0 [ 15.128000] VIDEO0: framerate changed 3 [ 15.128000] VIDEO0: resolution changed (1280 720) [ 15.129000] VIDEO0: aspect changed 3 [ 15.207000] set current avs auto aspect to 16:9 [ 15.208000] disable wss on display 0 [ 15.208000] disable wss on display 1 [ 15.209000] set current avs auto aspect to 16:9 [ 15.209000] disable wss on display 0 [ 15.210000] disable wss on display 1 [ 15.211000] set sb to 3(1) [ 15.240000] VIDEO0: set blank to 0 [ 15.241000] VIDEO0: stop decode [ 15.242000] VIDEO0: set blank to 0 [ 15.242000] no decoder left in sync handling so disable xpt_sync [ 17.919000] input: dreambox remote control (native) as /devices/virtual/input/input1 [ 17.922000] input: dreambox advanced remote control (native) as /devices/virtual/input/input2 [ 17.936000] input: dreambox ir keyboard as /devices/virtual/input/input3 [ 17.942000] input: dreambox ir mouse as /devices/virtual/input/input4 [ 18.083000] NET: Registered protocol family 10 [ 18.095000] 4013062 ms: [ 18.216000] 121 ms: 12 mkdir /dev/shm..... [ 18.342000] Empty flash at 0x00325a64 ends at 0x00326000 [ 18.502000] UBIFS: mounted UBI device 0, volume 1, name "data" [ 18.503000] UBIFS: file system size: 599072768 bytes (585032 KiB, 571 MiB, 2359 LEBs) [ 18.504000] UBIFS: journal size: 29966336 bytes (29264 KiB, 28 MiB, 118 LEBs) [ 18.505000] UBIFS: media format: w4/r0 (latest is w4/r0) [ 18.506000] UBIFS: default compressor: lzo [ 18.506000] UBIFS: reserved for root: 4952683 bytes (4836 KiB) [ 18.514000] XFS (sdb1): Mounting Filesystem [ 19.092000] XFS (sdb1): Ending clean mount [ 19.099000] XFS (sda1): Mounting Filesystem [ 19.305000] XFS (sda1): Ending clean mount [ 19.324000] 1107 ms: 14 [ 19.935000] 610 ms: 16 [ 19.999000] 64 ms: 18 [ 20.032000] 33 ms: 20 Configuring network interfaces... udhcpc (v1.19.4) started Sending discover... Sending select for 192.168.1.10... Lease of 192.168.1.10 obtained, lease time 259200 /etc/udhcpc.d/50default: Adding DNS 212.33.36.155 /etc/udhcpc.d/50default: Adding DNS 212.33.55.5 done. [ 22.927000] 2895 ms: 22 rdate: can't connect to remote host (192.53.103.108): Connection refused Starting rdate timesync...: Sync done[ 23.221000] 293 ms: 24 Starting rpcbind... Mounting /etc/enigma2/automounts.xml... [MountManager] 192.168.1.1 offline [ 27.157000] 3935 ms: 26 net.ipv4.conf.default.rp_filter = 1 net.ipv4.conf.all.rp_filter = 1 [ 27.219000] 62 ms: 28 Starting tpmd. [ 27.272000] 53 ms: 30 INIT: Entering runlevel: 3 Starting system message bus: dbus. [ 27.653000] 381 ms: 33 Starting Dropbear SSH server: dropbear. [ 27.750000] 97 ms: 34 Starting automounter: loading autofs4 kernel module, done. [ 28.943000] 1192 ms: 35 [ 29.032000] 88 ms: 36 Starting dbttcd. [ 29.089000] 57 ms: 37 Starting default emu. [ 29.160000] 70 ms: 38 creating NFS state directory: done NFSD Modul loaded.... NFSD Mounted.... RPCBIND Running.... starting 8 nfsd kernel threads: [ 29.573000] Installing knfsd (copyright (C) 1996 okir@monad.swb.de). [ 29.663000] NFSD: Using /var/lib/nfs/v4recovery as the NFSv4 state recovery directory [ 29.664000] NFSD: starting 90-second grace period done starting mountd: done starting statd: done [ 30.143000] 983 ms: 39 Starting syslogd/klogd: done [ 30.224000] 81 ms: 40 Starting internet superserver: xinetd. [ 30.319000] 95 ms: 41 * Starting Avahi mDNS/DNS-SD Daemon: avahi-daemon ...done. [ 30.688000] 368 ms: 42 [ 31.252000] 564 ms: 43 Starting Vixie-cron. [ 31.356000] 103 ms: 44 cat: can't open '/proc/stb/lcd/xres': No such file or directory [ 35.802000] ------------[ cut here ]------------ [ 35.802000] WARNING: at fs/proc/generic.c:586 proc_register+0x1f0/0x2ac() [ 35.803000] proc_dir_entry 'stb/lcd' already registered [ 35.804000] Modules linked in: tft_dm7020hd(O+) nfsd autofs4 ipv6 dreambox_keyboard(P) dreambox_rc2(P) bcm7405(P) alps_bsbe2(P) snd_pcm snd_timer snd_page_alloc tu1216(O) cu1216mk3(P) alps_bsbe1_c01a(P) bcm4506(P) helper(O) cxd1981(P) alps_bsbe1(O) lnb_ctrl(P) stv0299 lcd(P) stb_core(P) [ 35.807000] Call Trace: [ 35.807000] [<80499c10>] dump_stack+0x8/0x34 [ 35.808000] [<8002ed0c>] warn_slowpath_common+0x78/0xa4 [ 35.809000] [<8002edc0>] warn_slowpath_fmt+0x2c/0x38 [ 35.809000] [<80111e50>] proc_register+0x1f0/0x2ac [ 35.810000] [<801123b0>] proc_mkdir_mode+0x40/0x6c [ 35.810000] [] init_module+0x38/0x204 [tft_dm7020hd] [ 35.811000] [<80001570>] do_one_initcall+0x160/0x1f0 [ 35.812000] [<8006add8>] sys_init_module+0x1148/0x1e98 [ 35.812000] [<8000c83c>] stack_done+0x20/0x40 [ 35.813000] [ 35.813000] ---[ end trace ea40acdc4f3fcc38 ]--- [ 35.856000] 4499 ms: 45 * starting eDaemon: eDaemon... [ 35.910000] procfile_read_xres called [ 35.910000] procfile_read_xres called [ 35.912000] procfile_read_yres called [ 35.912000] procfile_read_yres called [ 35.914000] procfile_read_bpp called [ 35.915000] procfile_read_bpp called done. [ 35.932000] 75 ms: 46 [SCRIPT] start: OScam [ 36.080000] 147 ms: 47 [ 36.100000] 20 ms: 48 [ 36.159000] VIDEO0: set blank to 0 [ 36.163000] sync is off so we enable it [ 36.163000] playback! [ 36.164000] total video delay: 0 (0 ms) [ 36.168000] VIDEO0: start decode [ 36.170000] flush video decoder [ 36.207000] VIDEO0: first pts 0x0 [ 36.327000] VIDEO0: set blank to 0 [ 36.332000] VIDEO0: stop decode [ 36.332000] VIDEO0: set blank to 0 [ 36.333000] no decoder left in sync handling so disable xpt_sync [ 37.758000] 37:757341965 SMCA: invalid ioctl: 0x80047309 [ 37.759000] 37:758498741 SMCA: no etu_clkdiv found for sc_clkdiv=0 and fs=1166666 [ 38.070000] 38:69106245 SMCA: invalid ioctl: 0x8004730c enigma2 is the main pvr application... adjust oom score! [ 38.875000] 38:874432292 SMCA: invalid ioctl: 0x00005407 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. 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 [ 42.237000] bcmfb: enable manual blit [ 42.278000] 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! [ 42.355000] procfile_read_xres called [ 42.356000] procfile_read_xres called [ 42.357000] procfile_read_yres called [ 42.358000] procfile_read_yres called [ 42.360000] procfile_read_bpp called [ 42.360000] procfile_read_bpp called lcd buffer 0x743bd008 192000 bytes, stride 800 + (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: 4.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.. CI Slot 0 has fd 27 CI Slot 1 has fd 28 [ 42.418000] tsmux set cisource reg 06 to val 00 CI Slot 0 setSource(0) [ 42.420000] tsmux set cisource reg 07 to val 00 CI Slot 1 setSource(0) [ 42.422000] tsmux set tsports reg 00 to val 00 eDVBCIInterfaces->setInputSource[ 42.423000] tsmux set tsports reg 01 to val 01 (0, 0) eDVBCIInterfaces->setInputSource(1, 1) eDVBCIInterfaces->setInputSource(2, 2) eDVBCIInterfaces->setInputSource(3, 3) done, found 2 common interface slots + (40) eServiceCenter settings instance. + (41) eHbbtv + (41) eServiceFactoryBludisc + (41) eServiceFactoryM2TS + (41) eServiceFactoryMP3 + (41) eServiceFactoryFS + (41) eServiceFactoryDVB reached rl 70 ---- opening lame channel db reading services (version 4) loaded 420 services scanning for frontends.. opening frontend 0 detected terrestrial frontend (0)setVoltage 0V close frontend 0 opening frontend 1 detected terrestrial frontend (1)setVoltage 0V close frontend 1 scanning for demux.. scanning for decoders.. scanning for descramblers.. found 1 adapter, 2 frontends(2 sim) and 5 demux, boxtype 5 [eDVBLocalTimeHandler] Use valid Linux Time 'Sat Oct 12 11:32:27 2013' :) (RTC?) [EPGC] Initialized EPGCache (wait for setCacheFile call now) Loading spinners... found 12 spinners! executing main setIoPrio best-effort level 6 ok [ 43.471000] 7371 ms: 49 [ 43.515000] 44 ms: 50 /proc/stb/frontend/0/lnb_sense is 0 [setupConfigEntries] initial_call for stored uuid: 6a1428a5-6af8-429e-b0c5-8f89a6495020 {'mountpoint': '/media/hdd', 'device_info': 'eSATA', 'device_description': 'ATA-Hitachi HTS54501 (160.041 GB)', 'enabled': 'true'} main thread is non-idle! display spinner! [ 45.062000] cdfs 2.6.27 loaded. [setupConfigEntries] initial_call for stored uuid: 79b7c217-1005-43f5-8b48-c5bca3ad6b10 {'mountpoint': '/media/archiv', 'device_info': 'SATA', 'device_description': 'ATA-WDC WD30EZRX-00D (3000.592 GB)', 'enabled': 'true'} enumerating block devices... found block device 'loop0': blacklisted found block device 'loop1': blacklisted found block device 'mtdblock0': blacklisted found block device 'mtdblock1': blacklisted found block device 'mtdblock2': blacklisted found block device 'mtdblock3': blacklisted found block device 'sda': ok, removable=False, cdrom=False, partitions=['sda1'] Unable to determine structure of /dev fallback to udev new Harddisk sda -> /dev/sda -> /dev/sda [ePopen] command: ('hdparm', 'hdparm', '-S0', '/dev/sda') [addDevicePartition] device:'sda' with UUID:'None' [ 46.128000] 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:'79b7c217-1005-43f5-8b48-c5bca3ad6b10' [enumerateBlockDevices] devices_scanned_on_init: [('sda', False, False, True)] found block device 'sdb': ok, removable=False, cdrom=False, partitions=['sdb1'] Unable to determine structure of /dev fallback to udev new Harddisk sdb -> /dev/sdb -> /dev/sdb main thread is non-idle! display spinner! [ePopen] command: ('hdparm', 'hdparm', '-S0', '/dev/sdb') [addDevicePartition] device:'sdb' with UUID:'None' Harddisk.py: failed to read /sys/block/sdb1/removable found block device 'sdb1': error querying properties [addDevicePartition] device:'sdb1' with UUID:'6a1428a5-6af8-429e-b0c5-8f89a6495020' [enumerateBlockDevices] devices_scanned_on_init: [('sda', False, False, True), ('sdb', False, False, True)] Reading cables.xml couldn't open /etc/tuxbox/cables.xml!! Reading terrestrial.xml setSlotInfo for dvb frontend 0 to slotid 0, descr CXD1981, need rotorworkaround No, enabled No, DVB-S2 No setSlotInfo for dvb frontend 1 to slotid 1, descr CXD1981, need rotorworkaround No, enabled No, DVB-S2 No opening frontend 0 eDVBFrontend 0 t[ 47.664000] cxd1981: type changed to DVB-C ype change to 2 OK (0) preClose opening frontend 1 eDVBFrontend 1 t[ 47.704000] cxd1981: type changed to DVB-C ype change to 2 OK (1) preClose sec config cleared setSlotInfo for dvb frontend 0 to slotid 0, descr CXD1981, need rotorworkaround No, enabled Yes, DVB-S2 No setSlotInfo for dvb frontend 1 to slotid 1, descr CXD1981, need rotorworkaround No, enabled Yes, DVB-S2 No sec config completed [ 47.781000] 4266 ms: 50 [ 47.789000] 8 ms: 56 [ 47.837000] 47 ms: 56 [ 47.870000] 33 ms: 56 [ 47.872000] 2 ms: 56 [ 47.925000] 53 ms: 56 [ 48.406000] 481 ms: 56 [ 48.545000] 139 ms: 57 [ 48.557000] 12 ms: 57 [ 48.560000] 2 ms: 57 [ 48.562000] 2 ms: 57 Preferred tag editor set to None [ 48.933000] 371 ms: 57 [ 48.935000] 2 ms: 57 [ 49.049000] 114 ms: 57 [ 49.369000] 319 ms: 58 [ 49.371000] 2 ms: 58 [ 49.388000] 16 ms: 58 [ 49.390000] 1 ms: 58 [ 49.392000] 2 ms: 58 [ 49.409000] 17 ms: 58 [ 49.444000] 34 ms: 58 [ 50.460000] 1016 ms: 58 [ 50.469000] 8 ms: 60 [ 50.485000] 16 ms: 60 loading bouquet... /etc/enigma2/bouquets.tv loading bouquet... /etc/enigma2/userbouquet.favourites.tv 36 entries in Bouquet userbouquet.favourites.tv 1 entries in Bouquet bouquets.tv loading bouquet... /etc/enigma2/bouquets.radio loading bouquet... /etc/enigma2/userbouquet.favourites.radio 10 entries in Bouquet userbouquet.favourites.radio 1 entries in Bouquet bouquets.radio [ 50.504000] 19 ms: 60 [ 50.532000] 27 ms: 60 [ 50.552000] 19 ms: 60 [ 50.554000] 2 ms: 60 [ 50.557000] 3 ms: 60 [eDVBLocalTimeHandler] enable sync local time with transponder time! [ 50.572000] 15 ms: 60 [ 52.595000] 2022 ms: 60 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', '[ 52.665000] 69 ms: 63 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'] /usr/lib/python2.7/site-packages/coherence/extern/louie.py:8: UserWarning: extern.louie will soon be deprecated in favor of coherence.dispatcher. warnings.warn("extern.louie will soon be deprecated in favor of coherence.dispatcher.") WARN coherence Oct 12 11:32:41 Coherence UPnP framework version 0.6.7 starting... (coherence/base.py:292) WARN coherence Oct 12 11:32:41 hostname can't be resolved, maybe a system misconfiguration? (coherence/base.py:300) WARN webserver Oct 12 11:32:41 WebServer on port 45708 ready (coherence/base.py:129) [ResourceManager] adding: UPnPControlPoint [ePopen] command: ip -o addr show dev eth0 [ResourceManager] adding: iNetwork [ 56.556000] 3891 ms: 63 add dreampackage scanner plugin added [ 56.694000] 138 ms: 69 [ 56.696000] 2 ms: 69 [ 56.762000] 66 ms: 69 [ 56.772000] 10 ms: 70 [ 56.774000] 2 ms: 70 [ 56.780000] 6 ms: 70 [ 56.796000] 16 ms: 70 [ 56.815000] 18 ms: 70 [ 56.817000] 2 ms: 70 [FONT] adding font /usr/share/fonts/nmsbd.ttf...OK (Display) [ 56.906000] 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) [FONT] adding font /usr/share/fonts/tcm.ttf...OK (Regular_LCD) [FONT] adding font /usr/share/fonts/tcm.ttf...OK (Regular) [ 57.212000] 395 ms: 70 [ 57.329000] 116 ms: 70 [ 57.368000] set current avs auto aspect to 4:3 [ 57.368000] disable wss on display 0 [ 57.369000] disable wss on display 1 [ 57.369000] set sb to 3(2) [ 57.407000] set current avs auto aspect to 4:3 [ 57.408000] disable wss on display 0 [ 57.409000] disable wss on display 1 [ 57.409000] set sb to 3(2) [ 57.411000] disable wss on display 0 [ 57.412000] set wss 8 on display 1 [ 57.448000] set input to 0 [ 57.448000] set fb to 2(0) [ 57.449000] set current avs auto aspect to 4:3 [ 57.449000] disable wss on display 0 [ 57.450000] set wss 8 on display 1 [ 57.451000] set sb to 3(2) [ 57.454000] set ac3 to downmix [ 57.458000] set ac3plus to use_hdmi_caps --> setting scaler_sharpness to: 0000000C [ 57.509000] 180 ms: 71 [ 57.519000] 10 ms: 71 [ 57.536000] 16 ms: 71 [ 57.830000] 293 ms: 71 [ 57.835000] 5 ms: 71 setLCDBrightness 25 setLCDBrightness 102 [ 57.857000] 21 ms: 71 Activating keymap: Keyboard English [ePopen] command: loadkmap < /usr/share/keymaps/eng.kmap Activating language German language set to de_DE [WebInterface] set language to de [WebInterface] set language to de [WebInterface] set language to de [VLC] Checking for buildin servicets ... no [VLC] Checking for existing and usable servicets.so ... yes It's now Sat Oct 12 11:32:46 2013 [timer.py] next activation: 1381570466 (in 99494 ms) [WebInterface] fallback to default translation for Webinterface [dFlash] 4096 [MyTube] MyTubePlayerService - init [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 [MovieCut] set language to de [MovieCut] set language to de CIFSMOUNT {'username': 'username', 'sharedir': 'Stick', 'sharename': 'OPENWRT', 'active': 'True', 'ip': '192.168.1.1', 'hdd_replacement': 'False', 'password': 'password', 'isMounted': False, 'mounttype': 'cifs', 'options': 'rw'} [AutoMount.py] -getAutoMountPoints:self.automounts --> {'OPENWRT': {'username': 'username', 'sharedir': 'Stick', 'sharename': 'OPENWRT', 'active': 'True', 'ip': '192.168.1.1', 'hdd_replacement': 'False', 'password': 'password', 'isMounted': False, 'mounttype': 'cifs', 'options': 'rw'}} [AutoMount.py] CheckMountPoint [AutoMount.py] activeMounts:---> 1 [AutoMount.py] U/MOUNTCMD---> mount -t cifs -o rw,rsize=8192,wsize=8192,iocharset=utf8,username=username,password=password //192.168.1.1/Stick /media/net/OPENWRT [ePopen] command: mount -t cifs -o rw,rsize=8192,wsize=8192,iocharset=utf8,username=username,password=password //192.168.1.1/Stick /media/net/OPENWRT 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 [ 71.448000] set current avs auto aspect to 16:9 [ 71.448000] disable wss on display 0 [ 71.449000] set wss 7 on display 1 [ 71.449000] set sb to 3(1) [ 71.488000] set current avs auto aspect to 16:9 [ 71.488000] disable wss on display 0 [ 71.489000] set wss 7 on display 1 [ 71.490000] set sb to 3(1) [ 71.491000] disable wss on display 0 [ 71.491000] set wss 7 on display 1 [ 71.493000] set current avs auto aspect to 16:9 [ 71.494000] disable wss on display 0 [ 71.494000] set wss 7 on display 1 [ 71.495000] set sb to 3(1) -> setting aspect, policy, policy2, wss 16:9 panscan letterbox auto [ 71.500000] set current avs auto aspect to 16:9 [ 71.501000] disable wss on display 0 [ 71.501000] set wss 7 on display 1 [ 71.502000] set sb to 3(1) [ 71.505000] set current avs auto aspect to 16:9 [ 71.506000] disable wss on display 0 [ 71.506000] set wss 7 on display 1 [ 71.509000] set sb to 3(1) [ 71.512000] disable wss on display 0 [ 71.513000] set wss 7 on display 1 [ 71.515000] set current avs auto aspect to 16:9 [ 71.515000] disable wss on display 0 [ 71.516000] set wss 7 on display 1 [ 71.517000] set sb to 3(1) -> setting aspect, policy, policy2, wss 16:9 panscan letterbox auto [ 71.523000] set current avs auto aspect to 16:9 [ 71.524000] disable wss on display 0 [ 71.524000] set wss 7 on display 1 [ 71.526000] set sb to 3(1) [ 71.526000] CIFS VFS: default security mechanism requested. The default security mechanism will be upgraded from ntlm to ntlmv2 in kernel release 3.3 [ 71.530000] set current avs auto aspect to 16:9 [ 71.530000] disable wss on display 0 [ 71.531000] set wss 7 on display 1 [ 71.532000] CIFS VFS: Server requests plain text password but client support disabled [ 71.532000] set sb to 3(1) [ 71.534000] disable wss on display 0 [ 71.535000] set wss 7 on display 1 [ 71.536000] set current avs auto aspect to 16:9 [ 71.537000] disable wss on display 0 [ 71.538000] set wss 7 on display 1 [ 71.539000] set sb to 3(1) -> setting aspect, policy, policy2, wss 16:9 panscan letterbox auto [ 71.548000] set current avs auto aspect to 16:9 [ 71.549000] disable wss on display 0 [ 71.550000] set wss 7 on display 1 [ 71.551000] set sb to 3(1) [ 71.552000] set current avs auto aspect to 16:9 [ 71.553000] disable wss on display 0 [ 71.554000] set wss 7 on display 1 [ 71.555000] set sb to 3(1) [ 71.557000] disable wss on display 0 [ 71.558000] set wss 7 on display 1 [ 71.561000] set current avs auto aspect to 16:9 [ 71.562000] disable wss on display 0 [ 71.563000] set wss 7 on display 1 [ 71.564000] set sb to 3(1) setMode - port: DVI mode: 1080i rate: 50Hz [ 71.588000] using 50.00Hz as MonitorRefreshRate [ 71.708000] SET FORMAT: display[0], format=27 [ 71.708000] HDMI mode [ 71.708000] use EDID to detect colorspace [ 71.709000] using colorspace: 1 [ 71.789000] bcm_video_analog_port_setup (fmt=7) [ 71.907000] SET FORMAT: display[1], format=7 [ 72.027000] set current avs auto aspect to 16:9 [ 72.028000] disable wss on display 0 [ 72.029000] set wss 7 on display 1 [ 72.030000] set sb to 3(1) [ 72.032000] set current avs auto aspect to 16:9 [ 72.032000] disable wss on display 0 [ 72.033000] set wss 7 on display 1 [ 72.033000] set sb to 3(1) -> setting aspect, policy, policy2, wss 16:9 panscan letterbox auto [ 72.040000] set current avs auto aspect to 16:9 [ 72.041000] disable wss on display 0 [ 72.041000] set wss 7 on display 1 [ 72.042000] set sb to 3(1) [ 72.044000] set current avs auto aspect to 16:9 [ 72.044000] disable wss on display 0 [ 72.045000] set wss 7 on display 1 [ 72.045000] set sb to 3(1) [ 72.049000] disable wss on display 0 [ 72.049000] set wss 7 on display 1 [ 72.051000] set current avs auto aspect to 16:9 [ 72.051000] disable wss on display 0 [ 72.052000] set wss 7 on display 1 [ 72.052000] set sb to 3(1) sh: fpupgrade: command 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) [eCamdCtrl] starting cmd 5 [eCamdCtrl] executing /usr/bin/camdctrl current [TeleText] autostart(0, {}) [CrashlogAutoSubmit] - autostart [CI_Assignment] activating ci configs: [CI_Activate] FOUND 2 CI Slots [CI_Activate_Config_CI1] no config file found [CI_Activate_Config_CI1] error parsing xml... [CI_Activate] activate CI0 with following settings: 0 ([], [], []) starting hotplug handler [MiniDLNAConfig].apply 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] EMC: Setting EPG language: de_DE [AudioSync] set language to de [AudioSync] set language to de [MovieCut] set language to de [MovieCut] set language to de [ 75.072000] 17215 ms: 71 [ 75.091000] 18 ms: 96 [ 75.096000] tsmux set ciclk reg 34 to val 00 [ 75.101000] tsmux set ciclk reg 34 to val 00 FIXME: request for unknown slot FIXME: request for unknown slot [ 75.111000] 20 ms: 96 It's now Sat Oct 12 11:32:59 2013 [timer.py] next activation: 1381570479 (in 99013 ms) [TIMER] record time changed, start prepare is now: Sat Oct 12 20:09:40 2013 sanitycheck check checkTimerlist recording service: 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: record: 0 [Timer] Record ProcessRepeated It's now Sat Oct 12 11:33:00 2013 next real activation is Sat Oct 12 20:09:40 2013 [timer.py] next activation: 1381570480 (in 99957 ms) It's now Sat Oct 12 11:33:00 2013 [timer.py] next activation: 1381570480 (in 99952 ms) [ 75.210000] 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) InfoBarTunerState start Looking for embedded skin Repeated: 1 Repeated: 3 Repeated: 7 Repeated: 15 Repeated: 31 Repeated: 63 Repeated: 127 ProcessRepeated localrepeatedbegindate: Sat Oct 12 18:00:00 2013 localbegin: Sat Oct 12 18:00:00 2013 localend: Sat Oct 12 18:00:00 2013 localnow: Sat Oct 12 11:33:01 2013 Day: 0 Day: 1 Day: 2 Day: 3 Day: 4 Day: 5 Day: 6 ProcessRepeated result Sat Oct 12 18:00:00 2013 Sat Oct 12 18:00:01 2013 It's now Sat Oct 12 11:33:00 2013 next real activation is Sat Oct 12 18:00:01 2013 [timer.py] next activation: 1381570480 (in 99706 ms) [dFLASH] autostart [TeleText] ----- sessionstart(<__main__.Session instance at 0x2104120>) ----- [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 EMC: +++ EMC V3.7.3beta20130802 startup [ResourceManager] adding: NetworkAdapterSelection [ResourceManager] adding: AdapterSetup [CrashlogAutoSubmit] - autostart [CrashlogAutoSubmit] - not starting CrashlogAutoSubmit [MiniDLNAConfig].apply [Cec] power on [AutomaticVolumeAdjustment] Starting AutomaticVolumeAdjustment... [AutomaticVolumeAdjustmentConfig] Loading config file... [AutomaticVolumeAdjustmentConfig] Loaded 0 entries from config file... [AutomaticVolumeAdjustment] initialize config values... Looking for embedded skin port changed to DVI mode changed to 1080i getModeList for port DVI default ('1080i', 'Standard') preferedmodes ['720p', '576p', '480p', '576i', '480i', ('1080i', 'Standard')] [InstallerUpdateCheck] timer changed [InstallerUpdateCheck] is offline [CamdresetEveryDay] next reset: Sat Oct 12 23:44:59 2013 No skin to read... Looking for embedded skin [Toplevel.importExternalModules] Imported external module: Example [Toplevel.importExternalModules] Imported external module: EPGRefresh libpagecache exists... drop caches now! [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:442 auth=True ssl=True [WebInterface.registerBonjourService] No module named Bonjour.Bonjour [ 76.921000] 1809 ms: 96 [EPGC] set outdated epg timespan to 12 hours... [EPGC] set cache timespan to 28 days! [EPGC] setCacheFile read/write epg data from/to '/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 [ 77.000000] 78 ms: 99 setValue 60 Setvolume: 60 60 (raw) Setvolume: 26 26 (-1db) [ 77.100000] 100 ms: 99 [ 77.118000] 18 ms: 99 [prepareClose] running mainloop [prepareClose] running mainloop EMC: Setting EPG language: de_DE allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! [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 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! allocating new converter! reused converter! allocating new converter! reused converter! allocating new converter! main thread is non-idle! display spinner! WARN mediaserver Oct 12 11:33:04 MediaServer dm7020hd (TV & Radio) (DreamboxServiceStore) activated with id d9bba443-6282-4f1a-b4dc-f796fc279154 (coherence/upnp/devices/media_server.py:711) [EPGC] 67114 events read from /hdd/epg.dat [EPGC] load 26043 descriptors...[UPnPPlayer.getVolume] [UPnPPlayer.getMute] WARN mediarenderer Oct 12 11:33:06 dm7020hd MediaRenderer (UPnPMediaRenderer'>) activated with 5288fe1e-b830-4c09-be86-29b5a8dbfc28 (coherence/upnp/devices/media_renderer.py:142) cec event! attached: hdmi attached attached: hdmi cec address acknowledged my physical: 4.0.0.0 logical 3 CISlot 0 what 2 CISlot 1 what 2 child has terminated pipes closed child has terminated pipes closed poll: unhandled POLLERR/HUP/NVAL for fd 41(16) poll: unhandled POLLERR/HUP/NVAL for fd 44(16) child has terminated pipes closed finished [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 4807892 bytes for cache used [ePopen] command: route -n | grep eth0 child has terminated pipes closed poll: unhandled POLLERR/HUP/NVAL for fd 50(16) poll: unhandled POLLERR/HUP/NVAL for fd 53(16) child has terminated pipes closed [AutoMount.py] CheckMountPointFinished [AutoMount.py] result [AutoMount.py] retval 0 LEN 0 PATH im CheckMountPointFinished /media/net/OPENWRT poll: unhandled POLLERR/HUP/NVAL for fd 63(16) child has terminated pipes closed poll: unhandled POLLERR/HUP/NVAL for fd 69(16) child has terminated pipes closed poll: unhandled POLLERR/HUP/NVAL for fd 79(16) [SEC] lock 0 [SEC] lock 0 playing 1:0:1:4E25:2B6E:1:FFFF024A: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/SAT.1 A.png [TeleText] service started not pauseable. RemovePopup, id = ZapError allocate channel.. 2b6e:0001:ffff024a [eDVBCAService] new channel 0x2341ba8! (0)tune tuning to 586000 khz, sr 6900000, fec 9, modulation 5, inversion 2 OURSTATE: tuning allocate Channel: res 0 [eDVBCIInterfaces] addPMTHandler 1:0:1:4E25:2B6E:1:FFFF024A:0:0:0: recheckPMTHAndlers() recheck 0x2338a24 1:0:1:4E25:2B6E:1:FFFF024A:0:0:0: check Slot 0 check Slot 1 allocate demux FE_READ_BER failed (Resource temporarily unavailable) FE_READ_BER failed (Resource temporarily unavailable) FE_READ_BER failed (Resource temporarily unavailable) cec event! send 3 -> 0 : 04 [ 82.892000] CEC send ok! child has terminated pipes closed 0.0.0.0 169.254 192.168 nameservers: [[212, 33, 36, 155], [212, 33, 55, 5]] read configured interface: {'lo': {'dhcp': False}, 'eth0': {'dhcp': True}} self.ifaces after loading: {'eth0': {'preup': False, 'predown': False, 'ip': [192, 168, 1, 10], 'up': True, 'dns-nameservers': False, 'broadcast': False, 'mac': '00:09:34:2d:c6:b4', 'dhcp': True, 'bcast': [192, 168, 1, 255], 'netmask': [255, 255, 255, 0], 'gateway': [192, 168, 1, 1]}} poll: unhandled POLLERR/HUP/NVAL for fd 50(16) [SEC] delayed close frontend close frontend 1 [SEC] startTuneTimeout 5000 cec event! send 3 -> f : 82 40 00 child has terminated pipes closed poll: unhandled POLLERR/HUP/NVAL for fd 53(16) [SEC] unlock [SEC] setFrontend 1 (0)setting frontend (0)fe event: status 0, freq 586000000, inversion off, m_tuning 1 F [ 83.163000] CEC send ok! (0)fe event: status 1f, freq 586000000, inversion off, m_tuning 1 N OURSTATE: ok [eDVBCAService] channel 0x2341ba8 running [eDVBLocalTimeHandler] channel 0x2341ba8 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 0x2341ba8 running stop release channel timer no version filtering 0012: 4e 4e 25 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) (0320), and 1 audio stream(s) (0321), and the pcr pid is 0320, and the text pid is 0322 allocate demux disable teletext subtitles decoder state: play, vpid=800, apid=801 DMX_SET_PES_FILTER(0x320) - pcr - ok D[ 83.214000] start pcr0 on dmx 3 pid:320 index 5 EMUX_START - pcr - ok DMX_SET_PES_FILTER(0x321) - audio - ok DEMUX_START - audio - ok AUDIO_SET_BYPASS(1) - [ 83.217000] start audio on dmx 3 pid:321 [ 83.217000] audio xpt start [ 83.218000] sync is off so we enable it [ 83.218000] demux-index 3 pcr0pid 320 [ 83.219000] using 5 as pcr0 pidchannel [ 83.220000] MPEG [ 83.220000] audio: streamtype set 0 [ 83.220000] audio: streamtype_set: stop rave [ 83.222000] audio: streamtype_set: restart rave [ 83.222000] set mute 0 (111) 1 ok AUDIO_PAUSE - ok AUDIO_PLAY - [ 83.223000] audio: decoder start 2 [ 83.226000] video delay 0 (0 ms) [ 83.226000] total video delay: 0 (0 ms) ok Video Device: /dev/dvb/adapter0/video0 demux device: /dev/dvb/adapter0/demux3 VIDEO_SET_STREAMTYPE 0 - ok DMX[ 83.229000] start video0 on dmx 3 pid:320 _SET_PES_FILTER([ 83.230000] total video delay: 0 (0 ms) 0x320) - video - ok DEMUX_START - video - ok VIDEO_FREEZE - ok VIDEO_PLAY - [ 83.235000] VIDEO0: start decode ok DMX_SET_PES_FILTER(0x322) - 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. FE_READ_BER failed (Resource temporarily unavailable) FE_READ_BER failed (Resource temporarily unavailable) FE_READ_BER failed (Resource temporarily unavailable) [TeleText] serviceInfoChanged [TeleText] TXT PID 802 DEMUX 3 [TeleText] send array('B', [1, 3, 34, 3]) [AutomaticVolumeAdjustment] service changed [AutoRes] service changed FE_READ_BER failed (Resource temporarily unavailable) FE_READ_BER failed (Resource temporarily unavailable) + 1/1 TID 00 done! PATready use pmtpid 0404 for service_id 4e25 no version filtering 0404: 02 4e 25 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 doing version filtering 0000: 00 00 00 15 00 00 mask: ff 00 00 3f 00 00 mode: 00 00 00 3e 00 00 VIDEO_GET_EVENT - ok [AutoRes] got event evVideoSizeChanged VIDEO_GET_EVENT - ok [AutoRes] got event evFramerateChanged [ExtendedInfoBar] CAIDs: ['0000'] [ExtendedInfoBar] SID: 4E25 + 1/1 TID 02 done! [eDVBCAService] new service 1:0:1:4E25:2B6E:1:FFFF024A:0:0:0: [eDVBCAService] add demux 3 to slot 0 service 1:0:1:4E25:2B6E:1:FFFF024A:0:0:0: demux 3 mask 08 prevhash 00000000 [eDVBCAService] send 60 bytes 9f 80 32 38 03 4e 25 07 00 19 01 81 08 ff ff 02 4a 2b 6e 00 01 82 02 08 03 84 02 04 04 09 04 0b 00 f3 c2 02 03 20 00 00 03 03 21 00 00 06 03 22 00 00 06 03 23 00 00 05 05 05 00 00 recheckPMTHAndlers() recheck 0x2338a24 1:0:1:4E25:2B6E:1:FFFF024A:0:0:0: check Slot 0 check Slot 1 [eDVBCIInterfaces] gotPMT eventNewProgramInfo 0 0 start ait on pid 0505 no version filtering 0505: 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) (0320), and 2 audio stream(s) (0321, 0323), and the pcr pid is 0320, and the text pid is 0322 decoder state: play, vpid=800, a[ 83.813000] bcm_audio: got invalid pts (ret 2359298)!! pid=803 AUDIO_S[ 83.814000] audio: decoder stop TOP - ok DEMUX_STOP - audio - [ 83.816000] stop audio on dmx 3 pid:321 [ 83.816000] audio: xpt stop(3) [ 83.817000] bcm_audio_channel_stop(3) done ok AUDIO_CONTINUE - ok DMX_SET_PES_FILTER(0x323) - audio - ok DEMUX_START - audio - ok AUDIO_SET_BYPASS(0) - [ 83.819000] start audio on dmx 3 pid:323 [ 83.820000] audio xpt start [ 83.820000] AC3 [ 83.820000] audio: streamtype set 1 [ 83.821000] audio: streamtype_set: stop rave [ 83.821000] decode [ 83.822000] audio: streamtype_set: restart rave [ 83.822000] set mute 0 (111) 0 ok AUDIO_PAUSE - ok AUDIO_PLAY - [ 83.823000] audio: decoder start 2 [ 83.826000] video delay 0 (0 ms) [ 83.827000] total video delay: 0 (0 ms) ok AUDIO_CONTINUE - ok [ 83.862000] RAP first pts 0x1eff193c4, stc 0x10d1a3080, pcr valid [ 83.864000] audio_cdb_itb_error_isr! underflow [ 83.868000] audio_cdb_itb_error_isr! underflow FE_READ_BER failed (Resource temporarily unavailable) [ 83.872000] audio_cdb_itb_error_isr! underflow [ 83.876000] audio_cdb_itb_error_isr! underflow FE_READ_BER failed (Resource temporarily unavailable) [ 83.880000] audio_cdb_itb_error_isr! underflow [TeleText] serviceInfoChanged [TeleText][ 83.884000] audio_cdb_itb_error_isr! underflow TXT PID 802 DEMUX 3 [TeleText] send array('B', [1, 3, 34, 3]) [ 83.888000] audio_cdb_itb_error_isr! underflow [ 83.892000] audio_cdb_itb_error_isr! underflow doing version filtering 0404: 02 4e 25 07 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 [ 83.896000] audio_cdb_itb_error_isr! underflow [ 83.900000] audio_cdb_itb_error_isr! underflow sdt update done! FE_READ_BER failed (Resource temporarily unavailable) +- 1/2 TID 4e [ 84.118000] ch0: lock ++ 2/2 TID 4e done! doing version filtering 0012: 4e 4e 25 09 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 [ 84.948000] VIDEO0: first pts 0x10d1c33da [ 84.948000] VIDEO0: resolution changed (720 576) [ 85.100000] enable tsm0 [EPGC] start caching events(1381570390) [ 85.267000] VIDEO0: progressive changed (0) [DLNA] Device found: dm7020hd (MediaRenderer) [DLNA] Device found: dm7020hd (MediaRenderer) FE_READ_BER failed (Resource temporarily unavailable) FE_READ_BER failed (Resource temporarily unavailable) [DLNA] Device found: dm7020hd (TV & Radio) (MediaServer) [DLNA] Device found: dm7020hd (TV & Radio) (MediaServer) [DLNA] MediaRenderer detected: dm7020hd (MediaRenderer, uuid:5288fe1e-b830-4c09-be86-29b5a8dbfc28) + 1/1 TID 74 done! [eHbbtv] aitChanged pid=0x505 [eOipfApplication] Profile 0000, Version 1.1.1 [eOipfApplication] deu:SAT.1 HD Austria [eHbbtv] New Application: SAT.1 HD Austria (orgid=96, appid=4, urlBase=http://hbbtv.sat1.at/service/, initalPath=redbutton_s1at.php, controlCode=1, visibility=2) [eHbbtv] Resolving Application Locator: dvb://current.ait/96.4 [eHbbtv] We have 1 app(s) for service 1.11118.20005 [eHbbtv] 'dvb://current.ait/96.4' resolved to 'http://hbbtv.sat1.at/service/redbutton_s1at.php' doing version filtering 0505: 74 00 00 07 00 00 mask: ff 00 00 3f 00 00 mode: 00 00 00 3e 00 00 VIDEO_GET_EVENT - ok [AutoRes] got event evVideoSizeChanged VIDEO_GET_EVENT - ok [AutoRes] got event evVideoProgressiveChanged FE_READ_BER failed (Resource temporarily unavailable) [ 87.700000] CEC recv ok! [ 87.905000] CEC recv ok! PTS-Plugin: Erasing stranded timeshift pts_livebuffer.1 IBTS hide eBackgroundFileEraser '/media/hdd/pts//pts_livebuffer.1' finished cec event! handle message 5 -> f : 84 10 00 05 Report Physical Address 1.0.0.0 device type 5 (Audio System) IBTS tunerHide eBackgroundFileEraser '/media/hdd/pts//pts_livebuffer.1.meta' finished eBackgroundFileEraser '/media/hdd/pts//pts_livebuffer.1.eit' finished [ 88.514000] CEC recv ok! cec event! handle message 5 -> f : 84 10 00 05 Report Physical Address 1.0.0.0 device type 5 (Audio System) [ 88.616000] CEC recv ok! cec event! handle message 5 -> f : 72 01 [ 88.943000] CEC recv ok! cec event! handle message 4 -> f : 87 00 00 f0 Device Vendor ID 0000f0 [ 89.056000] HDMI: force disconnect! [ 89.056000] HDMI: now disconnected [ 89.056000] HDMI: stop CEC [ 89.057000] HDMI: now connected cec event! nothing attached! [ 89.087000] HDMI: EDID read ok [ 89.108000] using 50.00Hz as MonitorRefreshRate [ 89.227000] SET FORMAT: display[0], format=27 [ 89.228000] HDMI mode [ 89.228000] use EDID to detect colorspace [ 89.229000] using colorspace: 1 [ 89.343000] bcm_video_analog_port_setup (fmt=7) [ 89.448000] SET FORMAT: display[1], format=7 [ 89.567000] set current avs auto aspect to 16:9 [ 89.568000] disable wss on display 0 [ 89.569000] set wss 7 on display 1 [ 89.569000] HDMI: start CEC [ 89.570000] CEC recv ok! [ 89.571000] set sb to 3(1) cec event! attached: hdmi attached cec event! attached: hdmi attached cec event! handle message 0 -> f : 87 08 00 46 Device Vendor ID 080046 [ 89.632000] HDMI: use logical CEC address 3 cec event! attached: hdmi attached attached: hdmi cec address acknowledged my physical: 4.0.0.0 logical 3 Start timeshift! recording to /media/hdd/pts//timeshift.ayxzvM before: 1 after: 1 eRecordFileThread START setIoPrio realtime level 7 ok record write thread succesfully created! setIoPrio realtime level 7 ok [EITSave] query epg event id 28518, 1:0:1:4E25:2B6E:1:FFFF024A:0:0:0: [EITSave] found event.. store to disc [ 89.769000] CEC send ok! [EPGC] abort non avail schedule other reading [EPGC] abort non avail viasat reading [EPGC] nownext finished(1381570397) [EPGC] schedule finished(1381570400) [EPGC] stop caching events(1381570400) [EPGC] next update in 60 min [ 98.383000] CEC recv ok! cec event! attached: hdmi attached attached: hdmi cec address acknowledged my physical: 4.0.0.0 logical 3 cec event! handle message 0 -> f : 84 00 00 00 Report Physical Address 0.0.0.0 device type 0 (TV) [ 98.523000] CEC recv ok! cec event! handle message 0 -> f : 87 08 00 46 Device Vendor ID 080046 [ 98.804000] CEC recv ok! cec event! handle message 0 -> f : a0 08 00 46 00 04 00 01 Vendor Command with ID [ 98.974000] CEC recv ok! cec event! handle message 0 -> f : 32 67 65 72 Set Menu Language: ger [ 99.217000] CEC recv ok! cec event! handle message 5 -> f : 72 01 [ 100.476000] keys 83 action -> GlobalActions power_down [ 100.580000] keys 87 action -> GlobalActions power_up enter standby [ 100.612000] set mute 1 (111) 1 cannot open /proc/stb/audio/j1_mute(No such file or directory) stopService stopping thread. waiting for aio thread shutdown! record aio thread has finished eRecordFileThread STOP thread joined 0 remove timeshift file [eDVBCAService] free slot 0 demux 3 for service 1:0:1:4E25:2B6E:1:FFFF024A:0:0:0: [eDVBCAService] free service 1:0:1:4E25:2B6E:1:FFFF024A:0:0:0: recheckPMTHAndlers() [TeleText] service stopped [TeleText] send array('B', [1, 0, 0, 0]) decoder state: play, vpid=-1, ap[ 100.660000] stop pcr0 on dmx 3 pid:320 id=-1 DEMUX_STOP - pcr - ok DEMUX_STOP - vid[ 100.662000] stop video0 on dmx 3 pid:320 eo - [ 100.663000] VIDEO0: stop decode ok VIDEO_STOP - [ 100.664000] VIDEO0: set blank to 1 ok AUDIO_STOP - [ 100.666000] audio: decoder stop ok DEMUX_STOP - aud[ 100.668000] stop audio on dmx 3 pid:323 io - [ 100.669000] audio: xpt stop(10) [ 100.669000] no decoder left in sync handling so disable xpt_sync [ 100.670000] bcm_audio_channel_stop(10) done ok AUDIO_CONTINUE - ok DEMUX_STOP - ttx - ok start release channel timer [ 100.673000] set input to 1 [ 100.673000] set fb to 2(0) [ 100.688000] set sb to 3(0) reused converter! setLCDBrightness 25 [Cec] power off eBackgroundFileEraser '/media/hdd/pts//timeshift.ayxzvM' finished cec event! send 3 -> 0 : 36 [ 100.831000] CEC send ok! [ 100.996000] usb 1-1: usbfs: process 665 (usbtftdisplay) did not claim interface 0 before use [ 101.674000] HDMI: now powered down [ 101.845000] CEC recv ok! cec event! handle message 0 -> 3 : 46 Give OSD Name cec event! send 3 -> 0 : 47 44 72 65 61 6d 62 6f 78 [ 102.100000] CEC send ok! [ 102.161000] CEC recv ok! cec event! handle message 0 -> 3 : 8c Give Device Vendor ID cec event! send 3 -> f : 87 00 09 34 [ 102.296000] CEC send ok! [ 102.402000] CEC recv ok! cec event! handle message 0 -> 3 : 00 47 01 cec event! send 3 -> 0 : 00 00 00 [eDVBLocalTimeHandler] Receiver time is 'Sat Oct 12 11:33:27 2013' [eDVBLocalTimeHandler] Transponder time is 'Sat Oct 12 11:33:27 2013' [eDVBLocalTimeHandler] diff is 0 [eDVBLocalTimeHandler] diff < 120 .. use Transponder Time [eDVBLocalTimeHandler] not changed [ 102.513000] CEC send ok! [ 102.890000] CEC recv ok! cec event! handle message 0 -> f : a0 08 00 46 00 13 00 10 80 00 01 00 00 00 00 Vendor Command with ID [ 103.273000] CEC recv ok! cec event! handle message 0 -> f : a0 08 00 46 00 08 00 00 Vendor Command with ID release cached channel (timer timeout) [eDVBCAService] remove channel 0x2341ba8 [eDVBLocalTimeHandler] remove channel 0x2341ba8 [eEPGCache] remove channel 0x2341ba8 stop release channel timer (0) preClose [ 103.981000] CEC recv ok! cec event! handle message 0 -> 3 : [ 104.359000] CEC recv ok! cec event! handle message 5 -> f : 84 10 00 05 Report Physical Address 1.0.0.0 device type 5 (Audio System) nr_read 388 nr_write 5 sum 393 prev_sum 0 hdd was accessed since previous check! [IDLE] 0 300 False nr_read 1566 nr_write 61 sum 1627 prev_sum 0 hdd was accessed since previous check! [IDLE] 0 300 False [ 106.439000] CEC recv ok! cec event! handle message 4 -> f : 84 10 00 04 Report Physical Address 1.0.0.0 device type 4 (Playback Device) [prepareClose] running mainloop [SEC] lock 1 [SEC] delayed close frontend close frontend 0 [SEC] unlock [ 108.324000] CEC recv ok! cec event! handle message 0 -> f : 36 Standby HDMI-CEC: Standby Received! [ 108.612000] CEC recv ok! cec event! handle message 0 -> f : a0 08 00 46 00 09 00 01 Vendor Command with ID [ 108.818000] CEC recv ok! cec event! handle message 5 -> f : 72 00 nr_read 388 nr_write 5 sum 393 prev_sum 393 hdd IDLE! [IDLE] 30.0003890991 300 False nr_read 1566 nr_write 74 sum 1640 prev_sum 1627 hdd was accessed since previous check! [IDLE] 0 300 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 4842688 bytes for cache used [AutoRes] determineContent [AutoRes] switch deinterlacer mode to auto [AutoRes] new content is NonexNoneiNo [AutoRes] determined videomode 1080i [HTTPRootResource].isSessionValid :: created session with id '0' for client with token 'ca3a09212e2d3ef3e644880ad34895ad8612af4c' Harddisk.py: stat failed on /dev/sda2 Harddisk.py: stat failed on /dev/sda2 Harddisk.py: stat failed on /dev/sdb2 Harddisk.py: stat failed on /dev/sdb2 screen cleanup! [WebComponents.EPG] setting command to '1:7:1:0:0:0:0:0:0:0:FROM BOUQUET "userbouquet.favourites.tv" ORDER BY bouquet' [WebComponents.EPG] getting EPG NOW/NEXT 1:7:1:0:0:0:0:0:0:0:FROM BOUQUET "userbouquet.favourites.tv" ORDER BY bouquet screen cleanup! nr_read 388 nr_write 5 sum 393 prev_sum 393 hdd IDLE! [IDLE] 60.0000770092 300 False nr_read 1566 nr_write 80 sum 1646 prev_sum 1640 hdd was accessed since previous check! [IDLE] 0 300 False [DLNA] MediaServer Detected: dm7020hd (TV & Radio) (MediaServer) [DLNA] Device found: Nico_TV (MediaRenderer) [DLNA] Device found: Nico_TV (MediaRenderer) It's now Sat Oct 12 11:34:40 2013 next real activation is Sat Oct 12 18:00:01 2013 [timer.py] next activation: 1381570580 (in 99997 ms) It's now Sat Oct 12 11:34:40 2013 [timer.py] next activation: 1381570580 (in 99996 ms) It's now Sat Oct 12 11:34:40 2013 next real activation is Sat Oct 12 20:09:40 2013 [timer.py] next activation: 1381570580 (in 99993 ms) WARN dreambox_service_store Oct 12 11:34:40 ref 1:7:1:0:0:0:0:0:0:0:(type == 1) || (type == 17) || (type == 195) || (type == 25) FROM BOUQUET "bouquets.tv" ORDER BY bouquet (/usr/lib/enigma2/python/Plugins/SystemPlugins/UPnP/DreamboxServiceStore.py:93) [DLNA] MediaRenderer detected: Nico_TV (MediaRenderer, uuid:1ae7e2c2-1dd2-11b2-bdbe-b57eb128e898) [DLNA] Device found: dm7020hd Mediaserver (MediaServer) [DLNA] Device found: dm7020hd Mediaserver (MediaServer) WARN dreambox_service_store Oct 12 11:34:59 ref 1:7:1:0:0:0:0:0:0:0:FROM BOUQUET "userbouquet.favourites.tv" ORDER BY bouquet (/usr/lib/enigma2/python/Plugins/SystemPlugins/UPnP/DreamboxServiceStore.py:93) nr_read 388 nr_write 5 sum 393 prev_sum 393 hdd IDLE! [IDLE] 90.0186600685 300 False nr_read 1566 nr_write 82 sum 1648 prev_sum 1646 hdd was accessed since previous check! [IDLE] 0 300 False [HTTPRootResource].isSessionValid :: created session with id '0' for client with token '0a09a25d4b07f1c30223d24fe5b33c67eb3e6cad' IBTS Stream Event Looking for embedded skin IBTS show StreamService handle command 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: StreamService execBegin 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: recording service: > record: 0 allocate channel.. 2b75:0001:ffff018a opening frontend 0 [eDVBCAService] new channel 0x244e620! (0)tune tuning to 394000 khz, sr 6903076, fec 9, modulation 5, inversion 0 OURSTATE: tuning allocate Channel: res 0 [eDVBCIInterfaces] addPMTHandler 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: recheckPMTHAndlers() recheck 0x244946c 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: check Slot 0 check Slot 1 allocate demux RECORD event for us: *' at 0x22556c8> > IBTS tunerShow IBTS updateNextTimer 2 begin_date: 20131012 2010 service_name: ORF eins HD name: Cars 2 description: [TIMER] Filename calculated as: '/media/hdd/movie/20131012 2010 - ORF eins HD - Cars 2 - ' Looking for embedded skin IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress None None None None [SEC] startTuneTimeout 5000 [SEC] setFrontend 1 (0)setting frontend (0)fe event: status 0, freq 394000000, inversion off, m_tuning 1 F (0)fe event: status 1f, freq 394000000, inversion off, m_tuning 1 N OURSTATE: ok [eDVBCAService] channel 0x244e620 running [eDVBLocalTimeHandler] channel 0x244e620 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 0x244e620 running stop release channel timer [EPGC] next update in 2 sec RECORD service event 6 tuned.. no version filtering 0012: 4e f1 e0 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 RECORD event for us: *' at 0x2262110> > 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 RECORD service event 5 start streaming... RECORD event for us: *' at 0x2262110> > RECORD event for us: *' at 0x2262110> > + 1/1 TID 00 done! PATready use pmtpid 0398 for service_id f1e0 no version filtering 0398: 02 f1 e0 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 doing version filtering 0000: 00 00 00 1b 00 00 mask: ff 00 00 3f 00 00 mode: 00 00 00 3e 00 00 sdt update done! + 1/1 TID 02 done! [eDVBCAService] new service 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: [eDVBCAService] add demux 3 to slot 0 service 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: demux 3 mask 08 prevhash 00000000 [eDVBCAService] send 70 bytes 9f 80 32 42 03 f1 e0 09 00 19 01 81 08 ff ff 01 8a 2b 75 00 01 82 02 08 03 84 02 03 98 09 04 0b 00 f0 3e 0b 00 23 00 00 05 00 25 00 00 1b 07 80 00 00 04 07 81 00 00 04 07 82 00 00 06 07 83 00 00 06 07 85 00 00 recheckPMTHAndlers() recheck 0x244946c 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: HBBTV broadcast data on pid 0023 check Slot 0 check Slot 1 [eDVBCIInterfaces] gotPMT RECORD service event 5 start streaming... RECORD event for us: *' at 0x2262110> > RECORD event for us: *' at 0x2262110> > doing version filtering 0398: 02 f1 e0 09 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 -+ 1/2 TID 4e ++ 2/2 TID 4e done! [eDVBServiceRecord] now running: Disneys Jessie (1201 seconds) RECORD event for us: *' at 0x2262110> > doing version filtering 0012: 4e f1 e0 1d 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 [EPGC] start caching events(1381570505) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 4845635 bytes for cache used IBTS tunerHide [EPGC] abort non avail schedule other reading [EPGC] abort non avail viasat reading [EPGC] nownext finished(1381570512) IBTS Stream Event Looking for embedded skin IBTS show StreamService handle command StreamService execBegin -1:38171454:A:23AA000:0:0:A:0:0:23AA000: recording service: > record: -1 record returned non-zero IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress None None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress None None None None screen cleanup! StreamService execEnd -1:38171454:A:23AA000:0:0:A:0:0:23AA000: IBTS Stream Event IBTS updateType FINISHED IBTS show IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress None None None None IBTS Stream Event Looking for embedded skin IBTS show StreamService handle command 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: StreamService execBegin 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: recording service: > record: 0 use cached_channel allocate Channel: res 0 [eDVBCIInterfaces] addPMTHandler 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: recheckPMTHAndlers() recheck 0x244946c 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: check Slot 0 check Slot 1 recheck 0x247c514 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: check Slot 0 check Slot 1 RECORD service event 6 tuned.. no version filtering 0012: 4e f1 e0 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 RECORD event for us: *' at 0x2262128> > RECORD event for us: *' at 0x2262128> > 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 RECORD service event 5 RECORD event for us: *' at 0x2262128> > RECORD event for us: *' at 0x2262128> > RECORD event for us: *' at 0x2262128> > RECORD event for us: *' at 0x2262128> > start streaming... RECORD event for us: *' at 0x2262128> > RECORD event for us: *' at 0x2262128> > IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress None None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress None None None None + 1/1 TID 00 done! PATready use pmtpid 0398 for service_id f1e0 no version filtering 0398: 02 f1 e0 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 doing version filtering 0000: 00 00 00 1b 00 00 mask: ff 00 00 3f 00 00 mode: 00 00 00 3e 00 00 + 1/1 TID 02 done! [eDVBCAService] add demux 3 to slot 1 service 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: demux 3 mask 08 prevhash 03980804 [eDVBCAService] don't build/send the same CA PMT twice recheckPMTHAndlers() recheck 0x244946c 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: check Slot 0 check Slot 1 recheck 0x247c514 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: HBBTV broadcast data on pid 0023 check Slot 0 check Slot 1 [eDVBCIInterfaces] gotPMT RECORD service event 5 start streaming... RECORD event for us: *' at 0x2262110> > RECORD event for us: *' at 0x2262110> > RECORD event for us: *' at 0x2262110> > RECORD event for us: *' at 0x2262110> > doing version filtering 0398: 02 f1 e0 09 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 -+ 1/2 TID 4e ++ 2/2 TID 4e done! [eDVBServiceRecord] now running: Disneys Jessie (1201 seconds) RECORD event for us: *' at 0x2262110> > RECORD event for us: *' at 0x2262110> > doing version filtering 0012: 4e f1 e0 1d 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 IBTS tunerHide [EPGC] schedule finished(1381570522) [EPGC] stop caching events(1381570522) [EPGC] next update in 60 min [eDVBLocalTimeHandler] Receiver time is 'Sat Oct 12 11:35:25 2013' [eDVBLocalTimeHandler] Transponder time is 'Sat Oct 12 11:35:27 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] 4845981 bytes for cache used nr_read 388 nr_write 5 sum 393 prev_sum 393 hdd IDLE! [IDLE] 121.999472141 300 False nr_read 1566 nr_write 84 sum 1650 prev_sum 1648 hdd was accessed since previous check! [IDLE] 0 300 False screen cleanup! StreamService execEnd 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: stop recording! [eDVBServiceRecord] saving cutlist failed because tstools failed RECORD event for us: *' at 0x2262110> > RECORD event for us: *' at 0x2262110> > [eDVBCAService] free slot 0 demux 3 for service 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: demux 3 mask 08 prevhash 03980804 [eDVBCAService] don't build/send the same CA PMT twice recheckPMTHAndlers() recheck 0x247c514 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: check Slot 0 check Slot 1 IBTS Stream Event IBTS updateType FINISHED IBTS show IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress None None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS Stream Event Looking for embedded skin IBTS show StreamService handle command 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: StreamService execBegin 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: recording service: > record: 0 use cached_channel allocate Channel: res 0 [eDVBCIInterfaces] addPMTHandler 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: recheckPMTHAndlers() recheck 0x247c514 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: check Slot 0 check Slot 1 recheck 0x24aa83c 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: check Slot 0 check Slot 1 RECORD service event 6 tuned.. no version filtering 0012: 4e f1 e0 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 RECORD event for us: *' at 0x223a2d8> > RECORD event for us: *' at 0x223a2d8> > 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 RECORD service event 5 RECORD event for us: *' at 0x223a2d8> > RECORD event for us: *' at 0x223a2d8> > RECORD event for us: *' at 0x223a2d8> > RECORD event for us: *' at 0x223a2d8> > start streaming... RECORD event for us: *' at 0x223a2d8> > RECORD event for us: *' at 0x223a2d8> > IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress None None None None IBTS duration, timeleft, timeelapsed, progress None None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None + 1/1 TID 00 done! PATready use pmtpid 0398 for service_id f1e0 no version filtering 0398: 02 f1 e0 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 doing version filtering 0000: 00 00 00 1b 00 00 mask: ff 00 00 3f 00 00 mode: 00 00 00 3e 00 00 + 1/1 TID 02 done! [eDVBCAService] add demux 3 to slot 0 service 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: demux 3 mask 08 prevhash 03980804 [eDVBCAService] don't build/send the same CA PMT twice recheckPMTHAndlers() recheck 0x247c514 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: check Slot 0 check Slot 1 recheck 0x24aa83c 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: HBBTV broadcast data on pid 0023 check Slot 0 check Slot 1 [eDVBCIInterfaces] gotPMT RECORD service event 5 start streaming... RECORD event for us: *' at 0x21aeae8> > RECORD event for us: *' at 0x21aeae8> > RECORD event for us: *' at 0x21aeae8> > RECORD event for us: *' at 0x21aeae8> > doing version filtering 0398: 02 f1 e0 09 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 +- 1/2 TID 4e ++ 2/2 TID 4e done! [eDVBServiceRecord] now running: Disneys Jessie (1201 seconds) RECORD event for us: *' at 0x21aeae8> > RECORD event for us: *' at 0x21aeae8> > doing version filtering 0012: 4e f1 e0 1d 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 IBTS tunerHide screen cleanup! StreamService execEnd 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: stop recording! [eDVBServiceRecord] saving cutlist failed because tstools failed RECORD event for us: *' at 0x21aeae8> > RECORD event for us: *' at 0x21aeae8> > [eDVBCAService] free slot 0 demux 3 for service 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: demux 3 mask 08 prevhash 03980804 [eDVBCAService] don't build/send the same CA PMT twice recheckPMTHAndlers() recheck 0x247c514 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: check Slot 0 check Slot 1 IBTS Stream Event IBTS updateType FINISHED IBTS show IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress None None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS Stream Event Looking for embedded skin IBTS show StreamService handle command 1:0:1:1330:7D00:DE:FFFF0000:0:0:0: StreamService execBegin 1:0:1:1330:7D00:DE:FFFF0000:0:0:0: recording service: > record: 0 allocate channel.. 7d00:00de:ffff0000 available channel.. 2b75:0001:ffff018a opening frontend 1 [eDVBCAService] new channel 0x2507bc8! (1)tune tuning to 410000 khz, sr 6900000, fec 9, modulation 5, inversion 2 OURSTATE: tuning allocate Channel: res 0 [eDVBCIInterfaces] addPMTHandler 1:0:1:1330:7D00:DE:FFFF0000:0:0:0: recheckPMTHAndlers() recheck 0x247c514 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: check Slot 0 check Slot 1 recheck 0x24ab0e4 1:0:1:1330:7D00:DE:FFFF0000:0:0:0: check Slot 0 check Slot 1 allocate demux RECORD event for us: *' at 0x223a710> > RECORD event for us: *' at 0x223a710> > IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress None None None None FE_READ_BER failed (Resource temporarily unavailable) IBTS duration, timeleft, timeelapsed, progress None None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None [SEC] startTuneTimeout 5000 [SEC] setFrontend 1 (1)setting frontend (1)fe event: status 0, freq 410000000, inversion off, m_tuning 1 F (1)fe event: status 1f, freq 410000000, inversion off, m_tuning 1 N OURSTATE: ok [eDVBCAService] channel 0x2507bc8 running [eDVBLocalTimeHandler] channel 0x2507bc8 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 0x2507bc8 running stop release channel timer [EPGC] next update in 2 sec RECORD service event 6 tuned.. no version filtering 0012: 4e 13 30 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 RECORD event for us: *' at 0x2262128> > RECORD event for us: *' at 0x2262128> > 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 RECORD service event 5 start streaming... RECORD event for us: *' at 0x2262128> > RECORD event for us: *' at 0x2262128> > RECORD event for us: *' at 0x2262128> > RECORD event for us: *' at 0x2262128> > + 1/1 TID 00 done! PATready use pmtpid 00da for service_id 1330 no version filtering 00da: 02 13 30 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 + 1/1 TID 02 done! [eDVBCAService] new service 1:0:1:1330:7D00:DE:FFFF0000:0:0:0: [eDVBCAService] add demux 2 to slot 0 service 1:0:1:1330:7D00:DE:FFFF0000:0:0:0: demux 2 mask 04 prevhash 00000000 [eDVBCAService] send 70 bytes 9f 80 32 42 03 13 30 07 00 19 01 81 08 ff ff 00 00 7d 00 00 de 82 02 04 02 84 02 00 da 09 04 0b 00 f7 b3 1b 0b 68 00 00 04 0b 69 00 00 04 0b 6a 00 00 06 0b 6b 00 00 06 0b 6d 00 00 05 1e 1e 00 00 0b 1e 1f 00 00 recheckPMTHAndlers() recheck 0x247c514 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: check Slot 0 check Slot 1 recheck 0x24ab0e4 1:0:1:1330:7D00:DE:FFFF0000:0:0:0: check Slot 0 check Slot 1 [eDVBCIInterfaces] gotPMT RECORD service event 5 start streaming... RECORD event for us: *' at 0x2262128> > RECORD event for us: *' at 0x2262128> > RECORD event for us: *' at 0x2262128> > RECORD event for us: *' at 0x2262128> > doing version filtering 00da: 02 13 30 07 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 -+ 1/2 TID 4e [ 244.822000] CA: changed index (0 -> 1) of already running pid 0b68 on demux 2... this can cause picture/audio drop outs! [ 244.826000] CA: changed index (0 -> 1) of already running pid 0b69 on demux 2... this can cause picture/audio drop outs! [ 244.828000] CA: changed index (0 -> 1) of already running pid 0b6a on demux 2... this can cause picture/audio drop outs! [ 244.830000] CA: changed index (0 -> 1) of already running pid 0b6b on demux 2... this can cause picture/audio drop outs! [ 244.832000] CA: changed index (0 -> 1) of already running pid 0b6d on demux 2... this can cause picture/audio drop outs! sdt update done! Harddisk.py: stat failed on /dev/sda2 Harddisk.py: stat failed on /dev/sda2 Harddisk.py: stat failed on /dev/sdb2 Harddisk.py: stat failed on /dev/sdb2 screen cleanup! screen cleanup! StreamService execEnd 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: stop recording! [eDVBServiceRecord] saving cutlist failed because tstools failed RECORD event for us: *' at 0x2262128> > RECORD event for us: *' at 0x2262128> > [eDVBCAService] free slot 1 demux 3 for service 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: [eDVBCAService] free service 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: recheckPMTHAndlers() recheck 0x24ab0e4 1:0:1:1330:7D00:DE:FFFF0000:0:0:0: check Slot 0 check Slot 1 [eDVBCAService] remove channel 0x244e620 [eDVBLocalTimeHandler] remove channel 0x244e620 [eEPGCache] remove channel 0x244e620 (0) preClose IBTS Stream Event IBTS updateType FINISHED IBTS show poll: unhandled POLLERR/HUP/NVAL for fd 53(24) IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None [EPGC] start caching events(1381570553) IBTS duration, timeleft, timeelapsed, progress None None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None ++ 2/2 TID 4e done! [eDVBServiceRecord] now running: Der Edelweißkönig (4834 seconds) RECORD event for us: *' at 0x2262128> > doing version filtering 0012: 4e 13 30 3f 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 [prepareClose] running mainloop [SEC] lock 0 [SEC] delayed close frontend close frontend 0 [SEC] unlock [eDVBLocalTimeHandler] Receiver time is 'Sat Oct 12 11:35:57 2013' [eDVBLocalTimeHandler] Transponder time is 'Sat Oct 12 11:35:57 2013' [eDVBLocalTimeHandler] diff is 0 [eDVBLocalTimeHandler] diff < 120 .. use Transponder Time [eDVBLocalTimeHandler] not changed IBTS tunerHide [EPGC] abort non avail schedule other reading [EPGC] abort non avail viasat reading screen cleanup! StreamService execEnd 1:0:1:1330:7D00:DE:FFFF0000:0:0:0: stop recording! [eDVBServiceRecord] saving cutlist failed because tstools failed [eDVBCAService] free slot 0 demux 2 for service 1:0:1:1330:7D00:DE:FFFF0000:0:0:0: [eDVBCAService] free service 1:0:1:1330:7D00:DE:FFFF0000:0:0:0: recheckPMTHAndlers() start release channel timer IBTS Stream Event IBTS updateType FINISHED IBTS show IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress 1.0 None None None [EPGC] nownext finished(1381570560) IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None lookup for events with 'Supernatural' in title(ignore case) [TIMER] record time changed, start prepare is now: Tue Oct 15 02:39:40 2013 [TIMER] [AutoTimer] Try to add new timer based on AutoTimer Supernatural. sanitycheck check checkTimerlist recording service: 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: record: 0 recording service: 1:0:1:4E22:2B6E:1:FFFF024A:0:0:0: record: 0 [Timer] Record ProcessRepeated It's now Sat Oct 12 11:36:01 2013 next real activation is Sat Oct 12 20:09:40 2013 [timer.py] next activation: 1381570661 (in 99474 ms) [TIMER] record time changed, start prepare is now: Tue Oct 15 03:14:40 2013 [TIMER] [AutoTimer] Try to add new timer based on AutoTimer Supernatural. sanitycheck check checkTimerlist recording service: 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: record: 0 recording service: 1:0:1:4E22:2B6E:1:FFFF024A:0:0:0: record: 0 recording service: 1:0:1:4E22:2B6E:1:FFFF024A:0:0:0: record: 0 [Timer] Record ProcessRepeated It's now Sat Oct 12 11:36:01 2013 next real activation is Sat Oct 12 20:09:40 2013 [timer.py] next activation: 1381570661 (in 99227 ms) lookup for events with 'under the dome' in title(ignore case) nr_read 388 nr_write 5 sum 393 prev_sum 393 hdd IDLE! [IDLE] 152.142634153 300 False nr_read 1566 nr_write 86 sum 1652 prev_sum 1650 hdd was accessed since previous check! [IDLE] 0 300 False lookup for events with 'Lammbock' in title(ignore case) IBTS Stream Event Looking for embedded skin IBTS show StreamService handle command StreamService execBegin -1:38927246:A:22E2E88:0:0:A:0:0:22E2E88: recording service: > getBouquet failed.. no path given! eStaticServiceDVBBouquetInformation::isPlayable failed.. getBouquet failed! record returned non-zero IBTS tunerShow IBTS updateNextTimer 2 begin_date: 20131015 0240 service_name: ProSieben Austria name: Supernatural description: Supernatural [TIMER] Filename calculated as: '/media/hdd/movie/20131015 0240 - ProSieben Austria - Supernatural - Supernatural' Looking for embedded skin [EPGC] schedule finished(1381570563) [EPGC] stop caching events(1381570563) [EPGC] next update in 60 min IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 45.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None getBouquet failed.. no path given! IBTS duration, timeleft, timeelapsed, progress None None None None release cached channel (timer timeout) [eDVBCAService] remove channel 0x2507bc8 [eDVBLocalTimeHandler] remove channel 0x2507bc8 [eEPGCache] remove channel 0x2507bc8 stop release channel timer (1) preClose screen cleanup! StreamService execEnd -1:38927246:A:22E2E88:0:0:A:0:0:22E2E88: IBTS Stream Event IBTS updateType FINISHED IBTS show IBTS Stream Event Looking for embedded skin IBTS show StreamService handle command 1:0:1:1330:7D00:DE:FFFF0000:0:0:0: StreamService execBegin 1:0:1:1330:7D00:DE:FFFF0000:0:0:0: recording service: > record: 0 allocate channel.. 7d00:00de:ffff0000 opening frontend 0 [eDVBCAService] new channel 0x2542010! (0)tune tuning to 410000 khz, sr 6900000, fec 9, modulation 5, inversion 2 OURSTATE: tuning allocate Channel: res 0 [eDVBCIInterfaces] addPMTHandler 1:0:1:1330:7D00:DE:FFFF0000:0:0:0: recheckPMTHAndlers() recheck 0x252cb94 1:0:1:1330:7D00:DE:FFFF0000:0:0:0: check Slot 0 check Slot 1 allocate demux RECORD event for us: *' at 0x2241cb0> > IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress None None None None IBTS duration, timeleft, timeelapsed, progress 45.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None [SEC] startTuneTimeout 5000 [SEC] setFrontend 1 (0)setting frontend (0)fe event: status 0, freq 410000000, inversion off, m_tuning 1 F (0)fe event: status 1f, freq 410000000, inversion off, m_tuning 1 N OURSTATE: ok [eDVBCAService] channel 0x2542010 running [eDVBLocalTimeHandler] channel 0x2542010 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 0x2542010 running stop release channel timer RECORD service event 6 tuned.. no version filtering 0012: 4e 13 30 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 RECORD event for us: *' at 0x223d848> > 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 RECORD service event 5 start streaming... RECORD event for us: *' at 0x223d848> >[EPGC] next update in 59 min RECORD event for us: *' at 0x223d848> > + 1/1 TID 00 done! PATready use pmtpid 00da for service_id 1330 no version filtering 00da: 02 13 30 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 + 1/1 TID 02 done! [eDVBCAService] new service 1:0:1:1330:7D00:DE:FFFF0000:0:0:0: [eDVBCAService] add demux 3 to slot 0 service 1:0:1:1330:7D00:DE:FFFF0000:0:0:0: demux 3 mask 08 prevhash 00000000 [eDVBCAService] send 70 bytes 9f 80 32 42 03 13 30 07 00 19 01 81 08 ff ff 00 00 7d 00 00 de 82 02 08 03 84 02 00 da 09 04 0b 00 f7 b3 1b 0b 68 00 00 04 0b 69 00 00 04 0b 6a 00 00 06 0b 6b 00 00 06 0b 6d 00 00 05 1e 1e 00 00 0b 1e 1f 00 00 recheckPMTHAndlers() recheck 0x252cb94 1:0:1:1330:7D00:DE:FFFF0000:0:0:0: check Slot 0 check Slot 1 [eDVBCIInterfaces] gotPMT RECORD service event 5 start streaming... RECORD event for us: *' at 0x223d848> > RECORD event for us: *' at 0x223d848> > doing version filtering 00da: 02 13 30 07 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 -+ 1/2 TID 4e sdt update done! ++ 2/2 TID 4e done! [eDVBServiceRecord] now running: Der Edelweißkönig (4834 seconds) RECORD event for us: *' at 0x223d848> > doing version filtering 0012: 4e 13 30 3f 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 [prepareClose] running mainloop [SEC] lock 0 [SEC] delayed close frontend close frontend 1 [SEC] unlock IBTS Stream Event Looking for embedded skin IBTS show StreamService handle command 1:0:1:1330:7D00:DE:FFFF0000:0:0:0: StreamService execBegin 1:0:1:1330:7D00:DE:FFFF0000:0:0:0: recording service: > record: 0 use cached_channel allocate Channel: res 0 [eDVBCIInterfaces] addPMTHandler 1:0:1:1330:7D00:DE:FFFF0000:0:0:0: recheckPMTHAndlers() recheck 0x252cb94 1:0:1:1330:7D00:DE:FFFF0000:0:0:0: check Slot 0 check Slot 1 recheck 0x25454bc 1:0:1:1330:7D00:DE:FFFF0000:0:0:0: check Slot 0 check Slot 1 RECORD service event 6 tuned.. no version filtering 0012: 4e 13 30 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 RECORD event for us: *' at 0x223ae18> > RECORD event for us: *' at 0x223ae18> > 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 RECORD service event 5 RECORD event for us: *' at 0x223ae18> > RECORD event for us: *' at 0x223ae18> > RECORD event for us: *' at 0x223ae18> > RECORD event for us: *' at 0x223ae18> > start streaming... RECORD event for us: *' at 0x223ae18> > RECORD event for us: *' at 0x223ae18> > IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress None None None None IBTS duration, timeleft, timeelapsed, progress 45.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress None None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None +- 1/2 TID 4e + 1/1 TID 00 done! PATready use pmtpid 00da for service_id 1330 no version filtering 00da: 02 13 30 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 + 1/1 TID 02 done! [eDVBCAService] add demux 3 to slot 1 service 1:0:1:1330:7D00:DE:FFFF0000:0:0:0: demux 3 mask 08 prevhash 00da0803 [eDVBCAService] don't build/send the same CA PMT twice recheckPMTHAndlers() recheck 0x252cb94 1:0:1:1330:7D00:DE:FFFF0000:0:0:0: check Slot 0 check Slot 1 recheck 0x25454bc 1:0:1:1330:7D00:DE:FFFF0000:0:0:0: check Slot 0 check Slot 1 [eDVBCIInterfaces] gotPMT RECORD service event 5 start streaming... RECORD event for us: *' at 0x223d8f0> > RECORD event for us: *' at 0x223d8f0> > RECORD event for us: *' at 0x223d8f0> > RECORD event for us: *' at 0x223d8f0> > doing version filtering 00da: 02 13 30 07 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 ++ 2/2 TID 4e done! [eDVBServiceRecord] now running: Der Edelweißkönig (4834 seconds) RECORD event for us: *' at 0x223d8f0> > RECORD event for us: *' at 0x223d8f0> > doing version filtering 0012: 4e 13 30 3f 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 IBTS tunerHide Harddisk.py: stat failed on /dev/sda2 Harddisk.py: stat failed on /dev/sda2 Harddisk.py: stat failed on /dev/sdb2 Harddisk.py: stat failed on /dev/sdb2 screen cleanup! screen cleanup! StreamService execEnd 1:0:1:1330:7D00:DE:FFFF0000:0:0:0: stop recording! [eDVBServiceRecord] saving cutlist failed because tstools failed RECORD event for us: *' at 0x223d8f0> > RECORD event for us: *' at 0x223d8f0> > [eDVBCAService] free slot 0 demux 3 for service 1:0:1:1330:7D00:DE:FFFF0000:0:0:0: demux 3 mask 08 prevhash 00da0803 [eDVBCAService] don't build/send the same CA PMT twice recheckPMTHAndlers() recheck 0x25454bc 1:0:1:1330:7D00:DE:FFFF0000:0:0:0: check Slot 0 check Slot 1 IBTS Stream Event IBTS updateType FINISHED IBTS show IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 45.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress None None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None screen cleanup! StreamService execEnd 1:0:1:1330:7D00:DE:FFFF0000:0:0:0: stop recording! [eDVBServiceRecord] saving cutlist failed because tstools failed [eDVBCAService] free slot 1 demux 3 for service 1:0:1:1330:7D00:DE:FFFF0000:0:0:0: [eDVBCAService] free service 1:0:1:1330:7D00:DE:FFFF0000:0:0:0: recheckPMTHAndlers() start release channel timer IBTS Stream Event IBTS updateType FINISHED IBTS show IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 45.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None release cached channel (timer timeout) [eDVBCAService] remove channel 0x2542010 [eDVBLocalTimeHandler] remove channel 0x2542010 [eEPGCache] remove channel 0x2542010 stop release channel timer (0) preClose It's now Sat Oct 12 11:36:22 2013 next real activation is Sat Oct 12 18:00:01 2013 [timer.py] next activation: 1381570682 (in 99997 ms) It's now Sat Oct 12 11:36:22 2013 [timer.py] next activation: 1381570682 (in 99996 ms) IBTS tunerHide IBTS Stream Event Looking for embedded skin IBTS show StreamService handle command 1:0:1:2B5C:3F3:1:FFFF01BA:0:0:0: StreamService execBegin 1:0:1:2B5C:3F3:1:FFFF01BA:0:0:0: recording service: > record: 0 allocate channel.. 03f3:0001:ffff01ba [eDVBCAService] new channel 0x2443380! (0)tune tuning to 442000 khz, sr 6900000, fec 9, modulation 5, inversion 2 OURSTATE: tuning allocate Channel: res 0 [eDVBCIInterfaces] addPMTHandler 1:0:1:2B5C:3F3:1:FFFF01BA:0:0:0: recheckPMTHAndlers() recheck 0x2522a34 1:0:1:2B5C:3F3:1:FFFF01BA:0:0:0: check Slot 0 check Slot 1 allocate demux RECORD event for us: *' at 0x2255d58> > IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress None None None None IBTS duration, timeleft, timeelapsed, progress 45.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None [SEC] startTuneTimeout 5000 [SEC] setFrontend 1 (0)setting frontend (0)fe event: status 0, freq 442000000, inversion off, m_tuning 1 F (0)fe event: status 1f, freq 442000000, inversion off, m_tuning 1 N OURSTATE: ok [eDVBCAService] channel 0x2443380 running [eDVBLocalTimeHandler] channel 0x2443380 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 0x2443380 running stop release channel timer RECORD service event 6 tuned.. no version filtering 0012: 4e 2b 5c 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 RECORD event for us: *' at 0x22550e0> > 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 RECORD service event 5 start streaming... RECORD event for us: *' at 0x22550e0> > [EPGC] next update in 2 sec RECORD event for us: *' at 0x22550e0> > + 1/1 TID 00 done! PATready use pmtpid 13ec for service_id 2b5c no version filtering 13ec: 02 2b 5c 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 doing version filtering 0000: 00 00 00 0b 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:1:2B5C:3F3:1:FFFF01BA:0:0:0: [eDVBCAService] add demux 3 to slot 0 service 1:0:1:2B5C:3F3:1:FFFF01BA:0:0:0: demux 3 mask 08 prevhash 00000000 [eDVBCAService] send 85 bytes 9f 80 32 51 03 2b 5c 07 00 19 01 81 08 ff ff 01 ba 03 f3 00 01 82 02 08 03 84 02 13 ec 09 04 0b 00 ec 1e 05 04 92 00 00 0b 08 7b 00 00 1b 13 ed 00 00 03 13 ef 00 00 06 13 f0 00 00 06 13 f1 00 00 06 13 f2 00 00 06 13 f4 00 00 03 14 02 00 00 0b 14 34 00 00 recheckPMTHAndlers() recheck 0x2522a34 1:0:1:2B5C:3F3:1:FFFF01BA:0:0:0: HBBTV broadcast data on pid 087b Rds PID 13f4 detected ? ! ? HBBTV broadcast data on pid 1434 check Slot 0 check Slot 1 [eDVBCIInterfaces] gotPMT RECORD service event 5 start streaming... RECORD event for us: *' at 0x22550e0> > RECORD event for us: *' at 0x22550e0> > doing version filtering 13ec: 02 2b 5c 07 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 -+ 1/2 TID 4e ++ 2/2 TID 4e done! [eDVBServiceRecord] now running: Lust auf Deutschland (17/30) (2700 seconds) RECORD event for us: *' at 0x22550e0> > doing version filtering 0012: 4e 2b 5c 1f 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 sdt update done! [EPGC] start caching events(1381570585) [eDVBLocalTimeHandler] Receiver time is 'Sat Oct 12 11:36:27 2013' [eDVBLocalTimeHandler] Transponder time is 'Sat Oct 12 11:36:27 2013' [eDVBLocalTimeHandler] diff is 0 [eDVBLocalTimeHandler] diff < 120 .. use Transponder Time [eDVBLocalTimeHandler] not changed [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 4858233 bytes for cache used IBTS tunerHide screen cleanup! StreamService execEnd 1:0:1:2B5C:3F3:1:FFFF01BA:0:0:0: stop recording! [eDVBServiceRecord] saving cutlist failed because tstools failed [eDVBCAService] free slot 0 demux 3 for service 1:0:1:2B5C:3F3:1:FFFF01BA:0:0:0: [eDVBCAService] free service 1:0:1:2B5C:3F3:1:FFFF01BA:0:0:0: recheckPMTHAndlers() start release channel timer IBTS Stream Event IBTS updateType FINISHED IBTS show IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 45.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None nr_read 388 nr_write 5 sum 393 prev_sum 393 hdd IDLE! [IDLE] 181.999961138 300 False nr_read 1566 nr_write 90 sum 1656 prev_sum 1652 hdd was accessed since previous check! [IDLE] 0 300 False [EPGC] abort non avail schedule other reading [EPGC] abort non avail viasat reading [EPGC] nownext finished(1381570593) release cached channel (timer timeout) [eDVBCAService] remove channel 0x2443380 [eDVBLocalTimeHandler] remove channel 0x2443380 [eEPGCache] remove channel 0x2443380 [EPGC] abort caching events !! stop release channel timer (0) preClose IBTS Stream Event Looking for embedded skin IBTS show StreamService handle command StreamService execBegin -1:38281302:A:23E5C88:0:0:A:0:0:23E5C88: recording service: > record: -1 record returned non-zero IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress None None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 45.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None screen cleanup! StreamService execEnd -1:38281302:A:23E5C88:0:0:A:0:0:23E5C88: IBTS Stream Event IBTS updateType FINISHED IBTS show IBTS Stream Event Looking for embedded skin IBTS show StreamService handle command 1:0:1:2B5C:3F3:1:FFFF01BA:0:0:0: StreamService execBegin 1:0:1:2B5C:3F3:1:FFFF01BA:0:0:0: recording service: > record: 0 allocate channel.. 03f3:0001:ffff01ba [eDVBCAService] new channel 0x245d190! (0)tune tuning to 442000 khz, sr 6900000, fec 9, modulation 5, inversion 2 OURSTATE: tuning allocate Channel: res 0 [eDVBCIInterfaces] addPMTHandler 1:0:1:2B5C:3F3:1:FFFF01BA:0:0:0: recheckPMTHAndlers() recheck 0x255ea1c 1:0:1:2B5C:3F3:1:FFFF01BA:0:0:0: check Slot 0 check Slot 1 allocate demux RECORD event for us: *' at 0x2255f98> > IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress None None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 45.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None [SEC] startTuneTimeout 5000 [SEC] setFrontend 1 (0)setting frontend (0)fe event: status 0, freq 442000000, inversion off, m_tuning 1 F (0)fe event: status 1f, freq 442000000, inversion off, m_tuning 1 N OURSTATE: ok [eDVBCAService] channel 0x245d190 running [eDVBLocalTimeHandler] channel 0x245d190 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 0x245d190 running stop release channel timer RECORD service event 6 tuned.. no version filtering 0012: 4e 2b 5c 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 RECORD event for us: *' at 0x22557a0> > 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 RECORD service event 5 start streaming... RECORD event for us: [EPGC] next update in 2 sec *' at 0x22415c0> > RECORD event for us: *' at 0x22415c0> > -+ 1/2 TID 4e + 1/1 TID 00 done! PATready use pmtpid 13ec for service_id 2b5c no version filtering 13ec: 02 2b 5c 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 doing version filtering 0000: 00 00 00 0b 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:1:2B5C:3F3:1:FFFF01BA:0:0:0: [eDVBCAService] add demux 3 to slot 0 service 1:0:1:2B5C:3F3:1:FFFF01BA:0:0:0: demux 3 mask 08 prevhash 00000000 [eDVBCAService] send 85 bytes 9f 80 32 51 03 2b 5c 07 00 19 01 81 08 ff ff 01 ba 03 f3 00 01 82 02 08 03 84 02 13 ec 09 04 0b 00 ec 1e 05 04 92 00 00 0b 08 7b 00 00 1b 13 ed 00 00 03 13 ef 00 00 06 13 f0 00 00 06 13 f1 00 00 06 13 f2 00 00 06 13 f4 00 00 03 14 02 00 00 0b 14 34 00 00 recheckPMTHAndlers() recheck 0x255ea1c 1:0:1:2B5C:3F3:1:FFFF01BA:0:0:0: HBBTV broadcast data on pid 087b Rds PID 13f4 detected ? ! ? HBBTV broadcast data on pid 1434 check Slot 0 check Slot 1 [eDVBCIInterfaces] gotPMT RECORD service event 5 start streaming... RECORD event for us: *' at 0x22415c0> > RECORD event for us: *' at 0x22415c0> > doing version filtering 13ec: 02 2b 5c 07 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 ++ 2/2 TID 4e done! [eDVBServiceRecord] now running: Lust auf Deutschland (17/30) (2700 seconds) RECORD event for us: *' at 0x22415c0> > doing version filtering 0012: 4e 2b 5c 1f 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 sdt update done! [EPGC] start caching events(1381570597) IBTS tunerHide IBTS Stream Event Looking for embedded skin IBTS show StreamService handle command 1:0:1:2B5C:3F3:1:FFFF01BA:0:0:0: StreamService execBegin 1:0:1:2B5C:3F3:1:FFFF01BA:0:0:0: recording service: > record: 0 use cached_channel allocate Channel: res 0 [eDVBCIInterfaces] addPMTHandler 1:0:1:2B5C:3F3:1:FFFF01BA:0:0:0: recheckPMTHAndlers() recheck 0x255ea1c 1:0:1:2B5C:3F3:1:FFFF01BA:0:0:0: check Slot 0 check Slot 1 recheck 0x255553c 1:0:1:2B5C:3F3:1:FFFF01BA:0:0:0: check Slot 0 check Slot 1 RECORD service event 6 tuned.. no version filtering 0012: 4e 2b 5c 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 RECORD event for us: *' at 0x22595c0> > RECORD event for us: *' at 0x22595c0> > 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 RECORD service event 5 RECORD event for us: *' at 0x22595c0> > RECORD event for us: *' at 0x22595c0> > RECORD event for us: *' at 0x22595c0> > RECORD event for us: *' at 0x22595c0> > start streaming... RECORD event for us: *' at 0x22595c0> > RECORD event for us: *' at 0x22595c0> > IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress None None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress None None None None IBTS duration, timeleft, timeelapsed, progress 45.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None -+ 1/2 TID 4e + 1/1 TID 00 done! PATready use pmtpid 13ec for service_id 2b5c no version filtering 13ec: 02 2b 5c 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 doing version filtering 0000: 00 00 00 0b 00 00 mask: ff 00 00 3f 00 00 mode: 00 00 00 3e 00 00 + 1/1 TID 02 done! [eDVBCAService] add demux 3 to slot 1 service 1:0:1:2B5C:3F3:1:FFFF01BA:0:0:0: demux 3 mask 08 prevhash 13ec0803 [eDVBCAService] don't build/send the same CA PMT twice recheckPMTHAndlers() recheck 0x255ea1c 1:0:1:2B5C:3F3:1:FFFF01BA:0:0:0: check Slot 0 check Slot 1 recheck 0x255553c 1:0:1:2B5C:3F3:1:FFFF01BA:0:0:0: HBBTV broadcast data on pid 087b Rds PID 13f4 detected ? ! ? HBBTV broadcast data on pid 1434 check Slot 0 check Slot 1 [eDVBCIInterfaces] gotPMT RECORD service event 5 start streaming... RECORD event for us: *' at 0x22595c0> > RECORD event for us: *' at 0x22595c0> > RECORD event for us: *' at 0x22595c0> > RECORD event for us: *' at 0x22595c0> > doing version filtering 13ec: 02 2b 5c 07 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 ++ 2/2 TID 4e done! [eDVBServiceRecord] now running: Lust auf Deutschland (17/30) (2700 seconds) RECORD event for us: *' at 0x22595c0> > RECORD event for us: *' at 0x22595c0> > doing version filtering 0012: 4e 2b 5c 1f 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 [EPGC] abort non avail schedule other reading [EPGC] abort non avail viasat reading [EPGC] nownext finished(1381570605) IBTS tunerHide [EPGC] schedule finished(1381570607) [EPGC] stop caching events(1381570607) [EPGC] next update in 60 min Harddisk.py: stat failed on /dev/sda2 Harddisk.py: stat failed on /dev/sda2 Harddisk.py: stat failed on /dev/sdb2 Harddisk.py: stat failed on /dev/sdb2 screen cleanup! screen cleanup! StreamService execEnd 1:0:1:2B5C:3F3:1:FFFF01BA:0:0:0: stop recording! [eDVBServiceRecord] saving cutlist failed because tstools failed RECORD event for us: *' at 0x22595c0> > RECORD event for us: *' at 0x22595c0> > [eDVBCAService] free slot 0 demux 3 for service 1:0:1:2B5C:3F3:1:FFFF01BA:0:0:0: demux 3 mask 08 prevhash 13ec0803 [eDVBCAService] don't build/send the same CA PMT twice recheckPMTHAndlers() recheck 0x255553c 1:0:1:2B5C:3F3:1:FFFF01BA:0:0:0: check Slot 0 check Slot 1 IBTS Stream Event IBTS updateType FINISHED IBTS show IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress None None None None IBTS duration, timeleft, timeelapsed, progress 45.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None screen cleanup! StreamService execEnd 1:0:1:2B5C:3F3:1:FFFF01BA:0:0:0: stop recording! [eDVBServiceRecord] saving cutlist failed because tstools failed [eDVBCAService] free slot 1 demux 3 for service 1:0:1:2B5C:3F3:1:FFFF01BA:0:0:0: [eDVBCAService] free service 1:0:1:2B5C:3F3:1:FFFF01BA:0:0:0: recheckPMTHAndlers() start release channel timer IBTS Stream Event IBTS updateType FINISHED IBTS show IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 45.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None release cached channel (timer timeout) [eDVBCAService] remove channel 0x245d190 [eDVBLocalTimeHandler] remove channel 0x245d190 [eEPGCache] remove channel 0x245d190 stop release channel timer (0) preClose IBTS tunerHide [prepareClose] running mainloop [SEC] lock 0 [SEC] delayed close frontend close frontend 0 [SEC] unlock IBTS Stream Event Looking for embedded skin IBTS show StreamService handle command 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: StreamService execBegin 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: recording service: > record: 0 allocate channel.. abe0:00de:ffff0000 opening frontend 0 [eDVBCAService] new channel 0x2545bd8! (0)tune tuning to 810000 khz, sr 6900000, fec 9, modulation 5, inversion 2 OURSTATE: tuning allocate Channel: res 0 [eDVBCIInterfaces] addPMTHandler 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: recheckPMTHAndlers() recheck 0x2508c0c 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: check Slot 0 check Slot 1 allocate demux RECORD event for us: *' at 0x2241848> > IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress None None None None IBTS duration, timeleft, timeelapsed, progress 45.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None [SEC] startTuneTimeout 5000 [SEC] setFrontend 1 (0)setting frontend (0)fe event: status 0, freq 810000000, inversion off, m_tuning 1 F (0)fe event: status 1f, freq 810000000, inversion off, m_tuning 1 N OURSTATE: ok [eDVBCAService] channel 0x2545bd8 running [eDVBLocalTimeHandler] channel 0x2545bd8 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 0x2545bd8 running stop release channel timer RECORD service event 6 tuned.. [EPGC] next update in 2 sec no version filtering 0012: 4e 2b 66 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 RECORD event for us: *' at 0x22412d8> > 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 RECORD service event 5 start streaming... RECORD event for us: *' at 0x22412d8> > RECORD event for us: *' at 0x22412d8> > + 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 09 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:1:2B66:ABE0:DE:FFFF0000:0:0:0: [eDVBCAService] add demux 3 to slot 0 service 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: demux 3 mask 08 prevhash 00000000 [eDVBCAService] send 80 bytes 9f 80 32 4c 03 2b 66 0b 00 19 01 81 08 ff ff 00 00 ab e0 00 de 82 02 08 03 84 02 17 d4 09 04 0b 00 f6 30 1b 17 de 00 00 03 17 e8 00 00 03 17 e9 00 00 06 17 ea 00 00 03 17 eb 00 00 06 17 f2 00 00 06 17 f3 00 00 06 17 f4 00 00 05 18 1a 00 00 recheckPMTHAndlers() recheck 0x2508c0c 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: dvb subtitle PID 17f3 with wrong subtitling type (24)... force 0x10!! check Slot 0 check Slot 1 [eDVBCIInterfaces] gotPMT RECORD service event 5 start streaming... RECORD event for us: *' at 0x22412d8> > RECORD event for us: *' at 0x22412d8> > doing version filtering 17d4: 02 2b 66 0b 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 -+ 1/2 TID 4e sdt update done! ++ 2/2 TID 4e done! [eDVBServiceRecord] now running: Die Küchenschlacht Der Wochenrückblick (7200 seconds) RECORD event for us: *' at 0x2241848> > doing version filtering 0012: 4e 2b 66 03 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 [EPGC] start caching events(1381570620) nr_read 388 nr_write 5 sum 393 prev_sum 393 hdd IDLE! [IDLE] 212.000282049 300 False nr_read 1566 nr_write 94 sum 1660 prev_sum 1656 hdd was accessed since previous check! [IDLE] 0 300 False IBTS tunerHide screen cleanup! StreamService execEnd 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: stop recording! [eDVBServiceRecord] saving cutlist failed because tstools failed [eDVBCAService] free slot 0 demux 3 for service 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: [eDVBCAService] free service 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: recheckPMTHAndlers() start release channel timer IBTS Stream Event IBTS updateType FINISHED IBTS show IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 45.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS Stream Event Looking for embedded skin IBTS show StreamService handle command StreamService execBegin -1:38308446:A:23AD1C8:0:0:A:0:0:23AD1C8: recording service: > record: -1 record returned non-zero IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress None None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 45.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None [EPGC] abort non avail schedule other reading [EPGC] abort non avail viasat reading release cached channel (timer timeout) [eDVBCAService] remove channel 0x2545bd8 [eDVBLocalTimeHandler] remove channel 0x2545bd8 [eEPGCache] remove channel 0x2545bd8 [EPGC] abort caching events !! stop release channel timer (0) preClose screen cleanup! StreamService execEnd -1:38308446:A:23AD1C8:0:0:A:0:0:23AD1C8: IBTS Stream Event IBTS updateType FINISHED IBTS show IBTS Stream Event Looking for embedded skin IBTS show StreamService handle command 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: StreamService execBegin 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: recording service: > record: 0 allocate channel.. abe0:00de:ffff0000 [eDVBCAService] new channel 0x710a3920! (0)tune tuning to 810000 khz, sr 6900000, fec 9, modulation 5, inversion 2 OURSTATE: tuning allocate Channel: res 0 [eDVBCIInterfaces] addPMTHandler 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: recheckPMTHAndlers() recheck 0x71077fdc 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: check Slot 0 check Slot 1 allocate demux RECORD event for us: *' at 0x2262b00> > IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress None None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 45.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None [SEC] startTuneTimeout 5000 [SEC] setFrontend 1 (0)setting frontend (0)fe event: status 0, freq 810000000, inversion off, m_tuning 1 F (0)fe event: status 1f, freq 810000000, inversion off, m_tuning 1 N OURSTATE: ok [eDVBCAService] channel 0x710a3920 running [eDVBLocalTimeHandler] channel 0x710a3920 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 0x710a3920 running stop release channel timer RECORD service event 6 tuned.. [EPGC] next update in 2 sec no version filtering 0012: 4e 2b 66 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 RECORD event for us: *' at 0x223d8f0> > 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 RECORD service event 5 start streaming... RECORD event for us: *' at 0x223d8f0> > RECORD event for us: *' at 0x223d8f0> > + 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 09 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:1:2B66:ABE0:DE:FFFF0000:0:0:0: [eDVBCAService] add demux 3 to slot 0 service 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: demux 3 mask 08 prevhash 00000000 [eDVBCAService] send 80 bytes 9f 80 32 4c 03 2b 66 0b 00 19 01 81 08 ff ff 00 00 ab e0 00 de 82 02 08 03 84 02 17 d4 09 04 0b 00 f6 30 1b 17 de 00 00 03 17 e8 00 00 03 17 e9 00 00 06 17 ea 00 00 03 17 eb 00 00 06 17 f2 00 00 06 17 f3 00 00 06 17 f4 00 00 05 18 1a 00 00 recheckPMTHAndlers() recheck 0x71077fdc 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: dvb subtitle PID 17f3 with wrong subtitling type (24)... force 0x10!! check Slot 0 check Slot 1 [eDVBCIInterfaces] gotPMT RECORD service event 5 start streaming... RECORD event for us: *' at 0x223d8f0> > RECORD event for us: *' at 0x223d8f0> > doing version filtering 17d4: 02 2b 66 0b 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 sdt update done! +- 1/2 TID 4e ++ 2/2 TID 4e done! [eDVBServiceRecord] now running: Die Küchenschlacht Der Wochenrückblick (7200 seconds) RECORD event for us: *' at 0x223d8f0> > doing version filtering 0012: 4e 2b 66 03 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 [EPGC] start caching events(1381570630) IBTS tunerHide Harddisk.py: stat failed on /dev/sda2 Harddisk.py: stat failed on /dev/sda2 [EPGC] abort non avail schedule other reading [EPGC] abort non avail viasat reading Harddisk.py: stat failed on /dev/sdb2 Harddisk.py: stat failed on /dev/sdb2 screen cleanup! screen cleanup! StreamService execEnd 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: stop recording! [eDVBServiceRecord] saving cutlist failed because tstools failed [eDVBCAService] free slot 0 demux 3 for service 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: [eDVBCAService] free service 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: recheckPMTHAndlers() start release channel timer IBTS Stream Event IBTS updateType FINISHED IBTS show IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress 1.0 None None None [EPGC] nownext finished(1381570637) IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 45.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS Stream Event Looking for embedded skin IBTS show StreamService handle command 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: StreamService execBegin 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: recording service: > record: 0 use cached_channel stop release channel timer allocate Channel: res 0 [eDVBCIInterfaces] addPMTHandler 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: recheckPMTHAndlers() recheck 0x2541084 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: check Slot 0 check Slot 1 RECORD service event 6 tuned.. no version filtering 0012: 4e 2b 66 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 RECORD event for us: *' at 0x223ab00> > 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 RECORD service event 5 RECORD event for us: *' at 0x223ab00> > RECORD event for us: *' at 0x223ab00> > start streaming... RECORD event for us: *' at 0x223ab00> > IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 45.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress None None None None + 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 09 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:1:2B66:ABE0:DE:FFFF0000:0:0:0: [eDVBCAService] add demux 3 to slot 0 service 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: demux 3 mask 08 prevhash 00000000 [eDVBCAService] send 80 bytes 9f 80 32 4c 03 2b 66 0b 00 19 01 81 08 ff ff 00 00 ab e0 00 de 82 02 08 03 84 02 17 d4 09 04 0b 00 f6 30 1b 17 de 00 00 03 17 e8 00 00 03 17 e9 00 00 06 17 ea 00 00 03 17 eb 00 00 06 17 f2 00 00 06 17 f3 00 00 06 17 f4 00 00 05 18 1a 00 00 recheckPMTHAndlers() recheck 0x2541084 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: dvb subtitle PID 17f3 with wrong subtitling type (24)... force 0x10!! check Slot 0 check Slot 1 [eDVBCIInterfaces] gotPMT RECORD service event 5 start streaming... RECORD event for us: *' at 0x223a110> > RECORD event for us: *' at 0x223a110> > doing version filtering 17d4: 02 2b 66 0b 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 +- 1/2 TID 4e ++ 2/2 TID 4e done! [eDVBServiceRecord] now running: Die Küchenschlacht Der Wochenrückblick (7200 seconds) RECORD event for us: *' at 0x223a110> > doing version filtering 0012: 4e 2b 66 03 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 [EPGC] schedule finished(1381570640) [EPGC] stop caching events(1381570640) [EPGC] next update in 60 min IBTS tunerHide [eDVBLocalTimeHandler] Receiver time is 'Sat Oct 12 11:37:27 2013' [eDVBLocalTimeHandler] Transponder time is 'Sat Oct 12 11:37:27 2013' [eDVBLocalTimeHandler] diff is 0 [eDVBLocalTimeHandler] diff < 120 .. use Transponder Time [eDVBLocalTimeHandler] not changed [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 4901303 bytes for cache used IBTS Stream Event Looking for embedded skin IBTS show StreamService handle command StreamService execBegin -1:38182014:A:24AC540:0:0:A:0:0:24AC540: recording service: > record: -1 record returned non-zero IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress None None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 45.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress None None None None nr_read 388 nr_write 5 sum 393 prev_sum 393 hdd IDLE! [IDLE] 242.043483019 300 False nr_read 1566 nr_write 98 sum 1664 prev_sum 1660 hdd was accessed since previous check! [IDLE] 0 300 False screen cleanup! StreamService execEnd -1:38182014:A:24AC540:0:0:A:0:0:24AC540: IBTS Stream Event IBTS updateType FINISHED IBTS show IBTS Stream Event Looking for embedded skin IBTS show StreamService handle command 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: StreamService execBegin 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: recording service: > record: 0 use cached_channel allocate Channel: res 0 [eDVBCIInterfaces] addPMTHandler 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: recheckPMTHAndlers() recheck 0x2541084 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: check Slot 0 check Slot 1 recheck 0x710a5b14 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: check Slot 0 check Slot 1 RECORD service event 6 tuned.. no version filtering 0012: 4e 2b 66 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 RECORD event for us: *' at 0x2255e78> > RECORD event for us: *' at 0x2255e78> > 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 RECORD service event 5 RECORD event for us: *' at 0x2255e78> > RECORD event for us: *' at 0x2255e78> > RECORD event for us: *' at 0x2255e78> > RECORD event for us: *' at 0x2255e78> > start streaming... RECORD event for us: *' at 0x2255e78> > RECORD event for us: *' at 0x2255e78> > IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 45.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress None None None None IBTS duration, timeleft, timeelapsed, progress None None None None + 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 09 00 00 mask: ff 00 00 3f 00 00 mode: 00 00 00 3e 00 00 + 1/1 TID 02 done! [eDVBCAService] add demux 3 to slot 1 service 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: demux 3 mask 08 prevhash 17d40805 [eDVBCAService] don't build/send the same CA PMT twice recheckPMTHAndlers() recheck 0x2541084 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: check Slot 0 check Slot 1 recheck 0x710a5b14 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: dvb subtitle PID 17f3 with wrong subtitling type (24)... force 0x10!! check Slot 0 check Slot 1 [eDVBCIInterfaces] gotPMT RECORD service event 5 start streaming... RECORD event for us: *' at 0x223af98> > RECORD event for us: *' at 0x223af98> > RECORD event for us: *' at 0x223af98> > RECORD event for us: *' at 0x223af98> > doing version filtering 17d4: 02 2b 66 0b 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 +- 1/2 TID 4e ++ 2/2 TID 4e done! [eDVBServiceRecord] now running: Die Küchenschlacht Der Wochenrückblick (7200 seconds) RECORD event for us: *' at 0x223af98> > RECORD event for us: *' at 0x223af98> > doing version filtering 0012: 4e 2b 66 03 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 screen cleanup! StreamService execEnd 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: stop recording! [eDVBServiceRecord] saving cutlist failed because tstools failed RECORD event for us: *' at 0x223af98> > RECORD event for us: *' at 0x223af98> > [eDVBCAService] free slot 0 demux 3 for service 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: demux 3 mask 08 prevhash 17d40805 [eDVBCAService] don't build/send the same CA PMT twice recheckPMTHAndlers() recheck 0x710a5b14 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: check Slot 0 check Slot 1 IBTS Stream Event IBTS updateType FINISHED IBTS show IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 45.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress None None None None IBTS tunerHide IBTS Stream Event Looking for embedded skin IBTS show StreamService handle command 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: StreamService execBegin 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: recording service: > record: 0 use cached_channel allocate Channel: res 0 [eDVBCIInterfaces] addPMTHandler 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: recheckPMTHAndlers() recheck 0x710a5b14 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: check Slot 0 check Slot 1 recheck 0x25199f4 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: check Slot 0 check Slot 1 RECORD service event 6 tuned.. no version filtering 0012: 4e 2b 66 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 RECORD event for us: *' at 0x2259d70> > RECORD event for us: *' at 0x2259d70> > 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 RECORD service event 5 RECORD event for us: *' at 0x2259d70> > RECORD event for us: *' at 0x2259d70> > RECORD event for us: *' at 0x2259d70> > RECORD event for us: *' at 0x2259d70> > start streaming... RECORD event for us: *' at 0x2259d70> > RECORD event for us: *' at 0x2259d70> > IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress None None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 45.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress None None None None It's now Sat Oct 12 11:37:41 2013 next real activation is Sat Oct 12 20:09:40 2013 [timer.py] next activation: 1381570761 (in 99683 ms) + 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 09 00 00 mask: ff 00 00 3f 00 00 mode: 00 00 00 3e 00 00 +- 1/2 TID 4e + 1/1 TID 02 done! [eDVBCAService] add demux 3 to slot 0 service 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: demux 3 mask 08 prevhash 17d40805 [eDVBCAService] don't build/send the same CA PMT twice recheckPMTHAndlers() recheck 0x710a5b14 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: check Slot 0 check Slot 1 recheck 0x25199f4 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: dvb subtitle PID 17f3 with wrong subtitling type (24)... force 0x10!! check Slot 0 check Slot 1 [eDVBCIInterfaces] gotPMT RECORD service event 5 start streaming... RECORD event for us: *' at 0x2259200> > RECORD event for us: *' at 0x2259200> > RECORD event for us: *' at 0x2259200> > RECORD event for us: *' at 0x2259200> > doing version filtering 17d4: 02 2b 66 0b 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 ++ 2/2 TID 4e done! [eDVBServiceRecord] now running: Die Küchenschlacht Der Wochenrückblick (7200 seconds) RECORD event for us: *' at 0x2259200> > RECORD event for us: *' at 0x2259200> > doing version filtering 0012: 4e 2b 66 03 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 IBTS tunerHide Harddisk.py: stat failed on /dev/sda2 Harddisk.py: stat failed on /dev/sda2 Harddisk.py: stat failed on /dev/sdb2 Harddisk.py: stat failed on /dev/sdb2 screen cleanup! screen cleanup! StreamService execEnd 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: stop recording! [eDVBServiceRecord] saving cutlist failed because tstools failed RECORD event for us: *' at 0x2255170> > RECORD event for us: *' at 0x2262fe0> > [eDVBCAService] free slot 0 demux 3 for service 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: demux 3 mask 08 prevhash 17d40805 [eDVBCAService] don't build/send the same CA PMT twice recheckPMTHAndlers() recheck 0x25199f4 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: check Slot 0 check Slot 1 IBTS Stream Event IBTS updateType FINISHED IBTS show IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress None None None None IBTS duration, timeleft, timeelapsed, progress 45.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None screen cleanup! StreamService execEnd 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: stop recording! [eDVBServiceRecord] saving cutlist failed because tstools failed [eDVBCAService] free slot 1 demux 3 for service 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: [eDVBCAService] free service 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: recheckPMTHAndlers() start release channel timer IBTS Stream Event IBTS updateType FINISHED IBTS show IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 45.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None release cached channel (timer timeout) [eDVBCAService] remove channel 0x710a3920 [eDVBLocalTimeHandler] remove channel 0x710a3920 [eEPGCache] remove channel 0x710a3920 stop release channel timer (0) preClose IBTS tunerHide [prepareClose] running mainloop [SEC] lock 0 [SEC] delayed close frontend close frontend 0 [SEC] unlock nr_read 388 nr_write 5 sum 393 prev_sum 393 hdd IDLE! [IDLE] 271.999406099 300 False nr_read 1566 nr_write 102 sum 1668 prev_sum 1664 hdd was accessed since previous check! [IDLE] 0 300 False It's now Sat Oct 12 11:38:02 2013 next real activation is Sat Oct 12 18:00:01 2013 [timer.py] next activation: 1381570782 (in 99998 ms) It's now Sat Oct 12 11:38:02 2013 [timer.py] next activation: 1381570782 (in 99996 ms) IBTS Stream Event Looking for embedded skin IBTS show StreamService handle command 1:0:1:4E24:2B6E:1:FFFF024A:0:0:0: StreamService execBegin 1:0:1:4E24:2B6E:1:FFFF024A:0:0:0: recording service: > record: 0 allocate channel.. 2b6e:0001:ffff024a opening frontend 0 [eDVBCAService] new channel 0x255cf20! (0)tune tuning to 586000 khz, sr 6900000, fec 9, modulation 5, inversion 2 OURSTATE: tuning allocate Channel: res 0 [eDVBCIInterfaces] addPMTHandler 1:0:1:4E24:2B6E:1:FFFF024A:0:0:0: recheckPMTHAndlers() recheck 0x252a0e4 1:0:1:4E24:2B6E:1:FFFF024A:0:0:0: check Slot 0 check Slot 1 allocate demux RECORD event for us: *' at 0x22411b8> > IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress None None None None IBTS duration, timeleft, timeelapsed, progress 45.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None [SEC] startTuneTimeout 5000 [SEC] setFrontend 1 (0)setting frontend (0)fe event: status 0, freq 586000000, inversion off, m_tuning 1 F (0)fe event: status 1f, freq 586000000, inversion off, m_tuning 1 N OURSTATE: ok [eDVBCAService] channel 0x255cf20 running [eDVBLocalTimeHandler] channel 0x255cf20 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 0x255cf20 running stop release channel timer RECORD service event 6 tuned.. no version filtering 0012: 4e 4e 24 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 [EPGC] next update in 55 min RECORD event for us: *' at 0x2241170> > 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 RECORD service event 5 start streaming... RECORD event for us: *' at 0x2241170> > RECORD event for us: *' at 0x2241170> > + 1/1 TID 00 done! PATready use pmtpid 0403 for service_id 4e24 no version filtering 0403: 02 4e 24 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 doing version filtering 0000: 00 00 00 15 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:1:4E24:2B6E:1:FFFF024A:0:0:0: [eDVBCAService] add demux 3 to slot 0 service 1:0:1:4E24:2B6E:1:FFFF024A:0:0:0: demux 3 mask 08 prevhash 00000000 [eDVBCAService] send 55 bytes 9f 80 32 33 03 4e 24 07 00 19 01 81 08 ff ff 02 4a 2b 6e 00 01 82 02 08 03 84 02 04 03 09 04 0b 00 f3 c1 02 00 a6 00 00 03 00 a7 00 00 06 00 a9 00 00 05 04 05 00 00 recheckPMTHAndlers() recheck 0x252a0e4 1:0:1:4E24:2B6E:1:FFFF024A:0:0:0: check Slot 0 check Slot 1 [eDVBCIInterfaces] gotPMT RECORD service event 5 start streaming... RECORD event for us: *' at 0x2241170> > RECORD event for us: *' at 0x2241170> > doing version filtering 0403: 02 4e 24 07 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 -+ 1/2 TID 4e sdt update done! ++ 2/2 TID 4e done! [eDVBServiceRecord] now running: Achtung Kontrolle - Einsatz für die Ordnungshüter (4800 seconds) RECORD event for us: *' at 0x2241170> > doing version filtering 0012: 4e 4e 24 17 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 IBTS tunerHide screen cleanup! StreamService execEnd 1:0:1:4E24:2B6E:1:FFFF024A:0:0:0: stop recording! [eDVBServiceRecord] saving cutlist failed because tstools failed [eDVBCAService] free slot 0 demux 3 for service 1:0:1:4E24:2B6E:1:FFFF024A:0:0:0: [eDVBCAService] free service 1:0:1:4E24:2B6E:1:FFFF024A:0:0:0: recheckPMTHAndlers() start release channel timer IBTS Stream Event IBTS updateType FINISHED IBTS show IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 45.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None release cached channel (timer timeout) [eDVBCAService] remove channel 0x255cf20 [eDVBLocalTimeHandler] remove channel 0x255cf20 [eEPGCache] remove channel 0x255cf20 stop release channel timer (0) preClose IBTS tunerHide [prepareClose] running mainloop [SEC] lock 0 [SEC] delayed close frontend close frontend 0 [SEC] unlock [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 4901263 bytes for cache used nr_read 388 nr_write 5 sum 393 prev_sum 393 hdd IDLE! [IDLE] 301.999603987 300 False [ePopen] command: ('hdparm', 'hdparm', '-y', '/dev/sda') nr_read 1566 nr_write 106 sum 1672 prev_sum 1668 hdd was accessed since previous check! [IDLE] 0 300 False child has terminated pipes closed poll: unhandled POLLERR/HUP/NVAL for fd 41(16) [DLNA] MediaServer Detected: dm7020hd Mediaserver (MediaServer) [DLNA] Device found: BubbleUPnP Media Server (Galaxy Nexus) (MediaServer) [DLNA] Device found: BubbleUPnP Media Server (Galaxy Nexus) (MediaServer) [DLNA] Device found: BubbleUPnP (Galaxy Nexus) (MediaRenderer) [DLNA] Device found: BubbleUPnP (Galaxy Nexus) (MediaRenderer) [DLNA] MediaServer Detected: BubbleUPnP Media Server (Galaxy Nexus) (MediaServer) nr_read 388 nr_write 5 sum 393 prev_sum 393 hdd IDLE! [IDLE] 331.999402046 300 True nr_read 1566 nr_write 110 sum 1676 prev_sum 1672 hdd was accessed since previous check! [IDLE] 0 300 False It's now Sat Oct 12 11:39:20 2013 next real activation is Sat Oct 12 20:09:40 2013 [timer.py] next activation: 1381570861 (in 99997 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 4901263 bytes for cache used nr_read 388 nr_write 5 sum 393 prev_sum 393 hdd IDLE! [IDLE] 361.999616146 300 True nr_read 1566 nr_write 112 sum 1678 prev_sum 1676 hdd was accessed since previous check! [IDLE] 0 300 False IBTS Stream Event Looking for embedded skin IBTS show StreamService handle command StreamService execBegin -1:39197926:A:24946D0:0:0:A:0:0:24946D0: recording service: > getBouquet failed.. no path given! eStaticServiceDVBBouquetInformation::isPlayable failed.. getBouquet failed! record returned non-zero IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress 45.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None getBouquet failed.. no path given! IBTS duration, timeleft, timeelapsed, progress None None None None screen cleanup! StreamService execEnd -1:39197926:A:24946D0:0:0:A:0:0:24946D0: IBTS Stream Event IBTS updateType FINISHED IBTS show IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress 45.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS Stream Event Looking for embedded skin IBTS show StreamService handle command StreamService execBegin -1:38287646:A:238D238:0:0:A:0:0:238D238: recording service: > record: -1 record returned non-zero IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress None None None None IBTS duration, timeleft, timeelapsed, progress 45.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None screen cleanup! StreamService execEnd -1:38287646:A:238D238:0:0:A:0:0:238D238: IBTS Stream Event IBTS updateType FINISHED IBTS show IBTS Stream Event Looking for embedded skin IBTS show StreamService handle command 1:0:1:4E25:2B6E:1:FFFF024A:0:0:0: StreamService execBegin 1:0:1:4E25:2B6E:1:FFFF024A:0:0:0: recording service: > record: 0 allocate channel.. 2b6e:0001:ffff024a opening frontend 0 [eDVBCAService] new channel 0x248c848! (0)tune tuning to 586000 khz, sr 6900000, fec 9, modulation 5, inversion 2 OURSTATE: tuning allocate Channel: res 0 [eDVBCIInterfaces] addPMTHandler 1:0:1:4E25:2B6E:1:FFFF024A:0:0:0: recheckPMTHAndlers() recheck 0x25010e4 1:0:1:4E25:2B6E:1:FFFF024A:0:0:0: check Slot 0 check Slot 1 allocate demux RECORD event for us: *' at 0x2256608> > IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 45.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress None None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None [SEC] startTuneTimeout 5000 [SEC] setFrontend 1 (0)setting frontend (0)fe event: status 0, freq 586000000, inversion off, m_tuning 1 F (0)fe event: status 1f, freq 586000000, inversion off, m_tuning 1 N OURSTATE: ok [eDVBCAService] channel 0x248c848 running [eDVBLocalTimeHandler] channel 0x248c848 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 0x248c848 running stop release channel timer RECORD service event 6 tuned.. [EPGC] next update in 53 min no version filtering 0012: 4e 4e 25 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 RECORD event for us: *' at 0x22563c8> > 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 RECORD service event 5 start streaming... RECORD event for us: *' at 0x22563c8> > RECORD event for us: *' at 0x22563c8> > + 1/1 TID 00 done! PATready use pmtpid 0404 for service_id 4e25 no version filtering 0404: 02 4e 25 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 doing version filtering 0000: 00 00 00 15 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:1:4E25:2B6E:1:FFFF024A:0:0:0: [eDVBCAService] add demux 3 to slot 0 service 1:0:1:4E25:2B6E:1:FFFF024A:0:0:0: demux 3 mask 08 prevhash 00000000 [eDVBCAService] send 60 bytes 9f 80 32 38 03 4e 25 07 00 19 01 81 08 ff ff 02 4a 2b 6e 00 01 82 02 08 03 84 02 04 04 09 04 0b 00 f3 c2 02 03 20 00 00 03 03 21 00 00 06 03 22 00 00 06 03 23 00 00 05 05 05 00 00 recheckPMTHAndlers() recheck 0x25010e4 1:0:1:4E25:2B6E:1:FFFF024A:0:0:0: check Slot 0 check Slot 1 [eDVBCIInterfaces] gotPMT RECORD service event 5 start streaming... RECORD event for us: *' at 0x22563c8> > RECORD event for us: *' at 0x22563c8> > doing version filtering 0404: 02 4e 25 07 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 sdt update done! +- 1/2 TID 4e ++ 2/2 TID 4e done! [eDVBServiceRecord] now running: Richterin Salesch (3600 seconds) RECORD event for us: *' at 0x22563c8> > doing version filtering 0012: 4e 4e 25 09 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 IBTS tunerHide It's now Sat Oct 12 11:39:42 2013 [timer.py] next activation: 1381570882 (in 99998 ms) It's now Sat Oct 12 11:39:42 2013 next real activation is Sat Oct 12 18:00:01 2013 [timer.py] next activation: 1381570882 (in 99995 ms) IBTS Stream Event Looking for embedded skin IBTS show StreamService handle command 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: StreamService execBegin 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: recording service: > record: 0 allocate channel.. 2b75:0001:ffff018a available channel.. 2b6e:0001:ffff024a opening frontend 1 [eDVBCAService] new channel 0x254ffb8! (1)tune tuning to 394000 khz, sr 6903076, fec 9, modulation 5, inversion 0 OURSTATE: tuning allocate Channel: res 0 [eDVBCIInterfaces] addPMTHandler 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: recheckPMTHAndlers() recheck 0x25010e4 1:0:1:4E25:2B6E:1:FFFF024A:0:0:0: check Slot 0 check Slot 1 recheck 0x252b144 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: check Slot 0 check Slot 1 allocate demux RECORD event for us: *' at 0x225ee00> > RECORD event for us: *' at 0x225ee00> > IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress None None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 45.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress None None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None [SEC] startTuneTimeout 5000 screen cleanup! StreamService execEnd 1:0:1:4E25:2B6E:1:FFFF024A:0:0:0: stop recording! [eDVBServiceRecord] saving cutlist failed because tstools failed RECORD event for us: *' at 0x2256620> > RECORD event for us: *' at 0x2256620> > [eDVBCAService] free slot 0 demux 3 for service 1:0:1:4E25:2B6E:1:FFFF024A:0:0:0: [eDVBCAService] free service 1:0:1:4E25:2B6E:1:FFFF024A:0:0:0: recheckPMTHAndlers() recheck 0x252b144 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: check Slot 0 check Slot 1 [eDVBCAService] remove channel 0x248c848 [eDVBLocalTimeHandler] remove channel 0x248c848 [eEPGCache] remove channel 0x248c848 (0) preClose IBTS Stream Event IBTS updateType FINISHED IBTS show [SEC] setFrontend 1 (1)setting frontend IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress None None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 45.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None (1)fe event: status 0, freq 394000000, inversion off, m_tuning 1 F (1)fe event: status 1f, freq 394000000, inversion off, m_tuning 1 N OURSTATE: ok [eDVBCAService] channel 0x254ffb8 running [eDVBLocalTimeHandler] channel 0x254ffb8 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 0x254ffb8 running stop release channel timer RECORD service event 6 tuned.. [EPGC] next update in 55 min no version filtering 0012: 4e f1 e0 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 RECORD event for us: *' at 0x223d8f0> > 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 RECORD service event 5 start streaming... RECORD event for us: *' at 0x223d8f0> > RECORD event for us: *' at 0x223d8f0> > + 1/1 TID 00 done! PATready use pmtpid 0398 for service_id f1e0 no version filtering 0398: 02 f1 e0 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 doing version filtering 0000: 00 00 00 1b 00 00 mask: ff 00 00 3f 00 00 mode: 00 00 00 3e 00 00 + 1/1 TID 02 done! [eDVBCAService] new service 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: [eDVBCAService] add demux 2 to slot 0 service 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: demux 2 mask 04 prevhash 00000000 [eDVBCAService] send 70 bytes 9f 80 32 42 03 f1 e0 09 00 19 01 81 08 ff ff 01 8a 2b 75 00 01 82 02 04 02 84 02 03 98 09 04 0b 00 f0 3e 0b 00 23 00 00 05 00 25 00 00 1b 07 80 00 00 04 07 81 00 00 04 07 82 00 00 06 07 83 00 00 06 07 85 00 00 recheckPMTHAndlers() recheck 0x252b144 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: HBBTV broadcast data on pid 0023 check Slot 0 check Slot 1 [eDVBCIInterfaces] gotPMT RECORD service event 5 start streaming... RECORD event for us: *' at 0x223d8f0> > RECORD event for us: *' at 0x223d8f0> > doing version filtering 0398: 02 f1 e0 09 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 sdt update done! -+ 1/2 TID 4e ++ 2/2 TID 4e done! [eDVBServiceRecord] now running: Disneys Jessie (1201 seconds) RECORD event for us: *' at 0x223d8f0> > doing version filtering 0012: 4e f1 e0 1d 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 [prepareClose] running mainloop [SEC] lock 0 [SEC] delayed close frontend close frontend 0 [SEC] unlock [eDVBLocalTimeHandler] Receiver time is 'Sat Oct 12 11:39:57 2013' [eDVBLocalTimeHandler] Transponder time is 'Sat Oct 12 11:39:56 2013' [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] 4901263 bytes for cache used IBTS tunerHide screen cleanup! StreamService execEnd 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: stop recording! [eDVBServiceRecord] saving cutlist failed because tstools failed [eDVBCAService] free slot 0 demux 2 for service 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: [eDVBCAService] free service 1:0:1:F1E0:2B75:1:FFFF018A:0:0:0: recheckPMTHAndlers() start release channel timer IBTS Stream Event IBTS updateType FINISHED IBTS show IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 45.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None nr_read 388 nr_write 5 sum 393 prev_sum 393 hdd IDLE! [IDLE] 390.99932909 300 True nr_read 1566 nr_write 114 sum 1680 prev_sum 1678 hdd was accessed since previous check! [IDLE] 0 300 False IBTS Stream Event Looking for embedded skin IBTS show StreamService handle command 1:0:1:7031:7148:DE:FFFF0000:0:0:0: StreamService execBegin 1:0:1:7031:7148:DE:FFFF0000:0:0:0: recording service: > record: 0 [eDVBCAService] remove channel 0x254ffb8 [eDVBLocalTimeHandler] remove channel 0x254ffb8 [eEPGCache] remove channel 0x254ffb8 (1) preClose allocate channel.. 7148:00de:ffff0000 opening frontend 0 [eDVBCAService] new channel 0x254ffb8! (0)tune tuning to 706000 khz, sr 6900000, fec 9, modulation 5, inversion 2 OURSTATE: tuning allocate Channel: res 0 [eDVBCIInterfaces] addPMTHandler 1:0:1:7031:7148:DE:FFFF0000:0:0:0: recheckPMTHAndlers() recheck 0x2557be4 1:0:1:7031:7148:DE:FFFF0000:0:0:0: check Slot 0 check Slot 1 allocate demux RECORD event for us: *' at 0x225e0e0> > IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 45.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress None None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None [SEC] startTuneTimeout 5000 [SEC] setFrontend 1 (0)setting frontend (0)fe event: status 0, freq 706000000, inversion off, m_tuning 1 F (0)fe event: status 1f, freq 706000000, inversion off, m_tuning 1 N OURSTATE: ok [eDVBCAService] channel 0x254ffb8 running [eDVBLocalTimeHandler] channel 0x254ffb8 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 0x254ffb8 running stop release channel timer [EPGC] next update in 2 sec RECORD service event 6 tuned.. no version filtering 0012: 4e 70 31 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 RECORD event for us: *' at 0x2256260> > 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 RECORD service event 5 start streaming... RECORD event for us: *' at 0x2256260> > RECORD event for us: *' at 0x2256260> > + 1/1 TID 00 done! PATready use pmtpid 1809 for service_id 7031 no version filtering 1809: 02 70 31 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 doing version filtering 0000: 00 00 00 15 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:1:7031:7148:DE:FFFF0000:0:0:0: [eDVBCAService] add demux 3 to slot 0 service 1:0:1:7031:7148:DE:FFFF0000:0:0:0: demux 3 mask 08 prevhash 00000000 [eDVBCAService] send 50 bytes 9f 80 32 2e 03 70 31 07 00 19 01 81 08 ff ff 00 00 71 48 00 de 82 02 08 03 84 02 18 09 09 04 0b 00 ec 83 06 00 68 00 00 02 08 35 00 00 03 08 36 00 00 recheckPMTHAndlers() recheck 0x2557be4 1:0:1:7031:7148:DE:FFFF0000:0:0:0: check Slot 0 check Slot 1 [eDVBCIInterfaces] gotPMT RECORD service event 5 start streaming... RECORD event for us: *' at 0x2256260> > RECORD event for us: *' at 0x2256260> > doing version filtering 1809: 02 70 31 07 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 +- 1/2 TID 4e sdt update done! ++ 2/2 TID 4e done! [eDVBServiceRecord] now running: Weltbilder (1800 seconds) RECORD event for us: *' at 0x2256260> > doing version filtering 0012: 4e 70 31 2b 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 [EPGC] start caching events(1381570805) [prepareClose] running mainloop [SEC] lock 0 [SEC] delayed close frontend close frontend 1 [SEC] unlock IBTS tunerHide [EPGC] abort non avail schedule other reading [EPGC] abort non avail viasat reading [eDVBLocalTimeHandler] Receiver time is 'Sat Oct 12 11:40:12 2013' [eDVBLocalTimeHandler] Transponder time is 'Sat Oct 12 11:40:09 2013' [eDVBLocalTimeHandler] diff is -3 [eDVBLocalTimeHandler] diff < 120 .. use Transponder Time [eDVBLocalTimeHandler] update RTC [eDVBLocalTimeHandler] time_difference is -3 [eDVBLocalTimeHandler] update Linux Time [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 4917807 bytes for cache used [EPGC] nownext finished(1381570809) [EPGC] schedule finished(1381570819) [EPGC] stop caching events(1381570819) [EPGC] next update in 60 min screen cleanup! StreamService execEnd 1:0:1:7031:7148:DE:FFFF0000:0:0:0: stop recording! [eDVBServiceRecord] saving cutlist failed because tstools failed [eDVBCAService] free slot 0 demux 3 for service 1:0:1:7031:7148:DE:FFFF0000:0:0:0: [eDVBCAService] free service 1:0:1:7031:7148:DE:FFFF0000:0:0:0: recheckPMTHAndlers() start release channel timer IBTS Stream Event IBTS updateType FINISHED IBTS show IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 45.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None release cached channel (timer timeout) [eDVBCAService] remove channel 0x254ffb8 [eDVBLocalTimeHandler] remove channel 0x254ffb8 [eEPGCache] remove channel 0x254ffb8 stop release channel timer (0) preClose IBTS tunerHide nr_read 388 nr_write 5 sum 393 prev_sum 393 hdd IDLE! [IDLE] 417.999580145 300 True nr_read 1566 nr_write 116 sum 1682 prev_sum 1680 hdd was accessed since previous check! [IDLE] 0 300 False [prepareClose] running mainloop [SEC] lock 0 [SEC] delayed close frontend close frontend 0 [SEC] unlock IBTS Stream Event Looking for embedded skin IBTS show StreamService handle command 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: StreamService execBegin 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: recording service: > record: 0 allocate channel.. abe0:00de:ffff0000 opening frontend 0 [eDVBCAService] new channel 0x2545b10! (0)tune tuning to 810000 khz, sr 6900000, fec 9, modulation 5, inversion 2 OURSTATE: tuning allocate Channel: res 0 [eDVBCIInterfaces] addPMTHandler 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: recheckPMTHAndlers() recheck 0x245e20c 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: check Slot 0 check Slot 1 allocate demux RECORD event for us: *' at 0x225ebf0> > IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress None None None None IBTS duration, timeleft, timeelapsed, progress 45.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None [SEC] startTuneTimeout 5000 [SEC] setFrontend 1 (0)setting frontend (0)fe event: status 0, freq 810000000, inversion off, m_tuning 1 F (0)fe event: status 1f, freq 810000000, inversion off, m_tuning 1 N OURSTATE: ok [eDVBCAService] channel 0x2545b10 running [eDVBLocalTimeHandler] channel 0x2545b10 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 0x2545b10 running stop release channel timer [EPGC] next update in 56 min RECORD service event 6 tuned.. no version filtering 0012: 4e 2b 66 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 RECORD event for us: *' at 0x2256470> > 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 RECORD service event 5 start streaming... RECORD event for us: *' at 0x2256470> > RECORD event for us: *' at 0x2256470> > screen cleanup! StreamService execEnd 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: stop recording! [eDVBServiceRecord] saving cutlist failed because tstools failed recheckPMTHAndlers() start release channel timer IBTS Stream Event IBTS updateType FINISHED IBTS show IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 45.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS Stream Event Looking for embedded skin IBTS show StreamService handle command 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: StreamService execBegin 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: recording service: > record: 0 use cached_channel stop release channel timer allocate Channel: res 0 [eDVBCIInterfaces] addPMTHandler 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: recheckPMTHAndlers() recheck 0x7109f274 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: check Slot 0 check Slot 1 RECORD service event 6 tuned.. no version filtering 0012: 4e 2b 66 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 RECORD event for us: *' at 0x2256e00> > 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 RECORD service event 5 RECORD event for us: *' at 0x2256e00> > RECORD event for us: *' at 0x2256e00> > start streaming... RECORD event for us: *' at 0x2256e00> > IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress None None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 45.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None + 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 09 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:1:2B66:ABE0:DE:FFFF0000:0:0:0: [eDVBCAService] add demux 3 to slot 0 service 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: demux 3 mask 08 prevhash 00000000 [eDVBCAService] send 80 bytes 9f 80 32 4c 03 2b 66 0b 00 19 01 81 08 ff ff 00 00 ab e0 00 de 82 02 08 03 84 02 17 d4 09 04 0b 00 f6 30 1b 17 de 00 00 03 17 e8 00 00 03 17 e9 00 00 06 17 ea 00 00 03 17 eb 00 00 06 17 f2 00 00 06 17 f3 00 00 06 17 f4 00 00 05 18 1a 00 00 recheckPMTHAndlers() recheck 0x7109f274 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: dvb subtitle PID 17f3 with wrong subtitling type (24)... force 0x10!! check Slot 0 check Slot 1 [eDVBCIInterfaces] gotPMT RECORD service event 5 start streaming... RECORD event for us: *' at 0x2256248> > RECORD event for us: *' at 0x2256248> > doing version filtering 17d4: 02 2b 66 0b 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 +- 1/2 TID 4e ++ 2/2 TID 4e done! [eDVBServiceRecord] now running: Die Küchenschlacht Der Wochenrückblick (7200 seconds) RECORD event for us: *' at 0x2256080> > doing version filtering 0012: 4e 2b 66 03 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 IBTS tunerHide [eDVBLocalTimeHandler] Receiver time is 'Sat Oct 12 11:40:53 2013' [eDVBLocalTimeHandler] Transponder time is 'Sat Oct 12 11:40:57 2013' [eDVBLocalTimeHandler] diff is 4 [eDVBLocalTimeHandler] diff < 120 .. use Transponder Time [eDVBLocalTimeHandler] update RTC [eDVBLocalTimeHandler] time_difference is 4 [eDVBLocalTimeHandler] update Linux Time [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 4918977 bytes for cache used It's now Sat Oct 12 11:41:01 2013 next real activation is Sat Oct 12 20:09:40 2013 [timer.py] next activation: 1381570961 (in 99997 ms) nr_read 388 nr_write 5 sum 393 prev_sum 393 hdd IDLE! [IDLE] 452.000195026 300 True nr_read 1566 nr_write 120 sum 1686 prev_sum 1682 hdd was accessed since previous check! [IDLE] 0 300 False screen cleanup! StreamService execEnd 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: stop recording! [eDVBServiceRecord] saving cutlist failed because tstools failed [eDVBCAService] free slot 0 demux 3 for service 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: [eDVBCAService] free service 1:0:1:2B66:ABE0:DE:FFFF0000:0:0:0: recheckPMTHAndlers() start release channel timer IBTS Stream Event IBTS updateType FINISHED IBTS show IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 45.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS Stream Event Looking for embedded skin IBTS show StreamService handle command 1:0:1:4E96:6590:DE:FFFF0000:0:0:0: StreamService execBegin 1:0:1:4E96:6590:DE:FFFF0000:0:0:0: recording service: > record: 0 [eDVBCAService] remove channel 0x2545b10 [eDVBLocalTimeHandler] remove channel 0x2545b10 [eEPGCache] remove channel 0x2545b10 (0) preClose allocate channel.. 6590:00de:ffff0000 [eDVBCAService] new channel 0x2486700! (0)tune tuning to 778000 khz, sr 6900000, fec 9, modulation 5, inversion 2 OURSTATE: tuning allocate Channel: res 0 [eDVBCIInterfaces] addPMTHandler 1:0:1:4E96:6590:DE:FFFF0000:0:0:0: recheckPMTHAndlers() recheck 0x2563ed4 1:0:1:4E96:6590:DE:FFFF0000:0:0:0: check Slot 0 check Slot 1 allocate demux RECORD event for us: *' at 0x2256248> > IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress None None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 45.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None [SEC] startTuneTimeout 5000 [SEC] setFrontend 1 (0)setting frontend (0)fe event: status 0, freq 778000000, inversion off, m_tuning 1 F (0)fe event: status 1f, freq 778000000, inversion off, m_tuning 1 N OURSTATE: ok [eDVBCAService] channel 0x2486700 running [eDVBLocalTimeHandler] channel 0x2486700 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 0x2486700 running stop release channel timer RECORD service event 6 tuned.. [EPGC] next update in 2 sec no version filtering 0012: 4e 4e 96 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 RECORD event for us: *' at 0x2256e78> > 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 RECORD service event 5 start streaming... RECORD event for us: *' at 0x2256e78> > RECORD event for us: *' at 0x2256e78> > screen cleanup! StreamService execEnd 1:0:1:4E96:6590:DE:FFFF0000:0:0:0: stop recording! [eDVBServiceRecord] saving cutlist failed because tstools failed recheckPMTHAndlers() start release channel timer IBTS Stream Event IBTS updateType FINISHED IBTS show IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 45.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS Stream Event Looking for embedded skin IBTS show StreamService handle command 1:0:1:4E96:6590:DE:FFFF0000:0:0:0: StreamService execBegin 1:0:1:4E96:6590:DE:FFFF0000:0:0:0: recording service: > record: 0 use cached_channel stop release channel timer allocate Channel: res 0 [eDVBCIInterfaces] addPMTHandler 1:0:1:4E96:6590:DE:FFFF0000:0:0:0: recheckPMTHAndlers() recheck 0x71091b34 1:0:1:4E96:6590:DE:FFFF0000:0:0:0: check Slot 0 check Slot 1 RECORD service event 6 tuned.. no version filtering 0012: 4e 4e 96 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 RECORD event for us: *' at 0x2256ef0> > 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 RECORD service event 5 RECORD event for us: *' at 0x2256ef0> > RECORD event for us: *' at 0x2256ef0> > start streaming... RECORD event for us: *' at 0x2256ef0> > IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress None None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 45.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None -+ 1/2 TID 4e + 1/1 TID 00 done! PATready use pmtpid 0411 for service_id 4e96 no version filtering 0411: 02 4e 96 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 doing version filtering 0000: 00 00 00 39 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:1:4E96:6590:DE:FFFF0000:0:0:0: [eDVBCAService] add demux 3 to slot 0 service 1:0:1:4E96:6590:DE:FFFF0000:0:0:0: demux 3 mask 08 prevhash 00000000 [eDVBCAService] send 50 bytes 9f 80 32 2e 03 4e 96 05 00 19 01 81 08 ff ff 00 00 65 90 00 de 82 02 08 03 84 02 04 11 09 04 0b 00 f1 8a 02 01 3e 00 00 03 01 a2 00 00 03 01 b6 00 00 recheckPMTHAndlers() recheck 0x71091b34 1:0:1:4E96:6590:DE:FFFF0000:0:0:0: check Slot 0 check Slot 1 [eDVBCIInterfaces] gotPMT RECORD service event 5 start streaming... RECORD event for us: *' at 0x22561e8> > RECORD event for us: *' at 0x22561e8> > doing version filtering 0411: 02 4e 96 05 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 [EPGC] start caching events(1381570874) ++ 2/2 TID 4e done! [eDVBServiceRecord] now running: Rick - Der Restaurator (1800 seconds) RECORD event for us: *' at 0x22561e8> > doing version filtering 0012: 4e 4e 96 01 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 IBTS tunerHide [EPGC] abort non avail schedule other reading [EPGC] abort non avail viasat reading [EPGC] nownext finished(1381570881) It's now Sat Oct 12 11:41:22 2013 next real activation is Sat Oct 12 18:00:01 2013 [timer.py] next activation: 1381570982 (in 99997 ms) It's now Sat Oct 12 11:41:22 2013 [timer.py] next activation: 1381570982 (in 99996 ms) [DLNA] MediaRenderer removed: uuid:2591d7d0-ab4b-bf08-ffff-ffff99f2d16c [eDVBLocalTimeHandler] Receiver time is 'Sat Oct 12 11:41:29 2013' [eDVBLocalTimeHandler] Transponder time is 'Sat Oct 12 11:41:27 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 WARN event_protocol Oct 12 11:41:27 response with error code '404' received upon our 'unsubscribe' request (coherence/upnp/core/event.py:233) WARN event_protocol Oct 12 11:41:27 response with error code '404' received upon our 'unsubscribe' request (coherence/upnp/core/event.py:233) [EPGC] stop cleanloop [EPGC] 4918977 bytes for cache used WARN event_protocol Oct 12 11:41:27 response with error code '404' received upon our 'unsubscribe' request (coherence/upnp/core/event.py:233) WARN event_protocol Oct 12 11:41:27 response with error code '404' received upon our 'unsubscribe' request (coherence/upnp/core/event.py:233) WARN event_protocol Oct 12 11:41:27 response with error code '404' received upon our 'unsubscribe' request (coherence/upnp/core/event.py:233) WARN event_protocol Oct 12 11:41:27 response with error code '404' received upon our 'unsubscribe' request (coherence/upnp/core/event.py:233) WARN event_protocol Oct 12 11:41:27 response with error code '404' received upon our 'unsubscribe' request (coherence/upnp/core/event.py:233) WARN event_protocol Oct 12 11:41:27 response with error code '404' received upon our 'unsubscribe' request (coherence/upnp/core/event.py:233) WARN event_protocol Oct 12 11:41:27 response with error code '404' received upon our 'unsubscribe' request (coherence/upnp/core/event.py:233) WARN event_protocol Oct 12 11:41:27 response with error code '404' received upon our 'unsubscribe' request (coherence/upnp/core/event.py:233) [DLNA] MediaRenderer removed: uuid:1ae7e2c2-1dd2-11b2-bdbe-b57eb128e898 WARN event_protocol Oct 12 11:41:28 response with error code '400' received upon our 'unsubscribe' request (coherence/upnp/core/event.py:233) WARN event_protocol Oct 12 11:41:28 response with error code '400' received upon our 'unsubscribe' request (coherence/upnp/core/event.py:233) WARN event_protocol Oct 12 11:41:28 response with error code '400' received upon our 'unsubscribe' request (coherence/upnp/core/event.py:233) screen cleanup! StreamService execEnd 1:0:1:4E96:6590:DE:FFFF0000:0:0:0: stop recording! [eDVBServiceRecord] saving cutlist failed because tstools failed [eDVBCAService] free slot 0 demux 3 for service 1:0:1:4E96:6590:DE:FFFF0000:0:0:0: [eDVBCAService] free service 1:0:1:4E96:6590:DE:FFFF0000:0:0:0: recheckPMTHAndlers() start release channel timer IBTS Stream Event IBTS updateType FINISHED IBTS show IBTS tunerShow IBTS updateNextTimer 2 IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 1.0 None None None IBTS duration, timeleft, timeelapsed, progress 45.0 None None None IBTS duration, timeleft, timeelapsed, progress 105.0 None None None [EPGC] schedule finished(1381570889) [EPGC] stop caching events(1381570889) [EPGC] next update in 60 min WARN event_protocol Oct 12 11:41:29 response with error code '412' received upon our 'unsubscribe' request (coherence/upnp/core/event.py:233) WARN event_protocol Oct 12 11:41:29 response with error code '412' received upon our 'unsubscribe' request (coherence/upnp/core/event.py:233) WARN event_protocol Oct 12 11:41:29 response with error code '412' received upon our 'unsubscribe' request (coherence/upnp/core/event.py:233) nr_read 388 nr_write 5 sum 393 prev_sum 393 hdd IDLE! [IDLE] 479.999526024 300 True nr_read 1566 nr_write 124 sum 1690 prev_sum 1686 hdd was accessed since previous check! [IDLE] 0 300 False release cached channel (timer timeout) [eDVBCAService] remove channel 0x2486700 [eDVBLocalTimeHandler] remove channel 0x2486700 [eEPGCache] remove channel 0x2486700 stop release channel timer (0) preClose IBTS tunerHide [prepareClose] running mainloop [SEC] lock 0 [SEC] delayed close frontend close frontend 0 [SEC] unlock nr_read 388 nr_write 5 sum 393 prev_sum 393 hdd IDLE! [IDLE] 509.999745131 300 True nr_read 1566 nr_write 128 sum 1694 prev_sum 1690 hdd was accessed since previous check! [IDLE] 0 300 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 4918977 bytes for cache used nr_read 388 nr_write 5 sum 393 prev_sum 393 hdd IDLE! [IDLE] 540.000329971 300 True nr_read 1566 nr_write 130 sum 1696 prev_sum 1694 hdd was accessed since previous check! [IDLE] 0 300 False It's now Sat Oct 12 11:42:39 2013 next real activation is Sat Oct 12 20:09:40 2013 [timer.py] next activation: 1381571059 (in 99997 ms) nr_read 388 nr_write 5 sum 393 prev_sum 393 hdd IDLE! [IDLE] 570.000028133 300 True nr_read 1566 nr_write 132 sum 1698 prev_sum 1696 hdd was accessed since previous check! [IDLE] 0 300 False It's now Sat Oct 12 11:42:59 2013 next real activation is Sat Oct 12 18:00:01 2013 [timer.py] next activation: 1381571080 (in 99998 ms) It's now Sat Oct 12 11:43:00 2013 [timer.py] next activation: 1381571080 (in 99996 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 4918955 bytes for cache used nr_read 388 nr_write 5 sum 393 prev_sum 393 hdd IDLE! [IDLE] 600.000008106 300 True nr_read 1566 nr_write 132 sum 1698 prev_sum 1698 hdd IDLE! [IDLE] 29.9999678135 300 False nr_read 388 nr_write 5 sum 393 prev_sum 393 hdd IDLE! [IDLE] 630.00011611 300 True nr_read 1566 nr_write 132 sum 1698 prev_sum 1698 hdd IDLE! [IDLE] 60.0000989437 300 False It's now Sat Oct 12 11:44:19 2013 next real activation is Sat Oct 12 20:09:40 2013 [timer.py] next activation: 1381571159 (in 99997 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 4918830 bytes for cache used nr_read 388 nr_write 5 sum 393 prev_sum 393 hdd IDLE! [IDLE] 659.99999404 300 True nr_read 1566 nr_write 132 sum 1698 prev_sum 1698 hdd IDLE! [IDLE] 89.9999408722 300 False It's now Sat Oct 12 11:44:40 2013 [timer.py] next activation: 1381571180 (in 99998 ms) It's now Sat Oct 12 11:44:40 2013 next real activation is Sat Oct 12 18:00:01 2013 [timer.py] next activation: 1381571180 (in 99996 ms) nr_read 388 nr_write 5 sum 393 prev_sum 393 hdd IDLE! [IDLE] 689.999819994 300 True nr_read 1566 nr_write 132 sum 1698 prev_sum 1698 hdd IDLE! [IDLE] 119.999763012 300 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 4916685 bytes for cache used nr_read 388 nr_write 5 sum 393 prev_sum 393 hdd IDLE! [IDLE] 720.000061035 300 True nr_read 1566 nr_write 132 sum 1698 prev_sum 1698 hdd IDLE! [IDLE] 149.999974012 300 False