=~=~=~=~=~=~=~=~=~=~=~= PuTTY log 2011.03.09 21:05:57 =~=~=~=~=~=~=~=~=~=~=~= 3456}  2ND STAGE OK, build #82 (2011-02-25) 0.000 - BCM board setup Configure MEMC1_2........ Done 0.039 - fp init FP version 7 detected 0.106 - ca init 0.809 - load config 1.388 - config loaded. * press [S] to enter setup OLED found! lcd: BOOT #82 - NAND PROBE: 2c da 80 15 (normal) - read config file: /boot/secondstage.conf detected jffs2 blocksize: 128kb +++++++++++++++++++B++++ 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: /flash/bootlogo.elf bootlogo size: 170039 using 1920x1080i (50.00 Hz) DVI using colorspace: 0 *** BHDM: HDMI Output Mode: DVI (Video Only) create surface 1920 1080 Using the Small jpeg decoder library, Copyright (c) 2006, Luc Saillard parsing JPEG header.. Virtual FB Size: 1280x720 lcd: /flash/vmlinux.gz <5>Linux version 2.6.18-7.4-dm8000 (tmbinc@pepe.multimedia-labs.de) (gcc version 4.4.3 (GCC) ) #1 SMP Thu Feb 17 18:32:30 UTC 2011 Fetching vars from bootloader... none present, using defaults. Detected 256 MB on MEMC0 (strap 0x2219c310) <4>WARNING: read invalid MAC address ff:ff:ff:ff:ff:ff from flash @ 0xbffff824 Default command line = root=/dev/mtdblock3 rootfstype=jffs2 rw console=null 2 831ffec0 8302afe8 g_board_RAM_size=256MB Options: sata=1 enet=1 emac_1=0 no_mdio=0 docsis=0 ebi_war=0 pci=1 smp=1 CPU revision is: 0002a042 FPU revision is: 00130001 Determined physical RAM map: memory: 10000000 @ 00000000 (usable) ---> memsize from bootloader: 154 User-defined physical RAM map: node [00000000, 09a00000: RAM] node [09a00000, 06600000: RSVD] <5>Reserving 102 MB upper memory starting at 09a00000 <7>On node 0 totalpages: 65536 <7> DMA zone: 65536 pages, LIFO batch:15 Built 1 zonelists. Total pages: 65536 <5>Kernel command line: console=ttyS0,115200 root=/dev/mtdblock5 rootfstype=jffs2 rw before init RAC 0x01e0701f 0x0000000f 0x2fff0000 after init RAC 0x01e0705f 0x0000000f 0x2fff0000 [4294667.296000] ======> Before RAC_init:$22s5=00000020, $22s6(CBA)=11f0000c [4294667.296000] @B1F0_001C=00000001, @B1F0_0004=2fff0000, @B1F0_0000=01e0701f, @B1F0_0008=0000000f [4294667.296000] CBA = 11f00000 VALUE = 255 PAR_VAL2 = 0fff0000 [4294667.296000] RAC0 = b1f00000 RAC1 = b1f00008 RAC_RANGE = b1f00004 [4294667.296000] RAC_VALUE = 00087000 [4294667.296000] ******* Using CFE setting for RAC [4294667.296000] ******* $22s0=e30e3406, $22s5=00000020, $22s6=11f0000c [4294667.296000] Primary instruction cache 32kB, physically tagged, 2-way, linesize 64 bytes. [4294667.296000] Primary data cache 64kB, 4-way, linesize 64 bytes. [4294667.296000] Synthesized TLB refill handler (23 instructions). [4294667.296000] Synthesized TLB load handler fastpath (37 instructions). [4294667.296000] Synthesized TLB store handler fastpath (37 instructions). [4294667.296000] Synthesized TLB modify handler fastpath (36 instructions). [4294667.296000] PID hash table entries: 2048 (order: 11, 8192 bytes) [4294667.296000] Found MIPS counter frequency: 203 Mhz [4294667.296000] Using 202.501 MHz high precision timer. [4294667.296000] Console: colour dummy device 80x25 [4294667.400000] Dentry cache hash table entries: 32768 (order: 5, 131072 bytes) [4294667.406000] Inode-cache hash table entries: 16384 (order: 4, 65536 bytes) [4294667.425000] Memory: 151680k/262144k available (2623k kernel code, 110252k reserved, 566k data, 136k init, 0k highmem) [4294667.456000] Mount-cache hash table entries: 512 [4294667.460000] Checking for 'wait' instruction... available. [4294667.465000] plat_prepare_cpus: ENABLING 2nd Thread... [4294667.470000] TP0: prom_boot_secondary: Kick off 2nd CPU... [4294667.475000] CPU revision is: 0002a042 [4294667.475000] FPU revision is: 00130001 [4294667.475000] Primary instruction cache 32kB, physically tagged, 2-way, linesize 64 bytes. [4294667.475000] Primary data cache 64kB, 4-way, linesize 64 bytes. [4294667.475000] Synthesized TLB refill handler (23 instructions). [4294667.496000] Brought up 2 CPUs [4294667.601000] migration_cost=1000 [4294667.606000] NET: Registered protocol family 16 [4294667.611000] registering PCI controller with io_map_base unset [4294667.617000] registering PCI controller with io_map_base unset [4294667.622000] SCSI subsystem initialized [4294667.626000] usbcore: registered new driver usbfs [4294667.630000] usbcore: registered new driver hub [4294667.633000] PCI DEV in slot 1, ID=168c:001a [4294667.633000] PCI PnP: PCI_BAR[0] = ffff0000 [4294667.641000] PCI PnP: size requested is 10000 [4294667.644000] NET: Registered protocol family 2 [4294667.661000] IP route cache hash table entries: 2048 (order: 1, 8192 bytes) [4294667.668000] TCP established hash table entries: 8192 (order: 4, 65536 bytes) [4294667.674000] TCP bind hash table entries: 4096 (order: 3, 32768 bytes) [4294667.680000] TCP: Hash tables configured (established 8192 bind 4096) [4294667.686000] TCP reno registered [4294667.689000] brcm-pm: disabling power to USB block [4294667.693000] brcm-pm: disabling power to ENET block [4294667.697000] brcm-pm: disabling power to SATA block [4294667.702000] JFFS2 version 2.2. (NAND) (SUMMARY) (C) 2001-2006 Red Hat, Inc. [4294667.709000] Initializing Cryptographic API [4294667.713000] io scheduler noop registered [4294667.716000] io scheduler anticipatory registered [4294667.720000] io scheduler deadline registered [4294667.724000] io scheduler cfq registered (default) [4294667.731000] Serial: 8250/16550 driver $Revision: 1.90 $ 1 ports, IRQ sharing disabled [4294667.739000] serial8250: ttyS0 at MMIO 0x0 (irq = 65) is a 16550A [4294667.744000] brcm-pm: enabling power to ENET block [4294667.748000] Broadcom BCM7400 P42 Ethernet Network Device v2.0 Feb 17 2011 18:31:45 [4294667.755000] SUNDRY revision = 74000032, have IP Hdr Opt=1 [4294667.761000] Config Internal PHY Through MDIO: 100 MB Full-Duplex (auto-neg) [4294669.432000] brcm-pm: enabling power to SATA block [4294669.452000] ata1: SATA max UDMA/133 cmd 0xB0510000 ctl 0xB0510020 bmdma 0xB0510030 irq 42 [4294669.460000] ata2: SATA max UDMA/133 cmd 0xB0510100 ctl 0xB0510120 bmdma 0xB0510130 irq 42 [4294669.468000] scsi0 : sata_svw [4294669.773000] ata1: SATA link down (SStatus 4 SControl 300) [4294669.809000] ATA: abnormal status 0x7F on port 0xb051001c [4294669.815000] scsi1 : sata_svw [4294670.125000] ata2: SATA link up 1.5 Gbps (SStatus 113 SControl F0000) [4294670.135000] ata2.00: ATA-8, max UDMA/133, 1953525168 sectors: LBA48 NCQ (depth 0/32) [4294670.143000] ata2.00: ata2: dev 0 multi count 0 [4294670.148000] ata2.00: configured for UDMA/133 [4294670.153000] Vendor: ATA Model: WDC WD10EACS-00D Rev: 01.0 [4294670.159000] Type: Direct-Access ANSI SCSI revision: 05 [4294670.166000] SCSI device sda: 1953525168 512-byte hdwr sectors (1000205 MB) [4294670.172000] sda: Write Protect is off [4294670.175000] SCSI device sda: drive cache: write back [4294670.179000] SCSI device sda: 1953525168 512-byte hdwr sectors (1000205 MB) [4294670.186000] sda: Write Protect is off [4294670.189000] SCSI device sda: drive cache: write back [4294670.193000] sda: sda1 [4294670.201000] sd 1:0:0:0: Attached scsi disk sda [4294670.206000] sd 1:0:0:0: Attached scsi generic sg0 type 0 [4294670.428000] 4587 kb/s [4294670.430000] - NAND PROBE: 2c da 80 15 [4294670.433000] NAND device: Manufacturer ID: 0x2c, Chip ID: 0xda (Unknown NAND 256MiB 3,3V 8-bit) [4294670.441000] Scanning device for bad blocks [4294670.445000] Bad eraseblock 27 at 0x00360000 [4294670.453000] Bad eraseblock 151 at 0x012e0000 [4294670.482000] Bad eraseblock 826 at 0x06740000 [4294670.501000] Bad eraseblock 1233 at 0x09a20000 [4294670.529000] Bad eraseblock 1865 at 0x0e920000 [4294670.540000] Creating 7 MTD partitions on "NAND 256MiB 3,3V 8-bit": [4294670.546000] 0x0000000000000000-0x0000000010000000 : "complete" [4294670.551000] 0x0000000000000000-0x0000000000100000 : "loader" [4294670.557000] 0x0000000000100000-0x0000000000400000 : "boot partition" [4294670.563000] 0x0000000000400000-0x0000000004000000 : "root partition" [4294670.568000] 0x0000000004000000-0x0000000008000000 : "home partition" [4294670.574000] 0x0000000008000000-0x000000000f800000 : "unused partition" [4294670.580000] 0x000000000f800000-0x0000000010000000 : "preset partition" [4294670.587000] ehci_hcd_brcm_init: Initializing 2 EHCI controller(s) [4294670.592000] brcm-pm: enabling power to USB block [4294670.596000] 10 Dec 2004 USB 2.0 'Enhanced' Host Controller (EHCI) Driver (EHCI-brcm-0) [4294670.603000] drivers/usb/host/ehci-brcm.c: starting brcm EHCI USB Controller [4294670.609000] - USB h/w setup mode [4294670.609000] - USB power enable set for active LOW mode [4294670.618000] brcm-ehci brcm-ehci.0: BRCM EHCI [4294670.621000] brcm-ehci brcm-ehci.0: new USB bus registered, assigned bus number 1 [4294670.628000] brcm-ehci brcm-ehci.0: irq 62, io mem 0x10480300 [4294670.633000] brcm-ehci brcm-ehci.0: USB 0.0 started, EHCI 1.00, driver 10 Dec 2004 [4294670.640000] usb usb1: configuration #1 chosen from 1 choice [4294670.645000] hub 1-0:1.0: USB hub found [4294670.648000] hub 1-0:1.0: 2 ports detected [4294670.752000] 10 Dec 2004 USB 2.0 'Enhanced' Host Controller (EHCI) Driver (EHCI-brcm-1) [4294670.760000] drivers/usb/host/ehci-brcm.c: starting brcm EHCI USB Controller [4294670.766000] brcm-ehci-1 brcm-ehci-1.1: BRCM EHCI [4294670.770000] brcm-ehci-1 brcm-ehci-1.1: new USB bus registered, assigned bus number 2 [4294670.777000] brcm-ehci-1 brcm-ehci-1.1: irq 57, io mem 0x10480500 [4294670.782000] brcm-ehci-1 brcm-ehci-1.1: USB 0.0 started, EHCI 1.00, driver 10 Dec 2004 [4294670.790000] usb usb2: configuration #1 chosen from 1 choice [4294670.795000] hub 2-0:1.0: USB hub found [4294670.798000] hub 2-0:1.0: 2 ports detected [4294670.902000] ohci_hcd_brcm_init: Initializing 2 OHCI controller(s) [4294670.908000] 2005 April 22 USB 1.1 'Open' Host Controller (OHCI) Driver (OHCI-brcm-0) [4294670.915000] drivers/usb/host/ohci-brcm.c: starting brcm OHCI USB Controller [4294670.921000] - Resetting at b0480408 [4294670.924000] <-- brcm_start_hc [4294670.926000] brcm-ohci-0 brcm-ohci-0.0: BRCM OHCI [4294670.930000] brcm-ohci-0 brcm-ohci-0.0: new USB bus registered, assigned bus number 3 [4294670.937000] brcm-ohci-0 brcm-ohci-0.0: irq 63, io mem 0x10480400 [4294670.966000] usb 1-1: new high speed USB device using brcm-ehci and address 2 [4294670.997000] usb usb3: configuration #1 chosen from 1 choice [4294671.003000] hub 3-0:1.0: USB hub found [4294671.006000] hub 3-0:1.0: 2 ports detected [4294671.087000] usb 1-1: configuration #1 chosen from 1 choice [4294671.093000] hub 1-1:1.0: USB hub found [4294671.096000] hub 1-1:1.0: 3 ports detected [4294671.110000] 2005 April 22 USB 1.1 'Open' Host Controller (OHCI) Driver (OHCI-brcm-1) [4294671.118000] drivers/usb/host/ohci-brcm.c: starting brcm OHCI USB Controller [4294671.124000] - Resetting at b0480608 [4294671.127000] <-- brcm_start_hc [4294671.129000] brcm-ohci-1 brcm-ohci-1.1: BRCM OHCI [4294671.133000] brcm-ohci-1 brcm-ohci-1.1: new USB bus registered, assigned bus number 4 [4294671.140000] brcm-ohci-1 brcm-ohci-1.1: irq 64, io mem 0x10480600 [4294671.200000] usb usb4: configuration #1 chosen from 1 choice [4294671.206000] hub 4-0:1.0: USB hub found [4294671.209000] hub 4-0:1.0: 2 ports detected [4294671.313000] Initializing USB Mass Storage driver... [4294671.415000] usb 1-2: new high speed USB device using brcm-ehci and address 3 [4294671.538000] usb 1-2: configuration #1 chosen from 1 choice [4294671.710000] usb 1-1.3: new high speed USB device using brcm-ehci and address 4 [4294671.794000] usb 1-1.3: configuration #1 chosen from 1 choice [4294671.800000] scsi2 : SCSI emulation for USB Mass Storage devices [4294671.806000] usbcore: registered new driver usb-storage [4294671.806000] USB Mass Storage support registered. [4294671.806000] i2c /dev entries driver [4294671.819000] TCP bic registered [4294671.823000] NET: Registered protocol family 1 [4294671.826000] NET: Registered protocol family 17 [4294673.430000] VFS: Mounted root (jffs2 filesystem). [4294673.435000] Freeing unused kernel memory: 136k freed INIT: version 2.86 booting [4294675.372000] stb_core: module license 'Proprietary' taints kernel. [4294675.514000] 4003185 ms: [4294675.563000] 46 ms: 27 Starting /etc/rcS.d/S02sysfs... [4294675.580000] 11 ms: =s Startting the hotplug events dispatcher Synthesizing the initial hotplug events Waiting for /dev to be fully populated udevd-event[109]: node_symlink: device node '/dev/dbox/lcd0' already exists, link to '/dev/dbox/oled0' will not overwrite it [4294676.820000] isa bounce pool size: 16 pages [4294676.825000] Vendor: Generic Model: USB SD Reader Rev: 1.00 [4294676.833000] Type: Direct-Access ANSI SCSI revision: 00 [4294676.845000] sd 2:0:0:0: Attached scsi removable disk sdb [4294676.851000] sd 2:0:0:0: Attached scsi generic sg1 type 0 [4294676.858000] Vendor: Generic Model: USB CF Reader Rev: 1.01 [4294676.866000] Type: Direct-Access ANSI SCSI revision: 00 [4294676.880000] sd 2:0:0:1: Attached scsi removable disk sdc [4294676.886000] sd 2:0:0:1: Attached scsi generic sg2 type 0 [4294676.894000] Vendor: Generic Model: USB SM Reader Rev: 1.02 [4294676.901000] Type: Direct-Access ANSI SCSI revision: 00 [4294676.916000] sd 2:0:0:2: Attached scsi removable disk sdd [4294676.922000] sd 2:0:0:2: Attached scsi generic sg3 type 0 [4294676.929000] Vendor: Generic Model: USB MS Reader Rev: 1.03 [4294676.936000] Type: Direct-Access ANSI SCSI revision: 00 [4294676.951000] sd 2:0:0:3: Attached scsi removable disk sde [4294676.957000] sd 2:0:0:3: Attached scsi generic sg4 type 0 [4294677.521000] ath_hal: 2008-08-15 (AR5210, AR5211, AR5212, AR5416, RF5111, RF5112, RF2413, RF5413, RF2133, RF2425, REGOPS_FUNC, DFS, XR) [4294677.812000] wlan: svn r3314 [4294678.077000] ath_pci: svn r3314 [4294678.080000] Atheros HAL provided by OpenWrt, DD-WRT and MakSat Technologies [4294678.672000] MadWifi: ath_getchannels: HAL returned 26 channels. [4294678.678000] MadWifi: ath_getchannels: Channel 1 (2412 MHz) Max Tx Power 16 dBm (hw limited) [16 hw 20 reg] Flags CF_CCK CF_2GHZ [4294678.690000] MadWifi: ath_getchannels: Channel 1 (2412 MHz) Max Tx Power 16 dBm (hw limited) [16 hw 20 reg] Flags CF_OFDM CF_2GHZ [4294678.702000] MadWifi: ath_getchannels: Channel 2 (2417 MHz) Max Tx Power 16 dBm (hw limited) [16 hw 20 reg] Flags CF_CCK CF_2GHZ [4294678.714000] MadWifi: ath_getchannels: Channel 2 (2417 MHz) Max Tx Power 16 dBm (hw limited) [16 hw 20 reg] Flags CF_OFDM CF_2GHZ [4294678.726000] MadWifi: ath_getchannels: Channel 3 (2422 MHz) Max Tx Power 16 dBm (hw limited) [16 hw 20 reg] Flags CF_CCK CF_2GHZ [4294678.738000] MadWifi: ath_getchannels: Channel 3 (2422 MHz) Max Tx Power 16 dBm (hw limited) [16 hw 20 reg] Flags CF_OFDM CF_2GHZ [4294678.750000] MadWifi: ath_getchannels: Channel 4 (2427 MHz) Max Tx Power 16 dBm (hw limited) [16 hw 20 reg] Flags CF_CCK CF_2GHZ [4294678.762000] MadWifi: ath_getchannels: Channel 4 (2427 MHz) Max Tx Power 16 dBm (hw limited) [16 hw 20 reg] Flags CF_OFDM CF_2GHZ [4294678.774000] MadWifi: ath_getchannels: Channel 5 (2432 MHz) Max Tx Power 16 dBm (hw limited) [16 hw 20 reg] Flags CF_CCK CF_2GHZ [4294678.786000] MadWifi: ath_getchannels: Channel 5 (2432 MHz) Max Tx Power 16 dBm (hw limited) [16 hw 20 reg] Flags CF_OFDM CF_2GHZ [4294678.798000] MadWifi: ath_getchannels: Channel 6 (2437 MHz) Max Tx Power 16 dBm (hw limited) [16 hw 20 reg] Flags CF_CCK CF_2GHZ [4294678.810000] MadWifi: ath_getchannels: Channel 6 (2437 MHz) Max Tx Power 16 dBm (hw limited) [16 hw 20 reg] Flags CF_OFDM CF_2GHZ [4294678.822000] MadWifi: ath_getchannels: Channel 7 (2442 MHz) Max Tx Power 16 dBm (hw limited) [16 hw 20 reg] Flags CF_CCK CF_2GHZ [4294678.834000] MadWifi: ath_getchannels: Channel 7 (2442 MHz) Max Tx Power 16 dBm (hw limited) [16 hw 20 reg] Flags CF_OFDM CF_2GHZ [4294678.846000] MadWifi: ath_getchannels: Channel 8 (2447 MHz) Max Tx Power 16 dBm (hw limited) [16 hw 20 reg] Flags CF_CCK CF_2GHZ [4294678.858000] MadWifi: ath_getchannels: Channel 8 (2447 MHz) Max Tx Power 16 dBm (hw limited) [16 hw 20 reg] Flags CF_OFDM CF_2GHZ [4294678.870000] MadWifi: ath_getchannels: Channel 9 (2452 MHz) Max Tx Power 16 dBm (hw limited) [16 hw 20 reg] Flags CF_CCK CF_2GHZ [4294678.881000] MadWifi: ath_getchannels: Channel 9 (2452 MHz) Max Tx Power 16 dBm (hw limited) [16 hw 20 reg] Flags CF_OFDM CF_2GHZ [4294678.893000] MadWifi: ath_getchannels: Channel 10 (2457 MHz) Max Tx Power 16 dBm (hw limited) [16 hw 20 reg] Flags CF_CCK CF_2GHZ [4294678.905000] MadWifi: ath_getchannels: Channel 10 (2457 MHz) Max Tx Power 16 dBm (hw limited) [16 hw 20 reg] Flags CF_OFDM CF_2GHZ [4294678.917000] MadWifi: ath_getchannels: Channel 11 (2462 MHz) Max Tx Power 16 dBm (hw limited) [16 hw 20 reg] Flags CF_CCK CF_2GHZ [4294678.929000] MadWifi: ath_getchannels: Channel 11 (2462 MHz) Max Tx Power 16 dBm (hw limited) [16 hw 20 reg] Flags CF_OFDM CF_2GHZ [4294678.941000] MadWifi: ath_getchannels: Channel 12 (2467 MHz) Max Tx Power 16 dBm (hw limited) [16 hw 20 reg] Flags CF_CCK CF_2GHZ [4294678.953000] MadWifi: ath_getchannels: Channel 12 (2467 MHz) Max Tx Power 16 dBm (hw limited) [16 hw 20 reg] Flags CF_OFDM CF_2GHZ [4294678.965000] MadWifi: ath_getchannels: Channel 13 (2472 MHz) Max Tx Power 16 dBm (hw limited) [16 hw 20 reg] Flags CF_CCK CF_2GHZ [4294678.977000] MadWifi: ath_getchannels: Channel 13 (2472 MHz) Max Tx Power 16 dBm (hw limited) [16 hw 20 reg] Flags CF_OFDM CF_2GHZ [4294678.989000] MadWifi: ath_attach: Switching rfkill capability off [4294678.997000] ==DriverVersion: v2.6.6.0.20101111== [4294679.002000] [4294679.002000] 8712_usb_endpoint_descriptor(0): [4294679.007000] bLength=7 [4294679.009000] bDescriptorType=5 [4294679.011000] bEndpointAddress=83 [4294679.013000] wMaxPacketSize=200 [4294679.016000] bInterval=0 [4294679.018000] [4294679.018000] 8712_usb_endpoint_descriptor(1): [4294679.023000] bLength=7 [4294679.025000] bDescriptorType=5 [4294679.027000] bEndpointAddress=4 [4294679.029000] wMaxPacketSize=200 [4294679.031000] bInterval=0 [4294679.033000] [4294679.033000] 8712_usb_endpoint_descriptor(2): [4294679.038000] bLength=7 [4294679.040000] bDescriptorType=5 [4294679.042000] bEndpointAddress=6 [4294679.045000] wMaxPacketSize=200 [4294679.047000] bInterval=0 [4294679.049000] [4294679.049000] 8712_usb_endpoint_descriptor(3): [4294679.054000] bLength=7 [4294679.056000] bDescriptorType=5 [4294679.058000] bEndpointAddress=d [4294679.060000] wMaxPacketSize=200 [4294679.062000] bInterval=0 [4294679.064000] [4294679.065000] 8712u : USB_SPEED_HIGH [4294679.069000] nr_endpoint=4 [4294679.073000] ath_rate_sample: 1.2 (svn r3314) [4294679.080000] MadWifi: ath_attach: Switching per-packet transmit power control off [4294679.089000] wifi0: 11b rates: 1Mbps 2Mbps 5.5Mbps 11Mbps [4294679.095000] wifi0: 11g rates: 1Mbps 2Mbps 5.5Mbps 11Mbps 6Mbps 9Mbps 12Mbps 18Mbps 24Mbps 36Mbps 48Mbps 54Mbps [4294679.105000] wifi0: H/W encryption support: WEP AES AES_CCM TKIP [4294679.112000] wifi0: ath_announce: Use hw queue 1 for WME_AC_BE traffic [4294679.119000] wifi0: ath_announce: Use hw queue 0 for WME_AC_BK traffic [4294679.125000] wifi0: ath_announce: Use hw queue 2 for WME_AC_VI traffic [4294679.132000] wifi0: ath_announce: Use hw queue 3 for WME_AC_VO traffic [4294679.139000] wifi0: ath_announce: Use hw queue 8 for CAB traffic [4294679.145000] wifi0: ath_announce: Use hw queue 9 for beacons [4294679.174000] Boot from EFUSE [4294679.177000] Autoload OK!! [4294679.201000] ath_pci: wifi0: Atheros 2413: mem=0xd1000000, irq=33 [4294680.241000] CustomerID = 0x 0 [4294680.245000] MAC Address from efuse= 0-c-f6-a4-ee-39 [4294680.250000] usbcore: registered new driver r871x_usb_drv done [4294680.388000] 4806 ms: 29 Starting /etc/rcS.d/S03udev... [4294680.407000] 14 ms: =s [4294680.425000] 16 ms: 31 Starting /etc/rcS.d/S04bootup... [4294680.437000] 6 ms: 10 [4294681.258000] kjournald starting. Commit interval 5 seconds [4294681.258000] EXT3-fs warning: maximal mount count reached, running e2fsck is recommended [4294681.262000] EXT3 FS on sda1, internal journal [4294681.262000] EXT3-fs: mounted filesystem with ordered data mode. [4294681.285000] 846 ms: 12 [4294681.307000] 20 ms: 14 tar: short read[4294681.325000] 16 ms: 15 /dev/sda: setting standby[4294681.393000] 65 ms: 16 to 120 (10 minutes) /dev/sda: setting acoustic management to 128 acoustic =[4294681.472000] 75 ms: 17 128 (128=quiet ... 254=fast) [4294681.505000] input: dreambox remote control (native) as /class/input/input0 [4294681.512000] input: dreambox advanced remote control (native) as /class/input/input1 [4294681.553000] input: dreambox ir keyboard as /class/input/input2 [4294681.560000] input: dreambox ir mouse as /class/input/input3 [4294682.051000] fpga init [4294684.829000] done OK 0 [4294687.681000] enter base init, xvd 20100413, vdc 20100413, rap 20090430, xpt 20100825 [4294687.689000] !!! kernMemSize: 154 MB [4294687.693000] smca set muxes [4294687.696000] smcb set muxes [4294687.698000] smcc set muxes [4294687.710000] 20:414016000 SMCA: controller reset timed out [4294687.724000] 20:428016000 SMCB: controller reset timed out [4294689.992000] maskffffffff [4294689.995000] using fpga version 2a [4294689.997000] tsmux set tsports reg 02 to val dc [4294690.001000] tsmux set tsports reg 02 to val dc [4294690.004000] tsmux set tsports reg 03 to val fe [4294690.008000] tsmux set tsports reg 03 to val fe [4294690.012000] tsmux set cisource reg 00 to val 55 [4294690.016000] tsmux set cisource reg 00 to val 55 [4294690.019000] tsmux set cisource reg 01 to val 55 [4294690.023000] tsmux set cisource reg 01 to val 55 [4294690.027000] register adapter [4294690.029000] register adapter [4294690.031000] register adapter [4294690.034000] register adapter [4294690.037000] register adapter [4294690.161000] FP Version 7 [4294690.172000] input: dreambox front panel as /class/input/input4 [4294690.231000] HDMI: device attached [4294690.262000] set sb to 3(2) [4294690.265000] set fb to 2(-1) [4294690.267000] set input to 0 [4294690.269000] set fb to 2(-1) [4294690.273000] bcm_video_analog_port_setup (fmt=7) [4294690.278000] SET FORMAT: display[1], format=7 [4294690.281000] display 0 uses vbi path 1 [4294690.284000] display 1 uses vbi path 0 [4294690.287000] HDMI: hotplug handler! [4294690.290000] Write AVS: 40 40 00 00 00 00 00 03 00 02 00 00 00 ff [4294690.300000] Write AVS: 40 40 00 00 00 00 18 63 00 02 00 00 00 ff [4294690.311000] set sb to 3(2) [4294690.314000] set sb to 3(2) [4294690.325000] using 50.00Hz as MonitorRefreshRate [4294690.329000] SET FORMAT: display[0], format=37 [4294690.333000] HDMI detected [4294690.335000] HDMI mode [4294690.336000] use EDID to detect colorspace [4294690.340000] using colorspace: 1 [4294690.414000] set fb to 2(0) [4294690.417000] bcm_video_analog_port_setup (fmt=7) [4294690.420000] SET FORMAT: display[1], format=7 [4294690.424000] disable wss on display 0 [4294690.427000] disable wss on display 1 [4294690.430000] bcmfb: creating surface with pixel format 0x07e48888 (BPXL_eA8_R8_G8_B8) udevd-event[496]: node_symlink: rename(/dev/fb.udev-tmp, /dev/fb) failed: Is a directory [4294690.576000] enable mad [4294690.636000] VIDEO0: set fallback framerate to 60000 [4294690.641000] VIDEO0: set progressive override mode to 1 [4294690.645000] VIDEO0: set streamtype! [4294690.648000] set MPEG2 [4294690.649000] sw rave disabled! [4294690.779000] enable mad [4294690.781000] VIDEO1: set fallback framerate to 60000 [4294690.786000] VIDEO1: set progressive override mode to 1 [4294690.790000] VIDEO1: set streamtype! [4294690.793000] set MPEG2 [4294690.794000] sw rave disabled! [4294690.800000] sync is off so we enable it [4294690.804000] playback! [4294690.806000] total video delay: 0 (0 ms) [4294690.809000] VIDEO0: start decode [4294690.813000] flush video decoder [4294690.815000] VIDEO0 got pts failed !!!! (ret 0) [4294691.266000] set ac3 to downmix [4294691.269000] set aac to downmix [4294691.299000] VIDEO0: first pts 0x0 [4294691.326000] init ALSA! [4294691.330000] DVB: registering new adapter (BCM7400) [4294691.439000] autodetecting NIMs... [4294691.443000] ret: 2, feid: 04 [4294691.446000] Found: Slot C, ID: 04 (by CA) [4294691.450000] ret: 2, feid: 01 [4294691.453000] Found: Slot D, ID: 01 (by CA) [4294691.457000] Initializing adapter 0 (BCM4501 (internal)-DVB-S2) [4294691.463000] bcm4501: found 4501, revision 2(c0) [4294691.468000] bcm_initAP [4294691.475000] BCM4501: upload & start firmware [4294691.487000] enable tsm0 [4294692.902000] 4501 uCode 0x65 [4294692.909000] DVB: registering adapter 0 frontend 0 (bcm4501)... [4294692.915000] Initializing adapter 1 (BCM4501 (internal)-DVB-S2) [4294692.921000] DVB: registering adapter 0 frontend 0 (bcm4501)... [4294692.927000] Initializing adapter 2 (Alps BSBE1 702A-DVB-S) [4294693.136000] DVB: registering adapter 0 frontend 0 (ST STV0299 DVB-S)... [4294693.143000] Initializing adapter 3 (Philips CU1216Mk3-DVB-C) [4294693.149000] DVB: registering adapter 0 frontend 0 (CU1216Mk3)... [4294693.155000] CI removed... [4294693.158000] CI removed... [4294693.161000] CI removed... [4294693.163000] registered vtuner vtuner0, minor 53 [4294693.168000] registered vtuner vtuner1, minor 52 [4294693.172000] CI removed... [4294694.158000] VIDEO0: stop decode [4294694.161000] no decoder left in sync handling so disable xpt_sync [4294694.175000] 12700 ms: 18 [4294694.268000] using 50.00Hz as MonitorRefreshRate [4294694.388000] SET FORMAT: display[0], format=27 [4294694.393000] HDMI detected [4294694.394000] HDMI mode [4294694.397000] use EDID to detect colorspace [4294694.400000] using colorspace: 1 [4294694.465000] bcm_video_analog_port_setup (fmt=7) [4294694.583000] SET FORMAT: display[1], format=7 [4294694.702000] set current avs auto aspect to 16:9 [4294694.707000] disable wss on display 0 [4294694.709000] disable wss on display 1 [4294694.712000] set sb to 3(1) [4294694.714000] Write AVS: 40 40540 ms: 19 [4294694.724000] 00 00 00 00 18 61 0012 ms: 20 [4294694.732000] 02 00 00 00 ff [4294694.764000] 33 ms: 21 [4294694.775000] 9 ms: 22 [4294694.777000] 0 ms: 23 [4294694.861000] VIDEO0: set blank to 0 [4294694.865000] sync is off so we enable it [4294694.869000] playback! [4294694.872000] total video delay: 0 (0 ms) [4294694.897000] VIDEO0: start decode [4294694.901000] flush video decoder [4294695.032000] VIDEO0: first pts 0x0 [4294695.035000] VIDEO0: framerate changed 3 [4294695.038000] VIDEO0: resolution changed (1280 720) [4294695.042000] VIDEO0: aspect changed 3 [4294695.045000] set current avs auto aspect to 16:9 [4294695.050000] disable wss on display 0 [4294695.053000] disable wss on display 1 [4294695.056000] set current avs auto aspect to 16:9 [4294695.060000] disable wss on display 0 [4294695.063000] disable wss on display 1 [4294695.067000] set sb to 3(1) [4294695.148000] VIDEO0: set blank to 0 [4294695.236000] enable tsm0 [4294695.253000] VIDEO0: stop decode [4294695.256000] VIDEO0: set blank to 0 [4294695.260000] no decoder left in sync handling so disable xpt_sync ldconfig: Can't open configuration file /etc/ld.so.conf: No such file or directory [4294704.095000] 9315 ms: 24 [4294704.114000] 16 ms: 25 [4294704.129000] 12 ms: =s Starting system message bus: dbus. [4294704.543000] 412 ms: 33 Starting /etc/rcS.d/S05dbus-1... [4294704.558000] 10 ms: =s [4294704.621000] 61 ms: 35 Starting /etc/rcS.d/S10tpmd... [4294704.645000] 19 ms: =s [4294704.725000] 78 ms: 37 Starting /etc/rcS.d/S20modutils.sh... [4294704.753000] 22 ms: =s * Starting Avahi mDNS/DNS-SD Daemon: avahi-daemon [ ok ] [4294705.331000] 575 ms: 39 Starting /etc/rcS.d/S21avahi-daemon... [4294705.348000] 11 ms: =s [4294705.397000] 47 ms: 41 Starting /etc/rcS.d/S38devpts.sh... [4294705.416000] 13 ms: =s Setting up IP spoofing protection: rp_filter. Configuring network interfaces... Error for wireless request "Set ESSID" (8B1A) : SET failed on device wlan0 ; Operation not [4294708.889000] 3470 ms: 43 Starting /etc/rcS.d/S40networking... permitted. done. INIT: Entering runlevel: 3 system message bus already started; not starting. Starting system message bus: /usr/bin/dbus-daemon is already running 590 Starting Dropbear SSH server: dropbear. Starting internet superserver: inetd. Starting syslogd/klogd: done * starting FTP Server: vsftpd... done. Starting automounter: done. * Starting Avahi mDNS/DNS-SD Daemon: avahi-daemon [ ok ] [4294711.126000] VIDEO0: set blank to 0 [4294711.132000] sync is off so we enable it [4294711.136000] playback! [4294711.138000] total video delay: 0 (0 ms) [4294711.143000] VIDEO0: start decode [4294711.147000] flush video decoder [4294711.188000] VIDEO0: first pts 0x0 Error : Temporary failure in name resolution 9 Mar 21:06:43 ntpdate[860]: can't find host de.pool.ntp.org 9 Mar 21:06:43 ntpdate[860]: no servers can be used, exiting [4294711.306000] VIDEO0: set blank to 0 [4294711.310000] VIDEO0: stop decode [4294711.313000] VIDEO0: set blank to 0 [4294711.316000] no decoder left in sync handling so disable xpt_sync setenv('prefix', '/usr', 0) setenv('exec_prefix', '/usr', 0) setenv('bindir', '/usr/bin', 0) setenv('sbindir', '/usr/sbin', 0) setenv('libexecdir', '/usr/libexec', 0) setenv('datarootdir', '${prefix}/share', 0) setenv('datadir', '/usr/share', 0) setenv('sysconfdir', '/etc', 0) setenv('sharedstatedir', '/com', 0) setenv('localstatedir', '/var', 0) setenv('libdir', '/usr/lib', 0) setenv('localedir', '${datarootdir}/locale', 0) setenv('prefix', '/usr', 1) setenv('exec_prefix', '/usr', 1) setenv('bindir', '/usr/bin', 1) setenv('sbindir', '/usr/sbin', 1) setenv('libexecdir', '/usr/libexec', 1) setenv('datarootdir', '/usr/share', 1) setenv('datadir', '/usr/share', 1) setenv('sysconfdir', '/etc', 1) setenv('sharedstatedir', '/com', 1) setenv('localstatedir', '/var', 1) setenv('libdir', '/usr/lib', 1) setenv('localedir', '/usr/share/locale', 1) resolve: resolve ${datadir}/enigma2/encoding.conf resolve: -> /usr/share/enigma2/encoding.conf resolve: resolve ${libdir}/enigma2/python resolve: -> /usr/lib/enigma2/python PYTHONPATH: /usr/lib/enigma2/python + (1) Background File Eraser + (8) graphics acceleration manager + (9) GFBDC [4294716.218000] bcmfb: enable manual blit 16384k video mem [4294716.254000] bcmfb: creating surface with pixel format 0x07e48888 (BPXL_eA8_R8_G8_B8) - double buffering available! 13144kB available for acceleration surfaces. resolution: 720 x 576 x 32 (stride: 2880) + (9) gLCDDC found OLED display! lcd buffer 0x6aec88 8448 bytes, stride 132 + (9) Font Render Class [FONT] initializing lib... [FONT] loading fonts... [FONT] Intializing font cache, using max. 4MB... + (10[4294716.480000] tsmux set cisource reg 00 to val 54 ) gRC RC thread created success[4294716.487000] tsmux set cisource reg 00 to val 44 fully + (15) eWindowStyleManage[4294716.494000] tsmux set cisource reg 01 to val 54 r + (20) DVB-CI UI + (20) UHF Modulator could[4294716.501000] tsmux set cisource reg 01 to val 44 nt open /dev/rfmod0!!!! + (20) [4294716.508000] tsmux set tsports reg 02 to val dc RC Input layer + (20) misc opti[4294716.514000] tsmux set tsports reg 02 to val dc ons + (20) AVSwitch Driver + (21) input device[4294716.522000] tsmux set tsports reg 03 to val fe driver Input device "dreambox [4294716.528000] tsmux set tsports reg 03 to val fe remote control (native)" is not a keyboard. Input device "dreambox advanced remote control (native)" is not a keyboard. Input device "dreambox ir keyboard" is a keyboard. Input device "dreambox ir mouse" is not a keyboard. Input device "dreambox front panel" is not a keyboard. Found 5 input devices! + (21) Console RC Driver + (30) eActionMap + (35) CI Slots scanning for common interfaces.. CI Slot 0 setSource(0) CI Slot 1 setSource(0) CI Slot 2 setSource(0) CI Slot 3 setSource(0) eDVBCIInterfaces->setInputSource(0, 0) eDVBCIInterfaces->setInputSource(1, 1) eDVBCIInterfaces->setInputSource(2, 2) eDVBCIInterfaces->setInputSource(3, 3) done, found 4 common interface slots + (40) eServiceCenter settings instance. + (41) eServiceFactoryM2TS + (41) eServiceFactoryMP3 + (41) eServiceFactoryFS + (41) eServiceFactoryDVB reached rl 70 resolve: resolve ${sysconfdir}/enigma2/lamedb resolve: -> /etc/enigma2/lamedb ---- opening lame channel db reading services (version 4) loaded 1862 services scanning f[4294716.883000] bcm4501 channel 0 is in normale mode now or frontends.. opening frontend 0 detected satellite frontend close frontend [4294716.893000] bcm4501 channel 1 is in normale mode now 0 opening frontend 1 detected satellite frontend close frontend 1 opening frontend 2 detected satellite frontend close frontend 2 opening frontend 3 [4294717.157000] tda: init complete detected cable frontend close frontend 3 found 1 adapter, 4 frontends(4 sim) and 5 demux, boxtype 4 Use valid Linux Time :) (RTC?) [EPGC] Initialized EPGCache (wait for setCacheFile call now) resolve: resolve ${datadir}/enigma2/skin_default/pal.png resolve: -> /usr/share/enigma2/skin_default/pal.png Loading spinners... resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait1.png resolve: -> /usr/share/enigma2/skin_default/spinner/wait1.png resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait2.png resolve: -> /usr/share/enigma2/skin_default/spinner/wait2.png resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait3.png resolve: -> /usr/share/enigma2/skin_default/spinner/wait3.png resolve: resolve ${datadir}/enigma2/skin_d[4294717.918000] 9022 ms: =s [efault/spinner/wait4.png resolve: -> /usr/share/enigma2/skin_default/spinner/wait4.png resolve: resolve ${datadir}/enigma2/skin_default/spinner/wait5.png resolve: -> /usr/share/enigma2/skin_default/spinner/wait5.png found 4 spinner! executing main setIoPrio best-effort level 3 ok resolve: resolve ${libdir}/enigma2/python/mytest.py resolve: -> /usr/lib/enigma2/python/mytest.py resolve: resolve ${sysconfdir}/ resolve: -> /etc/ resolve: resolve ${sysconfdir}/ resolve: -> /etc/ resolve: resolve ${datadir}/fonts/ resolve: -> /usr/share/fonts/ resolve: resolve ${sysconfdir}/enigma2/ resolve: -> /etc/enigma2/ resolve: resolve ${libdir}/enigma2/python/Plugins/ resolve: -> /usr/lib/enigma2/python/Plugins/ resolve: resolve ${datadir}/enigma2/po/ resolve: -> /usr/share/enigma2/po/ resolve: resolve ${datadir}/enigma2/ resolve: -> /usr/share/enigma2/ resolve: resolve ${datadir}/enigma2/ resolve: -> /usr/share/enigma2/ resolve: resolve ${sysconfdir}/enigma2/playlist/ resolve: -> /etc/enigma2/playlist/ resolve: resolve ${datadir}/enigma2/defaults/ resolve: -> /usr/share/enigma2/defaults/ resolve: resolve ${datadir}/enigma2/dealer resolve: -> /usr/share/enigma2/dealer resolve: resolve ${datadir}/meta resolve: -> /usr/share/meta resolve: resolve ${datadir}/enigma2/defaults/ resolve: -> /usr/share/enigma2/defaults/ main thread is non-idle! display spinner! /proc/stb/frontend/0/lnb_sense is 0 enumerating block devices... found block device 'sde': no medium found block device 'sdd': no medium found block device 'sdc': no medium found block device 'sdb': no medium found block device 'mtdblock6': blacklisted found block device 'mtdblock5': blacklisted found block device 'mtdblock4': blacklisted found block device 'mtdblock3': blacklisted found block device 'mtdblock2': blacklisted found block device 'mtdblock1': blacklisted found block device 'mtdblock0': blacklisted found block device 'sda': ok, removable=False, cdrom=False, partitions=['sda1'] new Harddisk sda -> /dev/sda -> /dev/sda [ePopen] command: ('hdparm', 'hdparm', '-S0', '/dev/sda') found block device 'sda1': error querying properties not loading user skin: [Errno 2] No such file or directory: '/etc/enigma2/skin_user.xml' main thread is non-idle! display spinner! Preferred tag editor set to None Reading satellites.xml Reading cables.xml couldn't open /etc/tuxbox/cables.xml!! resolve: resolve ${datadir}/enigma2/unicable.xml resolve: -> /usr/share/enigma2/unicable.xml removing internal link on frontend id 1 sec config cleared setSlotInfo for dvb frontend 0 to slotid 0, descr BCM4501 (internal), need rotorworkaround Yes, enabled Yes, DVB-S2 Yes setSlotInfo for dvb fro[4294723.050000] 1476 ms: 58 ntend 1 to slotid 1, descr BCM4501 (internal), need rotorworkaround Yes, enabled Yes, DVB-S2 Yes setSlotInfo for dvb frontend 2 to slotid 2, descr Alps BSBE1 702A, need rotorworkaround Yes, enabled Yes, DVB-S2 No setSlotInfo for dvb frontend 3 to slotid 3, descr Philips CU1216Mk3, need rotorworkaround No, enabled Yes, DVB-S2 No slot: 0 configmode:[4294723.081000] 28 ms: 60 simple diseqcmode: single sl[4294723.086000] 1 ms: 60 ot: 1 configmode: equal slot: 2[4294723.091000] 1 ms: 61 configmode: equal sec config completed [4294723.123000] 29 ms: 61 [4294723.158000] 32 ms: 61 resolve: resolve ${datadir}/enigma2/setup.xml resolve: -> /usr/share/enigma2/setup.xml [4294723.373000] 213 ms: 61 [4294723.377000] 1 ms: 61 [4294723.395000] 16 ms: 61 resolve: resolve ${sysconfdir}/enigma2/ resolve: -> /etc/enigma2/ loading bouquet... /etc/enigma2/bouquets.tv resolve: resolve ${sysconfdir}/enigma2/ resolve: -> /etc/enigma2/ loading bouquet... /etc/enigma2/userbouquet.hdtv__tv_.tv 28 entries in Bouquet userbouquet.hdtv__tv_.tv resolve: resolve ${sysconfdir}/enigma2/ resolve: -> /etc/enigma2/ loading bouquet... /etc/enigma2/userbouquet.dbe00.tv 13 entries in Bouquet userbouquet.dbe00.tv resolve: resolve ${sysconfdir}/enigma2/ resolve: -> /etc/enigma2/ loading bouquet... /etc/enigma2/userbou[4294723.447000] 49 ms: 61 quet.dbe01.tv 15 entries in Bouquet userbouquet.dbe01.tv resolve: resolve ${sysconfdir}/enigma2/ resolve: -> /etc/enigma2/ loading bouquet... /etc/enigma2/userbouquet.dbe12.tv 12 entries in Bouquet userbouquet.dbe12.tv resolve: resolve ${sysconfdir}/enigma2/ resolve: -> /etc/enigma2/ loading bouquet... /etc/enigma2/userbouquet.dbe0f.tv 7 entries in Bouquet userbouquet.dbe0[4294723.482000] 32 ms: 61 f.tv resolve: resolve ${sysconfdir}/enigma2/ resolve: -> /etc/enigma2/ loading bouquet... /etc/enigma2/userbouquet.dbe08.tv 10 entries in Bouquet userbouquet.dbe08.tv resolve: resolve ${sysconfdir}/enigma2/ resolve: -> /etc/enigma2/ loading bouquet... /etc/enigma2/userbouquet.dbe04.tv 12 entries in Bouquet userbouquet.dbe04.tv resolve: resolve ${sysconfdir}/enigma2/ resolve: -> /etc/enigma2/ loading bouquet... /etc/enigma2/userbouquet.dbe07.tv 14 entries in Bouquet userbouquet.dbe07.tv resolve: resolve ${sysconfdir}/enigma2/ resolve: -> /etc/enigma2/ loading bouquet... /etc/enigma2/userbouquet.dbe06.tv 8 entries in Bouquet userbouquet.dbe06.tv resolve: resolve ${sysconfdir}/enigma2/ resolve: -> /etc/enigma2/ loading bouquet... /etc/enigma2/userbouquet.dbe[4294723.551000] 66 ms: 61 05.tv 7 entries in Bouquet userbouquet.dbe05.tv resolve: resolve ${sysconfdir}/enigma2/ resol[4294723.561000] 6 ms: 62 ve: -> /etc/enigma2/ loading bouquet... /etc/en[4294723.567000] 2 ms: 62 igma2/userbouquet.dbe09.tv 20 entries in Bouquet userbouquet.dbe09.tv resolve: resolve ${sysconfdir}/enigma2/ [4294723.579000] 9 ms: 62 resolve: -> /etc/enigma2/ loading bouquet... /etc/enigma2/userbouquet.dbe0a.tv 12 entries in Bouquet userbouquet.dbe0a.tv resolve: resolve ${sysconfdir}/enigma2/ resolve: -> /etc/enigma2/ loading bouquet... /etc/enigma2/userbouquet.dbe0b.tv 12 entries in Bouquet userbouquet.dbe0b.tv resolve: resolve ${sysconfdir}/enigma2/ resolve: -> /etc/enigma2/ loading bouquet... /etc/enigma2/userbouquet.dbe0d.tv 14 entries in Bouquet userbouquet.dbe0d.tv resolve: resolve ${sysconfdir}/enigma2/ resolve: -> /etc/enigma2/ loading bouquet... /etc/enigma2/userbouquet.dbe0e.tv 21 entries in Bouquet userbouquet.dbe0e.tv resolve: resolve ${sysconfdir}/enigma2/ resolve: -> /etc/enigma2/ loading bouquet... /etc/enigma2/userbouquet.favourites.tv 0 entries in Bouquet userbouquet.favourites.tv 16 entries in Bouquet bouquets.tv resolve: resolve ${sysconfdir}/enigma2/ resolve: -> /etc/enigma2/ loading bouquet... /etc/enigma2/bouquets.radio resolve: resolve ${sysconfdir}/enigma2/ resolve: -> /etc/enigma2/ loading bouquet... /etc/enigma2/userbouquet.favourites.radio 26 entries in Bouquet userbouquet.favourites.radio 1 entries in Bouquet bouquets.radio [eDVBLocalTimeHandler] enable sync local time with transponder time! /usr/lib/python2.6/site-packages/twisted/internet/_sslverify.py:5: DeprecationWarning: the md5 module is deprecated; use hashlib instead import itertools, md5 [4294727.576000] 3995 ms: 62 [4294727.586000] 7 ms: 70 add dreampackage scanner plugin added [4294727.897000] 309 ms: 70 [4294727.901000] 1 ms: 71 [4294727.994000] 90 ms: 71 [4294728.000000] 3 ms: 71 [4294728.004000] 1 ms: 71 [4294728.014000] 8 ms: 71 [4294728.044000] 28 ms: 71 [4294728.069000] 22 ms: 71 [4294728.074000] 2 ms: 71 [FONT] adding font /usr/share/fonts/nmsbd.ttf...OK (Display) [4294728.294000] bcmfb: creating surface with pixel format 0x07e48888 (BPXL_eA8_R8_G8_B8) - double buffering available! 9184kB available for acceleration surfaces. resolution: 1280 x 720 x 32 (stride: 5120) [FONT] adding font /usr/share/fonts/nmsbd.ttf...OK (Regular) [FONT] adding font /usr/share/fonts/lcd.ttf...OK (LCD) [FONT] adding font /usr/share/fonts/ae_AlMateen.ttf...OK (Replacement) [FONT] adding font /usr/share/fonts/tuxtxt.ttf...OK (Console) [4294728.863000] 787 ms: 71 [iInputDevices] setRepeat for device event0 to 80 ms [iInputDevices] setDelay for device event0 to 800 ms [4294728.940000] 75 ms: 73 [4294728.966000] Write AVS: 40set current avs auto aspect to 16:9 [4294728.974000] disable wss on display 0 [4294728.976000] disable wss on display 1 [4294728.979000] 40 00 00 00 00 00 61 00 02 00 00 00 ff [4294728.989000] set sb to 3(1) [4294729.003000] set current avs auto aspect to 16:9 [4294729.007000] disable wss on display 0 [4294729.010000] disable wss on display 1 [4294729.013000] set sb to 3(1) [4294729.015000] disable wss on display 0 [4294729.019000] set wss 7 on display 1 [4294729.060000] set input to 0 [4294729.063000] set fb to 2(0) [4294729.066000] set current avs auto aspect to 16:9 [4294729.071000] disable wss on display 0 [4294729.075000] set wss 7 on display 1 [4294729.079000] set sb to 3(1) [4294729.085000] set ac3 to downmix --> setting scaler_sharpness to: 00000011 [4294729.119000] 176 ms: 74 [4294729.135000] 13 ms: 74 couldn't open /proc/stb/misc/12V_output resolve: resolve ${datadir}/enigma2/keymap.xml resolve: -> /usr/share/enigma2/keymap.xml [4294729.210000] 72 ms: 74 [4294729.504000] 291 ms: 74 [ePopen] command: ip -o addr [ePopen] command: ip -o addr [ePopen] command: ip -o addr [4294729.604000] 96 ms: 75 setLCDBrightness 25 setLCDBrightness 76 [4294729.657000] 51 ms: 75 resolve: resolve ${datadir}/keymaps/ resolve: -> /usr/share/keymaps/ resolve: resolve ${datadir}/keymaps/ resolve: -> /usr/share/keymaps/ resolve: resolve ${datadir}/keymaps/ resolve: -> /usr/share/keymaps/ Activating keymap: Dreambox Keyboard Deutsch resolve: resolve ${datadir}/keymaps/ resolve: -> /usr/share/keymaps/ [ePopen] command: loadkmap < /usr/share/keymaps/dream-de.kmap Activating language German language set to de_DE [4294731.130000] 1470 ms: 75 [4294731.148000] 15 ms: 79 [4294731.168000] 17 ms: 79 /usr/lib/python2.6/site-packages/twisted/python/filepath.py:12: DeprecationWarning: the sha module is deprecated; use the hashlib module instead import sha [WebInterface] set language to de [WebInterface] set language to de [WebInterface] fallback to default translation for Webinterface resolve: resolve ${libdir}/enigma2/python/Plugins/SystemPlugins/WirelessLan resolve: -> /usr/lib/enigma2/python/Plugins/SystemPlugins/WirelessLan 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, polic[4294736.770000] set current avs auto aspect to 16:9 y2, wss 16:9 let[4294736.775000] disable wss on display 0 terbox letterbox[4294736.780000] set wss 7 on display 1 auto [4294736.784000] set sb to 3(1) [4294736.787000] set current avs auto aspect to 16:9 [4294736.792000] disable wss on display 0 [4294736.795000] set wss 7 on display 1 [4294736.799000] set sb to 3(1) [4294736.804000] disable wss on display 0 [4294736.808000] set wss 7 on display 1 [4294736.812000] set current avs auto aspect to 16:9 [4294736.817000] disable wss on display 0 [4294736.820000] set wss 7 on display 1 [4294736.822000] set sb to 3(1) -> setting aspect, policy, polic[4294736.828000] set current avs auto aspect to 16:9 y2, wss 16:9 let[4294736.834000] disable wss on display 0 terbox letterbox[4294736.839000] set wss 7 on display 1 auto [4294736.844000] set sb to 3(1) [4294736.849000] set current avs auto aspect to 16:9 [4294736.854000] disable wss on display 0 [4294736.857000] set wss 7 on display 1 [4294736.859000] set sb to 3(1) [4294736.862000] disable wss on display 0 [4294736.866000] set wss 7 on display 1 [4294736.871000] set current avs auto aspect to 16:9 [4294736.876000] disable wss on display 0 [4294736.880000] set wss 7 on display 1 [4294736.883000] set sb to 3(1) -> setting aspect, policy, polic[4294736.890000] set current avs auto aspect to 16:9 y2, wss 16:9 let[4294736.896000] disable wss on display 0 terbox letterbox[4294736.900000] set wss 7 on display 1 auto [4294736.904000] set sb to 3(1) [4294736.907000] set current avs auto aspect to 16:9 [4294736.912000] disable wss on display 0 [4294736.916000] set wss 7 on display 1 [4294736.919000] set sb to 3(1) [4294736.923000] disable wss on display 0 [4294736.927000] set wss 7 on display 1 [4294736.931000] set current avs auto aspect to 16:9 [4294736.935000] disable wss on display 0 [4294736.938000] set wss 7 on display 1 [4294736.941000] set sb to 3(1) -> setting aspect, policy, polic[4294736.946000] set current avs auto aspect to 16:9 y2, wss 16:9 let[4294736.952000] disable wss on display 0 terbox letterbox[4294736.957000] set wss 7 on display 1 auto [4294736.962000] set sb to 3(1) [4294736.967000] set current avs auto aspect to 16:9 [4294736.972000] disable wss on display 0 [4294736.976000] set wss 7 on display 1 [4294736.979000] set sb to 3(1) [4294736.983000] disable wss on display 0 [4294736.987000] set wss 7 on display 1 [4294736.991000] set current avs auto aspect to 16:9 [4294736.995000] disable wss on display 0 [4294736.998000] set wss 7 on display 1 [4294737.001000] set sb to 3(1) setMode - port: DVI mode: 1080i[4294737.007000] set current avs auto aspect to 16:9 rate: 50Hz [4294737.012000] disable wss on display 0 [4294737.017000] set wss 7 on display 1 [4294737.021000] set sb to 3(1) [4294737.025000] set current avs auto aspect to 16:9 [4294737.030000] disable wss on display 0 [4294737.033000] set wss 7 on display 1 [4294737.035000] set sb to 3(1) -> setting aspect, policy, polic[4294737.042000] set current avs auto aspect to 16:9 y2, wss 16:9 let[4294737.048000] disable wss on display 0 terbox letterbox[4294737.053000] set wss 7 on display 1 auto [4294737.058000] set sb to 3(1) [4294737.063000] set current avs auto aspect to 16:9 [4294737.068000] disable wss on display 0 [4294737.071000] set wss 7 on display 1 [4294737.074000] set sb to 3(1) [4294737.076000] disable wss on display 0 [4294737.080000] set wss 7 on display 1 [4294737.085000] set current avs auto aspect to 16:9 [4294737.090000] disable wss on display 0 [4294737.093000] set wss 7 on display 1 [4294737.097000] set sb to 3(1) resolve: resolve ${datadir}/enigma2/ resolve: -> /usr/share/enigma2/ resolve: resolve ${sysconfdir}/enigma2/ resolve: -> /etc/enigma2/ resolve: resolve ${sysconfdir}/enigma2/ resolve: -> /etc/enigma2/ resolve: resolve ${sysconfdir}/enigma2/ resolve: -> /etc/enigma2/ --> setting contrast to: 00008000 --> setting saturation to: 00008000 --> setting hue to: 00008000 --> setting brightness to: 00008000 --> setting block_noise_reduction to: 00000000 --> setting mosquito_noise_reduction to: 00000000 --> setting digital_contour_removal to: 00000000 --> setting splitmode to: off --> setting sharpness to: 00004600 --> setting auto_flesh to: 00000000 --> setting green_boost to: 00000000 --> setting blue_boost to: 00000000 --> setting dynamic_contrast to: 00000000 --> applying pep values starting hotplug handler add device sde to bdpoll current state: medium removed add device sdd to bdpoll current s[4294738.164000] 6994 ms: 79 tate: medium removed add device sdc to bdpoll current state: medium removed add device sdb to bdpoll current state: medium removed It's now Wed Mar 9 21:07:09 2011 [timer.py] next activation: 1299701329 (in 99053 ms) [TIMER] record time changed, start prepare is now: Thu Mar 10 17:56:40 2011 sanitycheck check checkTimerlist recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 [Timer] Record ProcessRepeated localrepeatedbegindate: Thu Mar 10 17:57:00 2011 localbegin: Thu Mar 10 17:57:00 2011 localend: Thu Mar 10 18:55:00 2011 localnow: Wed Mar 9 21:07:10 2011 Day: 0 Day: 1 Day: 2 Day: 3 Day: 4 ProcessRepeated result Thu Mar 10 17:57:00 2011 Thu Mar 10 18:55:00 2011 It's now Wed Mar 9 21:07:09 2011 next real activation is Thu Mar 10 17:56:40 2011 [timer.py] next activation: 1299701329 (in 99003 ms) [TIMER] record time changed, start prepare is now: Mon Mar 14 20:59:40 2011 sanitycheck check checkTimerlist recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:1:132F:3EF:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:1:132F:3EF:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 [Timer] Record ProcessRepeated localrepeatedbegindate: Mon Mar 14 21:00:00 2011 localbegin: Mon Mar 14 21:00:00 2011 localend: Mon Mar 14 22:00:00 2011 localnow: Wed Mar 9 21:07:11 2011 Day: 0 ProcessRepeated result Mon Mar 14 21:00:00 2011 Mon Mar 14 22:00:00 2011 It's now Wed Mar 9 21:07:10 2011 next real activation is Thu Mar 10 17:56:40 2011 [timer.py] next activation: 1299701330 (in 99951 ms) [TIMER] record time changed, start prepare is now: Wed Mar 2 20:12:40 2011 sanitycheck check checkTimerlist recording service: 1:0:19:EF75:3F9:1:C00000:0:0:0: record: 0 [Timer] Record ProcessRepeated already passed, skipping shouldSkip: True state == ended False waiting && disabled: 0 [TIMER] record time changed, start prepare is now: Thu Mar 3 20:12:40 2011 sanitycheck check checkTimerlist recording service: 1:0:19:EF75:3F9:1:C00000:0:0:0: record: 0 [Timer] Record ProcessRepeated already passed, skipping shouldSkip: True state == ended False waiting && disabled: 0 [TIMER] record time changed, start prepare is now: Tue Mar 8 13:53:40 2011 sanitycheck check checkTimerlist recording service: 1:0:19:EF15:421:1:C00000:0:0:0: record: 0 [Timer] Record ProcessRepeated already passed, skipping shouldSkip: True state == ended False waiting && disabled: 0 [TIMER] record time changed, start prepare is now: Tue Mar 8 13:23:40 2011 sanitycheck check checkTimerlist recording service: 1:0:19:EF15:421:1:C00000:0:0:0: record: 0 [Timer] Record ProcessRepeated already passed, skipping shouldSkip: True state == ended False waiting && disabled: 0 [TIMER] record time changed, start prepare is now: Tue Mar 8 23:59:40 2011 sanitycheck check checkTimerlist recording service: 1:0:1:14B:11:85:C00000:12:4:0::Option 1 record: 0 [Timer] Record ProcessRepeated already passed, skipping shouldSkip: True state == ended False waiting && disabled: 0 [TIMER] record time changed, start prepare is now: Thu Mar 10 17:56:40 2011 sanitycheck check checkTimerlist recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:1:132F:3EF:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:1:132F:3EF:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 [Timer] Record ProcessRepeated localrepeatedbegindate: Thu Mar 10 17:57:00 2011 localbegin: Thu Mar 10 17:57:00 2011 localend: Thu Mar 10 18:55:00 2011 localnow: Wed Mar 9 21:07:11 2011 Day: 0 Day: 1 Day: 2 Day: 3 Day: 4 ProcessRepeated result Thu Mar 10 17:57:00 2011 Thu Mar 10 18:55:00 2011 already passed, skipping shouldSkip: False state == ended False waiting && disabled: 1 [TIMER] record time changed, start prepare is now: Thu Mar 10 19:58:40 2011 sanitycheck check checkTimerlist recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:1:132F:3EF:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:1:132F:3EF:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 recording service: 1:0:19:2B5C:3F3:1:C00000:0:0:0: record: 0 [Timer] Record ProcessRepeated localrepeatedbegindate: Thu Mar 10 19:59:00 2011 localbegin: Thu Mar 10 19:59:00 2011 localend: Thu Mar 10 20:17:00 2011 localnow: Wed Mar 9 21:07:11 2011 Day: 0 Day: 1 Day: 2 Day: 3 Day: 4 Day: 5 Day: 6 ProcessRepeated result Thu Mar 10 19:59:00 2011 Thu Mar 10 20:17:00 2011 already passed, skipping shouldSkip: False state == ended False waiting && disabled: 1 It's now Wed Mar 9 21:07:10 2011 [timer.py] next activation: 1299701330 (in 99756 ms) Looking for embedded skin [Toplevel.importExternalModules] Could NOT import external module: AutoTimer [Toplevel.importExternalModules] Exception Caught No module named AutoTimer.AutoTimerResource [Toplevel.importExternalModules] Could NOT import external module: EPGRefresh [Toplevel.importExternalModules] Exception Caught No module named EPGRefresh.EPGRefreshResource [Toplevel.importExternalModules] Imported external module: Example [Webinterface] started on 0.0.0.0:80 auth=False ssl=False [WebI[4294739.104000] 936 ms: 94 nterface.registerBonjourService] No module named Bonjour.Bonjour [WebInterface.unregisterBonjourService] No module named Bonjour.Bonjour [EPGC] setCacheFile read/write epg data from/to '/hdd/epg.dat' [EPGC] time updated.. start EPG Mainloop before: 1 after: 1 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! RemovePopup, id = ZapError allocating new converter! allocating new converter! resolve: resolve ${datadir}/enigma2/%s/ resolve: -> /usr/share/enigma2/%s/ allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! reused converter! allocating new converter! allocating new converter! allocating new converter! allocating new converter! reused converter! reused converter! allocating new converter! allocating new converter! allocating new converter! [4294740.215000] 1108 ms: 96 setValue 45 [4294740.328000] set mute 0 (000) 1 cannot open /proc/stb/audio/j1_m[4294740.334000] 116 ms: 99 ute(No such file or directory) Setvolume: 100 100 (raw) Setvolume: 0 0 (-1db) Setvolume: 45 45 (raw) Setvolume: 35 35 (-1db) [4294740.353000] 16 ms: 99 playing 1:0:1:2EE3:441:1:C00000:0:0:0: [EPGC] 24665 events read from /hdd/epg.dat not pauseable. RemovePopup, id = ZapError allo[4294741.453000] stv0299 standby reg verify failed! cate channel.. 0441:0001 opening frontend 2 [eDVBCAService] new channel 0x180dd00! (2)tune prepare_sat System 0 Freq 12187500 Pol 0 SR 27500000 INV 2 FEC 3 orbpos 192 system 0 modulation 1 pilot 2, rolloff 0 tuning to 1587 mhz OURSTATE: tuning allocate Channel: res 0 [eDVBCIInterfaces] addPMTHandler 1:0:1:2EE3:441:1:C00000:0:0:0: allocate demux resolve: resolve ${sysconfdir}/scan_tp_valid_check.py resolve: -> /etc/scan_tp_valid_check.py nr_read 215 nr_write 1 sum 216 prev_sum 0 hdd was accessed since previous check! [IDLE] 0 120 False [SEC] set static current limiting [SEC] invalidate current switch params [SEC] setVoltage 2 [SEC] sleep 10ms child has terminated pipes closed child has terminated pipes closed [ePopen] command: route -n | grep eth0 child has terminated pipes closed [ePopen] command: route -n | grep ath0 child has terminated pipes closed [ePopen] command: route -n | grep wlan0 poll: unhandled POLLERR/HUP/NVAL for fd 32(16) child has terminated pipes closed poll: unhandled POLLERR/HUP/NVAL for fd 37(16) poll: unhandled POLLERR/HUP/NVAL for fd 38(16) poll: unhandled POLLERR/HUP/NVAL for fd 41(16) poll: unhandled POLLERR/HUP/NVAL for fd 43(16) [SEC] setTone 1 [SEC] sleep 10ms child has terminated pipes closed poll: unhandled POLLERR/HUP/NVAL for fd 42(16) [SEC] update current switch params [SEC] startTuneTimeout 5000 [SEC] setFronte[4294741.865000] tuner freq is 1587500 nd 1 setting fr[4294741.869000] symbolrate is 27500000 ontend 2 [SEC] [4294741.873000] inversion is OFF sleep 500ms (2)fe event: status 0, inversion off, m_tuning 1 child has terminated pipes closed child has terminated pipes closed nameservers: [[192, 168, 123, 1]] read configured interface: {'lo': {'dhcp': False}, 'ath0': {'dhcp': False, 'netmask': [255, 255, 255, 0], 'gateway': [192, 168, 123, 1], 'address': [192, 168, 123, 12]}, 'wlan0': {'dhcp': False}, 'eth0': {'dhcp': Fals[4294741.954000] start pcr0 on dmx 0 pid:a3 index 5 e}} self.ifaces[4294741.961000] start audio on dmx 0 pid:68 after loading: [4294741.965000] audio xpt start {'ath0': {'preup[4294741.970000] sync is off so we enable it ': '\tpre-up /us[4294741.975000] demux-index 0 pcr0pid a3 r/sbin/wpa_suppl[4294741.980000] using 5 as pcr0 pidchannel icant -iath0 -c/etc/wpa_supplica[4294741.987000] MPEG nt.conf -B -dd -[4294741.990000] audio: streamtype set 0 Dmadwifi\n', 'ip[4294741.995000] audio: streamtype_set: stop rave ': [192, 168, 123, 12], 'up': False, 'netmask': [255, 255, 255, 0], 'dhcp': False, 'gateway': [192, 168, 123, 1], 'postdown': '\tpost-down wpa_cli terminate\n'}[4294742.015000] audio: streamtype_set: restart rave , 'wlan0': {'pre[4294742.020000] set mute 0 (111) 1 up': '\tpre-up /[4294742.025000] audio: decoder start 2 usr/sbin/wpa_supplicant -iwlan0 -c/etc/wpa_supplicant.conf -B -dd -Dwext\n', 'ip': [192, 168, 123, 12], 'up': False, 'netmask': [255, 255, 255, 0], 'dhcp': False, 'gateway': [1[4294742.045000] video delay 0 (0 ms) 92, 168, 123, 1][4294742.048000] total video delay: 0 (0 ms) [4294742.053000] ch0: lock , 'postdown': '\tpost-down wpa_c[4294742.058000] start video0 on dmx 0 pid:a3 li terminate\n'}[4294742.063000] total video delay: 0 (0 ms) , 'eth0': {'preu[4294742.070000] VIDEO0: start decode p': False, 'ip': [192, 168, 123, 11], 'up': False, 'mac': '00:09:34:1c:10:c5', 'dhcp': False, 'netmask': [255, 255, 255, 0], 'gateway': [192, 168, 123, 1], 'postdown': False}} poll: unhandled POLLERR/HUP/NVAL for fd 40(16) poll: unhandled POLLERR/HUP/NVAL for fd 43(16) (2)fe event: status 1f, inversion off, m_tuning 2 OURSTATE: ok [eDVBCAService] channel 0x180dd00 running [eDVBLocalTimerHandler] channel 0x180dd00 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 0x180dd00 running stop release channel timer no version filtering 001[4294742.125000] RAP first pts 0x65e7517e, stc 0x65e73658, pcr valid 2: 4e 2e e3 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 ok ... now we start!! no version filtering 0000: 00 00 00 00 00 00 mask: ff 00 00 00 00 00 mode: 00 00 00 00 00 00 eventNewProgramInfo 0 0 have 1 video stream(s) (00a3), and 1 audio stream(s) (0068), and the pcr pid is 00a3, and the text pid is 0069 allocate demux disable teletext subtitles decoder state: play, vpid=163, apid=104 DMX_SET_PES_FILTER(0xa3) - pcr - ok DEMUX_START - pcr - ok DMX_SET_PES_FILTER(0x68) - audio - ok DEMUX_START - audio - ok AUDIO_SET_BYPASS(1) - ok AUDIO_PAUSE - ok AUDIO_PLAY - ok Video Device: /dev/dvb/adapter0/video0 demux device: /dev/dvb/adapter0/demux0 VIDEO_SET_STREAMTYPE 0 - ok DMX_SET_PES_FILTER(0xa3) - video - ok DEMUX_START - video - ok VIDEO_FREEZE - ok VIDEO_PLAY - ok DMX_SET_PES_FILTER(0x69) - 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. VIDEO_GET_EVENT - ok VIDEO_GET_EVENT - ok [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 2188943 bytes for cache used [EPGC] next update in 2 sec + 1/1 TID 00 done! PATready use pmtpid 002c for service_id 2ee3 no version filtering 002c: 02 2e e3 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 doing version filtering 0000: 00 00 00 0d 00 00 mask: ff 00 00 3f 00 00 mode: 00 00 00 3e 00 00 [SEC] set dynamic current limiting + 1/1 TID 02 done! eventNewProgramInfo 0 0 have 1 [4294742.439000] VIDEO0: first pts 0x65e82f6a [4294742.444000] VIDEO0: resolution changed (720 576) [4294742.448000] RAP sampling rate info isr [4294742.451000] eBitRateChange Isr.. set source_changed_event! [4294742.456000] eModeChange Isr.. set source_changed_event! video stream(s) (00a3), and 2 audio stream(s) (0068, 006a), and the pcr pid is 00a3, and the text pid is 0069 decoder state: play, vpid=163, apid=104 [eDVBCAService] new service 1:0:1:2EE3:441:1:C00000:0:0:0: [eDVBCAService] add demux 0 to slot 0 service 1:0:1:2EE3:441:1:C00000:0:0:0: [eDVBCIInterfaces] gotPMT demux 0 mask 01 prevhash 00000000 doing version filtering 002c: 02 2e e3 03 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 VIDEO_GET_EVENT - ok [4294742.611000] enable tsm0 +- 1/2 TID 4e [4294743.074000] VIDEO0: progressive changed (0) VIDEO_GET_EVENT - ok sdt update done! ++ 2/2 TID 4e done! doing version filtering 0012: 4e 2e e3 23 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 [EPGC] start caching events(1299701235) [EPGC] abort non avail schedule other reading [EPGC] abort non avail viasat reading [EPGC] nownext finished(1299701242) [eDVBLocalTimerHandler] diff is 1 [eDVBLocalTimerHandler] diff < 120 .. use Transponder Time [eDVBLocalTimerHandler] update RTC [eDVBLocalTimerHandler] time update to 21:07:25 [eDVBLocalTimerHandler] m_time_difference is 1 [eDVBLocalTimerHandler] set Linux Time [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 2188943 bytes for cache used nr_read 301 nr_write 10 sum 311 prev_sum 216 hdd was accessed since previous check! [IDLE] 0 120 False [EPGC] schedule finished(1299701252) [EPGC] stop caching events(1299701252) [EPGC] next update in 60 min no ancillary data in audio stream... abort radiotext pes parser action -> InfobarMenuActions mainMenu loading mainmenu XML... TimerEdit TimerEditList PluginBrowser PluginBrowser allocating new converter! allocating new converter! nr_read 301 nr_write 10 sum 311 prev_sum 311 hdd IDLE! [IDLE] 11.967799902 120 False action -> OkCancelActions ok okbuttonClick Ci CiSelection ParentalControlSetup ParentalControlSetup allocating new converter! allocating new converter! action -> OkCancelActions ok okbuttonClick LanguageSelection LanguageSelection NetworkSetup NetworkAdapterSelection InputDeviceSetup InputDeviceSelection RecordPaths RecordPathsSettings allocating new converter! allocating new converter! action -> OkCancelActions ok okbuttonClick allocating new converter! action -> OkCancelActions ok [ePopen] command: iwconfig wlan0 child has terminated pipes closed self.wlaniface after loading: {'wlan0': {'acesspoint': 'Not-Associated Sensitivity:0/0', 'quality': '0 ', 'signal': '0', 'frequency': False, 'essid': False, 'encryption': 'Nicht unterst\xc3\xbctzt', 'bitrate': False}} [ePopen] command: ping -c 1 82.149.226.170 [ePopen] command: ping -c 1 193.99.144.85 [ePopen] command: ping -c 1 209.85.135.103 poll: unhandled POLLERR/HUP/NVAL for fd 54(16) child has terminated pipes closed poll: unhandled POLLERR/HUP/NVAL for fd 57(17) child has terminated pipes closed poll: unhandled POLLERR/HUP/NVAL for fd 60(16) child has terminated pipes closed poll: unhandled POLLERR/HUP/NVAL for fd 54(16) action -> WizardActions ok killing self.WlanConsole [4294773.637000] 1 RCR=0x153f00e [4294773.640000] 2 RCR=0x553f00e [4294773.647000] MAC Address= 0-c-f6-a4-ee-39 [4294773.651000] fwdbg:RTL8712 FW version 0.0.1# 三 8月 11 20:37:05 CST 2010 SVN [4294773.659000] fwdbg:Chip Version:00000002 [4294773.662000] fwdbg:HCI type: 00000012(00000004) [4294773.662000] [4294773.668000] fwdbg:rf_cofig: 00000012(000000ff, 00000000, 00000000) [4294773.668000] [4294773.675000] fwdbg:mp_mode: 00000000(00000001), IQK: 403f0101 [4294773.675000] [4294773.682000] fwdbg:vcs type: 00000002(00000001) [4294773.682000] [4294773.688000] fwdbg:32k calibra: 743, 32K TSF: 0000002c [4294773.692000] fwdbg:target thermal: 00000015, bt_coexist: 00000000 [4294773.692000] [4294773.699000] fwdbg:->(00000001, 00000001, 00000001, 00000000) [4294773.699000] [4294773.793000] fwdbg:get survey cmd [4294773.793000] main thread is non-idle! display spinner! [4294775.448000] fwdbg:survey done(0000000e, 00000000) [4294775.448000] wpa_ie=dd180050f20101000050f20201000050f20201000050f2020000 rsn_ie=30140100000fac020100000fac040100000fac020000 wpa_ie=dd1a0050f20101000050f20202000050f2020050f20401000050f202 rsn_ie=30180100000fac020200000fac02000fac040100000fac020000 wpa_ie=dd180050f20101000050f20201000050f20201000050f2020000 rsn_ie=30140100000fac020100000fac040100000fac020000 wpa_ie=dd160050f20101000050f20201000050f20201000050f202 rsn_ie=30140100000fac020100000fac040100000fac020100 wpa_ie=dd160050f20101000050f20201000050f20201000050f202 wpa_ie=dd1a0050f20101000050f20202000050f2020050f20401000050f202 rsn_ie=30180100000fac020200000fac02000fac040100000fac020000 rsn_ie=30140100000fac040100000fac040100000fac020000 wpa_ie=dd160050f20101000050f20201000050f20201000050f202 rsn_ie=30140100000fac020100000fac040100000fac020000 wpa_ie=dd1a0050f20101000050f20202000050f2020050f20401000050f202 rsn_ie=30180100000fac020200000fac02000fac040100000fac020100 rsn_ie=30140100000fac040100000fac040100000fac020000 wpa_ie=dd180050f20101000050f20201000050f20201000050f2020000 rsn_ie=30140100000fac020100000fac040100000fac020000 wpa_ie=dd180050f20101000050f20201000050f20201000050f2020000 rsn_ie=30140100000fac020100000fac040100000fac020000 [Wlan.py] Got Hidden SSID Scan Value 1 [Wlan.py] Got SSID SSIDX1 [Wlan.py] Got Encryption: WPA2 [Wlan.py] WS-CONFIG--> {'ssid': 'SSIDX1', 'encryption_wepkeytype': 'ASCII', 'encryption': True, 'key': 'xxxx', 'encryption_type': 'WPA2', 'hiddenessid': 'SSIDX1'} ERROR reading PES (fd=36) - Value too large for defined data type poll: unhandled POLLERR/HUP/NVAL for fd 36(8) action -> SetupActions right unknown action SetupActions/right! typo in keymap? action -> SetupActions right nr_read 301 nr_write 10 sum 311 prev_sum 311 hdd IDLE! [IDLE] 23.9676671028 120 False action -> SetupActions ok action -> MsgBoxActions ok setting for adapter wlan0 attribute up to value True setting for adapter wlan0 attribute dhcp to value False setting for adapter wlan0 attribute ip to value [192, 168, 123, 12] setting for adapter wlan0 attribute netmask to value [255, 255, 255, 0] setting for adapter wlan0 attribute gateway to value [192, 168, 123, 1] Using "wext" as wpa-supplicant driver setting for adapter wlan0 attribute configStrings to value pre-up iwconfig wlan0 essid "SSIDX1" pre-up /usr/sbin/wpa_supplicant -iwlan0 -c/etc/wpa_supplicant.conf -B -dd -Dwext post-down wpa_cli terminate #WPA Supplicant Configuration by enigma2 ctrl_interface=/var/run/wpa_supplicant eapol_version=1 fast_reauth=1 ap_scan=1 network={ ssid="SSIDX1" scan_ssid=0 key_mgmt=WPA-PSK proto=WPA RSN pairwise=CCMP TKIP group=CCMP TKIP psk="xxxx" } (192, 168, 123, 12) (192, 168, 123, 12) (192, 168, 123, 11) [ePopen] command: /etc/init.d/avahi-daemon stop child has terminated pipes closed [eBatch] retval=0, cmds left=8, data: * Stopping Avahi mDNS/DNS-SD Daemon: avahi-daemon [ ok ] [ePopen] command: ip addr flush ath0 poll: unhandled POLLERR/HUP/NVAL for fd 55(16) child has terminated pipes closed [eBatch] retval=0, cmds left=7, data: [ePopen] command: ip addr flush wlan0 poll: unhandled POLLERR/HUP/NVAL for fd 55(16) child has terminated pipes closed [eBatch] retval=0, cmds left=6, data: [ePopen] command: ip addr flush eth0 poll: unhandled POLLERR/HUP/NVAL for fd 55(16) child has terminated pipes closed [eBatch] retval=0, cmds left=5, data: [ePopen] command: /etc/init.d/networking stop poll: unhandled POLLERR/HUP/NVAL for fd 55(16) [4294780.935000] (2)871x_drv - drv_close, bup=1, hw_init_completed=1 [4294780.941000] -871x_drv - drv_close, bup=1 child has terminated pipes closed [eBatch] retval=0, cmds left=4, data: Deconfiguring network interfaces... Unmounting remote filesystems... Unmounting other remote filesystems... killall: smbd: no process killed killall: nmbd: no process killed Unmounting remote filesystems... Unmounting other remote filesystems... Failed to connect to wpa_supplicant - wpa_ctrl_open: No such file or directory done. [ePopen] command: killall -9 udhcpc poll: unhandled POLLERR/HUP/NVAL for fd 55(16) child has terminated pipes closed [eBatch] retval=1, cmds left=3, data: killall: udhcpc: no process killed [ePopen] command: rm /var/run/udhcpc* poll: unhandled POLLERR/HUP/NVAL for fd 55(16) child has terminated pipes closed [eBatch] retval=1, cmds left=2, data: rm: cannot remove '/var/run/udhcpc*': No such file or directory [ePopen] command: /etc/init.d/networking start poll: unhandled POLLERR/HUP/NVAL for fd 55(16) [4294781.570000] fwdbg:setAuth: 00000000 [4294781.570000] [4294781.576000] fwdbg:get join cmd [4294781.576000] [4294781.901000] fwdbg:cur channel: 00000008, bcn interval: 00000064 [4294781.901000] [4294781.970000] fwdbg:link to Atheros AP [4294781.970000] [4294781.975000] fwdbg:issue auth [4294781.975000] [4294781.979000] fwdbg:issue assocreq(00000031) [4294781.979000] [4294781.985000] fwdbg:mac id #5: 00000053, 00000fff, 00000000 [4294781.985000] [4294781.992000] fwdbg:join res(00000002, 000001a5) [4294781.992000] [4294782.063000] fwdbg:->(00000001, 00000001, 00000001, 00000000) [4294782.063000] [4294783.173000] r871x_wx_set_pmkid: IW_PMKSA_FLUSH! [4294783.177000] set_mode = IW_MODE_INFRA [4294783.180000] fwdbg:set opmode: 00000000 [4294783.180000] [4294783.191000] r871x_wx_set_pmkid: IW_PMKSA_FLUSH! [4294783.300000] set_mode = IW_MODE_INFRA [4294783.304000] fwdbg:set opmode: 00000000 [4294783.304000] [4294783.310000] [4294783.310000] wpa_ie(length:22): [4294783.315000] 0x30 0x14 0x01 0x00 0x00 0x0f 0xac 0x04 [4294783.319000] 0x01 0x00 0x00 0x0f 0xac 0x04 0x01 0x00 [4294783.325000] 0x00 0x0f 0xac 0x02 0x00 0x00 0xc0 0x83 [4294783.329000] +r8711_wx_set_freq f=98f c=7 wrqu->e=0 wrqu->m=8 [4294783.335000] fwdbg:setAuth: 00000002 [4294783.335000] [4294783.340000] fwdbg:issue_deauth [4294783.340000] [4294783.349000] fwdbg:get join cmd [4294783.349000] [4294783.674000] fwdbg:cur channel: 00000008, bcn interval: 00000064 [4294783.674000] [4294783.688000] fwdbg:link to Atheros AP [4294783.688000] [4294783.694000] fwdbg:issue auth [4294783.694000] [4294783.698000] fwdbg:issue assocreq(00000047) [4294783.698000] [4294783.704000] fwdbg:mac id #5: 0000005b, 100fffff, 00000007 [4294783.704000] [4294783.710000] fwdbg:join res(00000002, 000001a5) [4294783.710000] child has terminated pipes closed [eBatch] retval=0, cmds left=1, data: Setting up IP spoofing protection: rp_filter. Configuring network interfaces... done. [ePopen] command: /etc/init.d/avahi-daemon start poll: unhandled POLLERR/HUP/NVAL for fd 55(16) child has terminated pipes closed [eBatch] retval=0, cmds left=0, data: * Starting Avahi mDNS/DNS-SD Daemon: avahi-daemon [ ok ] [ePopen] command: ip -o addr [ePopen] command: ip -o addr [ePopen] command: ip -o addr poll: unhandled POLLERR/HUP/NVAL for fd 55(16) child has terminated pipes closed [ePopen] command: route -n | grep eth0 poll: unhandled POLLERR/HUP/NVAL for fd 55(16) child has terminated pipes closed [ePopen] command: route -n | grep ath0 poll: unhandled POLLERR/HUP/NVAL for fd 58(16) child has terminated pipes closed [ePopen] command: route -n | grep wlan0 poll: unhandled POLLERR/HUP/NVAL for fd 61(16) child has terminated pipes closed poll: unhandled POLLERR/HUP/NVAL for fd 58(16) child has terminated pipes closed poll: unhandled POLLERR/HUP/NVAL for fd 59(16) child has terminated pipes closed 192.168 169.254 0.0.0.0 nameservers: [[192, 168, 123, 1]] read configured interface: {'lo': {'dhcp': False}, 'ath0': {'dhcp': False}, 'wlan0': {'dhcp': False, 'netmask': [255, 255, 255, 0], 'gateway': [192, 168, 123, 1], 'address': [192, 168, 123, 12]}, 'eth0': {'dhcp': False}} self.ifaces after loading: {'ath0': {'preup': '\tpre-up /usr/sbin/wpa_supplicant -iath0 -c/etc/wpa_supplicant.conf -B -dd -Dmadwifi\n', 'ip': [192, 168, 123, 12], 'up': False, 'netmask': [255, 255, 255, 0], 'dhcp': False, 'gateway': [192, 168, 123, 1], 'postdown': '\tpost-down wpa_cli terminate\n'}, 'wlan0': {'preup': '\tpre-up /usr/sbin/wpa_supplicant -iwlan0 -c/etc/wpa_supplicant.conf -B -dd -Dwext\n', 'ip': [192, 168, 123, 12], 'up': True, 'netmask': [255, 255, 255, 0], 'dhcp': False, 'gateway': [192, 168, 123, 1], 'postdown': '\tpost-down wpa_cli terminate\n'}, 'eth0': {'preup': False, 'ip': [192, 168, 123, 11], 'up': False, 'mac': '00:09:34:1c:10:c5', 'dhcp': False, 'netmask': [255, 255, 255, 0], 'gateway': [192, 168, 123, 1], 'postdown': False}} poll: unhandled POLLERR/HUP/NVAL for fd 61(16) [4294784.740000] fwdbg:rcv set_stakey [4294784.740000] [4294784.902000] fwdbg:issue action: 00000003, 00000000, 00000000 [4294784.902000] [4294784.910000] fwdbg:ADDBA RSP: 00000001 [4294784.910000] [4294785.732000] [got_addbareq_event_callback] mac = 0 1F 3F D1 52 36, seq = 48, tid = 0 [4294785.740000] fwdbg:issue action: 00000003, 00000001, 00000000 [4294785.740000] action -> MsgBoxActions ok [ePopen] command: iwconfig wlan0 [4294789.111000] fwdbg:issue action: 00000003, 00000000, 00000006 [4294789.111000] [4294789.119000] fwdbg:ADDBA RSP: 00000041 [4294789.119000] child has terminated pipes closed self.wlaniface after loading: {'wlan0': {'acesspoint': '00:1F:3F:D1:52:36', 'quality': '56/100', 'signal': '56/100', 'frequency': '2.447', 'essid': 'SSIDX1', 'encryption': 'Eingeschaltet', 'bitrate': '150 Mb/s'}} poll: unhandled POLLERR/HUP/NVAL for fd 59(16) nr_read 301 nr_write 111 sum 412 prev_sum 311 hdd was accessed since previous check! [IDLE] 0 120 False action -> WizardActions back killing self.WlanConsole [ePopen] command: iwconfig wlan0 child has terminated pipes closed self.wlaniface after loading: {'wlan0': {'acesspoint': '00:1F:3F:D1:52:36', 'quality': '56/100', 'signal': '56/100', 'frequency': '2.447', 'essid': 'SSIDX1', 'encryption': 'Eingeschaltet', 'bitrate': '150 Mb/s'}} [ePopen] command: ping -c 1 82.149.226.170 [ePopen] command: ping -c 1 193.99.144.85 [ePopen] command: ping -c 1 209.85.135.103 poll: unhandled POLLERR/HUP/NVAL for fd 55(16) child has terminated pipes closed poll: unhandled POLLERR/HUP/NVAL for fd 55(16) child has terminated pipes closed poll: unhandled POLLERR/HUP/NVAL for fd 61(16) action -> WizardActions back killing self.WlanConsole action -> OkCancelActions cancel action -> OkCancelActions cancel action -> OkCancelActions cancel action -> OkCancelActions cancel child has terminated pipes closed poll: unhandled POLLERR/HUP/NVAL for fd 58(16) nr_read 301 nr_write 111 sum 412 prev_sum 412 hdd IDLE! [IDLE] 11.9873490334 120 False