CPU 01 Dreambox DM900 AVS init... AVS init OK AVS load:select_image: addr_offset: 00051000 part_offset: 00000000 bootStatus: 2a252b25 AVS load_code offset =00051000 LOADED AVS: overtemp mon ON single board select_image: addr_offset: 00055000 part_offset: 00000000 bootStatus: 3d2b2525 MEMSYS-STD SHMOO 02010000 BLD:11138M HW:hpf0_b1p6 V:2.1.0.0 MCB: FLEX AVS start:status=000000ff STB: Current voltage=00000385(901) temperature=00005f10(24336) PV=00000346(838) MV=00000385(901) AVS FW rev=30333278 [0.3.2.x] OK DDR0: !@ ffe0e780 <= ffe0df10 MEMSYS-0 @ f1100000 OK DDR1: =@ ffe0e780 <= ffe0df10 MEMSYS-1 @ f1180000 OK Sdram Scramble OTP = 0x00000001 Sdram Scramble OK select_image: addr_offset: 00020000 part_offset: 00000000 bootStatus: 1b25252b BFW load mode OTP = 0x0000000f bfw_hash_locked = 0x00000000 BFW key3 OK, BFW load OK BFW v2.1.0 COPY CODE... DONE MICH: disable success SSBL PINMUX CACHE FLUSH OK MMU ON CACHE FLUSH OK _fbss 07080cd0 _ebss 0713dd70 _end 0713dd90 HEAP @ 07200000 STACK @ 09300000 ARCH: CONFIG OK CLR BSS 07080cd0 to 0713dd70 OK CLR SRAM OK CACHE FLUSH OK CPU CLKSET OK GO! ,/ ,'/___, BOLT v1.18 v1.18 LOCAL BUILD .'__ ,' (2016-12-01 16:24:31 cynric@cynric-VirtualBox) /,' Copyright (C) 2016 Broadcom /' Board: BCM97252SSFF SYS_CTRL: product=72521, family=7439b1, strap=000000b2, otp @ 0xf0404030 = 0x822000e0: en_cr(0x00000060) en_testport(0x00000080) macrovision_disable(0x02000000) moca_disable(0x80000000) rv9_disable(0x00200000) otp @ 0xf0404034 = 0x00000021: moca2_disable(0x00000001) rfm_disable(0x00000020) CPU: 2x B15 [420f00f3] 1719 MHz SCB: 432 MHz DDR0 @ 1067MHz, DDR1 @ 1067MHz RESET CAUSE: 0x000010 s3_wakeup (1 of 23 possible causes) CS0: SFDP SPI, 32MB, 64kB blocks, 64kB erase block, 256B pages CS1: NAND: unrecognized ID: 0x7effff 0xffffffff RTS0: 0x1101004, 256 clients, ok RTS1: 0x1181004, 256 clients, ok BOX MODE: 5 card if inited set pwm to 0/255 disp id 5420 load image AVS: park check AVS: temperature monitoring enabled AVS: STB: V=0.899V, T=+25.797C, PV=0.838V, MV=0.901V, FW=30333278 [0.3.2.x] USB otp=00000040 USB @ 0xf0470200: IPP is active low, IOC is negative polarity init fp found card in unknown state ca valid! set pwm to 200/255 Normal bootup Loader:zimg Filesys:raw Dev:emmcflash0.kernel File: Options:(null) Reading 4249192 bytes from zImage........... Starting program at 0x8000 (DTB @ 0x7728000) 32 bit boot... Uncompressing Linux... done, booting the kernel. [ 0.000000] Booting Linux on physical CPU 0x0 [ 0.000000] Initializing cgroup subsys cpuset [ 0.000000] Initializing cgroup subsys cpu [ 0.000000] Initializing cgroup subsys cpuacct [ 0.000000] Linux version 3.14-1.17-dm900 (dm900@opendreambox.org) (gcc version 5.3.0 (GCC) ) #1 SMP Fri Feb 9 14:21:32 UTC 2018 [ 0.000000] CPU: ARMv7 Processor [420f00f3] revision 3 (ARMv7), cr=30c7387d [ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, PIPT instruction cache [ 0.000000] Machine model: BCM97252SSFF [ 0.000000] moving dtb from 0x0000000007728000 to 0x0000000000835e70 [ 0.000000] bmem: Reserved 640 MiB at 0x0000000018000000 [ 0.000000] bmem: Reserved 384 MiB at 0x0000000080000000 [ 0.000000] cma: Reserved 16 MiB at 0x000000000f000000 [ 0.000000] Memory policy: Data cache writealloc [ 0.000000] MCP: Enabling write pairing [ 0.000000] PERCPU: Embedded 8 pages/cpu @cdfc0000 s8384 r8192 d16192 u32768 [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 523776 [ 0.000000] Kernel command line: bmem=640M@384M bmem=384M@2048M console=ttyS0,1000000 root=/dev/mmcblk0p2 rootwait rootfstype=ext4 coherent_pool=2M [ 0.000000] PID hash table entries: 1024 (order: 0, 4096 bytes) [ 0.000000] Dentry cache hash table entries: 32768 (order: 5, 131072 bytes) [ 0.000000] Inode-cache hash table entries: 16384 (order: 4, 65536 bytes) [ 0.000000] Memory: 1006912K/2097152K available (6114K kernel code, 214K rwdata, 1588K rodata, 244K init, 208K bss, 1073856K reserved, 16384K cma-reserved, 786428K highmem) [ 0.000000] Virtual kernel memory layout: [ 0.000000] vector : 0xffff0000 - 0xffff1000 ( 4 kB) [ 0.000000] fixmap : 0xfff00000 - 0xfffe0000 ( 896 kB) [ 0.000000] vmalloc : 0xd0800000 - 0xff000000 ( 744 MB) [ 0.000000] lowmem : 0xc0000000 - 0xd0000000 ( 256 MB) [ 0.000000] pkmap : 0xbfe00000 - 0xc0000000 ( 2 MB) [ 0.000000] modules : 0xbf000000 - 0xbfe00000 ( 14 MB) [ 0.000000] .text : 0xc0008000 - 0xc078dcec (7704 kB) [ 0.000000] .init : 0xc078e000 - 0xc07cb0c0 ( 245 kB) [ 0.000000] .data : 0xc07cc000 - 0xc0801b20 ( 215 kB) [ 0.000000] .bss : 0xc0801b28 - 0xc0835e70 ( 209 kB) [ 0.000000] Hierarchical RCU implementation. [ 0.000000] Additional per-CPU info printed with stalls. [ 0.000000] RCU restricting CPUs from NR_CPUS=4 to nr_cpu_ids=2. [ 0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 [ 0.000000] NR_IRQS:16 nr_irqs:16 16 [ 0.000000] irq_brcmstb_l2: registered L2 intc (mem: 0xfc403000, parent irq: 93) [ 0.000000] irq_brcmstb_l2: registered L2 intc (mem: 0xfc3e1000, parent irq: 64) [ 0.000000] irq_brcmstb_l2: registered L2 intc (mem: 0xfc410640, parent irq: 95) [ 0.000000] irq_brcmstb_l2: registered L2 intc (mem: 0xfc4d1200, parent irq: 58) [ 0.000000] Architected cp15 timer(s) running at 27.00MHz (virt). [ 0.000004] sched_clock: 56 bits at 27MHz, resolution 37ns, wraps every 2545165795328ns [ 0.000010] Switching to timer-based delay loop [ 0.000234] Console: colour dummy device 80x30 [ 0.000255] Calibrating delay loop (skipped), value calculated using timer frequency.. 54.00 BogoMIPS (lpj=27000) [ 0.000263] pid_max: default: 32768 minimum: 301 [ 0.000356] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes) [ 0.000360] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes) [ 0.005881] Initializing cgroup subsys devices [ 0.005897] Initializing cgroup subsys freezer [ 0.005903] Initializing cgroup subsys net_cls [ 0.005929] CPU: Testing write buffer coherency: ok [ 0.006147] CPU0: update cpu_power 1024 [ 0.006153] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000 [ 0.006204] Setting up static identity map for 0x5d5ab8 - 0x5d5b10 [ 0.007433] CPU1: Booted secondary processor [ 0.007452] CPU1: update cpu_power 1024 [ 0.007455] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001 [ 0.007523] Brought up 2 CPUs [ 0.007533] SMP: Total of 2 processors activated (108.00 BogoMIPS). [ 0.007538] CPU: All CPU(s) started in SVC mode. [ 0.007923] devtmpfs: initialized [ 0.011555] VFP support v0.3: implementor 42 architecture 4 part 00 variant 0 rev 0 [ 0.012130] regulator-dummy: no parameters [ 0.012306] NET: Registered protocol family 16 [ 0.013239] DMA: preallocated 2048 KiB pool for atomic coherent allocations [ 0.013427] cpuidle: using governor ladder [ 0.013432] cpuidle: using governor menu [ 0.014572] irq: no irq domain found for /rdb/interrupt-controller@f040a700 ! [ 0.014657] irq: no irq domain found for /rdb/interrupt-controller@f0417380 ! [ 0.016351] syscon f0404000.syscon: regmap [mem 0xf0404000-0xf0404523] registered [ 0.016423] syscon f03e2400.syscon: regmap [mem 0xf03e2400-0xf03e27ff] registered [ 0.016488] syscon f0452000.syscon: regmap [mem 0xf0452000-0xf04520ff] registered [ 0.016552] syscon f0404100.syscon: regmap [mem 0xf0404100-0xf040415b] registered [ 0.016614] syscon f040415c.syscon: regmap [mem 0xf040415c-0xf040419b] registered [ 0.016680] syscon f0410700.syscon: regmap [mem 0xf0410700-0xf041070b] registered [ 0.016745] syscon f041070c.syscon: regmap [mem 0xf041070c-0xf0410713] registered [ 0.016808] syscon f1101004.syscon: regmap [mem 0xf1101004-0xf1101403] registered [ 0.016869] syscon f1181004.syscon: regmap [mem 0xf1181004-0xf1181403] registered [ 0.016939] syscon f0404080.syscon: regmap [mem 0xf0404080-0xf0404083] registered [ 0.017005] syscon f04040a4.syscon: regmap [mem 0xf04040a4-0xf04040a7] registered [ 0.017067] syscon f03e0154.syscon: regmap [mem 0xf03e0154-0xf03e0157] registered [ 0.017144] syscon f03e0354.syscon: regmap [mem 0xf03e0354-0xf03e0357] registered [ 0.017210] syscon f03e0400.syscon: regmap [mem 0xf03e0400-0xf03e0403] registered [ 0.017514] irq: no irq domain found for /rdb/interrupt-controller@f0417380 ! [ 0.017740] Broadcom Brahma-B15 readahead cache at: 0xfc3e2478 [ 0.022094] bio: create slab at 0 [ 0.022403] brcmstb-gpio f040a600.gpio: Couldn't get IRQ. Enable CONFIG_BCM7120_L2_IRQ if you want GPIO interrupt support [ 0.022428] brcmstb-gpio f040a600.gpio: Registered 5 banks (GPIO(s): 0-159) [ 0.022456] brcmstb-gpio f0417400.gpio: Couldn't get IRQ. Enable CONFIG_BCM7120_L2_IRQ if you want GPIO interrupt support [ 0.022469] brcmstb-gpio f0417400.gpio: Registered 2 banks (GPIO(s): 160-223) [ 0.022829] SCSI subsystem initialized [ 0.023043] usbcore: registered new interface driver usbfs [ 0.023073] usbcore: registered new interface driver hub [ 0.023130] usbcore: registered new device driver usb [ 0.023164] media: Linux media interface: v0.10 [ 0.023191] Linux video capture interface: v2.00 [ 0.023228] pps_core: LinuxPPS API ver. 1 registered [ 0.023231] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.023242] PTP clock support registered [ 0.023460] Advanced Linux Sound Architecture Driver Initialized. [ 0.023749] Bluetooth: Core ver 2.18 [ 0.023764] NET: Registered protocol family 31 [ 0.023767] Bluetooth: HCI device and connection manager initialized [ 0.023775] Bluetooth: HCI socket layer initialized [ 0.023782] Bluetooth: L2CAP socket layer initialized [ 0.023788] Bluetooth: SCO socket layer initialized [ 0.024197] Switched to clocksource arch_sys_counter [ 0.024206] cfg80211: Calling CRDA to update world regulatory domain [ 0.028553] thermal thermal_zone0: failed to read out thermal zone 0 [ 0.028643] NET: Registered protocol family 2 [ 0.029049] TCP established hash table entries: 2048 (order: 1, 8192 bytes) [ 0.029065] TCP bind hash table entries: 2048 (order: 2, 16384 bytes) [ 0.029087] TCP: Hash tables configured (established 2048 bind 2048) [ 0.029122] TCP: reno registered [ 0.029128] UDP hash table entries: 256 (order: 1, 8192 bytes) [ 0.029139] UDP-Lite hash table entries: 256 (order: 1, 8192 bytes) [ 0.029271] NET: Registered protocol family 1 [ 0.029499] RPC: Registered named UNIX socket transport module. [ 0.029504] RPC: Registered udp transport module. [ 0.029507] RPC: Registered tcp transport module. [ 0.029511] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.030112] futex hash table entries: 512 (order: 3, 32768 bytes) [ 0.030450] bounce pool size: 64 pages [ 0.030963] NFS: Registering the id_resolver key type [ 0.030994] Key type id_resolver registered [ 0.030998] Key type id_legacy registered [ 0.031008] nfs4filelayout_init: NFSv4 File Layout Driver Registering... [ 0.031137] SGI XFS with ACLs, security attributes, realtime, large block/inode numbers, no debug enabled [ 0.031447] msgmni has been set to 462 [ 0.032176] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) [ 0.032183] io scheduler noop registered [ 0.032216] io scheduler cfq registered (default) [ 0.032438] brcm-gisb-arb f0400000.gisb-arb: registered mem: fc400000, irqs: 258, 259 [ 0.032715] brcm-usb-phy f0470200.usb-phy: USB3.0 clock not found in Device Tree [ 0.098468] brcmstb_memc f1102000.memc-ddr: registered [ 0.098493] brcmstb_memc f1182000.memc-ddr: registered [ 0.098691] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled [ 0.099511] f040a900.serial: ttyS0 at MMIO 0xf040a900 (irq = 107, base_baud = 5062500) is a 16550A [ 0.196119] console [ttyS0] enabled [ 0.197369] loop: module loaded [ 0.198011] ahci brcmstb-ahci.0: can't get clock [ 0.198634] ahci brcmstb-ahci.0: SSS flag set, parallel bus scan disabled [ 0.210210] ahci brcmstb-ahci.0: AHCI 0001.0300 32 slots 2 ports 6 Gbps 0x3 impl platform mode [ 0.211206] ahci brcmstb-ahci.0: flags: 64bit ncq sntf stag pm clo pmp slum part [ 0.213857] scsi0 : ahci_platform [ 0.214491] scsi1 : ahci_platform [ 0.214996] ata1: SATA max UDMA/133 mmio [mem 0xf045a000-0xf045aa9b] port 0x100 irq 91 [ 0.215914] ata2: SATA max UDMA/133 mmio [mem 0xf045a000-0xf045aa9b] port 0x180 irq 91 [ 0.217338] spi_brcmstb f03e3400.spi: 1-lane output, 3-byte address [ 0.218107] spi_brcmstb f03e3400.spi: master is unqueued, this is deprecated [ 0.219243] m25p80 spi32766.0: found mx25l25635e, expected m25p80 [ 0.219952] spi_brcmstb f03e3400.spi: 1-lane output, 4-byte address [ 0.220687] m25p80 spi32766.0: mx25l25635e (32768 Kbytes) [ 0.221335] 5 ofpart partitions found on MTD device spi32766.0 [ 0.222004] Creating 5 MTD partitions on "spi32766.0": [ 0.222604] 0x000000000000-0x000000200000 : "flash0.bolt" [ 0.223705] 0x000000200000-0x000000220000 : "flash0.nvram" [ 0.224748] 0x000000220000-0x000000240000 : "flash0.devtree" [ 0.225812] 0x000000240000-0x000001000000 : "flash0.recovery" [ 0.226878] 0x000000000000-0x000002000000 : "flash0" [ 0.228145] libphy: Fixed MDIO Bus: probed [ 0.228744] tun: Universal TUN/TAP device driver, 1.6 [ 0.229333] tun: (C) 1999-2004 Max Krasnyansky [ 0.230372] bcmgenet f0b00000.ethernet: GENET 4.5 EPHY: 0x1001 [ 0.244201] libphy: bcmgenet MII bus: probed [ 0.265081] xhci-brcm: xHCI BRCM driver [ 0.265602] xhci-brcm f0471000.xhci_v2: xHCI Host Controller [ 0.266274] xhci-brcm f0471000.xhci_v2: new USB bus registered, assigned bus number 1 [ 0.267457] xhci-brcm f0471000.xhci_v2: irq 149, io mem 0xf0471000 [ 0.268300] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 0.269080] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 0.269915] usb usb1: Product: xHCI Host Controller [ 0.270482] usb usb1: Manufacturer: Linux 3.14-1.17-dm900 xhci-hcd [ 0.271197] usb usb1: SerialNumber: f0471000.xhci_v2 [ 0.272078] hub 1-0:1.0: USB hub found [ 0.272541] hub 1-0:1.0: config failed, hub doesn't have any ports! (err -19) [ 0.273472] xhci-brcm f0471000.xhci_v2: xHCI Host Controller [ 0.274132] xhci-brcm f0471000.xhci_v2: new USB bus registered, assigned bus number 2 [ 0.275153] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003 [ 0.275947] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 0.276787] usb usb2: Product: xHCI Host Controller [ 0.277357] usb usb2: Manufacturer: Linux 3.14-1.17-dm900 xhci-hcd [ 0.278067] usb usb2: SerialNumber: f0471000.xhci_v2 [ 0.278919] hub 2-0:1.0: USB hub found [ 0.279378] hub 2-0:1.0: 2 ports detected [ 0.280146] ehci-brcm: EHCI BRCM driver [ 0.280672] ehci-brcm f0470300.ehci_v2: EHCI Host Controller [ 0.281340] ehci-brcm f0470300.ehci_v2: new USB bus registered, assigned bus number 3 [ 0.292354] ehci-brcm f0470300.ehci_v2: irq 145, io mem 0xf0470300 [ 0.298206] ehci-brcm f0470300.ehci_v2: USB 2.0 started, EHCI 1.00 [ 0.299013] usb usb3: New USB device found, idVendor=1d6b, idProduct=0002 [ 0.299802] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 0.300636] usb usb3: Product: EHCI Host Controller [ 0.301203] usb usb3: Manufacturer: Linux 3.14-1.17-dm900 ehci_hcd [ 0.301912] usb usb3: SerialNumber: f0470300.ehci_v2 [ 0.302761] hub 3-0:1.0: USB hub found [ 0.303220] hub 3-0:1.0: 1 port detected [ 0.303864] ehci-brcm f0470500.ehci_v2: EHCI Host Controller [ 0.304529] ehci-brcm f0470500.ehci_v2: new USB bus registered, assigned bus number 4 [ 0.315525] ehci-brcm f0470500.ehci_v2: irq 146, io mem 0xf0470500 [ 0.322203] ehci-brcm f0470500.ehci_v2: USB 2.0 started, EHCI 1.00 [ 0.323008] usb usb4: New USB device found, idVendor=1d6b, idProduct=0002 [ 0.323796] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 0.324629] usb usb4: Product: EHCI Host Controller [ 0.325196] usb usb4: Manufacturer: Linux 3.14-1.17-dm900 ehci_hcd [ 0.325906] usb usb4: SerialNumber: f0470500.ehci_v2 [ 0.326735] hub 4-0:1.0: USB hub found [ 0.327196] hub 4-0:1.0: 1 port detected [ 0.327885] ohci-brcm: OHCI BRCM driver [ 0.328389] ohci-brcm f0470400.ohci_v2: BRCM OHCI controller [ 0.329047] ohci-brcm f0470400.ohci_v2: new USB bus registered, assigned bus number 5 [ 0.329973] ohci-brcm f0470400.ohci_v2: irq 147, io mem 0xf0470400 [ 0.385318] usb usb5: New USB device found, idVendor=1d6b, idProduct=0001 [ 0.386098] usb usb5: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 0.386932] usb usb5: Product: BRCM OHCI controller [ 0.387500] usb usb5: Manufacturer: Linux 3.14-1.17-dm900 ohci_hcd [ 0.388215] usb usb5: SerialNumber: f0470400.ohci_v2 [ 0.389062] hub 5-0:1.0: USB hub found [ 0.389535] hub 5-0:1.0: 1 port detected [ 0.390199] ohci-brcm f0470600.ohci_v2: BRCM OHCI controller [ 0.390860] ohci-brcm f0470600.ohci_v2: new USB bus registered, assigned bus number 6 [ 0.391780] ohci-brcm f0470600.ohci_v2: irq 148, io mem 0xf0470600 [ 0.447304] usb usb6: New USB device found, idVendor=1d6b, idProduct=0001 [ 0.448085] usb usb6: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 0.448920] usb usb6: Product: BRCM OHCI controller [ 0.449487] usb usb6: Manufacturer: Linux 3.14-1.17-dm900 ohci_hcd [ 0.450202] usb usb6: SerialNumber: f0470600.ohci_v2 [ 0.451028] hub 6-0:1.0: USB hub found [ 0.451496] hub 6-0:1.0: 1 port detected [ 0.452184] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver [ 0.452945] ehci-pci: EHCI PCI platform driver [ 0.453499] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver [ 0.454220] ohci-pci: OHCI PCI platform driver [ 0.454848] usbcore: registered new interface driver usb-storage [ 0.455550] i2c /dev entries driver [ 0.456000] lirc_dev: IR Remote Control driver registered, major 250 [ 0.457044] brcmstb_thermal f04d1500.thermal: registered AVS TMON of-sensor driver [ 0.458024] usbcore: registered new interface driver btusb [ 0.458717] cpufreq_cpu0: failed to get cpu0 regulator: -19 [ 0.459533] brcmstb-cpufreq: probe of f03e257c.cpu-clk-div failed with error -17 [ 0.460461] sdhci: Secure Digital Host Controller Interface driver [ 0.461169] sdhci: Copyright(c) Pierre Ossman [ 0.461678] sdhci-pltfm: SDHCI platform and OF driver helper [ 0.463431] mmc0: no vqmmc regulator found [ 0.463905] mmc0: no vmmc regulator found [ 0.494206] mmc0: SDHCI controller on f03e0000.sdhci [f03e0000.sdhci] using ADMA [ 0.496114] mmc1: no vqmmc regulator found [ 0.496594] mmc1: no vmmc regulator found [ 0.527200] mmc1: SDHCI controller on f03e0200.sdhci [f03e0200.sdhci] using ADMA [ 0.528141] hidraw: raw HID events driver (C) Jiri Kosina [ 0.528852] usbcore: registered new interface driver usbhid [ 0.529499] usbhid: USB HID core driver [ 0.531939] TCP: cubic registered [ 0.532944] NET: Registered protocol family 10 [ 0.533930] NET: Registered protocol family 17 [ 0.534668] Bluetooth: RFCOMM TTY layer initialized [ 0.535254] Bluetooth: RFCOMM socket layer initialized [ 0.535843] Bluetooth: RFCOMM ver 1.11 [ 0.536282] Bluetooth: BNEP (Ethernet Emulation) ver 1.3 [ 0.536892] Bluetooth: BNEP filters: protocol multicast [ 0.537501] Bluetooth: BNEP socket layer initialized [ 0.538071] Bluetooth: HIDP (Human Interface Emulation) ver 1.2 [ 0.538760] Bluetooth: HIDP socket layer initialized [ 0.539377] l2tp_core: L2TP core driver, V2.0 [ 0.539898] Key type dns_resolver registered [ 0.540466] Registering SWP/SWPB emulation handler [ 0.541325] regulator-dummy: disabling [ 0.542006] ALSA device list: [ 0.542373] No soundcards found. [ 0.542985] Waiting for root device /dev/mmcblk0p2... [ 0.602841] mmc1: BKOPS_EN bit is not set [ 0.609544] mmc1: new high speed MMC card at address 0001 [ 0.610376] mmcblk0: mmc1:0001 4FPD3R 3.64 GiB [ 0.610998] mmcblk0boot0: mmc1:0001 4FPD3R partition 1 4.00 MiB [ 0.611783] mmcblk0boot1: mmc1:0001 4FPD3R partition 2 4.00 MiB [ 0.612549] mmcblk0rpmb: mmc1:0001 4FPD3R partition 3 512 KiB [ 0.616270] mmcblk0: p1 p2 p3 [ 0.618798] mmcblk0boot1: unknown partition table [ 0.619839] mmcblk0boot0: unknown partition table [ 0.649418] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null) [ 0.650381] VFS: Mounted root (ext4 filesystem) readonly on device 179:2. [ 0.652489] devtmpfs: mounted [ 0.769696] random: systemd: uninitialized urandom read (16 bytes read, 51 bits of entropy available) [ 0.774293] systemd[1]: systemd 230 running in system mode. (-PAM -AUDIT -SELINUX -IMA -APPARMOR -SMACK +SYSVINIT +UTMP -LIBCRYPTSETUP -GCRYPT +GNUTLS +ACL +XZ -LZ4 -SECCOMP +BLKID -ELFUTILS +KMOD -IDN) [ 0.776594] systemd[1]: Detected architecture arm. Welcome to opendreambox 2.5.0! [ 0.779742] systemd[1]: Set hostname to . [ 0.793028] random: systemd: uninitialized urandom read (16 bytes read, 57 bits of entropy available) [ 0.808024] systemd-fstab-generator[75]: Checking was requested for "rootfs", but it is not a device. [ 0.812120] random: systemd-sysv-ge: uninitialized urandom read (16 bytes read, 64 bits of entropy available) [ 0.816271] random: systemd-sysv-ge: uninitialized urandom read (16 bytes read, 65 bits of entropy available) [ 0.823773] random: systemd: uninitialized urandom read (16 bytes read, 65 bits of entropy available) [ 0.824943] random: systemd: uninitialized urandom read (16 bytes read, 65 bits of entropy available) [ 0.826308] random: systemd: uninitialized urandom read (16 bytes read, 65 bits of entropy available) [ 0.827498] random: systemd: uninitialized urandom read (16 bytes read, 65 bits of entropy available) [ 0.828786] random: systemd: uninitialized urandom read (16 bytes read, 65 bits of entropy available) [ 0.834545] random: systemd: uninitialized urandom read (16 bytes read, 69 bits of entropy available) [ 0.904430] systemd[1]: Created slice System Slice. [ OK ] Created slice System Slice. [ 0.907339] systemd[1]: Reached target Paths. [ OK ] Reached target Paths. [ 0.909401] systemd[1]: Listening on Journal Socket. [ OK ] Listening on Journal Socket. [ 0.913410] systemd[1]: Mounting POSIX Message Queue File System... Mounting POSIX Message Queue File System... [ 0.919936] systemd[1]: Starting Load Kernel Modules... Starting Load Kernel Modules... [ 0.921658] systemd[1]: Created slice User and Session Slice. [ OK ] Created slice User and Session Slice. [ 0.924554] systemd[1]: Listening on udev Control Socket. [ OK ] Listening on udev Control Socket. [ 0.927487] systemd[1]: Reached target Slices. [ OK ] Reached target Slices. [ 0.930381] systemd[1]: Listening on Journal Socket (/dev/log). [ OK ] Listening on Journal Socket (/dev/log). [ 0.934868] systemd[1]: Starting Generate environment for enigma2... Starting Generate environment fo[ 0.936230] stb_core: module license 'Proprietary' taints kernel. r enigma2... [ 0.936998] Disabling lock debugging due to kernel taint [ 0.938238] systemd[1]: Reached target Swap. [ OK ] Reached target Swap. [ 0.942586] systemd[1]: Starting Remount Root and Kernel File Systems... Starting Remount Root and Kernel File Systems... [ 0.946319] systemd[1]: Reached target Host and Network Name Lookups. [ OK ] Reached target Host and Network Name Lookups. [ 0.949421] systemd[1]: Listening on udev Kernel Socket. [ OK ] Listening on udev Kernel Socket. [ 0.952646] systemd[1]: Created slice system-serial\x2dgetty.slice. [ OK ] Created slice system-serial\x2dgetty.slice. [ 0.957967] systemd[1]: Starting Setup Virtual Console... Starting Setup Virtual Console... [ 0.961576] systemd[1]: Starting Journal Service... Starting Journal Service... [ 0.964745] input: dreambox remote control (native) as /devices/virtual/input/input0 [ 0.966451] input: dreambox advanced remote control (native) as /devices/virtual/input/input1 [ 0.973498] systemd[1]: Starting Create list of required static device nodes for the current kernel... Starting Create list of required st... nodes for the current kernel... [ 0.979260] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null) [ 0.982558] systemd[1]: Set up automount data.automount. [ OK ] Set up automount data.automount. [ 0.990531] systemd[1]: Mounted POSIX Message Queue File System. [ OK ] Mounted POSIX Message Queue File System. [ 0.994403] systemd[1]: Started Remount Root and Kernel File Systems. [ OK ] Started Remount Root and Kernel File Systems. [ 1.000990] systemd[1]: Started Setup Virtual Console. [ OK ] Started Setup Virtual Console. [ 1.011012] systemd[1]: Starting udev Coldplug all Devices... Starting udev Coldplug all Devices... [ 1.057480] systemd[1]: Started Create list of required static device nodes for the current kernel. [ OK ] Started Create list of required sta...ce nodes for the current kernel. [ 1.063549] systemd[1]: Starting Create Static Device Nodes in /dev... Starting Create Static Device Nodes in /dev... [ 1.111847] systemd[1]: Started Generate environment for enigma2. [ OK ] Started Generate environment for enigma2. [ 1.134320] systemd[1]: Started Journal Service. [ OK ] Started Journal Service. [ 1.136649] random: nonblocking pool is initialized Starting Flush Journal to Persistent Storage... [ OK ] Started udev Coldplug all Devices. [ 1.253018] bcm7439: xvd 20160630, vdc 20160630, rap 20160630, xpt 20160630, driver version 20200226-dm900 [ OK ] Started Create Static Device Nodes in /dev. [ OK ] Reached target Local File Systems (Pre). Mounting /tmp... Mounting /var/volatile... Starting udev Kernel Device Manager... [ 1.288512] systemd-journald[93]: Received request to flush runtime journal from PID 1 [ OK ] Mounted /var/volatile. Starting Load/Save Random Seed... [ OK ] Started Flush Journal to Persistent Storage. [ OK ] Mounted /tmp. [ OK ] Reached target Local File Systems. Starting Create Volatile Files and Directories... [ OK ] Started GeminiSpinner. [ OK ] Started Load/Save Random Seed. [ OK ] Started Create Volatile Files and Directories. Starting Update UTMP about System Boot/Shutdown... Starting RPC bind portmap service... [ OK ] Started udev Kernel Device Manager. [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Started RPC bind portmap service. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. [ OK ] Found device /dev/ttyS0. [ 1.869492] 1:869301525 SMCB: controller reset timed out [ OK ] Found device /dev/sci0. [ 2.228461] register adapter [ 2.229046] register adapter [ 2.229604] register adapter [ 2.230109] register adapter [ 2.230655] register adapter [ 2.233498] fp: uart recv error 98 [ 2.234011] swd: status is 0, pls check [ 2.234481] swd: cannot init port [ 2.234868] ble module not found [ 2.235423] input: dreambox front panel as /devices/virtual/input/input2 [ 2.238790] OFFSET 1604425532 12780574 [ 2.239255] WKTMR 1262080 15120918 [ 2.239652] LAST WKTMR 1235847 [ 2.240030] set system time to 1605687613:33355 [ 2.240818] HDMI: CEC start ... state is now 1 [ 2.241716] set input to 0 [ 2.242033] set fb to 2(-1) [ 2.244750] startvideomode '1080p50' read from /etc/videomode [ 2.245695] bcmfb: creating surface with pixel format 0x07e48888 (BPXL_eA8_R8_G8_B8) [ 2.280311] HDMI: ignore false positive disconnect! [ 2.280878] HDMI: now powered down [ 2.281292] HDMI: Unable to retrieve Rx EDID info.. no rx device [ 2.281985] using 50.00Hz as MonitorRefreshRate [ 2.282514] SET FORMAT: display[0], format='1080p50' [ 2.319202] HDMI: CEC use logical address 3 [ 2.319715] HDMI: CEC init completed... state is now 3! [ 2.458988] HDMI: CEC send ok! [ 2.479235] ata1: SATA link up 6.0 Gbps (SStatus 133 SControl 300) [ 2.483748] ata1.00: ATA-10: lntenso SSD SATAIII, S1120A0, max UDMA/133 [ 2.484525] ata1.00: 2000409264 sectors, multi 1: LBA48 NCQ (depth 31/32) [ 2.491324] ata1.00: configured for UDMA/133 [ 2.492050] scsi 0:0:0:0: Direct-Access ATA lntenso SSD SATA S112 PQ: 0 ANSI: 5 [ 2.493922] sd 0:0:0:0: [sda] 2000409264 512-byte logical blocks: (1.02 TB/953 GiB) [ 2.495118] sd 0:0:0:0: [sda] Write Protect is off [ 2.495810] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA [ 2.501408] sda: sda1 sda2 [ 2.503639] sd 0:0:0:0: [sda] Attached SCSI disk [ OK ] Found device lntenso_SSD_SATAIII dreambox-storage. Mounting /media/hdd... [ 2.597371] EXT4-fs (sda1): mounted filesystem with ordered data mode. Opts: discard [ OK ] Mounted /media/hdd. [ 2.606215] ata2: SATA link down (SStatus 0 SControl 300) [ 2.667377] VIDEO0: enable deinterlacer [ 2.667925] VIDEO0: set fallback framerate to 60000 [ 2.668519] VIDEO0: set progressive override mode to 1 [ 2.669111] VIDEO0: set streamtype! [ 2.669528] -> set MPEG2 [ 2.669873] -> sw rave disabled! [ 2.754628] HDMI: CEC recv ok! [ 2.755058] VIDEO1: set fallback framerate to 60000 [ 2.755664] VIDEO1: set progressive override mode to 1 [ 2.756276] VIDEO1: set streamtype! [ 2.756683] -> set MPEG2 [ 2.757025] -> sw rave disabled! [ 2.792999] VIDEO2: set fallback framerate to 60000 [ 2.793586] VIDEO2: set progressive override mode to 1 [ 2.794178] VIDEO2: set streamtype! [ 2.794591] -> set MPEG2 [ 2.794934] -> sw rave disabled! [ 2.808486] set ac3 to downmix [ 2.808853] set wmapro to downmix [ 2.809274] set ac3plus to use_hdmi_caps [ 2.809736] set dtshd to force_dts [ 2.810133] set aac to downmix [ 2.810877] audio ch2: add stereo (background decoder) input to mixer DUMMY2 [ 2.811743] audio ch1: add stereo (hdmi-rx) input to mixer DUMMY [ 2.812748] DVB: registering new adapter (BCM7439) [ OK ] Found device /dev/dvb/adapter0/ca0. [ OK ] Found device /dev/dvb/adapter0/demux0. [ 2.896871] autodetecting NIMs... [ 2.898131] Found: Slot 0, ID: 1e (by CA) [ 2.898700] Initializing adapter 0 (BCM45208-DVB-S2) [ 2.899931] bcm45208(0): chipid register is 45216 [ 2.902807] bcm45208(0): opening 8 sat channels (demods) [ 2.903497] (NULL device *): DVB: registering adapter 0 frontend 0 (BCM45208)... [ 2.904453] bcm45208(0): InitAP [ 2.904954] Initializing adapter 1 (BCM45208-DVB-S2) [ 2.905577] (NULL device *): DVB: registering adapter 0 frontend 1 (BCM45208)... [ 2.906645] Initializing adapter 2 (BCM45208-DVB-S2) [ 2.907252] (NULL device *): DVB: registering adapter 0 frontend 2 (BCM45208)... [ 2.908463] Initializing adapter 3 (BCM45208-DVB-S2) [ 2.909078] (NULL device *): DVB: registering adapter 0 frontend 3 (BCM45208)... [ 2.910209] Initializing adapter 4 (BCM45208-DVB-S2) [ 2.910821] (NULL device *): DVB: registering adapter 0 frontend 4 (BCM45208)... [ 2.911811] Initializing adapter 5 (BCM45208-DVB-S2) [ 2.912430] (NULL device *): DVB: registering adapter 0 frontend 5 (BCM45208)... [ 2.913559] Initializing adapter 6 (BCM45208-DVB-S2) [ 2.914155] (NULL device *): DVB: registering adapter 0 frontend 6 (BCM45208)... [ 2.917818] Initializing adapter 7 (BCM45208-DVB-S2) [ 2.918465] (NULL device *): DVB: registering adapter 0 frontend 7 (BCM45208)... [ 2.922036] CI stopped... [ 2.922607] init ALSA! [ 2.930056] registered vtuner misc/vtuner0, minor 50 [ 2.931731] registered vtuner misc/vtuner1, minor 49 [ 2.933303] registered vtuner misc/vtuner2, minor 48 [ 2.934424] registered vtuner misc/vtuner3, minor 47 [ 2.935007] HDMI-RX: init [ 2.936122] HDMI-RX: no device attached [ 2.936633] HDMI-RX: video format change event [ 2.937147] HDMI-RX: hdmi packet status stopped [ 2.937677] HDMI-RX: hdmiInput0 Receiving DVI format [ 2.938274] HDMI-RX: hdmiInput0 Color Space change from '' to '' [ 2.938988] HDMI-RX: init done [ 2.939358] bcm_vce_init() [ 2.939678] bcm_vce_init() 0 [ OK ] Found device /dev/dvb/adapter0/video0. [ 2.964182] vice0: allocate output buffers [ OK ] Reached target Sound Card. [ 2.973064] input: dreambox ir keyboard as /devices/virtual/input/input3 [ 2.974622] input: dreambox ir mouse as /devices/virtual/input/input4 [ 2.979084] ble init (0) [ 2.979944] input: dreambox remote control (bluetooth le) as /devices/virtual/input/input5 Starting Dreambox Bootlogo... [ 2.988736] fuse init (API version 7.22) [ 3.001314] Installing knfsd (copyright (C) 1996 okir@monad.swb.de). [ OK ] Started Load Kernel Modules. Mounting NFSD configuration filesystem... Mounting FUSE Control File System... Starting Apply Kernel Variables... [ 3.019946] VIDEO0: set blank to 0 [ 3.021509] sync0 is off so we enable it [ 3.021977] sync0: allocated pcroffset 0 [ 3.022475] sync0: playback! [ 3.022864] VIDEO0: total delay: 0 (0 ms) [ OK ] Started Dreambox Bootlogo. [ 3.028217] VIDEO0: start decode [ 3.028762] VIDEO0: flush video decoder [ 3.029238] VIDEO0 got pts failed !!!! (ret 0) [ OK ] Mounted FUSE Control File System. [ OK ] Mounted NFSD configuration filesystem. [ OK ] Started Apply Kernel Variables. [ OK ] Reached target System Initialization. [ 3.46845] VIDEO0: first pts 0x0 [ 3.047268] VIDEO0: EOTF changed to SDR [ 3.047723] VIDEO0: framerate changed 3 [[ 3.048178] VIDEO0: resolution changed (1280 720) OK ] [ 3.048745] VIDEO0: aspect changed 3 Listening on streamproxy.socket.[ 3.049522] set current avs auto aspect to 16:9 [ 3.050226] set current avs auto aspect to 16:9 [ 3.050808] set sb to 3(1) [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Listening on vsftpd.socket. [ OK ] Listening on dropbear.socket. [ OK ] Listening on dbttcd.socket. [ OK ] Listening on dreamliveserver.socket. [ OK ] Listening on Avahi mDNS/DNS-SD Stack Activation Socket. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Reached target Timers. [ OK ] Listening on busybox-telnetd.socket. [ OK ] Listening on dccamd.socket. [ OK ] Listening on tpmd.socket. [ OK ] Reached target Sockets. Starting enigma2... [ OK ] Reached target Basic System. Starting Login Service... [ OK ] Started D-Bus System Message Bus. Starting Connection service... Starting dbttcd.service... Starting dccamd.service... [ OK ] Started Serial Getty on ttyS0. [ OK ] Reached target Login Prompts. [ 3.185775] VIDEO0: stop decode [ 3.186159] sync0 1fff no decoder left in sync handling so disable [ 3.186934] sync0: was last pcroffset0 user so free it Starting Avahi mDNS/DNS-SD Stack... Starting tpmd.service... [ OK ] Started Login Service. [ OK ] Started Avahi mDNS/DNS-SD Stack. [ OK ] Started Connection service. [ OK ] Reached target Network. [ OK ] Started NFS status monitor for NFSv2/3 locking.. [ OK ] Started NFS Mount Daemon. [ OK ] Started LPD. Starting NFS server and services... Starting Samba NMB Daemon... Starting Wait for network to be [ 3.379271] HDMI: now connected configured by ConnMan... [ 3.422842] HDMI: CEC Physical Addr 2.1.0.0 set from EDID [ 3.423684] HDMI: EDID read ok [ 3.424107] using 50.00Hz as MonitorRefreshRate [ 3.424683] VIDEO1: shared window not available [ 3.425255] SET FORMAT: display[0], format='1080p50' [ 3.425847] HDMI mode [ 3.426117] use EDID to detect colorspace [ 3.426610] preferred colorspace: Itu_R_BT_709 [ 3.427124] using 8bit output [ 3.430864] NFSD: Using /var/lib/nfs/v4recovery as the NFSv4 state recovery directory [ 3.433279] NFSD: starting 90-second grace period (net c07f9700) [ OK ] Started NFS server and services. [ 3.436805] usbcore: registered new interface driver usblp [ OK ] Started tpmd.service. Starting WPA supplicant... [ 3.628408] VIDEO1: shared window not available [ 3.628999] set current avs auto aspect to 16:9 [ 3.629645] HDMI: CEC recv ok! [ 3.630139] set sb to 3(1) [ 3.698241] f0b00000.etherne:01: Broadcom BCM7439 (2) PHY revision: 0x10, patch: 1 [ 3.702266] f0b00000.ethernet: configuring instance for internal PHY [ 3.703115] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready Starting Hostname Service... [ OK ] Started WPA supplicant. [ OK ] Started Hostname Service. [ 3.887646] HDMI: CEC recv ok! [ OK ] Started dbttcd.service. [ 4.090494] HDMI: CEC recv ok! [ 4.199384] HDMI: CEC recv ok! [ 4.602044] HDMI: CEC recv ok! [ OK ] Stopped LPD. [ OK ] Started LPD. [ 4.662915] HDMI: SDCD Event [ 5.033831] HDMI: CEC recv ok! [ 5.705309] libphy: f0b00000.etherne:01 - Link is Down [ 5.753940] HDMI: CEC recv ok! [ OK ] Stopped LPD. [ OK ] Started LPD. [ 6.761886] HDMI: CEC recv ok! [ 7.171097] libphy: f0b00000.etherne:01 - Link is Up - 1000/Full [ 7.171836] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ OK ] Stopped LPD. [ OK ] Started LPD. [ OK ] Started Wait for network to be configured by ConnMan. [ OK ] Reached target Network is Online. Starting Automounts filesystems on demand... [ OK ] Started Automounts filesystems on demand. [ 8.002541] HDMI: CEC recv ok! opendreambox 2.5.0 dm900 ttyS0 dm900 login: [ 10.244471] bcm45208(0): Info Id: 6 Type: 0 Version: 11.2 [ 10.266038] bcm45208(0): FW Id: 5 Type: 0 Version 1.8 [ 10.267334] bcm45208(0): opening 2 wfe channels (input adcs) [ 10.268009] bcm45208(0): opening 2 dsq channels (DiSEqC) [ 10.268634] bcm45208(0): init lnb_ctrl 0 [ 10.269416] bcm45208(0): init lnb_ctrl 1 [ 10.325605] bcm45208(0): init MTSIF [ 10.871379] bcm45208(0): enabled diseqc and wfe 0 [ 10.882884] bcm45208(0): in normal mode now [ 10.883367] bcm45208(0): rf input 0 used [ 10.922996] bcm45208(1): in normal mode now [ 10.923581] bcm45208(1): rf input 0 used [ 11.081073] bcm45208(0): sleeping now [ 11.111390] bcm45208(1): disabled diseqc and wfe 0 [ 11.122911] bcm45208(1): sleeping now [ 11.144529] bcm45208(2): enabled diseqc and wfe 0 [ 11.156051] bcm45208(2): in normal mode now [ 11.156534] bcm45208(2): rf input 0 used [ 11.168738] bcm45208(3): in normal mode now [ 11.169224] bcm45208(3): rf input 0 used [ 11.193616] bcm45208(2): sleeping now [ 11.223822] bcm45208(3): disabled diseqc and wfe 0 [ 11.235291] bcm45208(3): sleeping now [ 11.257565] bcm45208(4): enabled diseqc and wfe 0 [ 11.269074] bcm45208(4): in normal mode now [ 11.269558] bcm45208(4): rf input 0 used [ 11.300665] bcm45208(4): disabled diseqc and wfe 0 [ 11.312151] bcm45208(4): sleeping now [ 11.333642] bcm45208(5): enabled diseqc and wfe 0 [ 11.345127] bcm45208(5): in normal mode now [ 11.345609] bcm45208(5): rf input 0 used [ 11.376755] bcm45208(5): disabled diseqc and wfe 0 [ 11.388287] bcm45208(5): sleeping now [ 11.410645] bcm45208(6): enabled diseqc and wfe 0 [ 11.422115] bcm45208(6): in normal mode now [ 11.422597] bcm45208(6): rf input 0 used [ 11.453670] bcm45208(6): disabled diseqc and wfe 0 [ 11.465233] bcm45208(6): sleeping now [ 11.487715] bcm45208(7): enabled diseqc and wfe 0 [ 11.499184] bcm45208(7): in normal mode now [ 11.499666] bcm45208(7): rf input 0 used [ 11.510100] HDMI: CEC device open ... state is 3, flushed 10 old messages from RX fifo [ 11.511135] HDMI: CEC set devtype to 0 [ 11.511574] HDMI: CEC start ... state is now 1 [ 11.512141] HDMI: CEC returned state 1 [ 11.512576] HDMI: CEC state now 801 [ 11.537226] bcm45208(7): disabled diseqc and wfe 0 [ 11.552402] bcm45208(7): sleeping now [ 11.575061] HDMI: CEC use logical address 3 [ 11.575562] HDMI: CEC init completed... state is now 3! [ 11.607241] bcmfb: creating surface with pixel format 0x07c68888 (BPXL_eA8_B8_G8_R8) [ 11.711880] HDMI: CEC send ok! [ 12.365768] 0 ms: [ 12.399536] 34 ms: 0 [ 12.408064] 8 ms: 0 [ 12.411863] 3 ms: 0 [ 12.709839] 298 ms: 0 [ 12.739555] 30 ms: 2 [ 12.745655] 6 ms: 2 [ 12.746796] 1 ms: 2 [ 12.756829] 10 ms: 2 [ 12.784351] HDMI: CEC recv ok! [ 12.904147] 147 ms: 2 [ 12.924687] 20 ms: 3 [ 12.927552] 3 ms: 3 [ 12.928544] 1 ms: 3 [ 12.929657] 1 ms: 3 [ 13.411504] 481 ms: 3 [ 13.413588] 1 ms: 7 [ 13.878245] HDMI: CEC recv ok! [ 14.972690] HDMI: CEC recv ok! [ 29.544772] 16127 ms: 7 [ 29.548276] 3 ms: 48 [ 29.564888] 16 ms: 48 [ 29.612384] 47 ms: 48 [ 29.613725] 1 ms: 49 [ 29.617191] 4 ms: 49 [ 29.618439] 1 ms: 49 [ 29.619586] 1 ms: 49 [ 29.624245] 5 ms: 49 [ 29.628603] 4 ms: 49 [ 29.684368] change audioenc bitrate to 256000 bits/s [ 29.686710] vice0: change videoenc bitrate to 6000000 bits/s [ 29.687396] change audioenc bitrate to 128000 bits/s [ 29.702728] vice0: change gop length to 0ms [ 29.703229] vice0: allow new gop on new scene off [ 29.703775] vice0: change open gop to off [ 29.704255] vice0: change p-frames to 4 [ 29.704701] vice0: change b-frames to 2 [ 29.705156] vice0: change to 0 slices per pic [ 29.705715] vice0: change h264 profile to main [ 29.706245] vice0: change h264 level to 3.1 [ 29.798249] EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Opts: (null) [ 29.819628] 191 ms: 49 [ 29.820974] 1 ms: 50 [ 29.877413] 56 ms: 50 [ 29.884626] 7 ms: 50 [ 29.889432] 5 ms: 50 [ 29.893856] 4 ms: 50 [ 29.894955] 0 ms: 50 [ 29.896392] 1 ms: 50 [ 29.899980] 3 ms: 50 [ 29.901131] 1 ms: 50 [ 29.920033] 19 ms: 50 [ 30.900429] 980 ms: 51 [ 30.920421] 20 ms: 57 [ 30.921557] 1 ms: 57 [ 30.934868] 13 ms: 57 [ 30.936005] 0 ms: 57 [ 30.937287] 1 ms: 57 [ 30.939664] 2 ms: 57 [ 30.943194] 4 ms: 57 [ 30.951486] 8 ms: 57 [ 30.952696] 1 ms: 57 [ 31.017603] bcmfb: creating surface with pixel format 0x07c68888 (BPXL_eA8_B8_G8_R8) [ 31.074951] 122 ms: 57 [ 31.169943] 94 ms: 58 [ 31.172870] set input to 0 [ 31.173217] set fb to 2(-1) [ 31.173549] set current avs auto aspect to 16:9 [ 31.174102] set sb to 3(1) [ 31.175062] set ac3 to passthrough [ 31.175832] set ac3plus to use_hdmi_caps [ 31.207446] using 50.00Hz as MonitorRefreshRate [ 31.207978] VIDEO1: shared window not available [ 31.208547] SET FORMAT: display[0], format='1080p50' [ 31.209145] HDMI mode [ 31.209410] use EDID to detect colorspace [ 31.209872] preferred colorspace: Itu_R_BT_709 [ 31.210391] using 8bit output [ 31.327411] VIDEO1: shared window not available [ 31.327964] set current avs auto aspect to 16:9 [ 31.328532] set sb to 3(1) [ 31.427438] using 50.00Hz as MonitorRefreshRate [ 31.427969] VIDEO1: shared window not available [ 31.428534] SET FORMAT: display[0], format='1080p50' [ 31.429130] HDMI mode [ 31.429396] use EDID to detect colorspace [ 31.429857] preferred colorspace: Itu_R_BT_709 [ 31.430408] using 8bit output [ 31.547405] VIDEO1: shared window not available [ 31.547948] set current avs auto aspect to 16:9 [ 31.548511] set sb to 3(1) [ 31.549303] 379 ms: 59 [ 31.552553] 3 ms: 62 [ 31.556101] 4 ms: 62 [ 31.600663] 44 ms: 62 [ 31.604723] 4 ms: 62 [ 34.192945] set ac3 to hdmi_best [ 34.193631] set ac3 to hdmi_best [ 34.194167] set ac3plus to use_hdmi_caps [ 34.194724] set dtshd to use_hdmi_caps [ 34.195300] set aac to hdmi_best [ 34.195781] set wmapro to multichannel [ 34.574622] set current avs auto aspect to 16:9 [ 34.575212] set sb to 3(1) [ 34.575673] set current avs auto aspect to 16:9 [ 34.576254] set sb to 3(1) [ 34.576658] set current avs auto aspect to 16:9 [ 34.577204] set sb to 3(1) [ 34.578070] set current avs auto aspect to 16:9 [ 34.578601] set sb to 3(1) [ 34.578976] set current avs auto aspect to 16:9 [ 34.579535] set sb to 3(1) [ 34.579913] set current avs auto aspect to 16:9 [ 34.580465] set sb to 3(1) [ 34.581305] set current avs auto aspect to 16:9 [ 34.581888] set sb to 3(1) [ 34.582311] set current avs auto aspect to 16:9 [ 34.582844] set sb to 3(1) [ 34.583239] set current avs auto aspect to 16:9 [ 34.583773] set sb to 3(1) [ 34.584674] set current avs auto aspect to 16:9 [ 34.585233] set sb to 3(1) [ 34.585633] set current avs auto aspect to 16:9 [ 34.586175] set sb to 3(1) [ 34.587529] set current avs auto aspect to 16:9 [ 34.588106] set sb to 3(1) [ 34.588520] set current avs auto aspect to 16:9 [ 34.589066] set sb to 3(1) [ 34.589445] set current avs auto aspect to 16:9 [ 34.589973] set sb to 3(1) [ 34.753896] systemd-fstab-generator[429]: Checking was requested for "rootfs", but it is not a device. [ 35.114526] 3510 ms: 62 [ 35.131794] 17 ms: 86 [ 36.053921] set mute 0 1 [ 36.593103] 1461 ms: 86 [ 36.775301] 36:775073361 SMCB: invalid ioctl: 0x0000540b [ 37.139687] 546 ms: 96 [ 37.188573] 49 ms: 99 [ 37.200407] 12 ms: 99 [ 37.457117] bcm45208(0): enabled diseqc and wfe 0 [ 37.468692] bcm45208(0): in normal mode now [ 37.469191] bcm45208(0): rf input 0 used [ 37.473393] bcm45208(0): voltage(0) is now 18V [ 37.476179] start PCR0 on dmx 0 pid:ff index 3 [ 37.477097] start AUDIO0 on dmx 0 pid:103 index 1 [ 37.477693] audio ch0: xpt start [ 37.478087] audio ch0: reset GA threshold to 8ms [ 37.478630] sync0 is off so we enable it [ 37.479093] sync0: allocated pcroffset 0 [ 37.479553] sync0: demux-index 0 pcr pid ff [ 37.480078] sync0: using 3 as pcr pidchannel [ 37.480636] audio ch0: AC3 [ 37.480952] audio ch0: streamtype set 1 [ 37.481408] audio ch0: streamtype_set: stop rave [ 37.481962] audio ch0: AC3 supported [ 37.482383] audio ch0: passthru [ 37.482769] audio ch0: add compressed input to mixer SPDIF [ 37.483426] audio ch0: add compressed input to mixer MAI [ 37.484083] audio ch0: mai sample rate changed isr (48000) [ 37.484725] audio ch0: streamtype_set: restart rave [ 37.485509] audio ch0: decoder start [ 37.485941] audio ch0: video delay 0 (0 ms) [ 37.486439] VIDEO0: total delay: 0 (0 ms) [ 37.487532] VIDEO0: set streamtype! [ 37.487945] -> set H264 [ 37.488291] -> sw rave disabled! [ 37.488726] audio ch0 delay 18000 (200 ms) [ 37.489210] VIDEO0: total delay: 18000 (200 ms) [ 37.489847] start VIDEO0 on dmx 0 pid:ff index 3 [ 37.490420] VIDEO0: total delay: 18000 (200 ms) [ 37.495960] VIDEO0: start decode [ 37.505284] HDMI: CEC returned state 3 [ 37.505736] HDMI: CEC state now 803 [ 41.423391] audio ch0: first pts 0x1ddf7215c, stc 0x1ddf70486, pcr valid [ 41.453821] audio ch0: lock [ 41.454190] audio ch0: sample rate changed isr (48000) [ 41.749680] audio ch0: status ready isr [ 42.583528] VIDEO0: first pts 0x1ddf97e0c [ 42.584035] VIDEO0: resolution changed (1920 1080) [ 42.584594] VIDEO0: progressive changed (0) [ 42.733311] VIDEO0: enable tsm