=~=~=~=~=~=~=~=~=~=~=~= PuTTY log 2017.01.20 15:29:21 =~=~=~=~=~=~=~=~=~=~=~= Dreambox DM7 080 M0 M1 SHMOO 0 00000000 1 00000000 C do_boot . go .. [ 0.000000] Initializing cgroup subsys cpuset [ 0.000000] Initializing cgroup subsys cpu [ 0.000000] Linux version 3.4-4.0-dm7080 (dm7080@opendreambox.org) (gcc version 4.8.1 (GCC) ) #27 SMP Thu Dec 8 18:18:38 UTC 2016 [ 0.000000] Fetching vars from bootloader... none present, using defaults. [ 0.000000] Options: moca=0 sata=1 pcie=1 usb=1 [ 0.000000] Using 1024 MB + 1024 MB RAM (from CFE) [ 0.000000] bootconsole [early0] enabled [ 0.000000] CPU revision is: 00025b00 (Broadcom BMIPS5000) [ 0.000000] FPU revision is: 00130001 [ 0.000000] Determined physical RAM map: [ 0.000000] memory: 10000000 @ 00000000 (usable) [ 0.000000] memory: 30000000 @ 20000000 (usable) [ 0.000000] memory: 30000000 @ 90000000 (usable) [ 0.000000] bmem: adding 512 MB RESERVED region at 512 MB (0x20000000@0x20000000) [ 0.000000] Initrd not found or empty - disabling initrd [ 0.000000] Zone PFN ranges: [ 0.000000] Normal 0x00000000 -> 0x00050000 [ 0.000000] HighMem 0x00050000 -> 0x000c0000 [ 0.000000] Movable zone start PFN for each node [ 0.000000] Early memory PFN ranges [ 0.000000] 0: 0x00000000 -> 0x00010000 [ 0.000000] 0: 0x00020000 -> 0x00050000 [ 0.000000] 0: 0x00090000 -> 0x000c0000 [ 0.000000] PERCPU: Embedded 7 pages/cpu @81e12000 s6784 r8192 d13696 u32768 [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 452608 [ 0.000000] Kernel command line: bmem=512M@512M memc1=768M console=ttyS0,1000000 root=/dev/mmcblk0p1 rootwait rootfstype=ext4 [ 0.000000] PID hash table entries: 4096 (order: 2, 16384 bytes) [ 0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes) [ 0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes) [ 0.000000] Primary instruction cache 32kB, physically tagged, 4-way, linesize 64 bytes. [ 0.000000] Primary data cache 32kB, 4-way, linesize 32 bytes. [ 0.000000] MIPS secondary cache 512kB, 8-way, linesize 128 bytes. [ 0.000000] Memory: 1287712k/1048576k available (5915k kernel code, 547296k reserved, 1221k data, 256k init, 786432k highmem) [ 0.000000] Hierarchical RCU implementation. [ 0.000000] Additional per-CPU info printed with stalls. [ 0.000000] NR_IRQS:160 [ 0.000000] Measuring MIPS counter frequency... [ 0.000000] Detected MIPS clock frequency: 1407 MHz (175.877 MHz counter) [ 0.000000] Console: colour dummy device 80x25 [ 0.000000] Calibrating delay loop... 935.93 BogoMIPS (lpj=467968) [ 0.010000] pid_max: default: 32768 minimum: 301 [ 0.010000] Mount-cache hash table entries: 512 [ 0.011000] Initializing cgroup subsys cpuacct [ 0.012000] Initializing cgroup subsys devices [ 0.012000] Initializing cgroup subsys freezer [ 0.013000] SMP: Booting CPU1... [ 0.014000] Primary instruction cache 32kB, physically tagged, 4-way, linesize 64 bytes. [ 0.014000] Primary data cache 32kB, 4-way, linesize 32 bytes. [ 0.014000] MIPS secondary cache 512kB, 8-way, linesize 128 bytes. [ 0.014000] CPU revision is: 00025b00 (Broadcom BMIPS5000) [ 0.014000] FPU revision is: 00130001 [ 0.024000] SMP: CPU1 is running [ 0.024000] SMP: Booting CPU2... [ 0.024000] Primary instruction cache 32kB, physically tagged, 4-way, linesize 64 bytes. [ 0.024000] Primary data cache 32kB, 4-way, linesize 32 bytes. [ 0.024000] MIPS secondary cache 512kB, 8-way, linesize 128 bytes. [ 0.025000] CPU revision is: 00025b00 (Broadcom BMIPS5000) [ 0.025000] FPU revision is: 00130001 [ 0.034000] SMP: CPU2 is running [ 0.034000] SMP: Booting CPU3... [ 0.034000] Primary instruction cache 32kB, physically tagged, 4-way, linesize 64 bytes. [ 0.034000] Primary data cache 32kB, 4-way, linesize 32 bytes. [ 0.034000] MIPS secondary cache 512kB, 8-way, linesize 128 bytes. [ 0.034000] CPU revision is: 00025b00 (Broadcom BMIPS5000) [ 0.034000] FPU revision is: 00130001 [ 0.043000] SMP: CPU3 is running [ 0.043000] Brought up 4 CPUs [ 0.043000] devtmpfs: initialized [ 0.046000] bmem: adding extra 256 MB RESERVED region at 3072 MB (0x10000000@0xc0000000) [ 0.047000] NET: Registered protocol family 16 [ 0.047000] USB0: power enable is active high; overcurrent is active low [ 0.048000] USB1: power enable is active high; overcurrent is active low [ 0.049000] PCI: PCIe link up, 5.0Gbps x1 [ 0.052000] bio: create slab at 0 [ 0.053000] SCSI subsystem initialized [ 0.054000] usbcore: registered new interface driver usbfs [ 0.054000] usbcore: registered new interface driver hub [ 0.055000] usbcore: registered new device driver usb [ 0.055000] Advanced Linux Sound Architecture Driver Version 1.0.25. [ 0.056000] PCI host bridge to bus 0000:00 [ 0.056000] pci_bus 0000:00: root bus resource [mem 0xd0000000-0xefffffff] [ 0.057000] pci_bus 0000:00: root bus resource [mem 0x00000400-0x000007ff] [ 0.057000] PCI: found device 104c:8241 on PCIe bus, slot 0 (irq 36) [ 0.058000] pci 0000:00:00.0: BAR 0: assigned [mem 0xd0000000-0xd000ffff 64bit] [ 0.059000] pci 0000:00:00.0: BAR 2: assigned [mem 0xd0010000-0xd0011fff 64bit] [ 0.060000] Bluetooth: Core ver 2.16 [ 0.060000] NET: Registered protocol family 31 [ 0.060000] Bluetooth: HCI device and connection manager initialized [ 0.061000] Bluetooth: HCI socket layer initialized [ 0.061000] Bluetooth: L2CAP socket layer initialized [ 0.062000] Bluetooth: SCO socket layer initialized [ 0.062000] cfg80211: Calling CRDA to update world regulatory domain [ 0.063000] Switching to clocksource wktmr [ 0.071000] NET: Registered protocol family 2 [ 0.079000] IP route cache hash table entries: 32768 (order: 5, 131072 bytes) [ 0.080000] TCP established hash table entries: 131072 (order: 8, 1048576 bytes) [ 0.084000] TCP bind hash table entries: 65536 (order: 7, 524288 bytes) [ 0.086000] TCP: Hash tables configured (established 131072 bind 65536) [ 0.086000] TCP: reno registered [ 0.087000] UDP hash table entries: 512 (order: 2, 16384 bytes) [ 0.088000] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes) [ 0.089000] NET: Registered protocol family 1 [ 0.089000] RPC: Registered named UNIX socket transport module. [ 0.090000] RPC: Registered udp transport module. [ 0.091000] RPC: Registered tcp transport module. [ 0.091000] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.092000] PCI: Enabling device 0000:00:00.0 (0000 -> 0002) [ 0.094000] highmem bounce pool size: 64 pages [ 0.095000] NFS: Registering the id_resolver key type [ 0.096000] SGI XFS with security attributes, large block/inode numbers, no debug enabled [ 0.098000] msgmni has been set to 979 [ 0.099000] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 254) [ 0.100000] io scheduler noop registered [ 0.100000] io scheduler cfq registered (default) [ 0.101000] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled [ 0.102000] serial8250.0: ttyS0 at MMIO 0x10406b00 (irq = 67) is a 16550A [ 0.103000] console [ttyS0] enabled, bootconsole disabled [ 0.103000] console [ttyS0] enabled, bootconsole disabled [ 0.105000] loop: module loaded [ 0.106000] ahci: SSS flag set, parallel bus scan disabled [ 0.117000] ahci strict-ahci.0: AHCI 0001.0300 32 slots 2 ports 6 Gbps 0x3 impl platform mode [ 0.118000] ahci strict-ahci.0: flags: sntf stag clo slum part [ 0.122000] scsi0 : ahci_platform [ 0.123000] scsi1 : ahci_platform [ 0.124000] ata1: SATA max UDMA/133 mmio [mem 0x10181000-0x10190fff] port 0x100 irq 46 [ 0.124000] ata2: SATA max UDMA/133 mmio [mem 0x10181000-0x10190fff] port 0x180 irq 46 [ 0.126000] tun: Universal TUN/TAP device driver, 1.6 [ 0.126000] tun: (C) 1999-2004 Max Krasnyansky [ 0.419000] Found PHY at Address 3 [ 0.419000] bcmgenet: configuring instance #0 for external RGMII [ 0.420000] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver [ 0.421000] ehci-brcm ehci-brcm.0: Broadcom STB EHCI [ 0.421000] ehci-brcm ehci-brcm.0: new USB bus registered, assigned bus number 1 [ 0.432000] ata1: SATA link down (SStatus 0 SControl 300) [ 0.454000] ehci-brcm ehci-brcm.0: irq 71, io mem 0x10480300 [ 0.460000] ehci-brcm ehci-brcm.0: USB 0.0 started, EHCI 1.00 [ 0.461000] hub 1-0:1.0: USB hub found [ 0.461000] hub 1-0:1.0: 1 port detected [ 0.462000] ehci-brcm ehci-brcm.1: Broadcom STB EHCI [ 0.462000] ehci-brcm ehci-brcm.1: new USB bus registered, assigned bus number 2 [ 0.494000] ehci-brcm ehci-brcm.1: irq 72, io mem 0x10480500 [ 0.500000] ehci-brcm ehci-brcm.1: USB 0.0 started, EHCI 1.00 [ 0.500000] hub 2-0:1.0: USB hub found [ 0.501000] hub 2-0:1.0: 1 port detected [ 0.502000] ehci-brcm ehci-brcm.2: Broadcom STB EHCI [ 0.502000] ehci-brcm ehci-brcm.2: new USB bus registered, assigned bus number 3 [ 0.534000] ehci-brcm ehci-brcm.2: irq 76, io mem 0x10490300 [ 0.540000] ehci-brcm ehci-brcm.2: USB 0.0 started, EHCI 1.00 [ 0.540000] hub 3-0:1.0: USB hub found [ 0.541000] hub 3-0:1.0: 1 port detected [ 0.542000] ehci-brcm ehci-brcm.3: Broadcom STB EHCI [ 0.542000] ehci-brcm ehci-brcm.3: new USB bus registered, assigned bus number 4 [ 0.574000] ehci-brcm ehci-brcm.3: irq 77, io mem 0x10490500 [ 0.580000] ehci-brcm ehci-brcm.3: USB 0.0 started, EHCI 1.00 [ 0.581000] hub 4-0:1.0: USB hub found [ 0.581000] hub 4-0:1.0: 1 port detected [ 0.582000] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver [ 0.582000] ohci-brcm ohci-brcm.0: Broadcom STB OHCI [ 0.583000] ohci-brcm ohci-brcm.0: new USB bus registered, assigned bus number 5 [ 0.584000] ohci-brcm ohci-brcm.0: irq 73, io mem 0x10480400 [ 0.650000] hub 5-0:1.0: USB hub found [ 0.650000] hub 5-0:1.0: 1 port detected [ 0.651000] ohci-brcm ohci-brcm.1: Broadcom STB OHCI [ 0.652000] ohci-brcm ohci-brcm.1: new USB bus registered, assigned bus number 6 [ 0.652000] ohci-brcm ohci-brcm.1: irq 74, io mem 0x10480600 [ 0.718000] hub 6-0:1.0: USB hub found [ 0.718000] hub 6-0:1.0: 1 port detected [ 0.719000] ohci-brcm ohci-brcm.2: Broadcom STB OHCI [ 0.720000] ohci-brcm ohci-brcm.2: new USB bus registered, assigned bus number 7 [ 0.720000] ohci-brcm ohci-brcm.2: irq 78, io mem 0x10490400 [ 0.786000] hub 7-0:1.0: USB hub found [ 0.786000] hub 7-0:1.0: 1 port detected [ 0.787000] ohci-brcm ohci-brcm.3: Broadcom STB OHCI [ 0.788000] ohci-brcm ohci-brcm.3: new USB bus registered, assigned bus number 8 [ 0.788000] ohci-brcm ohci-brcm.3: irq 79, io mem 0x10490600 [ 0.854000] hub 8-0:1.0: USB hub found [ 0.854000] hub 8-0:1.0: 1 port detected [ 0.855000] xhci_hcd 0000:00:00.0: xHCI Host Controller [ 0.856000] xhci_hcd 0000:00:00.0: new USB bus registered, assigned bus number 9 [ 0.857000] xhci switched power on polarity [ 0.858000] hub 9-0:1.0: USB hub found [ 0.858000] hub 9-0:1.0: 2 ports detected [ 0.859000] xhci_hcd 0000:00:00.0: xHCI Host Controller [ 0.859000] xhci_hcd 0000:00:00.0: new USB bus registered, assigned bus number 10 [ 0.861000] hub 10-0:1.0: USB hub found [ 0.861000] hub 10-0:1.0: 2 ports detected [ 0.862000] Initializing USB Mass Storage driver... [ 0.862000] usbcore: registered new interface driver usb-storage [ 0.863000] USB Mass Storage support registered. [ 0.864000] i2c /dev entries driver [ 0.864000] lirc_dev: IR Remote Control driver registered, major 253 [ 0.865000] usbcore: registered new interface driver btusb [ 0.866000] sdhci: Secure Digital Host Controller Interface driver [ 0.866000] sdhci: Copyright(c) Pierre Ossman [ 0.867000] sdhci-pltfm: SDHCI platform and OF driver helper [ 0.867000] sdhci-brcmstb sdhci-brcmstb.0: Enabling controller [ 0.873000] mmc0: SDHCI controller on sdhci-brcmstb.0 [sdhci-brcmstb.0] using ADMA [ 0.873000] sdhci-brcmstb sdhci-brcmstb.1: Enabling controller [ 0.879000] mmc1: SDHCI controller on sdhci-brcmstb.1 [sdhci-brcmstb.1] using ADMA [ 0.880000] TCP: cubic registered [ 0.880000] NET: Registered protocol family 10 [ 0.882000] NET: Registered protocol family 17 [ 0.882000] Bluetooth: RFCOMM TTY layer initialized [ 0.883000] Bluetooth: RFCOMM socket layer initialized [ 0.883000] Bluetooth: RFCOMM ver 1.11 [ 0.884000] Bluetooth: BNEP (Ethernet Emulation) ver 1.3 [ 0.884000] Bluetooth: BNEP filters: protocol multicast [ 0.884000] Bluetooth: HIDP (Human Interface Emulation) ver 1.2 [ 0.886000] L2TP core driver, V2.0 [ 0.886000] Registering the dns_resolver key type [ 0.887000] PM: CP0 COUNT/COMPARE frequency does not depend on divisor [ 0.888000] EBI CS0: setting up SPI flash (primary) [ 0.889000] spi_brcmstb spi_brcmstb.0: 1-lane output, 3-byte address [ 0.890000] spi_brcmstb spi_brcmstb.0: master is unqueued, this is deprecated [ 0.891000] m25p80 spi0.0: mx25l12805d (16384 Kbytes) [ 0.892000] Creating 3 MTD partitions on "spi0.0": [ 0.892000] 0x000000000000-0x000001000000 : "entire_device" [ 0.893000] 0x000000000000-0x000000100000 : "bootloader" [ 0.894000] 0x000000100000-0x000001000000 : "recovery" [ 0.896000] ALSA device list: [ 0.896000] No soundcards found. [ 0.897000] Waiting for root device /dev/mmcblk0p1... [ 0.979000] mmc0: new high speed MMC card at address 0001 [ 0.980000] mmcblk0: mmc0:0001 SEM04G 3.68 GiB [ 0.981000] mmcblk0boot0: mmc0:0001 SEM04G partition 1 2.00 MiB [ 0.982000] mmcblk0boot1: mmc0:0001 SEM04G partition 2 2.00 MiB [ 0.988000] mmcblk0: p1 p2 [ 0.989000] mmcblk0boot1: unknown partition table [ 0.991000] mmcblk0boot0: unknown partition table [ 1.008000] EXT4-fs (mmcblk0p1): mounted filesystem with ordered data mode. Opts: (null) [ 1.009000] VFS: Mounted root (ext4 filesystem) on device 179:1. [ 1.016000] devtmpfs: mounted [ 1.298000] ata2: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [ 1.321000] systemd[1]: systemd 206 running in system mode. (-PAM +LIBWRAP -AUDIT -SELINUX +IMA +SYSVINIT -LIBCRYPTSETUP -GCRYPT +ACL +XZ) Welcome to Linux! [ 1.325000] systemd[1]: Set hostname to . [ 1.426000] ata2.00: ATA-9: WDC WD10JUCT-63CYNY0, 01.01A01, max UDMA/133 [ 1.427000] ata2.00: 1953525168 sectors, multi 0: LBA48 NCQ (depth 0/32) [ 1.428000] ata2.00: configured for UDMA/133 [ 1.429000] scsi 1:0:0:0: Direct-Access ATA WDC WD10JUCT-63C 01.0 PQ: 0 ANSI: 5 [ 1.430000] sd 1:0:0:0: [sda] 1953525168 512-byte logical blocks: (1.00 TB/931 GiB) [ 1.431000] sd 1:0:0:0: [sda] 4096-byte physical blocks [ 1.432000] sd 1:0:0:0: [sda] Write Protect is off [ 1.433000] sd 1:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA [ 1.476000] systemd[1]: Cannot add dependency job for unit display-manager.service, ignoring: Unit display-manager.service failed to load: No such file or directory. See system logs and 'systemctl status display-manager.service' for details. [ 1.479000] systemd[1]: Starting Generate environment for enigma2... Starting Generate environment for enigma2... [ 1.493000] systemd[1]: Expecting device dev-dvb-adapter0-video0.device... Expecting device dev-dvb-adapter0-video0.device... [ 1.497000] systemd[1]: Expecting device dev-ttyS0.device... Expecting device dev-ttyS0.device... [ 1.500000] systemd[1]: Starting Forward Password Requests to Wall Directory Watch. [ 1.501000] systemd[1]: Started Forward Password Requests to Wall Directory Watch. [ 1.503000] sda: sda1 sda2 [ 1.504000] sd 1:0:0:0: [sda] Attached SCSI disk [ 1.505000] systemd[1]: Expecting device dev-tpm0.device... Expecting device dev-tpm0.device... [ 1.508000] systemd[1]: Expecting device dev-venc0.device... Expecting device dev-venc0.device... [ 1.509000] systemd[1]: Starting Syslog Socket. [ OK ] Listening on Syslog Socket. [ 1.512000] systemd[1]: Listening on Syslog Socket. [ 1.512000] systemd[1]: Starting Delayed Shutdown Socket. [ OK ] Listening on Delayed Shutdown Socket. [ 1.516000] systemd[1]: Listening on Delayed Shutdown Socket. [ 1.516000] systemd[1]: Starting /dev/initctl Compatibility Named Pipe. [ OK ] Listening on /dev/initctl Compatibility Named Pipe. [ 1.520000] systemd[1]: Listening on /dev/initctl Compatibility Named Pipe. [ 1.521000] systemd[1]: Starting Root Slice. [ OK ] Created slice Root Slice. [ 1.524000] systemd[1]: Created slice Root Slice. [ 1.524000] systemd[1]: Starting User and Session Slice. [ OK ] Created slice User and Session Slice. [ 1.528000] systemd[1]: Created slice User and Session Slice. [ 1.528000] systemd[1]: Starting System Slice. [ OK ] Created slice System Slice. [ 1.532000] systemd[1]: Created slice System Slice. [ 1.532000] systemd[1]: Starting Slices. [ OK ] Reached target Slices. [ 1.536000] systemd[1]: Reached target Slices. [ 1.536000] systemd[1]: Starting system-serial\x2dgetty.slice. [ OK ] Created slice system-serial\x2dgetty.slice. [ 1.540000] systemd[1]: Created slice system-serial\x2dgetty.slice. [ 1.541000] systemd[1]: Starting Dispatch Password Requests to Console Directory Watch. [ 1.542000] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. [ 1.543000] systemd[1]: Starting Paths. [ OK ] Reached target Paths. [ 1.546000] systemd[1]: Reached target Paths. [ 1.546000] systemd[1]: Starting Journal Socket. [ OK ] Listening on Journal Socket. [ 1.549000] systemd[1]: Listening on Journal Socket. [ 1.549000] systemd[1]: Mounting POSIX Message Queue File System... Mounting POSIX Message Queue File System... [ 1.561000] systemd[1]: Mounted Debug File System. [ 1.572000] systemd[1]: Starting Apply Kernel Variables... Starting Apply Kernel Variables... [ 1.590000] systemd[1]: Starting Load Kernel Modules... Starting Load Kernel Modules... [ 1.601000] systemd[1]: Starting Journal Service... Starting Journal Service... [ OK ] Started Journal Service. [ 1.615000] systemd[1]: Started Journal Service. [ 1.615000] systemd[1]: Mounted Huge Pages File System. [ 1.617000] systemd[1]: Starting Create list of required static device nodes for the current kernel... Starting Create list of required static device nodes...rrent kernel... [ 1.631000] systemd[1]: Starting udev Kernel Socket. [ OK ] Listening on udev Kernel Socket. [ 1.635000] systemd[1]: Listening on udev Kernel Socket. [ 1.636000] systemd[1]: Starting udev Control Socket. [ OK ] Listening on udev Control Socket. [ 1.638000] stb_core: module license 'Proprietary' taints kernel. [ 1.638000] Disabling lock debugging due to kernel taint [ 1.639000] systemd[1]: Listening on udev Control Socket. [ 1.640000] systemd[1]: Starting udev Coldplug all Devices... Starting udev Coldplug all Devices... [ 1.657000] systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. [ 1.662000] systemd[1]: Started Set Up Additional Binary Formats. [ 1.662000] systemd[1]: Starting Swap. [ OK ] Reached target Swap. [ 1.665000] systemd[1]: Reached target Swap. [ 1.665000] systemd[1]: Started File System Check on Root Device. [ 1.666000] systemd[1]: Starting Remount Root and Kernel File Systems... Starting Remount Root and Kernel File Systems... [ OK ] Started Generate environment for enigma2. [ 1.706000] systemd[1]: Started Generate environment for enigma2. [ OK ] Mounted POSIX Message Queue File System. [ 1.710000] systemd[1]: Mounted POSIX Message Queue File System. [ OK ] Started Apply Kernel Variables. [ 1.724000] systemd[1]: Started Apply Kernel Variables. [ 1.766000] EXT4-fs (mmcblk0p1): re-mounted. Opts: (null) [ OK ] Started Remount Root and Kernel File Systems. [ 1.781000] systemd[1]: Started Remount Root and Kernel File Systems. [ OK ] Started Create list of required static device nodes ...current kernel. [ 1.793000] systemd[1]: Started Create list of required static device nodes for the current kernel. [ OK ] Started udev Coldplug all Devices. [ 1.803000] systemd[1]: Started udev Coldplug all Devices. [ 1.804000] systemd[1]: Starting Create static device nodes in /dev... Starting Create static device nodes in /dev... [ 1.817000] systemd[1]: Starting Load/Save Random Seed... Starting Load/Save Random Seed... [ OK ] Started Load/Save Random Seed. [ 1.926000] systemd[1]: Started Load/Save Random Seed. [ OK ] Started Create static device nodes in /dev. [ 1.977000] systemd[1]: Started Create static device nodes in /dev. [ 1.979000] systemd[1]: Starting udev Kernel Device Manager... Starting udev Kernel Device Manager... [ 1.992000] systemd[1]: Starting Local File Systems (Pre). [ OK ] Reached target Local File Systems (Pre). [ 1.995000] systemd[1]: Reached target Local File Systems (Pre). [ 1.995000] systemd[1]: Mounting /var/volatile... Mounting /var/volatile... [ 2.051000] systemd-udevd[110]: starting version 206 [ 2.101000] systemd[1]: var-volatile.mount: Directory /var/volatile to mount over is not empty, mounting anyway. [ 2.111000] systemd[1]: Mounting /tmp... Mounting /tmp... [ OK ] Started udev Kernel Device Manager. [ 2.128000] systemd[1]: Started udev Kernel Device Manager. [ OK ] Mounted /var/volatile. [ 2.134000] systemd[1]: Mounted /var/volatile. [ OK ] Mounted /tmp. [ 2.138000] systemd[1]: Mounted /tmp. [ 2.138000] systemd[1]: Starting Local File Systems. [ OK ] Reached target Local File Systems. [ 2.141000] systemd[1]: Reached target Local File Systems. [ 2.142000] systemd[1]: Starting Recreate Volatile Files and Directories... Starting Recreate Volatile Files and Directories... [ 2.264000] bcm7435: xvd 20130918, vdc 20130918, rap 20130918, xpt 20130918, driver version 20161208-dm820-2-g1255 [ OK ] Started Recreate Volatile Files and Directories. [ 2.282000] systemd[1]: Started Recreate Volatile Files and Directories. [ 2.283000] systemd[1]: Starting Update UTMP about System Reboot/Shutdown... Starting Update UTMP about System Reboot/Shutdown... [ 2.301000] systemd[1]: Started Run pending postinsts. [ OK ] Started Update UTMP about System Reboot/Shutdown. [ 2.321000] systemd[1]: Started Update UTMP about System Reboot/Shutdown. [ OK ] Found device /dev/ttyS0. [ 2.324000] systemd[1]: Found device /dev/ttyS0. [ OK ] Found device /dev/tpm0. [ 2.723000] systemd[1]: Found device /dev/tpm0. [ 2.730000] 2:729049877 SMCA: controller reset timed out [ 2.741000] 2:740698199 SMCB: controller reset timed out [ 3.191000] register adapter [ 3.191000] register adapter [ 3.192000] register adapter [ 3.192000] register adapter [ 3.193000] register adapter [ 3.194000] using fpga version 47 [ 3.194000] tsmux set tsports reg 00 to val 00 [ 3.195000] tsmux set tsports reg 01 to val 01 [ 3.195000] tsmux set tsports reg 02 to val 02 [ 3.196000] tsmux set tsports reg 03 to val 03 [ 3.196000] tsmux set tsports reg 04 to val 04 [ 3.197000] tsmux set tsports reg 05 to val 05 [ 3.197000] tsmux set ciclk reg 34 to val 00 [ 3.198000] tsmux set cisource reg 06 to val 00 [ 3.198000] tsmux set ciclk reg 34 to val 00 [ 3.199000] tsmux set cisource reg 07 to val 01 [ 3.200000] FP Version 1.15 [ 3.201000] input: dreambox front panel as /devices/virtual/input/input0 [ 3.926000] ina2xx 5-0040: power monitor ina219 (Rshunt = 10000 uOhm) [ 3.939000] set input to 0 [ 3.939000] set fb to 2(-1) [ 3.948000] startvideomode '1080p50' read from /etc/videomode [ 3.949000] HDMI: now connected [ 3.975000] HDMI: Physical CEC Addr set from EDID [ 3.976000] HDMI: EDID read ok [ 3.976000] HDMI: initial mode set! [ 3.977000] using 50.00Hz as MonitorRefreshRate [ 3.977000] SET FORMAT: display[0], format=37 [ 3.978000] HDMI mode [ 3.978000] use EDID to detect colorspace [ 3.978000] using colorspace: 1 [ 4.079000] HDMI: start CEC [ 4.079000] HDMI: use logical CEC address 3 [ 4.080000] bcmfb: creating surface with pixel format 0x07e48888 (BPXL_eA8_R8_G8_B8) [ 4.080000] CEC init completed! [ 4.219000] VIDEO0: enable deinterlacer [ 4.219000] CEC send ok! [ 4.220000] VIDEO0: set fallback framerate to 60000 [ 4.221000] VIDEO0: set progressive override mode to 1 [ 4.221000] VIDEO0: set streamtype! [ 4.222000] -> set MPEG2 [ 4.222000] -> sw rave disabled! [ 4.250000] VIDEO1: set fallback framerate to 60000 [ 4.251000] VIDEO1: set progressive override mode to 1 [ 4.251000] VIDEO1: set streamtype! [ 4.252000] -> set MPEG2 [ 4.252000] -> sw rave disabled! [ 4.325000] VIDEO2: set fallback framerate to 60000 [ 4.326000] VIDEO2: set progressive override mode to 1 [ 4.326000] VIDEO2: set streamtype! [ 4.327000] -> set MPEG2 [ 4.327000] -> sw rave disabled! [ 4.341000] set ac3 to downmix [ 4.341000] set ac3plus to use_hdmi_caps [ 4.342000] set aac to downmix [ 4.342000] audio ch2: add stereo (background decoder) input to mixer DUMMY2 [ 4.343000] audio ch1: add stereo (hdmi-rx) input to mixer DUMMY [ 4.344000] DVB: registering new adapter (BCM7435) [ OK ] Found device /dev/dvb/adapter0/video0. [ 4.398000] systemd[1]: Found device /dev/dvb/adapter0/video0. [ 4.398000] systemd[1]: Starting Dreambox Bootlogo... Starting Dreambox Bootlogo... [ 4.420000] VIDEO0: set blank to 0 [ OK [ 4.421000] sync0 is off so we enable it ] Started Dreamb[ 4.422000] sync0: allocated pcroffset 0 ox Bootlogo. [ 4.422000] sync0: playback! [ 4.423000] VIDEO0: total delay: 0 (0 ms) [ 4.423000] systemd[1]: Started Dreambox Bootlogo. [ 4.428000] VIDEO0: start decode [ 4.429000] VIDEO0: flush video decoder [ 4.429000] VIDEO0 got pts failed !!!! (ret 0) [ 4.443000] autodetecting NIMs... [ 4.443000] slot 0 [ 4.444000] ret: 2, feid: 14 [ 4.445000] Found: Slot 0, ID: 14 (by CA) [ 4.445000] slot 1 [ 4.446000] ret: 2, feid: 13 [ 4.446000] Found: Slot 1, ID: 13 (by CA) [ 4.447000] slot 2 [ 4.448000] ret: -145, feid: ff [ 4.448000] Initializing adapter 0 (BCM4506-DVB-S2) [ 4.459000] VIDEO0: first pts 0x0 [ 4.459000] VIDEO0: framerate changed 3 [ 4.459000] VIDEO0: resolution changed (1280 720) [ 4.459000] VIDEO0: aspect changed 3 [ 4.461000] set current avs auto aspect to 16:9 [ 4.462000] set current avs auto aspect to 16:9 [ 4.462000] set sb to 3(1) [ 4.500000] bcm4506: found 4506, revision 0(a1) [ 4.501000] bcm4506: bcm_initAP [ 4.501000] DVB: registering adapter 0 frontend 0 (bcm4506)... [ 4.502000] Initializing adapter 1 (BCM4506-DVB-S2) [ 4.507000] bcm4506: found 4506, revision 0(a1) [ 4.507000] DVB: registering adapter 0 frontend 1 (bcm4506)... [ 4.508000] Initializing adapter 2 (BCM4505-DVB-S2) [ 4.513000] bcm4506: upload & start firmware [ 4.561000] bcm4506: found 4505, revision 0(b0) [ 4.562000] bcm4506: bcm_initAP [ 4.562000] DVB: registering adapter 0 frontend 2 (bcm4506)... [ 4.563000] CI stopped... [ 4.565000] CI stopped... [ 4.565000] init ALSA! [ 4.567000] registered vtuner misc/vtuner0, minor 50 [ 4.567000] registered vtuner misc/vtuner1, minor 49 [ 4.568000] registered vtuner misc/vtuner2, minor 48 [ 4.569000] registered vtuner misc/vtuner3, minor 47 [ 4.570000] registered vtuner misc/vtuner4, minor 46 [ 4.570000] bcm4506: upload & start firmware [ 4.572000] registered vtuner misc/vtuner5, minor 45 [ 4.572000] HDMI-RX: init [ 4.573000] systemd[1]: Starting Sound Card. [ 4.574000] HDMI-RX: no device attached [ .574000] HDMI-RX: video format change event [ 4.575000] HDMI-RX: hdmi packet status stopped [ 4.575000] HDMI-RX: hdmiInput0 Receiving DVI format RGB (Default) [ 4.576000] HDMI-RX: hdmiInput0 Color Space change from 'RGB (Default)' to 'RGB (Default)' [ OK [ 4.577000] HDMI-RX: init done ] Reached target[ 4.578000] bcm_vce_init() [ 4.578000] bcm_vce_init() 0 Sound Card. [ 4.580000] systemd[1]: Reached target Sound Card. [ 4.586000] VIDEO0: set blank to 0 [ 4.587000] VIDEO0: stop decode [ 4.587000] VIDEO0: set blank to 0 [ 4.588000] sync0 1fff no decoder left in sync handling so disable [ 4.589000] sync0: was last pcroffset0 user so free it [ OK ] Found device /dev/venc0. [ 4.608000] systemd[1]: Found device /dev/venc0. [ 4.609000] vice0: allocate output buffers [ 4.623000] input: dreambox remote control (native) as /devices/virtual/input/input1 [ 4.625000] input: dreambox advanced remote control (native) as /devices/virtual/input/input2 [ 4.629000] input: dreambox ir keyboard as /devices/virtual/input/input3 [ 4.631000] input: dreambox ir mouse as /devices/virtual/input/input4 [ OK ] Started Load Kernel Modules. [ OK ] Reached target System Initialization. [ OK ] Listening on D-Bus System Message Bus Socket. [ OK ] Listening on streamproxy.socket. [ OK ] Listening on vsftpd.socket. [ OK ] Listening on tpmd.socket. [ OK ] Listening on dropbear.socket. [ OK ] Listening on Avahi mDNS/DNS-SD Stack Activation Socket. [ OK ] Listening on busybox-telnetd.socket. [ OK ] Reached target Timers. [ OK ] Listening on dbttcd.socket. [ OK ] Reached target Sockets. Starting enigma2... [ OK ] Reached target Basic System. Starting samba.service... Starting tpmd.service... Starting Avahi mDNS/DNS-SD Stack... Starting Kernel Logging Service... [ OK ] Started Kernel Logging Service. Starting System Logging Service... [ OK ] Started System Logging Service. Starting Dreambox Real-Time Streaming Protocol Server... Starting dbttcd.service... Starting D-Bus System Message Bus... [ OK ] Started D-Bus System Message Bus. Starting Gemini Tools... [ OK ] Started Gemini Tools. Starting Connection service... Starting Login Service... Starting Telephony service... [ OK ] Started tpmd.service. [ OK ] Started dbttcd.service. [ 5.791000] CEC recv ok! [ OK ] Started samba.service. [ 5.950000] CEC recv ok! [ 6.085000] CEC recv ok! [ OK ] Started Avahi mDNS/DNS-SD Stack. [ OK ] Started Connection service. [ OK ] Reached target Remote File Systems (Pre). [ OK ] Reached target Remote File Systems. Starting Trigger Flushing of Journal to Persistent Storage... [ OK ] Reached target Network. Starting Automounts filesystems on demand... Starting Patch /etc/issues.net to Gemini Plugin brand... [ OK ] Started Patch /etc/issues.net to Gemini Plugin brand. [ OK ] Started Telephony service. [ OK ] Started Login Service. [ 6.244000] fuse init (API version 7.18) Mounting FUSE Control File System... [ OK ] Mounted FUSE Control File System. [ 6.433000] bcm4506: bcm4506: ap not running - start now [ OK ] Started Trigger Flushing of Journal to Persistent Storage. Starting Permit User Sessions... [ 6.492000] bcm4506: bcm4506: ap not running - start now [ 6.543000] bcm4506: uCode 0x61 [ 6.551000] bcm4506: uCode 0x61 [ 6.555000] bcm4506: no bcm3445 detected [ 6.570000] bcm4506: no bcm3445 detected [ 6.579000] bcm4506: no bcm3445 detected [ OK ] Started Permit User Sessions. Starting Serial Getty on ttyS0... [ OK ] Started Serial Getty on ttyS0. [ OK ] Reached target Login Prompts. [ OK ] Started Dreambox Real-Time Streaming Protocol Server. [ 6.655000] vice0: change videoenc bitrate to 2048000 bits/s [ 6.657000] change audioenc bitrate to 128000 bits/s [ OK ] Started Automounts filesystems on demand. [ OK ] Reached target Multi-User System. [ OK ] Reached target Graphical Interface. [ 6.817000] ADDRCONF(NETDEV_UP): eth0: link is not ready [ 6.917000] bcmgenet bcmgenet.0: eth0: link up, 1000 Mbps, full duplex [ 6.918000] ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 8.416000] bcm4506: channel 0 is in normal mode now [ 8.426000] bcm4506: channel 0 is sleeping now [ 8.427000] bcm4506: channel 1 is in normal mode now [ 8.436000] bcm4506: channel 1 is sleeping now [ 8.441000] bcm4506: channel 0 is in normal mode now [ 8.452000] bcm4506: channel 0 is sleeping now [ 8.509000] bcmfb: enable manual blit [ 8.516000] HDMI: use logical CEC address 3 [ 8.517000] CEC init completed! [ 8.542000] bcmfb: creating surface with pixel format 0x07c68888 (BPXL_eA8_B8_G8_R8) [ 8.653000] CEC send ok! [ 9.048000] 0 ms: [ 9.073000] 25 ms: 0 [ 9.079000] 6 ms: 0 [ 9.083000] 4 ms: 0 ************************** * * * The Gemini Project * * * ************************** OpenDreambox dm7080 login: [ 9.957000] CEC recv ok! [ 11.451000] tsmux set cisource reg 06 to val 06 [ 11.452000] tsmux set cisource reg 07 to val 06 [ 11.523000] 2440 ms: 0 [ 11.561000] 38 ms: 18 [ 11.571000] 10 ms: 18 [ 11.572000] 1 ms: 18 [ 11.586000] 14 ms: 18 [ 12.002000] 415 ms: 18 [ 12.053000] 51 ms: 21 [ 12.057000] 3 ms: 21 [ 12.063000] 6 ms: 22 [ 12.064000] 1 ms: 22 [ 12.553000] 489 ms: 22 [ 12.558000] 5 ms: 25 [ 12.623000] 64 ms: 25 [ 12.624000] 1 ms: 26 [ 12.769000] 145 ms: 26 [ 12.870000] 101 ms: 27 [ 12.871000] 1 ms: 27 [ 12.876000] 4 ms: 27 [ 12.877000] 0 ms: 27 [ 12.879000] 1 ms: 27 [ 12.888000] 9 ms: 27 [ 12.897000] 9 ms: 28 [ 13.140000] 243 ms: 28 [ 13.146000] 6 ms: 29 [ 13.151000] 5 ms: 29 [ 13.158000] 7 ms: 29 [ 13.167000] 9 ms: 30 [ 13.174000] 7 ms: 30 [ 13.175000] 1 ms: 30 [ 13.177000] 2 ms: 30 [ 13.185000] 8 ms: 30 [ 13.838000] 653 ms: 30 [ 13.868000] 30 ms: 34 [ 15.055000] 1187 ms: 35 [ 15.094000] 39 ms: 43 [ 15.095000] 1 ms: 44 [ 15.114000] 19 ms: 44 [ 15.115000] 1 ms: 44 [ 15.116000] 1 ms: 44 [ 15.119000] 3 ms: 44 [ 15.125000] 6 ms: 44 [ 15.138000] 13 ms: 44 [ 15.139000] 1 ms: 44 [ 15.163000] bcmfb: creating surface with pixel format 0x07c68888 (BPXL_eA8_B8_G8_R8) [ 15.437000] 298 ms: 44 [ 15.488000] 51 ms: 46 [ 15.492000] set input to 0 [ 15.493000] set fb to 2(-1) [ 15.493000] set current avs auto aspect to 16:9 [ 15.494000] set sb to 3(1) [ 15.495000] set ac3 to passthrough [ 15.497000] set ac3plus to force_ac3 [ 15.500000] 12 ms: 46 [ 15.508000] 8 ms: 47 [ 15.514000] 5 ms: 47 [ 15.585000] 71 ms: 47 [ 15.591000] 6 ms: 47 [ 19.576000] EXT4-fs (sda1): mounted filesystem with ordered data mode. Opts: (null) [ 19.630000] Adding 1047596k swap on /dev/sda2. Priority:-1 extents:1 across:1047596k [ 19.904000] set current avs auto aspect to 16:9 [ 19.905000] set sb to 3(1) [ 19.919000] set current avs auto aspect to 16:9 [ 19.920000] set sb to 3(1) [ 19.920000] set current avs auto aspect to 16:9 [ 19.921000] set sb to 3(1) [ 19.923000] set current avs auto aspect to 16:9 [ 19.923000] set sb to 3(1) [ 19.924000] set current avs auto aspect to 16:9 [ 19.924000] set sb to 3(1) [ 19.925000] set current avs auto aspect to 16:9 [ 19.926000] set sb to 3(1) [ 19.928000] set current avs auto aspect to 16:9 [ 19.928000] set sb to 3(1) [ 19.929000] set current avs auto aspect to 16:9 [ 19.930000] set sb to 3(1) [ 19.930000] set current avs auto aspect to 16:9 [ 19.931000] set sb to 3(1) [ 19.933000] set current avs auto aspect to 16:9 [ 19.933000] set sb to 3(1) [ 19.934000] set current avs auto aspect to 16:9 [ 19.935000] set sb to 3(1) [ 19.937000] set current avs auto aspect to 16:9 [ 19.938000] set sb to 3(1) [ 19.938000] set current avs auto aspect to 16:9 [ 19.939000] set sb to 3(1) [ 19.940000] set current avs auto aspect to 16:9 [ 19.940000] set sb to 3(1) [ 19.968000] CEC recv ok! [ 20.571000] 4980 ms: 47 [ 20.578000] 7 ms: 84 [ 20.580000] tsmux set ciclk reg 34 to val 00 [ 20.582000] tsmux set ciclk reg 34 to val 00 [ 20.589000] 11 ms: 84 [ 21.017000] change audioenc bitrate to 96000 bits/s [ 21.023000] vice0: change videoenc bitrate to 1500000 bits/s [ 21.656000] 1066 ms: 84 [ 22.524000] 868 ms: 92 [ 22.566000] set mute 0 1 [ 22.568000] 44 ms: 99 [ 22.581000] 13 ms: 100 [ 22.640000] bcm4506: channel 0 is in normal mode now [ 22.647000] tsmux set tsports reg 00 to val 06 [ 22.650000] start pcr0 on dmx 7 pid:1465 index 3 [ 22.652000] start audio0 on dmx 7 pid:146a index 1 [ 22.652000] audio ch0: xpt start [ 22.653000] sync0 is off so we enable it [ 22.653000] sync0: allocated pcroffset 0 [ 22.653000] sync0: demux-index 7 pcr pid 1465 [ 22.654000] sync0: using 3 as pcr pidchannel [ 22.655000] audio ch0: AC3 [ 22.655000] audio ch0: streamtype set 1 [ 22.656000] audio ch0: streamtype_set: stop rave [ 22.656000] audio ch0: passthru [ 22.657000] audio ch0: add compressed input to mixer SPDIF [ 22.657000] audio ch0: streamtype_set: restart rave [ 22.658000] audio ch0: decoder start [ 22.659000] audio ch0: video delay 0 (0 ms) [ 22.659000] VIDEO0: total delay: 0 (0 ms) [ 22.662000] VIDEO0: set streamtype! [ 22.663000] -> set H264 [ 22.663000] -> sw rave disabled! [ 22.663000] audio ch0 delay 18000 (200 ms) [ 22.664000] VIDEO0: total delay: 18000 (200 ms) [ 22.665000] start video0 on dmx 7 pid:1465 index 3 [ 22.666000] VIDEO0: total delay: 18000 (200 ms) [ 22.672000] VIDEO0: start decode [ 23.438000] CEC send ok! [ 23.529000] audio ch0: lock [ 23.529000] audio ch0: sample rate changed isr (48000) [ 23.530000] audio ch0: mode change [ 23.530000] audio ch0: tsm fail [ 23.531000] audio ch0: ignore pts error when audio is not running [ 23.555000] CEC send ok! [ 23.564000] audio ch0: tsm fail [ 23.565000] audio ch0: ignore pts error when audio is not running [ 23.565000] audio ch0: first pts 0x1c7da6704, stc 0x1c7da5152, pcr valid [ 23.648000] CEC send ok! [ 23.716000] CEC send ok! [ 23.833000] CEC send ok! [ 23.872000] audio ch0: status ready [ 23.924000] CEC recv ok! [ 23.988000] CEC send ok! [ 24.130000] CEC send ok! [ 24.200000] CEC send ok! [ 24.259000] VIDEO0: first pts 0x1c7dccc36 [ 24.260000] VIDEO0: framerate changed 6 [ 24.260000] set current avs auto aspect to 16:9 [ 24.261000] set sb to 3(1) [ 24.274000] CEC send ok! [ 24.351000] CEC send ok! [ 24.410000] VIDEO0: enable tsm [ 24.442000] CEC recv ok! [ 24.548000] CEC send ok! [ 24.854000] CEC recv ok! [ 24.918000] CEC send ok! [ 25.467000] HDMI: force disconnect! [ 25.467000] HDMI: now disconnected [ 25.467000] HDMI: stop CEC RX [ 27.462000] CEC recv ok! [ 27.526000] CEC send ok! [ 27.615000] CEC recv ok! [ 27.742000] CEC send ok! [ 27.879000] CEC recv ok! [ 27.943000] CEC send ok! [ 28.080000] CEC recv ok! [ 28.382000] CEC recv ok! [ 28.856000] CEC recv ok! [ 28.993000] CEC send ok! [ 29.131000] CEC recv ok! [ 29.239000] CEC recv ok! [ 29.377000] CEC send ok! [ 29.514000] CEC recv ok! [ 29.694000] CEC recv ok! [ 29.841000] HDMI: force disconnect! [ 29.841000] HDMI: now disconnected [ 29.841000] HDMI: stop CEC RX [ 29.842000] HDMI: now connected [ 29.871000] HDMI: Physical CEC Addr set from EDID [ 29.871000] HDMI: EDID read ok [ 29.899000] using 50.00Hz as MonitorRefreshRate [ 29.900000] VIDEO1: shared window not available [ 29.979000] SET FORMAT: display[0], format=37 [ 29.980000] HDMI mode [ 29.980000] use EDID to detect colorspace [ 29.981000] using colorspace: 1 [ 30.121000] VIDEO1: shared window not available [ 30.199000] set current avs auto aspect to 16:9 [ 30.200000] HDMI: reset audio streamtype after EDID read [ 30.201000] audio ch0: streamtype set 1 [ 30.201000] audio ch0: streamtype_set: stop decoder [ 30.202000] audio ch0: decoder stop [ 30.202000] set sb to 3(1) [ 30.203000] audio ch0: streamtype_set: stop rave [ 30.203000] audio ch0: passthru [ 30.203000] audio ch0: add compressed input to mixer MAI [ 30.204000] audio ch0: streamtype_set: restart rave [ 30.205000] audio ch0: streamtype_set: restart decoder [ 30.206000] audio ch0: decoder start [ 30.206000] audio ch0 delay 18000 (200 ms) [ 30.206000] VIDEO0: total delay: 18000 (200 ms) [ 30.209000] HDMI: start CEC [ 30.209000] CEC recv ok! [ 30.220000] audio ch0: first pts 0x1c7e38b04, stc 0x1c7e374d8, pcr valid [ 30.252000] audio ch0: lock [ 30.253000] audio ch0: sample rate changed isr (48000) [ 30.253000] audio ch0: mode change [ 30.311000] HDMI: use logical CEC address 3 [ 30.312000] CEC init completed! [ 30.448000] CEC send ok! [ 30.528000] audio ch0: status ready [ 30.578000] CEC send ok! [ 30.713000] CEC recv ok! [ 30.828000] CEC recv ok! [ 30.986000] CEC recv ok! [ 31.099000] CEC send ok! [ 31.454000] CEC recv ok! [ 31.862000] CEC recv ok! [ 32.006000] CEC recv ok! [ 32.097000] CEC recv ok! [ 32.844000] CEC recv ok! [ 33.812000] CEC recv ok! [ 33.876000] CEC send ok! [ 33.964000] CEC recv ok! [ 34.386000] CEC recv ok! [ 35.245000] CEC recv ok! [ 35.310000] CEC send ok! [ 35.485000] CEC recv ok! [ 36.059000] CEC recv ok! [ 36.123000] CEC send ok! [ 36.658000] CEC recv ok! [ 36.868000] CEC recv ok! [ 37.097000] CEC recv ok! [ 40.663000] CEC recv ok! [ 40.813000] CEC recv ok! [ 40.957000] CEC recv ok! [ 41.118000] CEC recv ok! [ 55.867000] CEC recv ok! [ 56.010000] CEC recv ok! [ 56.174000] CEC recv ok! [ 56.318000] CEC recv ok! [ 56.781000] CEC recv ok! [ 56.894000] CEC send ok! [ 57.132000] CEC recv ok! [ 70.937000] CEC recv ok! [ 71.092000] CEC recv ok! [ 71.236000] CEC recv ok! [ 71.395000] CEC recv ok! [ 71.790000] CEC recv ok! [ 86.018000] CEC recv ok! [ 86.162000] CEC recv ok! [ 86.331000] CEC recv ok! [ 86.475000] CEC recv ok! [ 86.855000] CEC recv ok! [ 101.083000] CEC recv ok! [ 101.227000] CEC recv ok! [ 101.394000] CEC recv ok! [ 101.538000] CEC recv ok! [ 101.918000] CEC recv ok! [ 116.145000] CEC recv ok! [ 116.288000] CEC recv ok! [ 116.458000] CEC recv ok! [ 116.602000] CEC recv ok! [ 116.983000] CEC recv ok! [ 131.207000] CEC recv ok! [ 131.351000] CEC recv ok! [ 131.520000] CEC recv ok! [ 131.664000] CEC recv ok! [ 132.044000] CEC recv ok! [ 146.268000] CEC recv ok! [ 146.415000] CEC recv ok! [ 146.559000] CEC recv ok! [ 146.718000] CEC recv ok! [ 147.112000] CEC recv ok! [ 149.458000] stop pcr0 on dmx 7 pid:1465 [ 149.459000] stop video0 on dmx 7 pid:1465 [ 149.461000] VIDEO0: stop decode [ 149.461000] VIDEO0: set blank to 1 [ 149.462000] audio ch0: decoder stop [ 149.465000] stop audio0 on dmx 7 pid:146a [ 149.465000] audio ch0: xpt stop [ 149.466000] sync0 1fff no decoder left in sync handling so disable [ 149.466000] sync0: was last pcroffset0 user so free it [ 149.501000] tsmux set tsports reg 00 to val 06 [ 149.504000] start pcr0 on dmx 7 pid:196e index 3 [ 149.505000] start audio0 on dmx 7 pid:197a index 1 [ 149.506000] audio ch0: xpt start [ 149.506000] sync0 is off so we enable it [ 149.506000] sync0: allocated pcroffset 0 [ 149.507000] sync0: demux-index 7 pcr pid 196e [ 149.507000] sync0: using 3 as pcr pidchannel [ 149.508000] audio ch0: AC3 [ 149.509000] audio ch0: decoder start [ 149.509000] audio ch0 delay 18000 (200 ms) [ 149.510000] VIDEO0: total delay: 18000 (200 ms) [ 149.584000] start video0 on dmx 7 pid:196e index 3 [ 149.585000] VIDEO0: total delay: 18000 (200 ms) [ 149.591000] VIDEO0: start decode [ 149.954000] audio ch0: lock [ 149.955000] audio ch0: sample rate changed isr (48000) [ 149.955000] audio ch0: mode change [ 149.956000] audio ch0: tsm fail [ 149.956000] audio ch0: ignore pts error when audio is not running [ 149.989000] audio ch0: tsm fail [ 149.989000] audio ch0: ignore pts error when audio is not running [ 149.990000] audio ch0: first pts 0x2995a20e, stc 0x299590e8, pcr valid [ 150.284000] audio ch0: status ready [ 150.359000] VIDEO0: first pts 0x2996aa28 [ 150.509000] VIDEO0: enable tsm [ 161.333000] CEC recv ok! [ 161.480000] CEC recv ok! [ 161.624000] CEC recv ok! [ 161.783000] CEC recv ok! [ 162.177000] CEC recv ok! [ 176.394000] CEC recv ok! [ 176.541000] CEC recv ok! [ 176.685000] CEC recv ok! [ 176.843000] CEC recv ok! [ 177.238000] CEC recv ok! [ 191.460000] CEC recv ok! [ 191.605000] CEC recv ok! [ 191.749000] CEC recv ok! [ 191.908000] CEC recv ok! [ 192.345000] CEC recv ok! [ 206.521000] CEC recv ok! [ 206.666000] CEC recv ok! [ 206.810000] CEC recv ok! [ 206.969000] CEC recv ok! [ 207.405000] CEC recv ok! [ 213.708000] stop pcr0 on dmx 7 pid:196e [ 213.708000] stop video0 on dmx 7 pid:196e [ 213.710000] VIDEO0: stop decode [ 213.710000] VIDEO0: set blank to 1 [ 213.711000] audio ch0: decoder stop [ 213.714000] stop audio0 on dmx 7 pid:197a [ 213.714000] audio ch0: xpt stop [ 213.715000] sync0 1fff no decoder left in sync handling so disable [ 213.715000] sync0: was last pcroffset0 user so free it [ 213.751000] tsmux set tsports reg 00 to val 06 [ 213.754000] start pcr0 on dmx 7 pid:1338 index 4 [ 213.755000] start audio0 on dmx 7 pid:133e index 1 [ 213.755000] audio ch0: xpt start [ 213.756000] sync0 is off so we enable it [ 213.756000] sync0: allocated pcroffset 0 [ 213.757000] sync0: demux-index 7 pcr pid 1338 [ 213.757000] sync0: using 4 as pcr pidchannel [ 213.758000] audio ch0: AC3+ [ 213.759000] audio ch0: streamtype set 4 [ 213.759000] audio ch0: streamtype_set: stop rave [ 213.760000] audio ch0: force DDP to AC3 convert! [ 213.760000] audio ch0: passthru [ 213.761000] audio ch0: add stereo input to mixer DAC [ 213.761000] audio ch0: streamtype_set: restart rave [ 213.834000] audio ch0: decoder start [ 213.835000] audio ch0 delay 18000 (200 ms) [ 213.835000] VIDEO0: total delay: 18000 (200 ms) [ 213.841000] start video0 on dmx 7 pid:1338 index 4 [ 213.841000] VIDEO0: total delay: 18000 (200 ms) [ 213.847000] VIDEO0: start decode [ 214.198000] audio ch0: lock [ 214.198000] audio ch0: sample rate changed isr (48000) [ 214.199000] audio ch0: mode change [ 214.199000] audio ch0: tsm fail [ 214.199000] audio ch0: ignore pts error when audio is not running [ 214.231000] audio ch0: tsm fail [ 214.232000] audio ch0: ignore pts error when audio is not running [ 214.266000] audio ch0: tsm fail [ 214.266000] audio ch0: ignore pts error when audio is not running [ 214.267000] audio ch0: first pts 0x1cc5c8fce, stc 0x1cc5c7ac0, pcr valid [ 214.573000] audio ch0: status ready [ 214.573000] audio ch0: dialnorm change [ 215.159000] VIDEO0: first pts 0x1cc5ec86a [ 215.159000] VIDEO0: framerate changed 3 [ 215.160000] VIDEO0: resolution changed (1920 1080) [ 215.160000] VIDEO0: progressive changed (0) [ 215.161000] set current avs auto aspect to 16:9 [ 215.162000] set sb to 3(1) [ 215.312000] VIDEO0: enable tsm [ 221.583000] CEC recv ok! [ 221.634000] stop pcr0 on dmx 7 pid:1338 [ 221.635000] stop video0 on dmx 7 pid:1338 [ 221.636000] VIDEO0: stop decode [ 221.637000] VIDEO0: set blank to 1 [ 221.637000] audio ch0: decoder stop [ 221.641000] stop audio0 on dmx 7 pid:133e [ 221.641000] audio ch0: xpt stop [ 221.642000] sync0 1fff no decoder left in sync handling so disable [ 221.642000] sync0: was last pcroffset0 user so free it [ 221.678000] tsmux set tsports reg 00 to val 06 [ 221.682000] start pcr0 on dmx 7 pid:17de index 3 [ 221.683000] start audio0 on dmx 7 pid:17ea index 1 [ 221.684000] audio ch0: xpt start [ 221.684000] sync0 is off so we enable it [ 221.685000] sync0: allocated pcroffset 0 [ 221.685000] sync0: demux-index 7 pcr pid 17de [ 221.686000] sync0: using 3 as pcr pidchannel [ 221.687000] audio ch0: AC3 [ 221.687000] audio ch0: streamtype set 1 [ 221.687000] audio ch0: streamtype_set: stop rave [ 221.688000] audio ch0: passthru [ 221.688000] audio ch0: remove stereo input from mixer DAC [ 221.689000] audio ch0: streamtype_set: restart rave [ 221.727000] CEC recv ok! [ 221.762000] audio ch0: decoder start [ 221.763000] audio ch0 delay 18000 (200 ms) [ 221.763000] VIDEO0: total delay: 18000 (200 ms) [ 221.767000] start video0 on dmx 7 pid:17de index 3 [ 221.768000] VIDEO0: total delay: 18000 (200 ms) [ 221.774000] VIDEO0: start decode [ 221.899000] CEC recv ok! [ 222.043000] CEC recv ok! [ 222.107000] audio ch0: first pts 0x2a0af268, stc 0x2a0ae092, pcr valid [ 222.139000] audio ch0: lock [ 222.139000] audio ch0: sample rate changed isr (48000) [ 222.140000] audio ch0: mode change [ 222.402000] audio ch0: status ready [ 222.423000] CEC recv ok! [ 223.019000] VIDEO0: first pts 0x2a0c6bde [ 223.019000] VIDEO0: framerate changed 6 [ 223.020000] VIDEO0: resolution changed (1280 720) [ 223.020000] VIDEO0: progressive changed (1) [ 223.021000] set current avs auto aspect to 16:9 [ 223.022000] set sb to 3(1) [ 223.170000] VIDEO0: enable tsm [ 241.968000] CEC recv ok! [ 242.112000] CEC recv ok! [ 242.272000] CEC recv ok! [ 242.416000] CEC recv ok! [ 242.796000] CEC recv ok! [ 257.029000] CEC recv ok! [ 257.202000] CEC recv ok! [ 257.346000] CEC recv ok! [ 257.505000] CEC recv ok! [ 257.899000] CEC recv ok! [ 272.090000] CEC recv ok! [ 272.234000] CEC recv ok! [ 272.398000] CEC recv ok! [ 272.541000] CEC recv ok! [ 272.922000] CEC recv ok! [ 287.151000] CEC recv ok! [ 287.295000] CEC recv ok! [ 287.459000] CEC recv ok! [ 287.603000] CEC recv ok! [ 287.983000] CEC recv ok! [ 302.212000] CEC recv ok! [ 302.356000] CEC recv ok! [ 302.520000] CEC recv ok! [ 302.664000] CEC recv ok! [ 303.044000] CEC recv ok! [ 317.273000] CEC recv ok! [ 317.417000] CEC recv ok! [ 317.582000] CEC recv ok! [ 317.726000] CEC recv ok! [ 318.107000] CEC recv ok! [ 332.335000] CEC recv ok! [ 332.479000] CEC recv ok! [ 332.645000] CEC recv ok! [ 332.789000] CEC recv ok! [ 333.169000] CEC recv ok! [ 347.399000] CEC recv ok! [ 347.543000] CEC recv ok! [ 347.709000] CEC recv ok! [ 347.853000] CEC recv ok! [ 348.233000] CEC recv ok! [ 362.463000] CEC recv ok! [ 362.607000] CEC recv ok! [ 362.774000] CEC recv ok! [ 362.918000] CEC recv ok! [ 363.299000] CEC recv ok! [ 377.525000] CEC recv ok! [ 377.669000] CEC recv ok! [ 377.837000] CEC recv ok! [ 377.981000] CEC recv ok! [ 378.361000] CEC recv ok! [ 392.586000] CEC recv ok! [ 392.730000] CEC recv ok! [ 392.900000] CEC recv ok! [ 393.044000] CEC recv ok! [ 393.425000] CEC recv ok! [ 407.647000] CEC recv ok! [ 407.791000] CEC recv ok! [ 407.962000] CEC recv ok! [ 408.106000] CEC recv ok! [ 408.486000] CEC recv ok! [ 422.708000] CEC recv ok! [ 422.852000] CEC recv ok! [ 423.022000] CEC recv ok! [ 423.166000] CEC recv ok! [ 423.546000] CEC recv ok! [ 437.769000] CEC recv ok! [ 437.913000] CEC recv ok! [ 438.057000] CEC recv ok! [ 438.216000] CEC recv ok! [ 438.610000] CEC recv ok! [ 452.830000] CEC recv ok! [ 452.975000] CEC recv ok! [ 453.119000] CEC recv ok! [ 453.278000] CEC recv ok! [ 453.672000] CEC recv ok! [ 467.892000] CEC recv ok! [ 468.039000] CEC recv ok! [ 468.183000] CEC recv ok! [ 468.342000] CEC recv ok! [ 468.736000] CEC recv ok! [ 482.954000] CEC recv ok! [ 483.102000] CEC recv ok! [ 483.246000] CEC recv ok! [ 483.405000] CEC recv ok! [ 483.799000] CEC recv ok! [ 498.016000] CEC recv ok! [ 498.163000] CEC recv ok! [ 498.307000] CEC recv ok! [ 498.466000] CEC recv ok! [ 498.860000] CEC recv ok! [ 511.346000] stop pcr0 on dmx 7 pid:17de [ 511.346000] stop video0 on dmx 7 pid:17de [ 511.348000] VIDEO0: stop decode [ 511.348000] VIDEO0: set blank to 1 [ 511.349000] audio ch0: decoder stop [ 511.352000] stop audio0 on dmx 7 pid:17ea [ 511.352000] audio ch0: xpt stop [ 511.353000] sync0 1fff no decoder left in sync handling so disable [ 511.353000] sync0: was last pcroffset0 user so free it [ 511.394000] tsmux set tsports reg 00 to val 06 [ 511.397000] start pcr0 on dmx 7 pid:14d3 index 3 [ 511.399000] start audio0 on dmx 7 pid:14d8 index 1 [ 511.399000] audio ch0: xpt start [ 511.400000] sync0 is off so we enable it [ 511.400000] sync0: allocated pcroffset 0 [ 511.401000] sync0: demux-index 7 pcr pid 14d3 [ 511.401000] sync0: using 3 as pcr pidchannel [ 511.402000] audio ch0: AC3 [ 511.402000] audio ch0: decoder start [ 511.403000] audio ch0 delay 18000 (200 ms) [ 511.403000] VIDEO0: total delay: 18000 (200 ms) [ 511.479000] start video0 on dmx 7 pid:14d3 index 3 [ 511.479000] VIDEO0: total delay: 18000 (200 ms) [ 511.485000] VIDEO0: start decode [ 511.862000] audio ch0: lock [ 511.862000] audio ch0: sample rate changed isr (48000) [ 511.863000] audio ch0: mode change [ 511.863000] audio ch0: tsm fail [ 511.864000] audio ch0: ignore pts error when audio is not running [ 511.897000] audio ch0: tsm fail [ 511.898000] audio ch0: ignore pts error when audio is not running [ 511.898000] audio ch0: first pts 0x6dc06a76, stc 0x6dc054b6, pcr valid [ 512.205000] audio ch0: status ready [ 512.478000] VIDEO0: first pts 0x6dc29b4c [ 512.628000] VIDEO0: enable tsm [ 513.080000] CEC recv ok! [ 513.226000] CEC recv ok! [ 513.370000] CEC recv ok! [ 513.529000] CEC recv ok! [ 513.923000] CEC recv ok! [ 528.141000] CEC recv ok! [ 528.287000] CEC recv ok! [ 528.430000] CEC recv ok! [ 528.589000] CEC recv ok! [ 528.983000] CEC recv ok! [ 530.501000] stop pcr0 on dmx 7 pid:14d3 [ 530.502000] stop video0 on dmx 7 pid:14d3 [ 530.503000] VIDEO0: stop decode [ 530.504000] VIDEO0: set blank to 1 [ 530.505000] audio ch0: decoder stop [ 530.507000] stop audio0 on dmx 7 pid:14d8 [ 530.507000] audio ch0: xpt stop [ 530.508000] sync0 1fff no decoder left in sync handling so disable [ 530.508000] sync0: was last pcroffset0 user so free it [ 530.541000] tsmux set tsports reg 00 to val 06 [ 530.545000] start pcr0 on dmx 7 pid:17de index 3 [ 530.546000] start audio0 on dmx 7 pid:17ea index 1 [ 530.547000] audio ch0: xpt start [ 530.547000] sync0 is off so we enable it [ 530.548000] sync0: allocated pcroffset 0 [ 530.548000] sync0: demux-index 7 pcr pid 17de [ 530.549000] sync0: using 3 as pcr pidchannel [ 530.622000] audio ch0: AC3 [ 530.623000] audio ch0: decoder start [ 530.623000] audio ch0 delay 18000 (200 ms) [ 530.623000] VIDEO0: total delay: 18000 (200 ms) [ 530.627000] start video0 on dmx 7 pid:17de index 3 [ 530.628000] VIDEO0: total delay: 18000 (200 ms) [ 530.634000] VIDEO0: start decode [ 531.000000] audio ch0: lock [ 531.000000] audio ch0: sample rate changed isr (48000) [ 531.001000] audio ch0: mode change [ 531.001000] audio ch0: tsm fail [ 531.001000] audio ch0: ignore pts error when audio is not running [ 531.032000] audio ch0: tsm fail [ 531.033000] audio ch0: ignore pts error when audio is not running [ 531.066000] audio ch0: tsm fail [ 531.066000] audio ch0: ignore pts error when audio is not running [ 531.067000] audio ch0: first pts 0x2bb33d28, stc 0x2bb32bb4, pcr valid [ 531.361000] audio ch0: status ready [ 531.678000] VIDEO0: first pts 0x2bb45b36 [ 531.828000] VIDEO0: enable tsm [ 540.006000] stop pcr0 on dmx 7 pid:17de [ 540.007000] stop video0 on dmx 7 pid:17de [ 540.009000] VIDEO0: stop decode [ 540.009000] VIDEO0: set blank to 1 [ 540.010000] audio ch0: decoder stop [ 540.013000] stop audio0 on dmx 7 pid:17ea [ 540.013000] audio ch0: xpt stop [ 540.014000] sync0 1fff no decoder left in sync handling so disable [ 540.014000] sync0: was last pcroffset0 user so free it [ 540.052000] tsmux set tsports reg 00 to val 06 [ 540.056000] start pcr0 on dmx 7 pid:196e index 3 [ 540.057000] start audio0 on dmx 7 pid:197a index 1 [ 540.058000] audio ch0: xpt start [ 540.058000] sync0 is off so we enable it [ 540.059000] sync0: allocated pcroffset 0 [ 540.059000] sync0: demux-index 7 pcr pid 196e [ 540.060000] sync0: using 3 as pcr pidchannel [ 540.060000] audio ch0: AC3 [ 540.133000] audio ch0: decoder start [ 540.133000] audio ch0 delay 18000 (200 ms) [ 540.134000] VIDEO0: total delay: 18000 (200 ms) [ 540.137000] start video0 on dmx 7 pid:196e index 3 [ 540.137000] VIDEO0: total delay: 18000 (200 ms) [ 540.143000] VIDEO0: start decode [ 540.513000] audio ch0: lock [ 540.514000] audio ch0: sample rate changed isr (48000) [ 540.514000] audio ch0: mode change [ 540.515000] audio ch0: tsm fail [ 540.515000] audio ch0: ignore pts error when audio is not running [ 540.547000] audio ch0: tsm fail [ 540.547000] audio ch0: ignore pts error when audio is not running [ 540.548000] audio ch0: first pts 0x2badfc4e, stc 0x2badead0, pcr valid [ 540.738000] VIDEO0: first pts 0x2baea1f8 [ 540.842000] audio ch0: status ready [ 540.888000] VIDEO0: enable tsm [ 543.202000] CEC recv ok! [ 543.349000] CEC recv ok! [ 543.493000] CEC recv ok! [ 543.651000] CEC recv ok! [ 544.046000] CEC recv ok! [ 546.738000] stop pcr0 on dmx 7 pid:196e [ 546.739000] stop video0 on dmx 7 pid:196e [ 546.740000] VIDEO0: stop decode [ 546.741000] VIDEO0: set blank to 1 [ 546.742000] audio ch0: decoder stop [ 546.745000] stop audio0 on dmx 7 pid:197a [ 546.745000] audio ch0: xpt stop [ 546.746000] sync0 1fff no decoder left in sync handling so disable [ 546.746000] sync0: was last pcroffset0 user so free it [ 546.810000] tsmux set tsports reg 00 to val 06 [ 546.814000] start pcr0 on dmx 7 pid:17de index 3 [ 546.815000] start audio0 on dmx 7 pid:17ea index 1 [ 546.816000] audio ch0: xpt start [ 546.816000] sync0 is off so we enable it [ 546.817000] sync0: allocated pcroffset 0 [ 546.817000] sync0: demux-index 7 pcr pid 17de [ 546.818000] sync0: using 3 as pcr pidchannel [ 546.891000] audio ch0: AC3 [ 546.892000] audio ch0: decoder start [ 546.892000] audio ch0 delay 18000 (200 ms) [ 546.893000] VIDEO0: total delay: 18000 (200 ms) [ 546.896000] start video0 on dmx 7 pid:17de index 3 [ 546.897000] VIDEO0: total delay: 18000 (200 ms) [ 546.903000] VIDEO0: start decode [ 547.226000] audio ch0: first pts 0x2bc96e68, stc 0x2e9e4d8, pcr invalid [ 547.258000] audio ch0: lock [ 547.258000] audio ch0: sample rate changed isr (48000) [ 547.259000] audio ch0: mode change [ 547.259000] audio ch0: tsm fail [ 547.260000] audio ch0: pts error 0 PTS 0x2bc96e68, STC 0x2bc96894, type 0 [ 547.538000] VIDEO0: first pts 0x2bca1bf6 [ 547.553000] audio ch0: status ready [ 547.689000] VIDEO0: enable tsm [ 558.263000] CEC recv ok! [ 558.412000] CEC recv ok! [ 558.556000] CEC recv ok! [ 558.715000] CEC recv ok! [ 559.109000] CEC recv ok! [ 573.324000] CEC recv ok! [ 573.473000] CEC recv ok! [ 573.617000] CEC recv ok! [ 573.776000] CEC recv ok! [ 574.170000] CEC recv ok! [ 588.399000] CEC recv ok! [ 588.543000] CEC recv ok! [ 588.711000] CEC recv ok! [ 588.855000] CEC recv ok! [ 589.235000] CEC recv ok! [ 603.449000] CEC recv ok! [ 603.599000] CEC recv ok! [ 603.742000] CEC recv ok! [ 603.902000] CEC recv ok! [ 604.296000] CEC recv ok! [ 618.510000] CEC recv ok! [ 618.660000] CEC recv ok! [ 618.804000] CEC recv ok! [ 618.963000] CEC recv ok! [ 619.357000] CEC recv ok! [ 633.570000] CEC recv ok! [ 633.724000] CEC recv ok! [ 633.868000] CEC recv ok! [ 634.027000] CEC recv ok! [ 634.421000] CEC recv ok! [ 648.631000] CEC recv ok! [ 648.785000] CEC recv ok! [ 648.929000] CEC recv ok! [ 649.088000] CEC recv ok! [ 649.482000] CEC recv ok! [ 663.692000] CEC recv ok! [ 663.846000] CEC recv ok! [ 663.990000] CEC recv ok! [ 664.149000] CEC recv ok! [ 664.543000] CEC recv ok! [ 692.348000] stop pcr0 on dmx 7 pid:17de [ 692.349000] stop video0 on dmx 7 pid:17de [ 692.350000] VIDEO0: stop decode [ 692.351000] VIDEO0: set blank to 1 [ 692.351000] audio ch0: decoder stop [ 692.354000] stop audio0 on dmx 7 pid:17ea [ 692.354000] audio ch0: xpt stop [ 692.355000] sync0 1fff no decoder left in sync handling so disable [ 692.356000] sync0: was last pcroffset0 user so free it [ 692.394000] tsmux set tsports reg 00 to val 06 [ 692.398000] start pcr0 on dmx 7 pid:14d3 index 3 [ 692.399000] start audio0 on dmx 7 pid:14d8 index 1 [ 692.400000] audio ch0: xpt start [ 692.400000] sync0 is off so we enable it [ 692.400000] sync0: allocated pcroffset 0 [ 692.401000] sync0: demux-index 7 pcr pid 14d3 [ 692.401000] sync0: using 3 as pcr pidchannel [ 692.402000] audio ch0: AC3 [ 692.403000] audio ch0: decoder start [ 692.403000] audio ch0 delay 18000 (200 ms) [ 692.404000] VIDEO0: total delay: 18000 (200 ms) [ 692.480000] start video0 on dmx 7 pid:14d3 index 3 [ 692.480000] VIDEO0: total delay: 18000 (200 ms) [ 692.486000] VIDEO0: start decode [ 692.854000] audio ch0: lock [ 692.854000] audio ch0: sample rate changed isr (48000) [ 692.855000] audio ch0: mode change [ 692.855000] audio ch0: tsm fail [ 692.856000] audio ch0: ignore pts error when audio is not running [ 692.889000] audio ch0: tsm fail [ 692.889000] audio ch0: ignore pts error when audio is not running [ 692.890000] audio ch0: first pts 0x6eb8f876, stc 0x6eb8e2a6, pcr valid [ 693.197000] audio ch0: status ready [ 693.257000] VIDEO0: first pts 0x6ebae5cc [ 693.408000] VIDEO0: enable tsm [ 694.980000] CEC recv ok! [ 695.123000] CEC recv ok! [ 695.283000] CEC recv ok! [ 695.428000] CEC recv ok! [ 695.808000] CEC recv ok! [ 710.038000] CEC recv ok! [ 710.182000] CEC recv ok! [ 710.346000] CEC recv ok! [ 710.490000] CEC recv ok! [ 710.870000] CEC recv ok! [ 720.555000] stop pcr0 on dmx 7 pid:14d3 [ 720.556000] stop video0 on dmx 7 pid:14d3 [ 720.557000] VIDEO0: stop decode [ 720.558000] VIDEO0: set blank to 1 [ 720.559000] audio ch0: decoder stop [ 720.561000] stop audio0 on dmx 7 pid:14d8 [ 720.561000] audio ch0: xpt stop [ 720.562000] sync0 1fff no decoder left in sync handling so disable [ 720.562000] sync0: was last pcroffset0 user so free it [ 720.677000] tsmux set tsports reg 00 to val 06 [ 720.681000] start pcr0 on dmx 7 pid:17de index 3 [ 720.682000] start audio0 on dmx 7 pid:17ea index 1 [ 720.683000] audio ch0: xpt start [ 720.683000] sync0 is off so we enable it [ 720.684000] sync0: allocated pcroffset 0 [ 720.684000] sync0: demux-index 7 pcr pid 17de [ 720.685000] sync0: using 3 as pcr pidchannel [ 720.686000] audio ch0: AC3 [ 720.686000] audio ch0: decoder start [ 720.687000] audio ch0 delay 18000 (200 ms) [ 720.687000] VIDEO0: total delay: 18000 (200 ms) [ 720.763000] start video0 on dmx 7 pid:17de index 3 [ 720.763000] VIDEO0: total delay: 18000 (200 ms) [ 720.769000] VIDEO0: start decode [ 721.145000] audio ch0: lock [ 721.145000] audio ch0: sample rate changed isr (48000) [ 721.146000] audio ch0: mode change [ 721.146000] audio ch0: tsm fail [ 721.147000] audio ch0: ignore pts error when audio is not running [ 721.148000] audio ch0: first pts 0x2cb84628, stc 0x2cb8353a, pcr valid [ 721.441000] audio ch0: status ready [ 721.597000] VIDEO0: first pts 0x2cb91de6 [ 721.748000] VIDEO0: enable tsm [ 725.100000] CEC recv ok! [ 725.244000] CEC recv ok! [ 725.408000] CEC recv ok! [ 725.551000] CEC recv ok!