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=0000037d(893) temperature=0000ba60(47712) PV=00000342(834) MV=00000380(896) 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.892V, T=+48.686C, PV=0.834V, MV=0.896V, 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.000235] Console: colour dummy device 80x30 [ 0.000256] Calibrating delay loop (skipped), value calculated using timer frequency.. 54.00 BogoMIPS (lpj=27000) [ 0.000265] pid_max: default: 32768 minimum: 301 [ 0.000358] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes) [ 0.000364] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes) [ 0.005888] Initializing cgroup subsys devices [ 0.005903] Initializing cgroup subsys freezer [ 0.005910] Initializing cgroup subsys net_cls [ 0.005939] CPU: Testing write buffer coherency: ok [ 0.006151] CPU0: update cpu_power 1024 [ 0.006158] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000 [ 0.006210] Setting up static identity map for 0x5d5ab8 - 0x5d5b10 [ 0.007446] CPU1: Booted secondary processor [ 0.007465] CPU1: update cpu_power 1024 [ 0.007468] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001 [ 0.007540] Brought up 2 CPUs [ 0.007550] SMP: Total of 2 processors activated (108.00 BogoMIPS). [ 0.007554] CPU: All CPU(s) started in SVC mode. [ 0.007944] devtmpfs: initialized [ 0.011537] VFP support v0.3: implementor 42 architecture 4 part 00 variant 0 rev 0 [ 0.012108] regulator-dummy: no parameters [ 0.012276] NET: Registered protocol family 16 [ 0.013200] DMA: preallocated 2048 KiB pool for atomic coherent allocations [ 0.013392] cpuidle: using governor ladder [ 0.013397] cpuidle: using governor menu [ 0.014538] irq: no irq domain found for /rdb/interrupt-controller@f040a700 ! [ 0.014622] irq: no irq domain found for /rdb/interrupt-controller@f0417380 ! [ 0.016316] syscon f0404000.syscon: regmap [mem 0xf0404000-0xf0404523] registered [ 0.016388] syscon f03e2400.syscon: regmap [mem 0xf03e2400-0xf03e27ff] registered [ 0.016454] syscon f0452000.syscon: regmap [mem 0xf0452000-0xf04520ff] registered [ 0.016517] syscon f0404100.syscon: regmap [mem 0xf0404100-0xf040415b] registered [ 0.016580] syscon f040415c.syscon: regmap [mem 0xf040415c-0xf040419b] registered [ 0.016647] syscon f0410700.syscon: regmap [mem 0xf0410700-0xf041070b] registered [ 0.016713] syscon f041070c.syscon: regmap [mem 0xf041070c-0xf0410713] registered [ 0.016774] syscon f1101004.syscon: regmap [mem 0xf1101004-0xf1101403] registered [ 0.016836] syscon f1181004.syscon: regmap [mem 0xf1181004-0xf1181403] registered [ 0.016905] syscon f0404080.syscon: regmap [mem 0xf0404080-0xf0404083] registered [ 0.016970] syscon f04040a4.syscon: regmap [mem 0xf04040a4-0xf04040a7] registered [ 0.017031] syscon f03e0154.syscon: regmap [mem 0xf03e0154-0xf03e0157] registered [ 0.017093] syscon f03e0354.syscon: regmap [mem 0xf03e0354-0xf03e0357] registered [ 0.017174] syscon f03e0400.syscon: regmap [mem 0xf03e0400-0xf03e0403] registered [ 0.017478] irq: no irq domain found for /rdb/interrupt-controller@f0417380 ! [ 0.017705] Broadcom Brahma-B15 readahead cache at: 0xfc3e2478 [ 0.022067] bio: create slab at 0 [ 0.022375] brcmstb-gpio f040a600.gpio: Couldn't get IRQ. Enable CONFIG_BCM7120_L2_IRQ if you want GPIO interrupt support [ 0.022400] brcmstb-gpio f040a600.gpio: Registered 5 banks (GPIO(s): 0-159) [ 0.022429] brcmstb-gpio f0417400.gpio: Couldn't get IRQ. Enable CONFIG_BCM7120_L2_IRQ if you want GPIO interrupt support [ 0.022442] brcmstb-gpio f0417400.gpio: Registered 2 banks (GPIO(s): 160-223) [ 0.022793] SCSI subsystem initialized [ 0.023012] usbcore: registered new interface driver usbfs [ 0.023042] usbcore: registered new interface driver hub [ 0.023102] usbcore: registered new device driver usb [ 0.023122] media: Linux media interface: v0.10 [ 0.023147] Linux video capture interface: v2.00 [ 0.023201] pps_core: LinuxPPS API ver. 1 registered [ 0.023205] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.023216] PTP clock support registered [ 0.023438] Advanced Linux Sound Architecture Driver Initialized. [ 0.023721] Bluetooth: Core ver 2.18 [ 0.023736] NET: Registered protocol family 31 [ 0.023739] Bluetooth: HCI device and connection manager initialized [ 0.023746] Bluetooth: HCI socket layer initialized [ 0.023753] Bluetooth: L2CAP socket layer initialized [ 0.023759] Bluetooth: SCO socket layer initialized [ 0.024151] Switched to clocksource arch_sys_counter [ 0.024162] cfg80211: Calling CRDA to update world regulatory domain [ 0.028501] thermal thermal_zone0: failed to read out thermal zone 0 [ 0.028586] NET: Registered protocol family 2 [ 0.028986] TCP established hash table entries: 2048 (order: 1, 8192 bytes) [ 0.029001] TCP bind hash table entries: 2048 (order: 2, 16384 bytes) [ 0.029023] TCP: Hash tables configured (established 2048 bind 2048) [ 0.029054] TCP: reno registered [ 0.029061] UDP hash table entries: 256 (order: 1, 8192 bytes) [ 0.029072] UDP-Lite hash table entries: 256 (order: 1, 8192 bytes) [ 0.029199] NET: Registered protocol family 1 [ 0.029425] RPC: Registered named UNIX socket transport module. [ 0.029429] RPC: Registered udp transport module. [ 0.029433] RPC: Registered tcp transport module. [ 0.029436] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.030043] futex hash table entries: 512 (order: 3, 32768 bytes) [ 0.030396] bounce pool size: 64 pages [ 0.030911] NFS: Registering the id_resolver key type [ 0.030948] Key type id_resolver registered [ 0.030953] Key type id_legacy registered [ 0.030964] nfs4filelayout_init: NFSv4 File Layout Driver Registering... [ 0.031097] SGI XFS with ACLs, security attributes, realtime, large block/inode numbers, no debug enabled [ 0.031410] msgmni has been set to 462 [ 0.032162] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) [ 0.032169] io scheduler noop registered [ 0.032187] io scheduler cfq registered (default) [ 0.032413] brcm-gisb-arb f0400000.gisb-arb: registered mem: fc400000, irqs: 258, 259 [ 0.032693] brcm-usb-phy f0470200.usb-phy: USB3.0 clock not found in Device Tree [ 0.098433] brcmstb_memc f1102000.memc-ddr: registered [ 0.098459] brcmstb_memc f1182000.memc-ddr: registered [ 0.098657] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled [ 0.099471] f040a900.serial: ttyS0 at MMIO 0xf040a900 (irq = 107, base_baud = 5062500) is a 16550A [ 0.196084] console [ttyS0] enabled [ 0.197329] loop: module loaded [ 0.197970] ahci brcmstb-ahci.0: can't get clock [ 0.198587] ahci brcmstb-ahci.0: SSS flag set, parallel bus scan disabled [ 0.210166] ahci brcmstb-ahci.0: AHCI 0001.0300 32 slots 2 ports 6 Gbps 0x3 impl platform mode [ 0.211162] ahci brcmstb-ahci.0: flags: 64bit ncq sntf stag pm clo pmp slum part [ 0.213799] scsi0 : ahci_platform [ 0.214436] scsi1 : ahci_platform [ 0.214941] ata1: SATA max UDMA/133 mmio [mem 0xf045a000-0xf045aa9b] port 0x100 irq 91 [ 0.215858] ata2: SATA max UDMA/133 mmio [mem 0xf045a000-0xf045aa9b] port 0x180 irq 91 [ 0.217295] spi_brcmstb f03e3400.spi: 1-lane output, 3-byte address [ 0.218064] spi_brcmstb f03e3400.spi: master is unqueued, this is deprecated [ 0.219204] m25p80 spi32766.0: found mx25l25635e, expected m25p80 [ 0.219912] spi_brcmstb f03e3400.spi: 1-lane output, 4-byte address [ 0.220647] m25p80 spi32766.0: mx25l25635e (32768 Kbytes) [ 0.221294] 5 ofpart partitions found on MTD device spi32766.0 [ 0.221964] Creating 5 MTD partitions on "spi32766.0": [ 0.222563] 0x000000000000-0x000000200000 : "flash0.bolt" [ 0.223656] 0x000000200000-0x000000220000 : "flash0.nvram" [ 0.224694] 0x000000220000-0x000000240000 : "flash0.devtree" [ 0.225752] 0x000000240000-0x000001000000 : "flash0.recovery" [ 0.226823] 0x000000000000-0x000002000000 : "flash0" [ 0.228092] libphy: Fixed MDIO Bus: probed [ 0.228693] tun: Universal TUN/TAP device driver, 1.6 [ 0.229281] tun: (C) 1999-2004 Max Krasnyansky [ 0.230313] bcmgenet f0b00000.ethernet: GENET 4.5 EPHY: 0x1001 [ 0.244157] libphy: bcmgenet MII bus: probed [ 0.265031] xhci-brcm: xHCI BRCM driver [ 0.265557] xhci-brcm f0471000.xhci_v2: xHCI Host Controller [ 0.266229] xhci-brcm f0471000.xhci_v2: new USB bus registered, assigned bus number 1 [ 0.267413] xhci-brcm f0471000.xhci_v2: irq 149, io mem 0xf0471000 [ 0.268256] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 0.269035] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 0.269872] usb usb1: Product: xHCI Host Controller [ 0.270439] usb usb1: Manufacturer: Linux 3.14-1.17-dm900 xhci-hcd [ 0.271154] usb usb1: SerialNumber: f0471000.xhci_v2 [ 0.272037] hub 1-0:1.0: USB hub found [ 0.272504] hub 1-0:1.0: config failed, hub doesn't have any ports! (err -19) [ 0.273437] xhci-brcm f0471000.xhci_v2: xHCI Host Controller [ 0.274095] xhci-brcm f0471000.xhci_v2: new USB bus registered, assigned bus number 2 [ 0.275115] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003 [ 0.275909] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 0.276748] usb usb2: Product: xHCI Host Controller [ 0.277317] usb usb2: Manufacturer: Linux 3.14-1.17-dm900 xhci-hcd [ 0.278027] usb usb2: SerialNumber: f0471000.xhci_v2 [ 0.278872] hub 2-0:1.0: USB hub found [ 0.279333] hub 2-0:1.0: 2 ports detected [ 0.280105] ehci-brcm: EHCI BRCM driver [ 0.280630] ehci-brcm f0470300.ehci_v2: EHCI Host Controller [ 0.281298] ehci-brcm f0470300.ehci_v2: new USB bus registered, assigned bus number 3 [ 0.292312] ehci-brcm f0470300.ehci_v2: irq 145, io mem 0xf0470300 [ 0.298162] ehci-brcm f0470300.ehci_v2: USB 2.0 started, EHCI 1.00 [ 0.298970] usb usb3: New USB device found, idVendor=1d6b, idProduct=0002 [ 0.299758] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 0.300591] usb usb3: Product: EHCI Host Controller [ 0.301158] usb usb3: Manufacturer: Linux 3.14-1.17-dm900 ehci_hcd [ 0.301867] usb usb3: SerialNumber: f0470300.ehci_v2 [ 0.302714] hub 3-0:1.0: USB hub found [ 0.303172] hub 3-0:1.0: 1 port detected [ 0.303810] ehci-brcm f0470500.ehci_v2: EHCI Host Controller [ 0.304477] ehci-brcm f0470500.ehci_v2: new USB bus registered, assigned bus number 4 [ 0.315473] ehci-brcm f0470500.ehci_v2: irq 146, io mem 0xf0470500 [ 0.322157] ehci-brcm f0470500.ehci_v2: USB 2.0 started, EHCI 1.00 [ 0.322961] usb usb4: New USB device found, idVendor=1d6b, idProduct=0002 [ 0.323749] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 0.324584] usb usb4: Product: EHCI Host Controller [ 0.325151] usb usb4: Manufacturer: Linux 3.14-1.17-dm900 ehci_hcd [ 0.325859] usb usb4: SerialNumber: f0470500.ehci_v2 [ 0.326686] hub 4-0:1.0: USB hub found [ 0.327139] hub 4-0:1.0: 1 port detected [ 0.327838] ohci-brcm: OHCI BRCM driver [ 0.328339] ohci-brcm f0470400.ohci_v2: BRCM OHCI controller [ 0.328999] ohci-brcm f0470400.ohci_v2: new USB bus registered, assigned bus number 5 [ 0.329921] ohci-brcm f0470400.ohci_v2: irq 147, io mem 0xf0470400 [ 0.385275] usb usb5: New USB device found, idVendor=1d6b, idProduct=0001 [ 0.386055] usb usb5: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 0.386890] usb usb5: Product: BRCM OHCI controller [ 0.387457] usb usb5: Manufacturer: Linux 3.14-1.17-dm900 ohci_hcd [ 0.388172] usb usb5: SerialNumber: f0470400.ohci_v2 [ 0.389024] hub 5-0:1.0: USB hub found [ 0.389497] hub 5-0:1.0: 1 port detected [ 0.390160] ohci-brcm f0470600.ohci_v2: BRCM OHCI controller [ 0.390823] ohci-brcm f0470600.ohci_v2: new USB bus registered, assigned bus number 6 [ 0.391745] ohci-brcm f0470600.ohci_v2: irq 148, io mem 0xf0470600 [ 0.447261] usb usb6: New USB device found, idVendor=1d6b, idProduct=0001 [ 0.448042] usb usb6: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 0.448877] usb usb6: Product: BRCM OHCI controller [ 0.449444] usb usb6: Manufacturer: Linux 3.14-1.17-dm900 ohci_hcd [ 0.450160] usb usb6: SerialNumber: f0470600.ohci_v2 [ 0.450983] hub 6-0:1.0: USB hub found [ 0.451449] hub 6-0:1.0: 1 port detected [ 0.452140] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver [ 0.452900] ehci-pci: EHCI PCI platform driver [ 0.453453] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver [ 0.454174] ohci-pci: OHCI PCI platform driver [ 0.454801] usbcore: registered new interface driver usb-storage [ 0.455503] i2c /dev entries driver [ 0.455953] lirc_dev: IR Remote Control driver registered, major 250 [ 0.456996] brcmstb_thermal f04d1500.thermal: registered AVS TMON of-sensor driver [ 0.457975] usbcore: registered new interface driver btusb [ 0.458669] cpufreq_cpu0: failed to get cpu0 regulator: -19 [ 0.459487] brcmstb-cpufreq: probe of f03e257c.cpu-clk-div failed with error -17 [ 0.460415] sdhci: Secure Digital Host Controller Interface driver [ 0.461123] sdhci: Copyright(c) Pierre Ossman [ 0.461630] sdhci-pltfm: SDHCI platform and OF driver helper [ 0.463384] mmc0: no vqmmc regulator found [ 0.463858] mmc0: no vmmc regulator found [ 0.494162] mmc0: SDHCI controller on f03e0000.sdhci [f03e0000.sdhci] using ADMA [ 0.496065] mmc1: no vqmmc regulator found [ 0.496544] mmc1: no vmmc regulator found [ 0.527155] mmc1: SDHCI controller on f03e0200.sdhci [f03e0200.sdhci] using ADMA [ 0.528099] hidraw: raw HID events driver (C) Jiri Kosina [ 0.528811] usbcore: registered new interface driver usbhid [ 0.529458] usbhid: USB HID core driver [ 0.531893] TCP: cubic registered [ 0.532890] NET: Registered protocol family 10 [ 0.533885] NET: Registered protocol family 17 [ 0.534447] ata1: SATA link up 6.0 Gbps (SStatus 133 SControl 300) [ 0.534662] Bluetooth: RFCOMM TTY layer initialized [ 0.534671] Bluetooth: RFCOMM socket layer initialized [ 0.534672] Bluetooth: RFCOMM ver 1.11 [ 0.534676] Bluetooth: BNEP (Ethernet Emulation) ver 1.3 [ 0.534677] Bluetooth: BNEP filters: protocol multicast [ 0.534682] Bluetooth: BNEP socket layer initialized [ 0.534684] Bluetooth: HIDP (Human Interface Emulation) ver 1.2 [ 0.534688] Bluetooth: HIDP socket layer initialized [ 0.534739] l2tp_core: L2TP core driver, V2.0 [ 0.534765] Key type dns_resolver registered [ 0.534837] Registering SWP/SWPB emulation handler [ 0.535129] regulator-dummy: disabling [ 0.541960] ALSA device list: [ 0.542325] No soundcards found. [ 0.542948] Waiting for root device /dev/mmcblk0p2... [ 0.545526] ata1.00: ATA-10: lntenso SSD SATAIII, S1120A0, max UDMA/133 [ 0.546294] ata1.00: 2000409264 sectors, multi 1: LBA48 NCQ (depth 31/32) [ 0.554158] ata1.00: configured for UDMA/133 [ 0.554875] scsi 0:0:0:0: Direct-Access ATA lntenso SSD SATA S112 PQ: 0 ANSI: 5 [ 0.556348] sd 0:0:0:0: [sda] 2000409264 512-byte logical blocks: (1.02 TB/953 GiB) [ 0.557410] sd 0:0:0:0: [sda] Write Protect is off [ 0.558016] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA [ 0.566605] sda: sda1 sda2 [ 0.567651] sd 0:0:0:0: [sda] Attached SCSI disk [ 0.602796] mmc1: BKOPS_EN bit is not set [ 0.609501] mmc1: new high speed MMC card at address 0001 [ 0.610329] mmcblk0: mmc1:0001 4FPD3R 3.64 GiB [ 0.610954] mmcblk0boot0: mmc1:0001 4FPD3R partition 1 4.00 MiB [ 0.611727] mmcblk0boot1: mmc1:0001 4FPD3R partition 2 4.00 MiB [ 0.612493] mmcblk0rpmb: mmc1:0001 4FPD3R partition 3 512 KiB [ 0.616117] mmcblk0: p1 p2 p3 [ 0.618601] mmcblk0boot1: unknown partition table [ 0.619632] mmcblk0boot0: unknown partition table [ 0.649281] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null) [ 0.650245] VFS: Mounted root (ext4 filesystem) readonly on device 179:2. [ 0.652376] devtmpfs: mounted [ 0.667175] ata2: SATA link down (SStatus 0 SControl 300) [ 0.769491] random: systemd: uninitialized urandom read (16 bytes read, 59 bits of entropy available) [ 0.774136] 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.776465] systemd[1]: Detected architecture arm. Welcome to opendreambox 2.5.0! [ 0.779689] systemd[1]: Set hostname to . [ 0.792946] random: systemd: uninitialized urandom read (16 bytes read, 64 bits of entropy available) [ 0.808708] systemd-fstab-generator[75]: Checking was requested for "rootfs", but it is not a device. [ 0.811636] random: systemd-sysv-ge: uninitialized urandom read (16 bytes read, 65 bits of entropy available) [ 0.815540] random: systemd-sysv-ge: uninitialized urandom read (16 bytes read, 65 bits of entropy available) [ 0.822801] random: systemd: uninitialized urandom read (16 bytes read, 67 bits of entropy available) [ 0.823973] random: systemd: uninitialized urandom read (16 bytes read, 67 bits of entropy available) [ 0.825307] random: systemd: uninitialized urandom read (16 bytes read, 67 bits of entropy available) [ 0.826503] random: systemd: uninitialized urandom read (16 bytes read, 67 bits of entropy available) [ 0.827778] random: systemd: uninitialized urandom read (16 bytes read, 67 bits of entropy available) [ 0.833551] random: systemd: uninitialized urandom read (16 bytes read, 70 bits of entropy available) [ 0.903331] systemd[1]: Created slice System Slice. [ OK ] Created slice System Slice. [ 0.906400] systemd[1]: Listening on Journal Socket. [ OK ] Listening on Journal Socket. [ 0.911913] systemd[1]: Starting Load Kernel Modules... Starting Load Kernel Modules... [ 0.913447] systemd[1]: Listening on Journal Socket (/dev/log). [ OK ] Listening on Journal Socket (/dev/log). [ 0.917832] systemd[1]: Starting Remount Root and Kernel File Systems... Starting Remount Root and Kernel File Systems... [ 0.921408] systemd[1]: Reached target Paths. [ OK ] Reached target Paths. [ 0.924389] systemd[1]: Reached target Swap. [ OK ] Reached target Swap. [ 0.927549] systemd[1]: Listening on udev Control Socket. [ OK ] Listening on udev Control Socket. [ 0.931816] systemd[1]: Mounting POSIX Message Queue File System... [ 0.933457] stb_core: module license 'Proprietary' taints kernel. [ 0.934183] Disabling lock debugging due to kernel taint Mounting POSIX Message Queue File System... [ 0.948200] input: dreambox remote control (native) as /devices/virtual/input/input0 [ 0.949295] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null) [ 0.949665] input: dreambox advanced remote control (native) as /devices/virtual/input/input1 [ 0.951606] systemd[1]: Created slice system-serial\x2dgetty.slice. [ OK ] Created slice system-serial\x2dgetty.slice. [ 0.955097] systemd[1]: Created slice User and Session Slice. [ OK ] Created slice User and Session Slice. [ 0.958340] systemd[1]: Reached target Slices. [ OK ] Reached target Slices. [ 0.962697] systemd[1]: Starting Setup Virtual Console... Starting Setup Virtual Console... [ 0.971118] 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.974442] systemd[1]: Listening on udev Kernel Socket. [ OK ] Listening on udev Kernel Socket. [ 0.978399] systemd[1]: Reached target Host and Network Name Lookups. [ OK ] Reached target Host and Network Name Lookups. [ 0.982705] systemd[1]: Starting Generate environment for enigma2... Starting Generate environment for enigma2... [ 0.987716] systemd[1]: Starting Journal Service... Starting Journal Service... [ 0.994808] systemd[1]: Set up automount data.automount. [ OK ] Set up automount data.automount. [ 1.002432] systemd[1]: Mounted POSIX Message Queue File System. [ OK ] Mounted POSIX Message Queue File System. [ 1.006255] systemd[1]: Started Remount Root and Kernel File Systems. [ OK ] Started Remount Root and Kernel File Systems. [ 1.009875] systemd[1]: Started Setup Virtual Console. [ OK ] Started Setup Virtual Console. [ 1.012792] 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.019200] systemd[1]: Starting Create Static Device Nodes in /dev... Starting Create Static Device Nodes in /dev... [ 1.055664] systemd[1]: Starting udev Coldplug all Devices... Starting udev Coldplug all Devices... [ 1.225984] bcm7439: xvd 20160630, vdc 20160630, rap 20160630, xpt 20160630, driver version 20200226-dm900 [ 1.247206] systemd[1]: Started Create Static Device Nodes in /dev. [ OK ] Started Create Static Device Nodes in /dev. [ 1.250614] systemd[1]: Reached target Local File Systems (Pre). [ OK ] Reached target Local File Systems (Pre). [ 1.254234] random: nonblocking pool is initialized [ 1.255230] systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. [ 1.257264] systemd[1]: Mounting /tmp... Mounting /tmp... [ 1.260363] systemd[1]: Mounting /var/volatile... Mounting /var/volatile... [ 1.264547] systemd[1]: Starting udev Kernel Device Manager... Starting udev Kernel Device Manager... [ 1.268079] systemd[1]: Started udev Coldplug all Devices. [ OK ] Started udev Coldplug all Devices. [ 1.276806] systemd[1]: Mounted /tmp. [ OK ] Mounted /tmp. [ 1.279884] systemd[1]: Mounted /var/volatile. [ OK ] Mounted /var/volatile. [ 1.282942] systemd[1]: Starting Load/Save Random Seed... Starting Load/Save Random Seed... [ 1.286337] systemd[1]: Reached target Local File Systems. [ OK ] Reached target Local File Systems. [ 1.290588] systemd[1]: Started GeminiSpinner. [ OK ] Started GeminiSpinner. [ 1.295683] systemd[1]: Started Load/Save Random Seed. [ OK ] Started Load/Save Random Seed. [ 1.344758] systemd[1]: Started Journal Service. [ OK ] Started Journal Service. Starting Flush Journal to Persistent Storage... [ OK ] Started Generate environment for enigma2. [ 1.413894] systemd-journald[97]: Received request to flush runtime journal from PID 1 [ OK ] Started Flush Journal to Persistent Storage. Starting Create Volatile Files and Directories... [ OK ] Started udev Kernel Device Manager. [ OK ] Started Create Volatile Files and Directories. Starting RPC bind portmap service... Starting Update UTMP about System Boot/Shutdown... [ OK ] Started RPC bind portmap service. [ OK ] Found device /dev/ttyS0. [ OK ] Started Update UTMP about System Boot/Shutdown. [ OK ] Found device lntenso_SSD_SATAIII dreambox-storage. Mounting /media/hdd... [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. [ 1.834333] EXT4-fs (sda1): mounted filesystem with ordered data mode. Opts: discard [ 1.843580] 1:842435625 SMCB: controller reset timed out [ OK ] Mounted /media/hdd. [ OK ] Found device /dev/sci0. [ 2.200597] register adapter [ 2.201229] register adapter [ 2.202277] register adapter [ 2.202836] register adapter [ 2.204623] register adapter [ 2.207749] fp: uart recv error 98 [ 2.208253] swd: status is 0, pls check [ 2.208704] swd: cannot init port [ 2.209089] ble module not found [ 2.209642] input: dreambox front panel as /devices/virtual/input/input2 [ 2.210973] OFFSET 1606406968 26180097 [ 2.211434] WKTMR 617 24392904 [ 2.211791] LAST WKTMR 590 [ 2.212130] set system time to 1606407586:872201 [ 2.212945] HDMI: CEC start ... state is now 1 [ 2.214520] set input to 0 [ 2.214840] set fb to 2(-1) [ 2.217105] startvideomode '1080p50' read from /etc/videomode [ 2.218096] bcmfb: creating surface with pixel format 0x07e48888 (BPXL_eA8_R8_G8_B8) [ 2.286115] HDMI: now connected [ 2.314499] HDMI: CEC Physical Addr 1.2.0.0 set from EDID [ 2.315121] HDMI: EDID read ok [ 2.315492] HDMI: initial mode set! [ 2.315898] using 50.00Hz as MonitorRefreshRate [ 2.316432] SET FORMAT: display[0], format='1080p50' [ 2.317010] HDMI mode [ 2.317284] use EDID to detect colorspace [ 2.317747] preferred colorspace: Itu_R_BT_709 [ 2.318265] using 8bit output [ 2.427247] HDMI: CEC use logical address 3 [ 2.427760] HDMI: CEC init completed... state is now 3! [ 2.567030] HDMI: CEC send ok! [ 2.725494] VIDEO0: enable deinterlacer [ 2.726052] VIDEO0: set fallback framerate to 60000 [ 2.726679] VIDEO0: set progressive override mode to 1 [ 2.727325] VIDEO0: set streamtype! [ 2.727731] -> set MPEG2 [ 2.728073] -> sw rave disabled! [ 2.812981] VIDEO1: set fallback framerate to 60000 [ 2.813580] VIDEO1: set progressive override mode to 1 [ 2.814190] VIDEO1: set streamtype! [ 2.814595] -> set MPEG2 [ 2.814937] -> sw rave disabled! [ 2.850917] VIDEO2: set fallback framerate to 60000 [ 2.851504] VIDEO2: set progressive override mode to 1 [ 2.852098] VIDEO2: set streamtype! [ 2.852572] -> set MPEG2 [ 2.852917] -> sw rave disabled! [ 2.866525] set ac3 to downmix [ 2.866891] set wmapro to downmix [ 2.867311] set ac3plus to use_hdmi_caps [ 2.867775] set dtshd to force_dts [ 2.868192] set aac to downmix [ 2.868886] audio ch2: add stereo (background decoder) input to mixer DUMMY2 [ 2.869868] audio ch1: add stereo (hdmi-rx) input to mixer DUMMY [ 2.870876] DVB: registering new adapter (BCM7439) [ OK ] Found device /dev/dvb/adapter0/ca0. [ OK ] Found device /dev/dvb/adapter0/demux0. [ 2.950071] autodetecting NIMs... [ 2.956232] Found: Slot 0, ID: 1e (by CA) [ 2.956704] Initializing adapter 0 (BCM45208-DVB-S2) [ 2.958081] bcm45208(0): chipid register is 45216 [ 2.960771] bcm45208(0): opening 8 sat channels (demods) [ 2.961426] (NULL device *): DVB: registering adapter 0 frontend 0 (BCM45208)... [ 2.962475] bcm45208(0): InitAP [ OK ] Found device /dev/dvb/adapter0/video0. [ 2.963647] Initializing adapter 1 (BCM45208-DVB-S2) [ 2.964325] (NULL device *): DVB: registering adapter 0 frontend 1 (BCM45208)... [ 2.966404] Initializing adapter 2 (BCM45208-DVB-S2) [ 2.967003] (NULL device *): DVB: registering adapter 0 frontend 2 (BCM45208)... [ 2.969074] Initializing adapter 3 (BCM45208-DVB-S2) [ 2.969712] (NULL device *): DVB: registering adapter 0 frontend 3 (BCM45208)... [ 2.971955] Initializing adapter 4 (BCM45208-DVB-S2) [ 2.972581] (NULL device *): DVB: registering adapter 0 frontend 4 (BCM45208)... Starting Dreambox Bootlogo... [ 2.976007] Initializing adapter 5 (BCM45208-DVB-S2) [ 2.976646] (NULL device *): DVB: registering adapter 0 frontend 5 (BCM45208)... [ 2.978032] Initializing adapter 6 (BCM45208-DVB-S2) [ 2.978656] (NULL device *): DVB: registering adapter 0 frontend 6 (BCM45208)... [ 2.981246] Initializing adapter 7 (BCM45208-DVB-S2) [ 2.981862] (NULL device *): DVB: registering adapter 0 frontend 7 (BCM45208)... [ OK ] Started Dreambox Bootlogo. [ 2.997346] init ALSA! [ 2.999966] VIDEO0: set blank to 0 [ 3.003596] sync0 is off so we enable it [ 3.003908] registered vtuner misc/vtuner0, minor 50 [ 3.003983] registered vtuner misc/vtuner1, minor 49 [ 3.004050] registered vtuner misc/vtuner2, minor 48 [ 3.004116] registered vtuner misc/vtuner3, minor 47 [ 3.004119] HDMI-RX: init [ 3.004972] HDMI-RX: no device attached [ 3.005026] HDMI-RX: video format change event [ 3.005028] HDMI-RX: hdmi packet status stopped [ 3.005031] HDMI-RX: hdmiInput0 Receiving DVI format [ 3.005033] HDMI-RX: hdmiInput0 Color Space change from '' to '' [ 3.005060] HDMI-RX: init done [ 3.005062] bcm_vce_init() [ 3.005063] bcm_vce_init() 0 [ 3.008828] CI stopped... [ 3.010772] sync0: allocated pcroffset 0 [ 3.011348] sync0: playback! [ 3.011722] VIDEO0: total delay: 0 (0 ms) [ OK ] Reached target Sound Card. [ 3.025114] VIDEO0: start decode [ 3.025666] VIDEO0: flush video decoder [ 3.026130] VIDEO0 got pts failed !!!! (ret 0) [ 3.028100] vice0: allocate output buffers [ 3.032933] input: dreambox ir keyboard as /devices/virtual/input/input3 [ 3.034307] input: dreambox ir mouse as /devices/virtual/input/input4 [ 3.037755] ble init (0) [ 3.038453] input: dreambox remote control (bluetooth le) as /devices/virtual/input/input5 [ 3.047625] fuse init (API version 7.22) [ 3.052538] VIDEO0: first pts 0x0 [ 3.052945] VIDEO0: EOTF changed to SDR [ 3.053406] VIDEO0: framerate changed 3 [ 3.053850] VIDEO0: resolution changed (1280 720) [ 3.054398] VIDEO0: aspect changed 3 [ 3.054956] set current avs auto aspect to 16:9 [ 3.055535] set current avs auto aspect to 16:9 [ 3.056097] set sb to 3(1) [ 3.065888] Installing knfsd (copyright (C) 1996 okir@monad.swb.de). [ OK ] Started Load Kernel Modules. Starting Apply Kernel Variables... Mounting NFSD configuration filesystem... Mounting FUSE Control File System... [ OK ] Mounted NFSD configuration filesystem. [ OK ] Mounted FUSE Control File System. [ OK ] Started Apply Kernel Variables. [ OK ] Reached target System Initialization. [ OK ] Listening on dbttcd.socket. [ OK ] Listening on tpmd.socket. [ OK ] Listening on dccamd.socket. [ OK ] Listening on dreamliveserver.socket. [ OK ] Started Daily Cleanup of Temporary Directories. [ OK ] Reached target Timers. [ OK ] Listening on Avahi mDNS/DNS-SD Stack Activation Socket. [ OK ] Listening on vsftpd.socket. [ OK ] Listening on streamproxy.socket. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Listening on busybox-telnetd.socket. [ OK ] Listening on dropbear.socket. [ OK ] Reached target Sockets. [ OK ] Reached target Basic System. Starting dbttcd.service... Starting Login Service... [ OK ] Started D-Bus System Message Bus. [ 3.184724] VIDEO0: stop decode [ 3.185110] sync0 1fff no decoder left in sync handling so disable [ 3.185891] sync0: was last pcroffset0 user so free it Starting Connection service... [ OK ] Started Serial Getty on ttyS0. [ OK ] Reached target Login Prompts. Starting Avahi mDNS/DNS-SD Stack... Starting dccamd.service... Starting tpmd.service... Starting enigma2... [ OK ] Started Login Service. [ OK ] Started Avahi mDNS/DNS-SD Stack. [ OK ] Started Connection service. [ OK ] Reached target Network. [ OK ] Started LPD. [ OK ] Started NFS status monitor for NFSv2/3 locking.. [ OK ] Started NFS Mount Daemon. Starting NFS server and services... Starting Samba NMB Daemon... Starting Wait for network to be configured by ConnMan... [ 3.461972] usbcore: registered new interface driver usblp [ 3.499070] NFSD: Using /var/lib/nfs/v4recovery as the NFSv4 state recovery directory [ 3.502762] NFSD: starting 90-second grace period (net c07f9700) [ OK ] Started NFS server and services. Starting WPA supplicant... Starting Hostname Service... [ 3.623171] f0b00000.etherne:01: Broadcom BCM7439 (2) PHY revision: 0x10, patch: 1 [ 3.625989] f0b00000.ethernet: configuring instance for internal PHY [ 3.626850] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [ OK ] Started tpmd.service. [ OK ] Started Hostname Service. [ OK ] Started WPA supplicant. [ OK ] Started dbttcd.service. [ OK ] Stopped LPD. [ OK ] Started LPD. [ 5.629277] libphy: f0b00000.etherne:01 - Link is Down [ OK ] Stopped LPD. [ OK ] Started LPD. [ 7.242265] libphy: f0b00000.etherne:01 - Link is Up - 1000/Full [ 7.242998] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ OK ] Started Wait for network to be configured by ConnMan. [ OK ] Stopped LPD. [ OK ] Started LPD. [ OK ] Reached target Network is Online. Starting Automounts filesystems on demand... [ OK ] Started Automounts filesystems on demand. opendreambox 2.5.0 dm900 ttyS0 dm900 login: [ 10.302694] bcm45208(0): Info Id: 6 Type: 0 Version: 11.2 [ 10.324339] bcm45208(0): FW Id: 5 Type: 0 Version 1.8 [ 10.325711] bcm45208(0): opening 2 wfe channels (input adcs) [ 10.326384] bcm45208(0): opening 2 dsq channels (DiSEqC) [ 10.326998] bcm45208(0): init lnb_ctrl 0 [ 10.327785] bcm45208(0): init lnb_ctrl 1 [ 10.382090] bcm45208(0): init MTSIF [ 10.926884] bcm45208(0): enabled diseqc and wfe 0 [ 10.938372] bcm45208(0): in normal mode now [ 10.938868] bcm45208(0): rf input 0 used [ 10.974688] bcm45208(1): in normal mode now [ 10.975196] bcm45208(1): rf input 0 used [ 11.134423] bcm45208(0): sleeping now [ 11.164698] bcm45208(1): disabled diseqc and wfe 0 [ 11.176253] bcm45208(1): sleeping now [ 11.198728] bcm45208(2): enabled diseqc and wfe 0 [ 11.210219] bcm45208(2): in normal mode now [ 11.210701] bcm45208(2): rf input 0 used [ 11.241980] bcm45208(2): disabled diseqc and wfe 0 [ 11.253511] bcm45208(2): sleeping now [ 11.275717] bcm45208(3): enabled diseqc and wfe 0 [ 11.287189] bcm45208(3): in normal mode now [ 11.287691] bcm45208(3): rf input 0 used [ 11.318644] bcm45208(3): disabled diseqc and wfe 0 [ 11.330163] bcm45208(3): sleeping now [ 11.351627] bcm45208(4): enabled diseqc and wfe 0 [ 11.363099] bcm45208(4): in normal mode now [ 11.363580] bcm45208(4): rf input 0 used [ 11.394623] bcm45208(4): disabled diseqc and wfe 0 [ 11.406121] bcm45208(4): sleeping now [ 11.428545] bcm45208(5): enabled diseqc and wfe 0 [ 11.440030] bcm45208(5): in normal mode now [ 11.440512] bcm45208(5): rf input 0 used [ 11.471667] bcm45208(5): disabled diseqc and wfe 0 [ 11.483153] bcm45208(5): sleeping now [ 11.503896] bcm45208(6): enabled diseqc and wfe 0 [ 11.515401] bcm45208(6): in normal mode now [ 11.515894] bcm45208(6): rf input 0 used [ 11.546915] bcm45208(6): disabled diseqc and wfe 0 [ 11.558446] bcm45208(6): sleeping now [ 11.580507] bcm45208(7): enabled diseqc and wfe 0 [ 11.592010] bcm45208(7): in normal mode now [ 11.592493] bcm45208(7): rf input 0 used [ 11.602714] HDMI: CEC device open ... state is 3, flushed 0 old messages from RX fifo [ 11.603732] HDMI: CEC set devtype to 0 [ 11.604171] HDMI: CEC start ... state is now 1 [ 11.604723] HDMI: CEC returned state 1 [ 11.605172] HDMI: CEC state now 801 [ 11.638696] bcm45208(7): disabled diseqc and wfe 0 [ 11.650370] bcm45208(7): sleeping now [ 11.667616] HDMI: CEC use logical address 3 [ 11.668118] HDMI: CEC init completed... state is now 3! [ 11.692325] bcmfb: creating surface with pixel format 0x07c68888 (BPXL_eA8_B8_G8_R8) [ 11.804397] HDMI: CEC send ok! [ 12.437603] 0 ms: [ 12.471216] 34 ms: 0 [ 12.482859] 11 ms: 0 [ 12.486800] 3 ms: 0 [ 12.787523] 301 ms: 0 [ 12.816421] 29 ms: 2 [ 12.822528] 6 ms: 2 [ 12.823621] 1 ms: 2 [ 12.833843] 10 ms: 2 [ 12.982061] 148 ms: 2 [ 13.002206] 20 ms: 3 [ 13.005123] 3 ms: 3 [ 13.006304] 1 ms: 3 [ 13.007450] 1 ms: 3 [ 13.491654] 485 ms: 3 [ 13.494715] 3 ms: 6 [ 19.683211] 6191 ms: 7 [ 19.687358] 3 ms: 48 [ 19.704889] 17 ms: 48 [ 19.755187] 50 ms: 48 [ 19.756894] 1 ms: 48 [ 19.761095] 4 ms: 48 [ 19.762811] 2 ms: 48 [ 19.763979] 1 ms: 48 [ 19.768780] 5 ms: 48 [ 19.773105] 4 ms: 48 [ 19.829263] change audioenc bitrate to 256000 bits/s [ 19.831756] vice0: change videoenc bitrate to 6000000 bits/s [ 19.832549] change audioenc bitrate to 128000 bits/s [ 19.847631] vice0: change gop length to 0ms [ 19.848120] vice0: allow new gop on new scene off [ 19.848792] vice0: change open gop to off [ 19.849259] vice0: change p-frames to 4 [ 19.849819] vice0: change b-frames to 2 [ 19.850264] vice0: change to 0 slices per pic [ 19.851017] vice0: change h264 profile to main [ 19.851620] vice0: change h264 level to 3.1 [ 19.942972] EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Opts: (null) [ 19.965223] 192 ms: 48 [ 19.966569] 1 ms: 50 [ 19.969910] 3 ms: 50 [ 19.976451] 7 ms: 50 [ 20.034746] 58 ms: 50 [ 20.039184] 4 ms: 50 [ 20.040230] 0 ms: 50 [ 20.041564] 1 ms: 50 [ 20.044929] 3 ms: 50 [ 20.046041] 1 ms: 50 [ 20.056707] 10 ms: 50 [ 21.036937] 981 ms: 50 [ 21.057089] 20 ms: 57 [ 21.058309] 1 ms: 57 [ 21.071686] 13 ms: 57 [ 21.072879] 1 ms: 57 [ 21.074191] 1 ms: 57 [ 21.076670] 2 ms: 57 [ 21.080211] 3 ms: 57 [ 21.088174] 8 ms: 57 [ 21.089461] 1 ms: 57 [ 21.154056] bcmfb: creating surface with pixel format 0x07c68888 (BPXL_eA8_B8_G8_R8) [ 21.211311] 122 ms: 57 [ 21.304878] 94 ms: 58 [ 21.307770] set input to 0 [ 21.308090] set fb to 2(-1) [ 21.308418] set current avs auto aspect to 16:9 [ 21.308991] set sb to 3(1) [ 21.310143] set ac3 to passthrough [ 21.311062] set ac3plus to use_hdmi_caps [ 21.346266] using 50.00Hz as MonitorRefreshRate [ 21.346816] VIDEO1: shared window not available [ 21.347365] SET FORMAT: display[0], format='1080p50' [ 21.347972] HDMI mode [ 21.348239] use EDID to detect colorspace [ 21.348712] preferred colorspace: Itu_R_BT_709 [ 21.349284] using 8bit output [ 21.466217] VIDEO1: shared window not available [ 21.466790] set current avs auto aspect to 16:9 [ 21.467341] set sb to 3(1) [ 21.566239] using 50.00Hz as MonitorRefreshRate [ 21.566783] VIDEO1: shared window not available [ 21.567331] SET FORMAT: display[0], format='1080p50' [ 21.567936] HDMI mode [ 21.568204] use EDID to detect colorspace [ 21.568676] preferred colorspace: Itu_R_BT_709 [ 21.569255] using 8bit output [ 21.686221] VIDEO1: shared window not available [ 21.686796] set current avs auto aspect to 16:9 [ 21.687346] set sb to 3(1) [ 21.688086] 383 ms: 59 [ 21.691371] 3 ms: 61 [ 21.694897] 3 ms: 61 [ 21.738906] 44 ms: 61 [ 21.742644] 4 ms: 62 [ 24.355063] set ac3 to hdmi_best [ 24.355731] set ac3 to hdmi_best [ 24.356269] set ac3plus to use_hdmi_caps [ 24.356827] set dtshd to use_hdmi_caps [ 24.357409] set aac to hdmi_best [ 24.357893] set wmapro to multichannel [ 24.744106] set current avs auto aspect to 16:9 [ 24.744654] set sb to 3(1) [ 24.745208] set current avs auto aspect to 16:9 [ 24.745752] set sb to 3(1) [ 24.746210] set current avs auto aspect to 16:9 [ 24.746749] set sb to 3(1) [ 24.747658] set current avs auto aspect to 16:9 [ 24.748213] set sb to 3(1) [ 24.748602] set current avs auto aspect to 16:9 [ 24.749242] set sb to 3(1) [ 24.749657] set current avs auto aspect to 16:9 [ 24.750208] set sb to 3(1) [ 24.751065] set current avs auto aspect to 16:9 [ 24.751598] set sb to 3(1) [ 24.751999] set current avs auto aspect to 16:9 [ 24.752529] set sb to 3(1) [ 24.752904] set current avs auto aspect to 16:9 [ 24.753457] set sb to 3(1) [ 24.754283] set current avs auto aspect to 16:9 [ 24.754824] set sb to 3(1) [ 24.755254] set current avs auto aspect to 16:9 [ 24.755788] set sb to 3(1) [ 24.757127] set current avs auto aspect to 16:9 [ 24.757673] set sb to 3(1) [ 24.758114] set current avs auto aspect to 16:9 [ 24.758650] set sb to 3(1) [ 24.759045] set current avs auto aspect to 16:9 [ 24.759575] set sb to 3(1) [ 24.920051] systemd-fstab-generator[425]: Checking was requested for "rootfs", but it is not a device. [ 25.281561] 3540 ms: 62 [ 25.300517] 18 ms: 86 [ 26.214765] set mute 0 1 [ 26.729586] 1429 ms: 86 [ 27.280264] 551 ms: 96 [ 27.328057] 48 ms: 99 [ 27.339449] 11 ms: 99 [ 27.569603] bcm45208(0): enabled diseqc and wfe 0 [ 27.581126] bcm45208(0): in normal mode now [ 27.581635] bcm45208(0): rf input 0 used [ 27.586055] bcm45208(0): voltage(0) is now 18V [ 27.590606] dvb_demux_feed_del: feed not in list (type=0 state=0 pid=ffff) [ 27.591651] start PCR0 on dmx 0 pid:1ff index 2 [ 27.592386] start AUDIO0 on dmx 0 pid:200 index 1 [ 27.592958] audio ch0: xpt start [ 27.593338] audio ch0: reset GA threshold to 8ms [ 27.593888] sync0 is off so we enable it [ 27.594341] sync0: allocated pcroffset 0 [ 27.594809] sync0: demux-index 0 pcr pid 1ff [ 27.595309] sync0: using 2 as pcr pidchannel [ 27.595864] audio ch0: AC3+ [ 27.596192] audio ch0: streamtype set 4 [ 27.596646] audio ch0: streamtype_set: stop rave [ 27.597199] audio ch0: HDMI device supports DDP [ 27.597741] audio ch0: passthru [ 27.598107] audio ch0: add compressed4x input to mixer SPDIF [ 27.598782] audio ch0: add compressed4x input to mixer MAI [ 27.599422] audio ch0: mai sample rate changed isr (48000) [ 27.600089] audio ch0: streamtype_set: restart rave [ 27.600775] audio ch0: decoder start [ 27.601191] audio ch0: video delay 0 (0 ms) [ 27.601686] VIDEO0: total delay: 0 (0 ms) [ 27.602735] VIDEO0: set streamtype! [ 27.603145] -> set H265 [ 27.603478] -> sw rave disabled! [ 27.603930] audio ch0 delay 18000 (200 ms) [ 27.604404] VIDEO0: total delay: 18000 (200 ms) [ 27.605047] start VIDEO0 on dmx 0 pid:1ff index 2 [ 27.605635] VIDEO0: total delay: 18000 (200 ms) [ 27.611575] VIDEO0: start decode [ 27.621938] HDMI: CEC returned state 3 [ 27.622393] HDMI: CEC state now 803 [ 27.935551] 27:934378570 SMCB: invalid ioctl: 0x0000540b [ 28.312252] audio ch0: first pts 0x207935e4, stc 0x2078a172, pcr valid [ 28.342916] audio ch0: lock [ 28.343290] audio ch0: mai sample rate changed isr (192000) [ 28.343962] audio ch0: sample rate changed isr (48000) [ 28.909252] VIDEO0: first pts 0x207bd4ac [ 28.909744] VIDEO0: framerate changed 6 [ 28.910217] VIDEO0: resolution changed (3840 2160) [ 28.913911] set current avs auto aspect to 16:9 [ 28.914506] set sb to 3(1) [ 28.978865] audio ch0: status ready isr [ 29.018872] dvb_demux_feed_del: feed not in list (type=0 state=0 pid=ffff) [ 29.063870] VIDEO0: enable tsm [ 31.349234] VIDEO0: EOTF changed to eFuture/eAribStdB67 (HLG) [ 31.349234] MaxContentLightLevel: 0 [ 31.349234] MaxFrameAverageLightLevel: 0 [ 31.349234] WhitePoint: 0 0 [ 31.349234] MinDispMasteringLuma: 0 [ 31.349234] MaxDispMasteringLuma: 0 [ 31.349234] DisplayPrimaries: [ 31.349234] green -> 0 0 [ 31.349234] blue -> 0 0 [ 31.349234] red -> 0 0 [ 31.354498] HDMI: receiver does not support HLG (10bit) content or wrong videomode is configured, no DRMInfoFrame sent. Fallback to SDR.