[ 0.000000] Initializing cgroup subsys cpuset [ 0.000000] Initializing cgroup subsys cpu [ 0.000000] Initializing cgroup subsys cpuacct [ 0.000000] Linux version 3.14.29-amlogics905x-ga1fbaec-dirty (root@user-VirtualBox) (gcc version 4.9.4 (Linaro GCC 4.9-2017.01) ) #149 SMP PREEMPT Tue Dec 26 15:53:41 MSK 2017 [ 0.000000] CPU: AArch64 Processor [410fd034] revision 4 [ 0.000000] no prop version_code [ 0.000000] fdt Reserved memory table: [ 0.000000] linux,meson-fb: 0x000000003e000000 - 0x0000000040000000 (32 MiB) [ 0.000000] linux,di: 0x000000003c200000 - 0x000000003e000000 (30 MiB) [ 0.000000] DI: DI reserved memory: created CMA memory pool at 0x000000003c200000, size 30 MiB [ 0.000000] linux,ion-dev: 0x000000003a200000 - 0x000000003c200000 (32 MiB) [ 0.000000] linux,ppmgr: 0x0000000038200000 - 0x000000003a200000 (32 MiB) [ 0.000000] linux,codec_mm_cma: 0x0000000026800000 - 0x0000000033800000 (208 MiB) [ 0.000000] linux,picdec: 0x0000000038200000 - 0x0000000038200000 (0 MiB) [ 0.000000] Reserved memory: incorrect alignment of CMA region [ 0.000000] linux,codec_mm_reserved: 0x0000000034100000 - 0x0000000038200000 (65 MiB) [ 0.000000] fdt Reserved memory total: 402 MiB [ 0.000000] cma: Reserved 8 MiB at 26000000 [ 0.000000] On node 0 totalpages: 249088 [ 0.000000] Normal zone: 4392 pages used for memmap [ 0.000000] Normal zone: 0 pages reserved [ 0.000000] Normal zone: 249088 pages, LIFO batch:31 [ 0.000000] psci: probing function IDs from device-tree [ 0.000000] PERCPU: Embedded 13 pages/cpu @ffffffc0340a4000 s20672 r8192 d24384 u53248 [ 0.000000] pcpu-alloc: s20672 r8192 d24384 u53248 alloc=13*4096 [ 0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 244696 [ 0.000000] Kernel command line: root=LABEL=ROOTFS rootflags=data=writeback rw logo=osd1,loaded,0x3d800000,1080p60hz vout=1080p60hz,enable console=ttyS0,115200n8 console=tty0 no_console_suspend consoleblank=0 fsck.repair=yes net.ifnames=0 mac=c4:2f:ad:19:91:44 [ 0.000000] logo: osd1 [ 0.000000] logo: loaded [ 0.000000] logo: 0x3d800000 [ 0.000000] logo: 1080p60hz [ 0.000000] PID hash table entries: 4096 (order: 3, 32768 bytes) [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes) [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes) [ 0.000000] Memory: 562992K/996352K available (10613K kernel code, 981K rwdata, 3972K rodata, 1184K init, 5782K bss, 433360K reserved) [ 0.000000] Virtual kernel memory layout: vmalloc : 0xffffff8000000000 - 0xffffff8040000000 ( 1024 MB) vmemmap : 0xffffff8040010000 - 0xffffff8041180000 ( 17 MB) modules : 0xffffffbffc000000 - 0xffffffc000000000 ( 64 MB) memory : 0xffffffc000000000 - 0xffffffc03e000000 ( 992 MB) .init : 0xffffffc001ec0000 - 0xffffffc001fe80c0 ( 1185 kB) .text : 0xffffffc001080000 - 0xffffffc001ebf454 ( 14590 kB) .data : 0xffffffc001fe9000 - 0xffffffc0020de500 ( 982 kB) [ 0.000000] PM: Registered nosave memory: [mem 0x01080000-0x01ebefff] [ 0.000000] SLUB: HWalign=64, Order=0-1, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] arch_multi_cluster:0 [ 0.000000] Preemptible hierarchical RCU implementation. [ 0.000000] RCU debugfs-based tracing is enabled. [ 0.000000] RCU restricting CPUs from NR_CPUS=8 to nr_cpu_ids=4. [ 0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS:64 nr_irqs:64 0 [ 0.000000] Architected cp15 timer(s) running at 24.00MHz (phys). [ 0.000004] sched_clock: 56 bits at 24MHz, resolution 41ns, wraps every 2863311519744ns [ 0.000305] Console: colour dummy device 80x25 [ 0.000887] console [tty0] enabled [ 0.002054] allocated 4194304 bytes of page_cgroup [ 0.002067] please try 'cgroup_disable=memory' option if you don't want memory cgroups [ 0.002094] Calibrating delay loop (skipped), value calculated using timer frequency.. 48.00 BogoMIPS (lpj=240000) [ 0.002120] pid_max: default: 32768 minimum: 301 [ 0.002231] Security Framework initialized [ 0.002267] AppArmor: AppArmor initialized [ 0.002319] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes) [ 0.002336] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes) [ 0.004433] device-tree: Duplicate name in /efusekey, renamed to "key0#1" [ 0.004468] device-tree: Duplicate name in /efusekey, renamed to "key1#1" [ 0.004486] device-tree: Duplicate name in /efusekey, renamed to "key2#1" [ 0.004503] device-tree: Duplicate name in /efusekey, renamed to "key3#1" [ 0.007275] Initializing cgroup subsys memory [ 0.007309] Initializing cgroup subsys devices [ 0.007324] Initializing cgroup subsys freezer [ 0.007338] Initializing cgroup subsys blkio [ 0.007350] Initializing cgroup subsys perf_event [ 0.007405] ftrace: allocating 36669 entries in 144 pages [ 0.047556] /cpus/cpu@0: Missing clock-frequency property [ 0.047591] /cpus/cpu@1: Missing clock-frequency property [ 0.047607] /cpus/cpu@2: Missing clock-frequency property [ 0.047622] /cpus/cpu@3: Missing clock-frequency property [ 0.047639] hw perfevents: enabled with arm/armv8-pmuv3 PMU driver, 7 counters available [ 0.087408] Meson chip version = RevA (21:A - 82:0) [ 0.107491] CPU1: Booted secondary processor [ 0.127473] CPU2: Booted secondary processor [ 0.147488] CPU3: Booted secondary processor [ 0.147566] Brought up 4 CPUs [ 0.147615] SMP: Total of 4 processors activated. [ 0.148154] devtmpfs: initialized [ 0.153852] sched: registering cpufreq notifiers for scale-invariant loads [ 0.153945] instabooting: 0 [ 0.160586] xor: measuring software checksum speed [ 0.257350] 8regs : 2292.000 MB/sec [ 0.357354] 8regs_prefetch: 2158.800 MB/sec [ 0.457384] 32regs : 2615.200 MB/sec [ 0.557412] 32regs_prefetch: 2364.400 MB/sec [ 0.557424] xor: using function: 32regs (2615.200 MB/sec) [ 0.557446] pinctrl core: initialized pinctrl subsystem [ 0.558113] regulator-dummy: no parameters [ 0.558874] NET: Registered protocol family 16 [ 0.560813] cpuidle: using governor menu [ 0.561081] aml_vdac_init: module init [ 0.561255] register canvas platform driver [ 0.561346] register rdma platform driver [ 0.562216] vdso: 2 pages (1 code, 1 data) at base ffffffc001ff4000 [ 0.562269] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. [ 0.562596] DMA: preallocated 256 KiB pool for atomic allocations [ 0.563817] software IO TLB [mem 0x23400000-0x23800000] (4MB) mapped at [ffffffc023400000-ffffffc0237fffff] [ 0.563837] Serial: AMBA PL011 UART driver [ 0.564442] aml_i2c version: 20140813 [ 0.564688] i2c-core: driver [pmu4] using legacy resume method [ 0.564776] codec_mm:codec_mm_module_init [ 0.565011] aml_watch_point_probe, in [ 0.565387] gxbb_mpll_clk: register mpll_clk_out0 success done [ 0.565410] gxbb_mpll_clk: register mpll_clk_out1 success done [ 0.565425] gxbb_mpll_clk: register mpll_clk_out2 success done [ 0.565628] clk_sys: register PLL sys_pll success done [ 0.565651] gxl_clk: [ xtal ] ->clockrate: 24000000Hz [ 0.565663] gxl_clk: [ 32Khz ] ->clockrate: 32000Hz [ 0.565676] gxl_clk: [ clk81 ] ->clockrate: 166666666Hz [ 0.565689] gxl_clk: [ fixed_pll ] ->clockrate: 2000000000Hz [ 0.565701] gxl_clk: [ fclk_div2 ] ->clockrate: 1000000000Hz [ 0.565713] gxl_clk: [ fclk_div3 ] ->clockrate: 666666666Hz [ 0.565725] gxl_clk: [ fclk_div4 ] ->clockrate: 500000000Hz [ 0.565737] gxl_clk: [ fclk_div5 ] ->clockrate: 400000000Hz [ 0.565749] gxl_clk: [ fclk_div7 ] ->clockrate: 285714285Hz [ 0.565786] gxl_clk: clock initialization complete [ 0.565993] clkmsr: Gxl msr_clk_reg0=ffffff800005875c,msr_clk_reg2=ffffff800005a764 [ 0.568448] aml_iomap: amlogic iomap probe done [ 0.569144] pinmux-gxl c1109880.pinmux: Init pinux probe! [ 0.570399] pinmux-gxl c1109880.pinmux: Probed amlogic pinctrl driver [ 0.570903] genirq: Setting trigger mode 8 for irq 241 failed (gic_set_type+0x0/0xbc) [ 0.570939] genirq: Setting trigger mode 8 for irq 242 failed (gic_set_type+0x0/0xbc) [ 0.571142] genirq: Setting trigger mode 8 for irq 241 failed (gic_set_type+0x0/0xbc) [ 0.571174] genirq: Setting trigger mode 8 for irq 242 failed (gic_set_type+0x0/0xbc) [ 0.573690] codec_mm has 2 memory regions [ 0.573747] codec_mm codec_mm.19: assigned reserved memory node linux,codec_mm_cma ok [ 0.573770] codec_mm codec_mm.19: assigned reserved memory node linux,codec_mm_reserved ok [ 0.573889] codec_mm has 2 memory regions [ 0.573916] codec_mm codec_mm.19: assigned reserved memory node linux,codec_mm_cma ok [ 0.573937] codec_mm codec_mm.19: assigned reserved memory node linux,codec_mm_reserved ok [ 0.575839] vpu: driver version: v02 [ 0.575886] vpu: load vpu_clk: 666667000Hz(7) [ 0.575986] vpu: vpu_probe OK [ 0.577881] tv_vout: tvout_probe [ 0.577913] tv_vout: major number 254 for disp [ 0.577925] vout_notify: vout_register_server [ 0.577936] tv_vout: register tv module server ok [ 0.578034] tv_vout: tvout_probe OK [ 0.578689] canvas_probe reg=00000000c8838000,size=400 [ 0.578730] canvas maped reg_base =ffffff800007a000 [ 0.582729] rdma_probe [ 0.854977] bio: create slab at 0 [ 1.018229] raid6: int64x1 493 MB/s [ 1.188237] raid6: int64x2 722 MB/s [ 1.358284] raid6: int64x4 1035 MB/s [ 1.528337] raid6: int64x8 1199 MB/s [ 1.698482] raid6: neonx1 773 MB/s [ 1.868517] raid6: neonx2 1203 MB/s [ 2.038557] raid6: neonx4 1564 MB/s [ 2.208622] raid6: neonx8 1729 MB/s [ 2.208633] raid6: using algorithm neonx8 (1729 MB/s) [ 2.208644] raid6: using intx1 recovery algorithm [ 2.209534] SCSI subsystem initialized [ 2.210075] usbcore: registered new interface driver usbfs [ 2.210197] usbcore: registered new interface driver hub [ 2.210336] usbcore: registered new device driver usb [ 2.211357] i2c-gpio i2c_gpio.38: using pins 172 (SDA) and 173 (SCL) [ 2.211521] media: Linux media interface: v0.10 [ 2.211626] Linux video capture interface: v2.00 [ 2.211900] pps_core: LinuxPPS API ver. 1 registered [ 2.211918] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 2.211999] PTP clock support registered [ 2.212630] hdmitx: system: amhdmitx_init [ 2.212652] hdmitx: system: Ver: 2014May6 [ 2.212841] hdmitx: system: amhdmitx_probe [ 2.213247] hdmitx: system: not find match init-data [ 2.213268] hdmitx: system: not find match pwr-ctl [ 2.213281] hdmitx hpd irq = 89 [ 2.213782] hdmitx20: Mapped PHY: 0xc0800000 [ 2.213807] hdmitx20: Mapped PHY: 0xc1104400 [ 2.213836] hdmitx20: Mapped PHY: 0xc8100000 [ 2.213848] hdmitx20: Mapped PHY: 0xc8834000 [ 2.213859] hdmitx20: Mapped PHY: 0xc883a000 [ 2.213871] hdmitx20: Mapped PHY: 0xc883c000 [ 2.213885] hdmitx20: Mapped PHY: 0xd0100000 [ 2.213897] hdmitx20: Mapped PHY: 0xda83a000 [ 2.213917] hdmitx: alread display in uboot 0x10 [ 2.213946] avmute set to 1 [ 2.214430] vout_serve: vout_init_module [ 2.214579] vout_serve: no matched vout_init mode [ 2.214682] vinfo: error: invalid vinfo. current vmode is not supported [ 2.214699] vout_serve: create vout attribute OK [ 2.214710] vout_serve: meson_vout_probe OK [ 2.214913] logo: logo_init [ 2.215240] osd_rdma: osd_rdma_init: rdma_table p=0x26041000,op=0x26041000 , v=0xffffff800007e000 [ 2.215262] osd_rdma: osd rdma request irq as second interrput function! [ 2.215467] Advanced Linux Sound Architecture Driver Initialized. [ 2.216145] NetLabel: Initializing [ 2.216167] NetLabel: domain hash size = 128 [ 2.216177] NetLabel: protocols = UNLABELED CIPSOv4 [ 2.216233] NetLabel: unlabeled traffic allowed by default [ 2.217462] Switched to clocksource arch_sys_counter [ 2.221069] hdmitx: system: irq 80000002 [ 2.231627] FS-Cache: Loaded [ 2.231984] CacheFiles: Loaded [ 2.232146] AppArmor: AppArmor Filesystem Enabled [ 2.243926] NET: Registered protocol family 2 [ 2.244449] TCP established hash table entries: 8192 (order: 4, 65536 bytes) [ 2.244545] TCP bind hash table entries: 8192 (order: 5, 131072 bytes) [ 2.244683] TCP: Hash tables configured (established 8192 bind 8192) [ 2.244769] TCP: reno registered [ 2.244785] UDP hash table entries: 512 (order: 2, 16384 bytes) [ 2.244819] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes) [ 2.245018] NET: Registered protocol family 1 [ 2.245297] RPC: Registered named UNIX socket transport module. [ 2.245317] RPC: Registered udp transport module. [ 2.245327] RPC: Registered tcp transport module. [ 2.245338] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 2.245568] aml_wifi wifi.32: [wifi_dev_probe] no power_on_pin2 [ 2.245584] aml_wifi wifi.32: [wifi_dev_probe] set pwm as 32k output [ 2.245647] aml_wifi wifi.32: [wifi_dev_probe] interrupt_pin=241 [ 2.245662] aml_wifi wifi.32: [wifi_dev_probe] irq_num=100, irq_trigger_type=1 [ 2.245679] aml_wifi wifi.32: [wifi_dev_probe] power_on_pin=240 [ 2.245693] aml_wifi wifi.32: [wifi_dev_probe] clock_32k_pin=0 [ 2.246151] aml_wifi wifi.32: [wifi_setup_dt] wifi_setup_dt [ 2.246205] aml_wifi wifi.32: [wifi_setup_dt] interrupt_pin(241) [ 2.246229] aml_wifi wifi.32: [wifi_setup_dt] power_on_pin(240) [ 2.246576] Unpacking initramfs... [ 2.435889] Freeing initrd memory: 4332K (ffffffc033a7d000 - ffffffc033eb8000) [ 2.438897] futex hash table entries: 1024 (order: 4, 65536 bytes) [ 2.439033] audit: initializing netlink subsys (disabled) [ 2.439089] audit: type=2000 audit(2.410:1): initialized [ 2.440028] HugeTLB registered 2 MB page size, pre-allocated 0 pages [ 2.447566] VFS: Disk quotas dquot_6.5.2 [ 2.447882] Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 2.449983] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ 2.451429] NFS: Registering the id_resolver key type [ 2.451492] Key type id_resolver registered [ 2.451504] Key type id_legacy registered [ 2.451522] nfs4filelayout_init: NFSv4 File Layout Driver Registering... [ 2.452134] jffs2: version 2.2. (NAND) © 2001-2006 Red Hat, Inc. [ 2.452609] ROMFS MTD (C) 2007 Red Hat, Inc. [ 2.453010] fuse init (API version 7.22) [ 2.453749] msgmni has been set to 1540 [ 2.455130] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 246) [ 2.455244] io scheduler noop registered (default) [ 2.455260] io scheduler deadline registered [ 2.455298] io scheduler cfq registered [ 2.532318] meson-rng c8834000.rng: hwrng registered [ 2.532691] [drm] Initialized drm 1.1.0 20060810 [ 2.537023] loop: module loaded [ 2.538219] mtdoops: mtd device (mtddev=name/number) must be supplied [ 2.539409] tun: Universal TUN/TAP device driver, 1.6 [ 2.539435] tun: (C) 1999-2004 Max Krasnyansky [ 2.546776] libphy: stmmac: probed [ 2.546808] eth0: PHY ID 01814400 at 8 IRQ POLL (stmmac-0:08) active [ 2.547310] PPP generic driver version 2.4.2 [ 2.547675] NET: Registered protocol family 24 [ 2.547858] usbcore: registered new interface driver cdc_ether [ 2.548012] usbcore: registered new interface driver cdc_ncm [ 2.548567] platform c9000000.dwc3: Driver dwc3 requests probe deferral [ 2.548737] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver [ 2.548754] ehci-h20ahb: H20AHB-EHCI Host Controller driver [ 2.548991] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver [ 2.549385] usbcore: registered new interface driver cdc_acm [ 2.549407] cdc_acm: USB Abstract Control Model driver for USB modems and ISDN adapters [ 2.549544] usbcore: registered new interface driver usb-storage [ 2.549816] usbcore: registered new interface driver usbserial [ 2.549940] usbcore: registered new interface driver usbserial_generic [ 2.550043] usbserial: USB Serial support registered for generic [ 2.550782] amlogic-new-usb2 d0078000.usb2phy: USB2 phy probe:phy_mem:0xd0078000, iomap phy_base:0xffffff80001de000 [ 2.551046] amlogic-new-usb3 d0078080.usb3phy: This phy has no usb port [ 2.551084] amlogic-new-usb3 d0078080.usb3phy: USB3 phy probe:phy_mem:0xd0078080, iomap phy_base:0xffffff80001fe080 [ 2.551745] mousedev: PS/2 mouse device common for all mice [ 2.552364] i2c /dev entries driver [ 2.553202] cpufreq-hotplug: cpufreq_gov_dbs_init: assumes CONFIG_NO_HZ [ 2.553519] CPUidle arm64: cpuidle init start!! [ 2.553962] ledtrig-cpu: registered to indicate activity on CPUs [ 2.554150] hidraw: raw HID events driver (C) Jiri Kosina [ 2.554659] usbcore: registered new interface driver usbhid [ 2.554681] usbhid: USB HID core driver [ 2.555597] meson_uart c81004c0.serial: ==uart0 reg addr = ffffff80004024c0 [ 2.555649] c81004c0.serial: ttyS0 at MMIO 0xc81004c0 (irq = 225, base_baud = 1500000) is a meson_uart [ 2.555679] meson_uart c81004c0.serial: ttyS0 use xtal(8M) 24000000 change 0 to 115200 [ 2.563407] hdmitx: plugin [ 2.703885] hdmitx: edid: check sum valid [ 2.703887] hdmitx: edid: check sum valid [ 2.703894] hdmitx: edid: blk0 raw data [ 2.703936] 00ffffffffffff0034a981a00101010100120103800000780adaffa3584aa229 17494b00000001010101010101010101010101010101011d00bc52d01e20b828 5540ba882100001e011d007251d01e206e285500ba882100001e000000fc0050 616e61736f6e69632d54560a000000fd00173d0f440f000a20202020202001c6 [ 2.703940] hdmitx: edid: blk1 raw data [ 2.703978] 020321725093841f101405201203110216071506012309070167030c002000b8 26023a80d072382d40102c4580ba882100001e011d80d0721c1620102c2580ba 882100009e8c0ad090204031200c405500ba8821000018011d8018711c162058 2c2500ba882100009e8c0ad08a20e02d10103e9600ba882100001800000000e5 [ 2.703983] EDID Parser: [ 2.704061] hdmitx: edid: find IEEEOUT [ 2.704065] hdmitx: edid: check sum valid [ 2.704066] hdmitx: edid: check sum valid [ 2.704071] vinfo: error: invalid vinfo. current vmode is not supported [ 2.704073] hdmitx: update RX hdr info 0 [ 2.706104] hdmitx: ddc rd8b error 0x3a 0x00 0x00 [ 2.708147] [RX]-receive ksv list len:1,depth:1,cas:0,dev:0 [ 2.708152] vinfo: error: invalid vinfo. current vmode is not supported [ 2.708154] hdmitx: video: get current mode: invalid [ 2.708156] hdmitx: update rx hdr info 0 [ 2.708184] hdmitx: edid: not find mapped vic [ 2.708220] hdmitx: system: already init VIC = 0 Now VIC = 0 [ 2.708225] hdmitx: system: packet: can't get vendor data [ 2.708227] hdmtix: set audio [ 2.708236] hdmitx tx_aud_src = 0 [ 2.708246] hdmitx: system: irq 80000001 [ 2.708283] hdmitx: fs = 0, cd = 4, tmds_clk = 0 [ 2.708286] hdmitx aud_n_para = 6144 [ 2.708303] hdmitx set channel status [ 2.708362] hdmtix: set audio [ 2.708371] hdmitx tx_aud_src = 0 [ 2.708395] hdmitx: fs = 0, cd = 4, tmds_clk = 0 [ 2.708396] hdmitx aud_n_para = 6144 [ 2.708413] hdmitx set channel status [ 2.708481] Start = 0x10000100 End = 0x100001ff [ 2.708488] [0x10000103]: 0x00000008 [ 2.708492] [0x10000104]: 0x00000001 [ 2.708647] [0x10000170]: 0x00000010 [ 2.708671] [0x10000180]: 0x000000ff [ 2.708674] [0x10000181]: 0x000000ff [ 2.708676] [0x10000182]: 0x00000003 [ 2.708679] [0x10000183]: 0x00000007 [ 2.708682] [0x10000184]: 0x0000003f [ 2.708685] [0x10000185]: 0x00000002 [ 2.708690] [0x10000187]: 0x000000ff [ 2.708693] [0x10000188]: 0x00000003 [ 4.339717] console [ttyS0] enabled [ 4.343857] meson_uart c11084c0.serial: ==uart1 reg addr = ffffff80004044c0 [ 4.350436] c11084c0.serial: ttyS1 at MMIO 0xc11084c0 (irq = 58, base_baud = 1500000) is a meson_uart [ 4.360474] dwc_otg: usb0: type: 2 speed: 0, config: 0, dma: 0, id: 0, phy: d0078000, ctrl: 0 [ 4.368352] dwc_otg_driver_probe host only, not probe usb_otg!!! [ 4.374898] hdmitx: system: hdmitx_hdcp_init [ 4.379062] ESM HLD: Initializing... [ 4.382572] ESM HLD: Registering device range 'esm'... [ 4.387848] ESM HLD: Device range 'esm' has been registered. [ 4.393611] ESM HLD: Creating class /sys/class/elliptic... [ 4.399321] ESM HLD: The class /sys/class/elliptic has been created. [ 4.405685] ESM HLD: Creating device 'esm'... [ 4.410396] ESM HLD: Device 'esm' has been created. [ 4.415173] ESM HLD: Done initializing the HLD driver. [ 4.436505] aml_vrtc rtc.31: rtc core: registered aml_vrtc as rtc0 [ 4.437413] BLASTER Driver Init [ 4.441330] secmon has 1 memory regions [ 4.444510] secmon: share in base: 0xffffff800040e000, share out base: 0xffffff8000410000 [ 4.452771] secmon secmon.4: assigned reserved memory node linux,secmon ok [ 4.459743] secmon: probe done [ 4.463287] storage: storage in base: 0xffffff8001600000 [ 4.468373] storage: storage out base: 0xffffff8001680000 [ 4.473883] storage: storage block base: 0xffffff8001700000 [ 4.479580] storage: probe done! [ 4.483189] Error: Driver 'ICPlus IP175C' is already registered, aborting... [ 4.490107] libphy: ICPlus IP175C: Error -16 in registering driver [ 4.496396] Error: Driver 'AMLOGIC internal phy' is already registered, aborting... [ 4.504162] libphy: AMLOGIC internal phy: Error -16 in registering driver [ 4.512409] Error: Driver 'RTL8211F Gigabit Ethernet' is already registered, aborting... [ 4.519266] libphy: RTL8211F Gigabit Ethernet: Error -16 in registering driver [ 4.527066] aml_sd_emmc_probe: line 3558 [ 4.530649] mmc driver version: 1.07, 2015-01-21: fix a bug in tuning which caused eMMC data CRC error [ 4.540492] aml_sd_emmc_reg_init 1146 [ 4.543919] get property: ocr_avail, value:0x00200080 [ 4.550319] get property: f_min, value:400000 [ 4.556454] get property: f_max, value:100000000 [ 4.562815] get property: max_req_size, value:0x00020000 [ 4.569299] get property: irq_in, value:3 [ 4.574969] get property: irq_out, value:5 [ 4.580682] get property: gpio_cd, str: [ 4.586114] get property: pinname, str:sd [ 4.591709] get property: jtag_pin, str: [ 4.597136] get property: card_type, value:5 [ 4.602851] get property: gpio_dat3, str: [ 4.608283] sd:pdata->caps = 7 [ 4.611452] sd:pdata->caps2 = 0 [ 4.648657] [aml_is_card_insert] card OUT [ 4.648748] [aml_is_card_insert] card OUT [ 4.651370] [aml_sd_emmc_probe] aml_sd_emmc_probe() success! [ 4.657173] aml_sd_emmc_probe: line 3558 [ 4.661491] aml_sd_emmc_reg_init 1146 [ 4.665071] get property: ocr_avail, value:0x00200080 [ 4.671467] get property: f_min, value:300000 [ 4.677586] get property: f_max, value:100000000 [ 4.683964] get property: max_req_size, value:0x00020000 [ 4.690441] get property: pinname, str:emmc [ 4.696213] get property: card_type, value:1 [ 4.701917] get property: gpio_dat3, str: [ 4.707338] get property: hw_reset, str: [ 4.712812] emmc:pdata->caps = c0000d47 [ 4.716742] emmc:pdata->caps2 = 18060 [ 4.720548] storage 1, boot 1 [ 4.723638] get_storage_dev return 1 [ 4.767465] [aml_sd_emmc_probe] aml_sd_emmc_probe() success! [ 4.772970] aml_sd_emmc_probe: line 3558 [ 4.773356] aml_sd_emmc_reg_init 1146 [ 4.775610] get property: ocr_avail, value:0x00200080 [ 4.781997] get property: f_min, value:400000 [ 4.788116] get property: f_max, value:200000000 [ 4.794493] get property: max_req_size, value:0x00020000 [ 4.800971] get property: pinname, str:sdio [ 4.806742] get property: card_type, value:3 [ 4.812167] emmc: BKOPS_EN bit is not set [ 4.816645] sdio:pdata->caps = 7810f [ 4.819465] emmc: try set sd/emmc to DDR mode [ 4.820094] emmc: new DDR MMC card at address 0001 [ 4.820991] emmc: clock 50000000, 8-bit-bus-width [ 4.820992] mmcblk0: emmc:0001 EMS008 7.20 GiB [ 4.821161] mmcblk0boot0: emmc:0001 EMS008 partition 1 4.00 MiB [ 4.821313] mmcblk0boot1: emmc:0001 EMS008 partition 2 4.00 MiB [ 4.821471] mmcblk0rpmb: emmc:0001 EMS008 partition 3 512 KiB [ 4.822805] mmcblk0: unknown partition table [ 4.823544] [aml_sd_emmc_irq] emmc: warning... data crc, vstat:0xe1ff00ff, virqc:3fff [ 4.823544] [aml_sd_emmc_irq] @ cmd 18 with ffffffc023beb948; stop 0, status 4 [ 4.823552] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 4.823553] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x12000, operation is in ["ecebved] disk! [ 4.823572] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 4.823578] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 4.823580] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 4.823582] emmc: retry, rx_phase 0 -> 1 [ 4.823606] aml_sd_emmc_data_thread : 2563 [ 4.823984] [mmc_read_partition_tbl] mmc read partition OK! [ 4.823985] add_emmc_partition [ 4.824338] [mmcblk0p01] bootloader offset 0x000000000000, size 0x000000400000 [ 4.824578] [mmcblk0p02] reserved offset 0x000002400000, size 0x000004000000 [ 4.824772] [mmcblk0p03] cache offset 0x000006c00000, size 0x000020000000 [ 4.824968] [mmcblk0p04] env offset 0x000027400000, size 0x000000800000 [ 4.825158] [mmcblk0p05] logo offset 0x000028400000, size 0x000002000000 [ 4.825343] [mmcblk0p06] recovery offset 0x00002ac00000, size 0x000002000000 [ 4.825554] [mmcblk0p07] rsv offset 0x00002d400000, size 0x000000800000 [ 4.825753] [mmcblk0p08] tee offset 0x00002e400000, size 0x000000800000 [ 4.825945] [mmcblk0p09] crypt offset 0x00002f400000, size 0x000002000000 [ 4.826131] [mmcblk0p10] misc offset 0x000031c00000, size 0x000002000000 [ 4.826316] [mmcblk0p11] instaboot offset 0x000034400000, size 0x000020000000 [ 4.826524] [mmcblk0p12] boot offset 0x000054c00000, size 0x000002000000 [ 4.826727] [mmcblk0p13] system offset 0x000057400000, size 0x000040000000 [ 4.826911] [mmcblk0p14] data offset 0x000097c00000, size 0x000135180000 [ 4.826957] card key: card_blk_probe. [ 4.826962] emmc_key_init:527 emmc key lba_start:0x12020,lba_end:0x12220 [ 4.826967] emmc key: emmc_key_init:552 ok. [ 4.827271] amlmmc_dtb_init: register dtb chardev [ 4.827364] amlmmc_dtb_init: register dtb chardev OK [ 4.827365] Exit aml_emmc_partition_ops OK. [ 4.830073] mmcblk0boot1: unknown partition table [ 4.832505] mmcblk0boot0: unknown partition table [ 4.832881] clear_emmc_wait_flag [ 5.090665] sdio:pdata->caps2 = 0 [ 5.127466] [aml_sd_emmc_probe] aml_sd_emmc_probe() success! [ 5.128032] ion_dev has 1 memory regions [ 5.134629] fb: osd_init_module [ 5.135118] fb: viu vsync irq: 35 [ 5.138466] meson-fb has 1 memory regions [ 5.142616] meson-fb meson-fb.16: assigned reserved memory node linux,meson-fb ok [ 5.150195] vinfo: error: invalid vinfo. current vmode is not supported [ 5.156906] fb: osd_probe vinfo:ffffffc00207e3b0 [ 5.161657] fb: init fbdev bpp is:32 [ 5.166065] fb: Frame buffer memory assigned at [ 5.166065] fb: 0, phy: 0x000000003e000000, vir:0xffffff8001900000, size=24576K [ 5.166068] fb: ---------------clear fb0 memory ffffff8001900000 [ 5.179696] fb: osd[0] canvas.idx =0x40 [ 5.179697] fb: osd[0] canvas.addr=0x3e000000 [ 5.179699] fb: osd[0] canvas.width=7680 [ 5.179700] fb: osd[0] canvas.height=3240 [ 5.179702] fb: osd[0] frame.width=1920 [ 5.179703] fb: osd[0] frame.height=1080 [ 5.185238] vinfo: error: invalid vinfo. current vmode is not supported [ 5.227561] Console: switching to colour frame buffer device 240x67 [ 5.318313] fb: osd probe OK [ 5.318665] ge2d: ge2d_init_module [ 5.319367] ge2d: ge2d_dev major:241 [ 5.323528] ge2d: ge2d clock is 400 MHZ [ 5.327038] ge2d: ge2d: pdev=ffffffc024ad7000, irq=182, rstc=0xffffffc024af2b80, clk=ffffffc024a56e00 [ 5.336412] ge2d: mapped phy: 0xd0160000 [ 5.340412] ge2d: ge2d start monitor [ 5.344186] ge2d: ge2d workqueue monitor start [ 5.344686] codec:Amlogic A/V streaming port init [ 5.346890] codec:get gate demux control ok ffffffc022653900 [ 5.346895] codec:get gate parser_top control ok ffffffc022653600 [ 5.346900] codec:get gate vpu_intr control ok ffffffc022653300 [ 5.346906] codec:get gate vdec control ok ffffffc022653000 [ 5.347825] codec:[tsync_pcr_init]init success. [ 5.347829] codec:amvideocap_init_module [ 5.348022] codec:amvideocap_probe,amvideocap [ 5.348027] codec:use cma buf. [ 5.348030] codec:amvideocap_dev_register [ 5.350207] amvenc_avc_probe -- reserved memory config fail. [ 5.350213] amvenc_avc - cma memory pool size: 40 MB [ 5.350242] encode_wq_init. [ 5.350250] encode start monitor. [ 5.350323] encode workqueue monitor start. [ 5.351012] jpegenc module init [ 5.351435] codec:picdec_driver_probe called. [ 5.351440] picdec has 1 memory regions [ 5.351480] codec:picdec_driver_probe done. [ 5.352776] vinfo: error: invalid vinfo. current vmode is not supported [ 5.353005] codec:create_ge2d_work_queue video task ok [ 5.353551] codec:used fix clk for vdec clk source! [ 5.353558] codec:register clk_set_setting cpu[33] [ 5.353970] vpu_init [ 5.353972] The chip is not support hevc encoder [ 5.353979] DI: di_module_init ok. [ 5.353990] DI: di_module_init: major 235 [ 5.354579] DI: di_probe [ 5.354885] deinterlace has 1 memory regions [ 5.354926] DI: di reveser memory 0x3c200000, size 30MB. [ 5.354937] deinterlace deinterlace.26: assigned reserved memory node linux,di ok [ 5.354965] di_irq:78,timerc_irq:38 [ 5.496856] rdma_register, rdma_table_addr ffffff800058b000 rdma_table_addr_phy 26048000 reg_buf ffffffc0227a6000 [ 5.506568] rdma_register success, handle 1 table_size 8192 [ 5.512256] DI: di_probe allocate rdma channel 1. [ 5.517239] DI: DI hw version 2. [ 5.522191] 0x000000db:Y=db,U=0,V=0 [ 5.527132] 0x000000dc:Y=dc,U=0,V=0 [ 5.532005] 0x000000dd:Y=dd,U=0,V=0 [ 5.536803] 0x000000de:Y=de,U=0,V=0 [ 5.541560] 0x000000df:Y=df,U=0,V=0 [ 5.546291] 0x000000e0:Y=e0,U=0,V=0 [ 5.550998] 0x000000e1:Y=e1,U=0,V=0 [ 5.555621] 0x000000e2:Y=e2,U=0,V=0 [ 5.560140] 0x000000e3:Y=e3,U=0,V=0 [ 5.564553] 0x000000f0:Y=f0,U=0,V=0 [ 5.568892] 0x000000f1:Y=f1,U=0,V=0 [ 5.573178] 0x000000f2:Y=f2,U=0,V=0 [ 5.577419] 0x000000f3:Y=f3,U=0,V=0 [ 5.581577] 0x000000f4:Y=f4,U=0,V=0 [ 5.585642] 0x000000f5:Y=f5,U=0,V=0 [ 5.589640] 0x000000f6:Y=f6,U=0,V=0 [ 5.593561] 0x000000f7:Y=f7,U=0,V=0 [ 5.597477] 0x000000f8:Y=f8,U=0,V=0 [ 5.601372] 0x000000f9:Y=f9,U=0,V=0 [ 5.605259] 0x000000fa:Y=fa,U=0,V=0 [ 5.609130] 0x000000fb:Y=fb,U=0,V=0 [ 5.612988] 0x000000fc:Y=fc,U=0,V=0 [ 5.616932] DI: di_probe here. [ 5.621138] efusekeynum: 4 [ 5.624854] efusekeyname: mac offset: 0 size: 6 [ 5.629393] efusekeyname: mac_bt offset: 6 size: 6 [ 5.635737] efusekeyname: mac_wifi offset: 12 size: 6 [ 5.642138] efusekeyname: usid offset: 18 size: 16 [ 5.648953] efuse efuse.10: probe OK! [ 5.652972] key unify config unifykey-num is 14 [ 5.657008] key unify fact unifykey-num is 14 [ 5.661480] aml_unifykeys_probe:1273=============unifykey_devno:e900000 [ 5.668585] 6unifykey: device unifykeys created ok [ 5.673356] 6aml_unifykeys_init done! [ 5.677047] PPMGRDRV: warn: ppmgr module init func called [ 5.682764] PPMGRDRV: err: ppmgr_driver_probe called [ 5.687683] ppmgr has 1 memory regions [ 5.691569] PPMGRDRV: info: ppmgr_dev major:232 [ 5.696654] PPMGRDRV: info: ppmgr_probe done [ 5.701222] amlogic rfkill init [ 5.705073] enter bt_probe of_node [ 5.708778] not get gpio_en [ 5.712353] power on valid level is high [ 6.128053] ionvideo-000: V4L2 device registered as video13 [ 6.135336] ionvid: info: Video Technology Magazine Ion Video [ 6.141245] ionvid: info: Capture Board ver 1.0 successfully loaded [ 6.147616] audio_dsp: [dsp]register dsp to char divece(257) [ 6.154352] amaudio: amaudio: driver amaudio succuess! [ 6.159082] amlvid:err: amlvideo_init called [ 6.162850] amlvid:err: amlvideo_create_instance called [ 6.170372] amlvid:err: v4l2_dev.name=:amlvideo-000 [ 6.175384] amlvideo-000: V4L2 device registered as video10 [ 6.181337] [RX]-hdmirx: hdmirx_init. [ 6.185090] ESM HLD: Initializing... [ 6.188816] ESM HLD: Registering device range 'esm_rx'... [ 6.193780] ESM HLD: Device range 'esm_rx' has been registered. [ 6.199827] ESM HLD: Creating class /sys/class/elliptic_rx... [ 6.205833] ESM HLD: The class /sys/class/elliptic_rx has been created. [ 6.212433] ESM HLD: Creating device 'esm_rx'... [ 6.217419] ESM HLD: Device 'esm_rx' has been created. [ 6.222442] ESM HLD: Done initializing the HLD driver. [ 6.227686] [viuin..]viuin_init_module viuin module init [ 6.233689] [viuin..]viuin_probe probe ok. [ 6.237539] module init [ 6.241277] VECM probe start [ 6.248651] aml_vecm_probe: ok [ 6.252906] saradc c1108680.saradc: initialized by BL30 [ 6.256535] saradc c1108680.saradc: calibration start: [ 6.261613] saradc c1108680.saradc: nominal=0, value=5 [ 6.266823] saradc c1108680.saradc: nominal=256, value=251 [ 6.272454] saradc c1108680.saradc: nominal=512, value=500 [ 6.278053] saradc c1108680.saradc: nominal=768, value=748 [ 6.283641] saradc c1108680.saradc: nominal=1023, value=998 [ 6.289311] saradc c1108680.saradc: calibration end: coef=4219 [ 6.295578] remote: Driver init [ 6.299463] remote: platform_data g_remote_ao_offset=580 [ 6.303954] remote: platform_data irq =228 [ 6.308243] remote: set drvdata completed [ 6.314125] remote: device_create_file completed [ 6.318777] input: aml_keypad as /devices/meson-remote.12/input/input0 [ 6.324452] remote: input_register_device completed [ 6.330281] remote: set_remote_mode[74] [ 6.335370] remote: remote config major:229 [ 6.339933] remote: physical address:0x226ce000 [ 6.344880] gpio-key gpio_keypad.48: gpio_key: 0 name(power) pin() [ 6.349964] gpio-key gpio_keypad.48: amlogic_gpio_name_map_num pin 0!:: [ 6.356651] gpio-key gpio_keypad.48: gpio_key: 0 power(147) [ 6.362391] gpio-key gpio_keypad.48: start setup_timer [ 6.367611] gpio-key gpio_keypad.48: power key(116) registed. [ 6.373784] input: gpio_keypad as /devices/gpio_keypad.48/input/input1 [ 6.380450] gpio-key gpio_keypad.48: gpio keypad register input device completed. [ 6.387739] input input1: gpio keypad major:228 [ 6.393403] Sensor: lsm303d_init [ 6.398419] Sensor: stk8313_init [ 6.403120] Sensor: stk831x_init [ 6.407807] Sensor: mxc622x_acc_init [ 6.412435] Sensor: mxc6255xc_acc_init [ 6.416982] Sensor: l3gd20_gyr_init [ 6.423398] cpuinfo: probe done [ 6.428308] defendkey c8834500.defendkey: defendkey_devno:e100000 [ 6.433761] defendkey c8834500.defendkey: defendkey: device defendkey created ok [ 6.441223] defendkey: driver init [ 6.446514] input: cec_input as /devices/virtual/input/input2 [ 6.451697] cectx aocec: aml_cec_probe(): no hdmirx reg resource [ 6.457396] cectx aocec: aml_cec_probe(): no hhi reg resource [ 6.463407] cectx aocec: aml_cec_probe(): can't find hdmirx [ 6.468980] input input1: key 116 up [ 6.474576] cec: wake up flag:0 [ 6.479710] aml_aes_dma c883e000.aml_aes: Aml AES_dma [ 6.484952] aml_tdes_dma c883e000.aml_tdes: Aml TDES_dma [ 6.490388] aml_sha_dma c883e000.aml_sha: Aml SHA1/SHA224/SHA256 dma [ 6.498083] aml_codec_T9015 c8832000.t9015: aml_T9015_audio_codec_probe [ 6.505870] aml-i2s-dai I2S.40: Can't retrieve mpll2 clock [ 6.510545] aml-i2s-dai: probe of I2S.40 failed with error -2 [ 6.516841] aml_pcm_dai: pcm mode detection =0 [ 6.522066] aml_spdif_dai: enterd aml_spdif_play,set_clock:-1,sample_rate=4 [ 6.528289] aml_spdif_dai: set normal 512 fs /4 fs [ 6.533126] aml_audio_hw: IEC958 16bit [ 6.537678] hdmitx: audio: aout notify rate 48000 [ 6.542245] hdmitx: audio: aout notify size 16 [ 6.546764] hdmitx: audio: aout notify format CT_PCM [ 6.551522] hdmtix: set audio [ 6.555965] hdmitx tx_aud_src = 0 [ 6.560402] hdmitx: fs = 3, cd = 4, tmds_clk = 0 [ 6.564791] hdmitx aud_n_para = 6144 [ 6.569197] hdmitx set channel status [ 6.573598] hdmitx: audio: Audio Type: PCM [ 6.577934] hdmitx: audio: set audio param [ 6.583300] aml_snd_m8_card aml_m8_snd.47: ASoC: Neither/both codec name/of_node are set for (null) [ 6.591474] aml_snd_m8_card aml_m8_snd.47: register aml sound card error -22 [ 6.598587] aml_snd_m8_card aml_m8_snd.47: Can't probe snd_soc_card [ 6.604965] aml_snd_m8_card: probe of aml_m8_snd.47 failed with error -22 [ 6.612552] GACT probability NOT on [ 6.617196] Mirror/redirect action on [ 6.621836] u32 classifier [ 6.626394] Actions configured [ 6.630996] Netfilter messages via NETLINK v0.30. [ 6.635722] nf_conntrack version 0.5.0 (6160 buckets, 24640 max) [ 6.641583] ctnetlink v0.93: registering with nfnetlink. [ 6.647107] xt_time: kernel timezone is -0000 [ 6.652149] ipip: IPv4 over IPv4 tunneling driver [ 6.657939] ip_tables: (C) 2000-2006 Netfilter Core Team [ 6.662979] arp_tables: (C) 2002 David S. Miller [ 6.667926] TCP: cubic registered [ 6.672748] Initializing XFRM netlink socket [ 6.678588] NET: Registered protocol family 10 [ 6.684411] mip6: Mobile IPv6 [ 6.689318] ip6_tables: (C) 2000-2006 Netfilter Core Team [ 6.694409] sit: IPv6 over IPv4 tunneling driver [ 6.700863] NET: Registered protocol family 17 [ 6.705843] NET: Registered protocol family 15 [ 6.710800] Bridge firewalling registered [ 6.715649] l2tp_core: L2TP core driver, V2.0 [ 6.720444] l2tp_ip: L2TP IP encapsulation support (L2TPv3) [ 6.725355] l2tp_netlink: L2TP netlink interface [ 6.730242] l2tp_eth: L2TP ethernet pseudowire support (L2TPv3) [ 6.736143] l2tp_debugfs: L2TP debugfs support [ 6.740938] l2tp_ip6: L2TP IP encapsulation support for IPv6 (L2TPv3) [ 6.747310] NET: Registered protocol family 35 [ 6.752176] Key type dns_resolver registered [ 6.757934] Registering SWP/SWPB emulation handler [ 6.765220] bio: create slab at 1 [ 6.771413] Btrfs loaded [ 6.776494] BTRFS: selftest: Running btrfs free space cache tests [ 6.782173] BTRFS: selftest: Running extent only tests [ 6.787412] BTRFS: selftest: Running bitmap only tests [ 6.792691] BTRFS: selftest: Running bitmap and extent tests [ 6.798480] BTRFS: selftest: Free space cache tests finished [ 6.804204] BTRFS: selftest: Running extent buffer operation tests [ 6.810347] BTRFS: selftest: Running btrfs_split_item tests [ 6.820030] BTRFS: selftest: Running find delalloc tests [ 7.096152] BTRFS: selftest: Running btrfs_get_extent tests [ 7.101636] BTRFS: selftest: Running hole first btrfs_get_extent test [ 7.197564] AppArmor: AppArmor sha1 policy hashing enabled [ 7.202523] regulator-dummy: disabling [ 7.909451] xhci-hcd xhci-hcd.0.auto: xHCI Host Controller [ 7.914445] xhci-hcd xhci-hcd.0.auto: new USB bus registered, assigned bus number 1 [ 7.922577] xhci-hcd xhci-hcd.0.auto: irq 62, io mem 0xc9000000 [ 7.928387] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 7.935117] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 7.942487] usb usb1: Product: xHCI Host Controller [ 7.947469] usb usb1: Manufacturer: Linux 3.14.29 xhci-hcd [ 7.953056] usb usb1: SerialNumber: xhci-hcd.0.auto [ 7.958809] hub 1-0:1.0: USB hub found [ 7.963735] hub 1-0:1.0: 2 ports detected [ 7.968873] xhci-hcd xhci-hcd.0.auto: xHCI Host Controller [ 7.973774] xhci-hcd xhci-hcd.0.auto: new USB bus registered, assigned bus number 2 [ 7.981688] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003 [ 7.988448] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 7.995750] usb usb2: Product: xHCI Host Controller [ 8.000816] usb usb2: Manufacturer: Linux 3.14.29 xhci-hcd [ 8.006358] usb usb2: SerialNumber: xhci-hcd.0.auto [ 8.012169] hub 2-0:1.0: USB hub found [ 8.017365] hub 2-0:1.0: config failed, hub doesn't have any ports! (err -19) [ 8.024944] console [netcon0] enabled [ 8.030140] netconsole: network logging started [ 8.035270] aml_vrtc rtc.31: setting system clock to 2015-01-01 00:00:25 UTC (1420070425) [ 8.044179] cpufreq-scpi cpufreq-meson.7: enter cpufreq [ 8.049517] cpufreq-scpi cpufreq-meson.7: probe cpufreq okay [ 8.060001] gxbb_pm: enter meson_pm_probe! [ 8.123048] gxbb_pm: meson_pm_probe done [ 8.129999] thermal: can't found cooling_devices [ 8.134485] aml-thermal: probe of thermal failed with error -22 [ 8.139908] aml_istbt_dev_ready NULL [ 8.144357] ALSA device list: [ 8.148713] No soundcards found. [ 8.153745] Freeing unused kernel memory: 1184K (ffffffc001ec0000 - ffffffc001fe8000) [ 8.182479] vout_serve: vmode set to 720p60hz [ 8.191827] vinfo: error: invalid vinfo. current vmode is not supported [ 8.198518] fb: current vmode=invalid [ 8.202952] tv_vout: tv_set_current_vmode[764]fps_target_mode=10 [ 8.208477] tv_vout: mode is 10,sync_duration_den=1,sync_duration_num=60 [ 8.215243] tv_vout: TV mode 720p60hz selected. [ 8.219939] vdac_enable: on:0,module_sel:8 [ 8.229230] vdac_enable: on:0,module_sel:8 [ 8.238483] tv_vout: new mode =720p60hz set ok [ 8.243028] vout_serve: vinfo mode is: 720p60hz [ 8.247691] vout_serve: new mode 720p60hz set ok [ 8.257241] hdmitx: video: get current mode: 720p60hz [ 8.262414] hdmitx: update rx hdr info 0 [ 8.266790] hdmitx: get ext_name [ 8.272821] hdmitx: system: already init VIC = 0 Now VIC = 4 [ 8.278234] hdmitx: rx no SCDC present indicator [ 8.285385] hdmitx: ddc rd8b error 0x54 0x01 [ 8.292502] hdmitx: ddc rd8b error 0x54 0x01 [ 8.297568] hdmirx version is 1.4 or below [ 8.302656] hdmitx div40: 0 [ 8.337462] hdmitx: system: set mode VIC 4 (cd0,cs0,pm1,vd0,1) [ 8.342954] hdmitx: system: set pll [ 8.347493] usb 1-1: new low-speed USB device number 2 using xhci-hcd [ 8.356193] hdmitx: ddc w1b error 0x54 0x20 0x00 [ 8.363416] hdmitx: ddc w1b error 0x54 0x20 0x00 [ 8.371608] hdmitx: ddc rd8b error 0x54 0x21 [ 8.376590] hdmitx: system: param->VIC:4 [ 8.381496] hdmitx: set clk: VIC = 4 cd = 4 [ 8.386367] config HPLL = 2970000 [ 8.391209] HPLL: 0xc000027b [ 8.395989] config HPLL done [ 8.400737] set_hpll_od3_clk_div[441] div = 6 [ 8.405472] j = 2 vid_clk_div = 1 [ 8.410181] hdmitx: set enc for VIC: 4 [ 8.414859] hdmitx_set_hw[4867] set VIC = 4 [ 8.490766] usb 1-1: New USB device found, idVendor=6901, idProduct=1224 [ 8.496742] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0 [ 8.504732] usb 1-1: ep 0x82 - rounding interval to 32 microframes, ep desc says 40 microframes [ 8.522515] input: HID 6901:1224 as /devices/c9000000.dwc3/xhci-hcd.0.auto/usb1/1-1/1-1:1.0/0003:6901:1224.0001/input/input3 [ 8.533850] hid-generic 0003:6901:1224.0001: input,hidraw0: USB HID v1.10 Keyboard [HID 6901:1224] on usb-xhci-hcd.0.auto-1/input0 [ 8.549479] hdmitx: system: phy setting done [ 8.552728] input: HID 6901:1224 as /devices/c9000000.dwc3/xhci-hcd.0.auto/usb1/1-1/1-1:1.1/0003:6901:1224.0002/input/input4 [ 8.553313] hid-generic 0003:6901:1224.0002: input,hidraw1: USB HID v1.10 Mouse [HID 6901:1224] on usb-xhci-hcd.0.auto-1/input1 [ 8.580235] hdmitx: system: irq 80000001 [ 8.584225] Sink is HDMI device [ 8.584240] hdmitx: system: packet: can't get vendor data [ 8.584244] hdmtix: set audio [ 8.584258] hdmitx tx_aud_src = 0 [ 8.584298] hdmitx: fs = 3, cd = 4, tmds_clk = 74250 [ 8.584301] hdmitx aud_n_para = 6144 [ 8.584328] hdmitx set channel status [ 8.584413] hdmitx: audio: Audio Type: PCM [ 8.584420] fb: current vmode=720p60hz [ 8.678433] Start = 0x10000100 End = 0x100001ff [ 8.688179] [0x10000104]: 0x00000001 [ 8.698166] [0x10000180]: 0x000000ff [ 8.698171] [0x10000181]: 0x000000ff [ 8.698179] fb: osd[0] enable: 1 (hdmi_init.sh) [ 8.698182] [0x10000182]: 0x00000003 [ 8.698187] [0x10000183]: 0x00000007 [ 8.698191] [0x10000184]: 0x0000003f [ 8.698196] [0x10000185]: 0x00000002 [ 8.698203] [0x10000187]: 0x000000ff [ 8.698208] [0x10000188]: 0x00000003 [ 8.752217] usb 1-2: new high-speed USB device number 3 using xhci-hcd [ 8.837321] random: systemd-udevd urandom read with 43 bits of entropy available [ 8.908644] usb 1-2: New USB device found, idVendor=0951, idProduct=1625 [ 8.914175] usb 1-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3 [ 8.921528] usb 1-2: Product: DT 101 II [ 8.925852] usb 1-2: Manufacturer: Kingston [ 8.930206] usb 1-2: SerialNumber: 0014785448B1B9C030000307 [ 8.938324] usb-storage 1-2:1.0: USB Mass Storage device detected [ 8.943565] scsi0 : usb-storage 1-2:1.0 [ 9.951294] scsi 0:0:0:0: Direct-Access Kingston DT 101 II PMAP PQ: 0 ANSI: 0 CCS [ 10.024568] sd 0:0:0:0: [sda] 7837696 512-byte logical blocks: (4.01 GB/3.73 GiB) [ 10.024664] sd 0:0:0:0: Attached scsi generic sg0 type 0 [ 10.040153] sd 0:0:0:0: [sda] Write Protect is off [ 10.046881] sd 0:0:0:0: [sda] Mode Sense: 23 00 00 00 [ 10.047124] sd 0:0:0:0: [sda] No Caching mode page found [ 10.053742] sd 0:0:0:0: [sda] Assuming drive cache: write through [ 10.062425] sd 0:0:0:0: [sda] No Caching mode page found [ 10.069111] sd 0:0:0:0: [sda] Assuming drive cache: write through [ 10.077038] sda: sda1 sda2 [ 10.085007] sd 0:0:0:0: [sda] No Caching mode page found [ 10.091701] sd 0:0:0:0: [sda] Assuming drive cache: write through [ 10.098945] sd 0:0:0:0: [sda] Attached SCSI removable disk [ 13.729042] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 13.797602] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 13.805027] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 13.939167] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 14.010970] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 14.071833] emmc: retry, rx_phase 1 -> 2 [ 14.077461] aml_sd_emmc_data_thread : 2563 [ 14.077472] emmc: req failed (CMD18): -110, retrying... [ 15.731714] random: nonblocking pool is initialized [ 18.173092] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 18.245733] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 18.253070] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x18, operation is in [bootloader] disk! [ 18.397084] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 18.467730] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 18.540107] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 18.574054] emmc: retry, rx_phase 2 -> 3 [ 18.579452] aml_sd_emmc_data_thread : 2563 [ 18.584694] emmc: req failed (CMD18): -110, retrying... [ 22.685892] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 22.752859] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 22.760195] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x38, operation is in [bootloader] disk! [ 22.893532] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 22.961078] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 22.976570] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 22.983035] emmc: retry, rx_phase 3 -> 0 [ 22.987937] aml_sd_emmc_data_thread : 2563 [ 22.992823] emmc: req failed (CMD18): -110, retrying... [ 27.093924] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 27.165919] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 27.173252] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x78, operation is in [bootloader] disk! [ 27.317446] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 27.391024] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 27.467931] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 27.476716] emmc: retry, rx_phase 0 -> 1 [ 27.483008] aml_sd_emmc_data_thread : 2563 [ 27.489325] emmc: req failed (CMD18): -110, retrying... [ 31.591009] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 31.670892] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 31.678229] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x10, operation is in [bootloader] disk! [ 31.838415] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 31.918163] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 31.974670] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 31.982041] emmc: retry, rx_phase 1 -> 2 [ 31.988506] aml_sd_emmc_data_thread : 2563 [ 31.994887] emmc: req failed (CMD18): -110, retrying... [ 36.096913] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 36.178846] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 36.186179] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x80, operation is in [bootloader] disk! [ 36.350117] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 36.432311] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 36.475961] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 36.483455] emmc: retry, rx_phase 2 -> 3 [ 36.490111] aml_sd_emmc_data_thread : 2563 [ 36.496688] emmc: req failed (CMD18): -110, retrying... [ 40.598933] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 40.682309] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 40.689646] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x40, operation is in [bootloader] disk! [ 40.854000] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 40.936529] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 40.976383] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 40.983954] emmc: retry, rx_phase 3 -> 0 [ 40.990679] aml_sd_emmc_data_thread : 2563 [ 40.997374] emmc: req failed (CMD18): -110, retrying... [ 45.100112] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 45.186059] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 45.193398] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x200, operation is in [bootloader] disk! [ 45.365003] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 45.450733] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 45.477075] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 45.483987] emmc: retry, rx_phase 0 -> 1 [ 45.490004] aml_sd_emmc_data_thread : 2563 [ 45.495971] emmc: req failed (CMD18): -110, retrying... [ 49.598143] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 49.685171] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 49.692507] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x20, operation is in [bootloader] disk! [ 49.865735] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 49.952167] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 49.977230] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 49.984176] emmc: retry, rx_phase 1 -> 2 [ 49.990226] aml_sd_emmc_data_thread : 2563 [ 49.996195] emmc: req failed (CMD18): -110, retrying... [ 54.102164] emmc: unexpected status 0x400b00 after switch [ 54.175855] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 54.211556] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 54.218889] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x1f80, operation is in [bootloader] disk! [ 54.289709] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 54.298756] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 54.308192] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 54.316154] emmc: retry, rx_phase 2 -> 3 [ 54.323222] aml_sd_emmc_data_thread : 2563 [ 54.327465] emmc: req failed (CMD18): -110, retrying... [ 58.422872] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 58.509805] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 58.517143] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x1ff0, operation is in [bootloader] disk! [ 58.689967] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 58.775970] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 58.864560] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 58.950831] emmc: retry, rx_phase 3 -> 0 [ 58.974713] aml_sd_emmc_data_thread : 2563 [ 58.977476] emmc: req failed (CMD18): -110, retrying... [ 63.072870] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 63.159871] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 63.167302] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 63.235914] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 63.272162] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 63.279864] emmc: retry, rx_phase 0 -> 1 [ 63.286651] aml_sd_emmc_data_thread : 2563 [ 63.293360] emmc: req failed (CMD18): -110, retrying... [ 67.395875] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 67.481815] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 67.489149] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x8, operation is in [bootloader] disk! [ 67.660564] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 67.746105] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 67.777233] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 67.784796] emmc: retry, rx_phase 1 -> 2 [ 67.791456] aml_sd_emmc_data_thread : 2563 [ 67.798033] emmc: req failed (CMD18): -110, retrying... [ 71.899908] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 71.985797] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 71.993135] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x1ff8, operation is in [bootloader] disk! [ 72.164858] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 72.250565] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 72.277054] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 72.283949] emmc: retry, rx_phase 2 -> 3 [ 72.289946] aml_sd_emmc_data_thread : 2563 [ 72.295858] emmc: req failed (CMD18): -110, retrying... [ 76.398152] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 76.484100] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 76.491435] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x1ef8, operation is in [bootloader] disk! [ 76.663265] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 76.748948] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 76.776950] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 76.783844] emmc: retry, rx_phase 3 -> 0 [ 76.789838] aml_sd_emmc_data_thread : 2563 [ 76.795752] emmc: req failed (CMD18): -110, retrying... [ 80.897019] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 80.983011] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 80.990348] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x1fc0, operation is in [bootloader] disk! [ 81.162224] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 81.248030] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 81.276881] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 81.283783] emmc: retry, rx_phase 0 -> 1 [ 81.289785] aml_sd_emmc_data_thread : 2563 [ 81.295704] emmc: req failed (CMD18): -110, retrying... [ 85.396884] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 85.482845] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 85.490181] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x1f00, operation is in [bootloader] disk! [ 85.662110] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 85.748383] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 85.776940] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 85.783894] emmc: retry, rx_phase 1 -> 2 [ 85.789945] aml_sd_emmc_data_thread : 2563 [ 85.795911] emmc: req failed (CMD18): -110, retrying... [ 89.898156] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 89.984533] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 89.991871] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x1e70, operation is in [bootloader] disk! [ 90.163876] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 90.250337] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 90.277076] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 90.284030] emmc: retry, rx_phase 2 -> 3 [ 90.290086] aml_sd_emmc_data_thread : 2563 [ 90.296056] emmc: req failed (CMD18): -110, retrying... [ 94.398157] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 94.484475] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 94.491811] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x1db0, operation is in [bootloader] disk! [ 94.663674] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 94.750007] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 94.777049] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 94.784004] emmc: retry, rx_phase 3 -> 0 [ 94.790067] aml_sd_emmc_data_thread : 2563 [ 94.796050] emmc: req failed (CMD18): -110, retrying... [ 98.898153] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 98.985091] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 98.992432] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x1d58, operation is in [bootloader] disk! [ 99.166260] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 99.253017] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 99.277289] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 99.284262] emmc: retry, rx_phase 0 -> 1 [ 99.290336] aml_sd_emmc_data_thread : 2563 [ 99.296334] emmc: req failed (CMD18): -110, retrying... [ 103.398158] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 103.485264] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 103.492603] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x1d20, operation is in [bootloader] disk! [ 103.666829] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 103.753707] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 103.777366] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 103.784346] emmc: retry, rx_phase 1 -> 2 [ 103.790416] aml_sd_emmc_data_thread : 2563 [ 103.796409] emmc: req failed (CMD18): -110, retrying... [ 107.898161] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 107.985167] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 107.992505] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x1c70, operation is in [bootloader] disk! [ 108.166555] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 108.253423] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 108.277349] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 108.284320] emmc: retry, rx_phase 2 -> 3 [ 108.290391] aml_sd_emmc_data_thread : 2563 [ 108.296384] emmc: req failed (CMD18): -110, retrying... [ 112.398161] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 112.485230] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 112.492564] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x1c30, operation is in [bootloader] disk! [ 112.666720] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 112.753560] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 112.777363] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 112.784335] emmc: retry, rx_phase 3 -> 0 [ 112.790405] aml_sd_emmc_data_thread : 2563 [ 112.796394] emmc: req failed (CMD18): -110, retrying... [ 116.898154] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 116.985149] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 116.992486] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x1c20, operation is in [bootloader] disk! [ 117.166541] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 117.253440] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 117.277354] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 117.284334] emmc: retry, rx_phase 0 -> 1 [ 117.290407] aml_sd_emmc_data_thread : 2563 [ 117.296402] emmc: req failed (CMD18): -110, retrying... [ 121.398170] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 121.485226] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 121.492562] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x1c48, operation is in [bootloader] disk! [ 121.666681] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 121.753541] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 121.777361] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 121.784333] emmc: retry, rx_phase 1 -> 2 [ 121.790399] aml_sd_emmc_data_thread : 2563 [ 121.796389] emmc: req failed (CMD18): -110, retrying... [ 125.898174] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 125.985146] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 125.992485] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x13f0, operation is in [bootloader] disk! [ 126.166439] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 126.253301] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 126.277335] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 126.284306] emmc: retry, rx_phase 2 -> 3 [ 126.290373] aml_sd_emmc_data_thread : 2563 [ 126.296363] emmc: req failed (CMD18): -110, retrying... [ 130.398431] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 130.485439] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 130.492774] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x800, operation is in [bootloader] disk! [ 130.666601] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 130.753365] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 130.777351] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 130.784313] emmc: retry, rx_phase 3 -> 0 [ 130.790377] aml_sd_emmc_data_thread : 2563 [ 130.796361] emmc: req failed (CMD18): -110, retrying... [ 134.898237] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 134.985163] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 134.992497] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x18, operation is in [bootloader] disk! [ 135.166073] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 135.252728] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 135.277280] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 135.284235] emmc: retry, rx_phase 0 -> 1 [ 135.290289] aml_sd_emmc_data_thread : 2563 [ 135.296265] emmc: req failed (CMD18): -110, retrying... [ 139.398176] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 139.484996] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 139.492334] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x38, operation is in [bootloader] disk! [ 139.665726] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 139.752281] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 139.777236] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 139.784191] emmc: retry, rx_phase 1 -> 2 [ 139.790243] aml_sd_emmc_data_thread : 2563 [ 139.796216] emmc: req failed (CMD18): -110, retrying... [ 143.898174] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 143.984978] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 143.992314] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x78, operation is in [bootloader] disk! [ 144.165655] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 144.252230] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 144.277226] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 144.284181] emmc: retry, rx_phase 2 -> 3 [ 144.290230] aml_sd_emmc_data_thread : 2563 [ 144.296203] emmc: req failed (CMD18): -110, retrying... [ 148.398168] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 148.484941] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 148.492278] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x10, operation is in [bootloader] disk! [ 148.665582] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 148.752093] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 148.777217] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 148.784171] emmc: retry, rx_phase 3 -> 0 [ 148.790217] aml_sd_emmc_data_thread : 2563 [ 148.796187] emmc: req failed (CMD18): -110, retrying... [ 152.898185] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 152.984917] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 152.992252] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x80, operation is in [bootloader] disk! [ 153.165465] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 153.251978] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 153.277214] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 153.284162] emmc: retry, rx_phase 0 -> 1 [ 153.290207] aml_sd_emmc_data_thread : 2563 [ 153.296176] emmc: req failed (CMD18): -110, retrying... [ 157.398181] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 157.484906] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 157.492243] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x40, operation is in [bootloader] disk! [ 157.665498] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 157.752001] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 157.777213] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 157.784160] emmc: retry, rx_phase 1 -> 2 [ 157.790206] aml_sd_emmc_data_thread : 2563 [ 157.796175] emmc: req failed (CMD18): -110, retrying... [ 161.898298] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 161.985079] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 161.992414] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x200, operation is in [bootloader] disk! [ 162.165805] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 162.252395] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 162.277239] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 162.284194] emmc: retry, rx_phase 2 -> 3 [ 162.290249] aml_sd_emmc_data_thread : 2563 [ 162.296225] emmc: req failed (CMD18): -110, retrying... [ 166.398171] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 166.484982] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 166.492316] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x20, operation is in [bootloader] disk! [ 166.665717] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 166.752271] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 166.777237] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 166.784192] emmc: retry, rx_phase 3 -> 0 [ 166.790246] aml_sd_emmc_data_thread : 2563 [ 166.796225] emmc: req failed (CMD18): -110, retrying... [ 170.898242] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 170.985078] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 170.992413] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x1000, operation is in [bootloader] disk! [ 171.166093] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 171.252790] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 171.277270] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 171.284234] emmc: retry, rx_phase 0 -> 1 [ 171.290295] aml_sd_emmc_data_thread : 2563 [ 171.296279] emmc: req failed (CMD18): -110, retrying... [ 180.938931] EXT4-fs (sda2): mounted filesystem with writeback data mode. Opts: data=writeback [ 182.287090] systemd[1]: System time before build time, advancing clock. [ 182.342946] systemd[1]: systemd 232 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN) [ 182.365159] systemd[1]: Detected architecture arm64. [ 182.414979] systemd[1]: Set hostname to . [ 182.474144] meson_uart c81004c0.serial: ttyS0 use xtal(8M) 24000000 change 115200 to 115200 [ 183.007500] systemd[1]: Listening on udev Control Socket. [ 183.023153] systemd[1]: Reached target Remote File Systems. [ 183.038440] systemd[1]: Listening on /dev/initctl Compatibility Named Pipe. [ 183.055335] systemd[1]: Created slice User and Session Slice. [ 183.071450] systemd[1]: Created slice System Slice. [ 183.085096] systemd[1]: Created slice system-getty.slice. [ 183.100300] systemd[1]: Mounting Huge Pages File System... [ 183.115671] systemd[1]: Mounting Debug File System... [ 183.129406] systemd[1]: Created slice system-systemd\x2dfsck.slice. [ 183.145351] systemd[1]: Mounting POSIX Message Queue File System... [ 183.159469] systemd[1]: Reached target Slices. [ 183.173005] systemd[1]: Listening on Journal Socket. [ 183.191301] systemd[1]: Starting Load Kernel Modules... [ 183.207324] systemd[1]: Starting Restore / save the current clock... [ 183.223754] systemd[1]: Starting Create list of required static device nodes for the current kernel... [ 183.243220] systemd[1]: Starting Set the console keyboard layout... [ 183.259580] systemd[1]: Starting Nameserver information manager... [ 183.274083] systemd[1]: Listening on Journal Socket (/dev/log). [ 183.288227] systemd[1]: Listening on fsck to fsckd communication Socket. [ 183.305092] systemd[1]: Starting Remount Root and Kernel File Systems... [ 183.320323] systemd[1]: Listening on Syslog Socket. [ 183.320988] aml_nftl_dev: module license 'Proprietary' taints kernel. [ 183.320990] Disabling lock debugging due to kernel taint [ 183.348447] systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. [ 183.366350] systemd[1]: Listening on udev Kernel Socket. [ 183.380994] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. [ 183.397775] systemd[1]: Started Forward Password Requests to Wall Directory Watch. [ 183.413990] systemd[1]: Reached target Encrypted Volumes. [ 183.428098] systemd[1]: Reached target Paths. [ 184.572268] EXT4-fs (sda2): re-mounted. Opts: commit=600,errors=remount-ro [ 184.674432] systemd[1]: Created slice system-serial\x2dgetty.slice. [ 184.694355] systemd[1]: Mounted Debug File System. [ 184.710084] systemd[1]: Mounted POSIX Message Queue File System. [ 184.724233] systemd[1]: Mounted Huge Pages File System. [ 184.739344] systemd[1]: Started Load Kernel Modules. [ 184.754104] systemd[1]: Started Restore / save the current clock. [ 184.769054] systemd[1]: Started Create list of required static device nodes for the current kernel. [ 184.789632] systemd[1]: Started Remount Root and Kernel File Systems. [ 184.807986] systemd[1]: Time has been changed [ 184.816663] systemd[1]: Started Nameserver information manager. [ 184.834020] systemd[1]: Activating swap /var/swap... [ 184.859525] systemd[1]: Starting udev Coldplug all Devices... [ 184.875541] systemd[1]: Starting Load/Save Random Seed... [ 184.891823] systemd[1]: Starting Create Static Device Nodes in /dev... [ 184.903123] Adding 131068k swap on /var/swap. Priority:-1 extents:1 across:131068k FS [ 184.918208] systemd[1]: Starting Apply Kernel Variables... [ 184.934267] systemd[1]: Mounting FUSE Control File System... [ 184.950848] systemd[1]: Mounting Configuration File System... [ 184.965472] systemd[1]: Activated swap /var/swap. [ 184.981887] systemd[1]: Mounted FUSE Control File System. [ 184.995891] systemd[1]: Mounted Configuration File System. [ 185.010381] systemd[1]: Started Set the console keyboard layout. [ 185.027995] systemd[1]: Started Load/Save Random Seed. [ 185.035873] systemd[1]: Started Apply Kernel Variables. [ 185.045804] systemd[1]: Reached target Swap. [ 185.268170] systemd[1]: Started udev Coldplug all Devices. [ 185.500021] systemd[1]: Started Create Static Device Nodes in /dev. [ 185.523145] systemd[1]: Starting udev Kernel Device Manager... [ 185.537221] systemd[1]: Reached target Local File Systems (Pre). [ 185.570566] systemd[1]: Mounting /tmp... [ 185.583624] systemd[1]: Mounted /tmp. [ 185.678378] systemd[1]: Started udev Kernel Device Manager. [ 185.888772] systemd[1]: Found device /dev/ttyS0. [ 185.976773] emmc: unexpected status 0x400b00 after switch [ 185.976815] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 185.976823] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 185.976830] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0xe66b80, operation is in [data] disk! [ 185.976843] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 185.976850] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 185.976854] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 185.976857] emmc: retry, rx_phase 1 -> 2 [ 185.976879] aml_sd_emmc_data_thread : 2563 [ 185.976887] emmc: req failed (CMD18): -110, retrying... [ 186.050307] mali-utgard d00c0000.mali: set min pp to default 1 [ 186.050322] mali-utgard d00c0000.mali: set min clk default to 0 [ 186.050444] mali-utgard d00c0000.mali: max clk set 5 [ 186.050452] mali-utgard d00c0000.mali: turbo clk set to 6 [ 186.050457] mali-utgard d00c0000.mali: default clk set to 2 [ 186.050929] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. [ 186.054570] gpu cooling register okay with err=0 [ 186.054645] gpu core cooling register okay with err=0 [ 186.054965] Mali: Mali device driver loaded [ 186.064743] systemd[1]: Starting Load/Save RF Kill Switch Status... [ 186.233894] BT_RADIO going: on [ 186.233917] BCM_BT: going ON [ 186.453183] ionvid: info: ionvideo open [ 186.647520] ionvid: info: ionvideo_stop_generating!!!! [ 186.647554] ionvid: info: ionvideo release [ 186.650278] systemd[1]: Started Load/Save RF Kill Switch Status. [ 186.736042] systemd[1]: Found device DT_101_II BOOT. [ 186.745414] systemd[1]: Starting File System Check on /dev/disk/by-label/BOOT... [ 186.766139] systemd[1]: Started File System Check Daemon to report status. [ 186.984072] systemd[1]: Started File System Check on /dev/disk/by-label/BOOT. [ 187.015319] systemd[1]: Mounting /boot... [ 187.668925] systemd[1]: Mounted /boot. [ 187.683077] systemd[1]: Reached target Local File Systems. [ 187.698962] systemd[1]: Starting Armbian enhanced Log2Ram... [ 187.715582] systemd[1]: Starting HDMI init... [ 187.728911] fb: osd[0] canvas.idx =0x40 [ 187.728915] fb: osd[0] canvas.addr=0x3e000000 [ 187.728918] fb: osd[0] canvas.width=5760 [ 187.728921] fb: osd[0] canvas.height=2160 [ 187.728923] fb: osd[0] frame.width=1920 [ 187.728925] fb: osd[0] frame.height=1080 [ 187.733079] systemd[1]: Starting Raise network interfaces... [ 187.778297] fb: Frame buffer memory assigned at [ 187.778298] fb: 1, phy: 0x000000003f800000, vir:0xffffff8003380000, size=1024K [ 187.778300] fb: fb1 open, logo index:1 [ 187.782666] fb: osd[1] canvas.idx =0x43 [ 187.782668] fb: osd[1] canvas.addr=0x3f800000 [ 187.782669] fb: osd[1] canvas.width=128 [ 187.782670] fb: osd[1] canvas.height=32 [ 187.782672] fb: osd[1] frame.width=32 [ 187.782673] fb: osd[1] frame.height=32 [ 187.798518] vout_serve: vmode set to 1080p60hz [ 187.798550] vout_serve: disable HDMI PHY as soon as possible [ 187.798557] fb: current vmode=720p60hz [ 187.798567] tv_vout: tv_set_current_vmode[764]fps_target_mode=16 [ 187.798572] tv_vout: mode is 16,sync_duration_den=1,sync_duration_num=60 [ 187.798582] tv_vout: TV mode 1080p60hz selected. [ 187.798588] vdac_enable: on:0,module_sel:8 [ 187.798598] vdac_enable: on:0,module_sel:8 [ 187.798607] tv_vout: new mode =1080p60hz set ok [ 187.798611] vout_serve: vinfo mode is: 1080p60hz [ 187.798615] vout_serve: new mode 1080p60hz set ok [ 187.798632] hdmitx: video: get current mode: 1080p60hz [ 187.798635] hdmitx: update rx hdr info 0 [ 187.798650] hdmitx: get ext_name 720p60hz [ 187.798688] hdmitx: system: already init VIC = 0 Now VIC = 16 [ 187.798695] hdmitx: rx no SCDC present indicator [ 187.800717] hdmitx: ddc rd8b error 0x54 0x01 [ 187.800727] systemd[1]: Starting Set console font and keymap... [ 187.802756] hdmitx: ddc rd8b error 0x54 0x01 [ 187.802763] hdmirx version is 1.4 or below [ 187.802765] hdmitx div40: 0 [ 187.810886] systemd[1]: Started ifup for eth0. [ 187.827711] hdmitx: system: set mode VIC 16 (cd0,cs0,pm1,vd0,1) [ 187.827723] hdmitx: system: set pll [ 187.827726] hdmitx: system: param->VIC:16 [ 187.827731] hdmitx: set clk: VIC = 16 cd = 4 [ 187.827739] config HPLL = 2970000 [ 187.827761] HPLL: 0xc000027b [ 187.827764] config HPLL done [ 187.827773] set_hpll_od3_clk_div[441] div = 6 [ 187.827783] j = 4 vid_clk_div = 1 [ 187.827797] hdmitx: set enc for VIC: 16 [ 187.827820] hdmitx_set_hw[4867] set VIC = 16 [ 187.831196] systemd[1]: Started Set console font and keymap. [ 187.837602] hdmitx: system: irq 80000001 [ 187.837624] Start = 0x10000100 End = 0x100001ff [ 187.837634] [0x10000104]: 0x00000001 [ 187.837637] [0x10000105]: 0x00000003 [ 187.837805] [0x10000170]: 0x00000004 [ 187.837833] [0x10000180]: 0x000000ff [ 187.837836] [0x10000181]: 0x000000ff [ 187.837881] [0x10000182]: 0x00000003 [ 187.837884] [0x10000183]: 0x00000007 [ 187.837886] [0x10000184]: 0x0000003f [ 187.837889] [0x10000185]: 0x00000002 [ 187.837893] [0x10000187]: 0x000000ff [ 187.837896] [0x10000188]: 0x00000003 [ 187.839496] hdmitx: ddc w1b error 0x54 0x20 0x00 [ 187.839624] hdmitx: system: irq 80000001 [ 187.839656] Start = 0x10000100 End = 0x100001ff [ 187.839665] [0x10000104]: 0x00000001 [ 187.839668] [0x10000105]: 0x00000003 [ 187.839829] [0x10000170]: 0x00000004 [ 187.839852] [0x10000180]: 0x000000ff [ 187.839855] [0x10000181]: 0x000000ff [ 187.839857] [0x10000182]: 0x00000003 [ 187.839860] [0x10000183]: 0x00000007 [ 187.839862] [0x10000184]: 0x0000003f [ 187.839865] [0x10000185]: 0x00000002 [ 187.839869] [0x10000187]: 0x000000ff [ 187.839872] [0x10000188]: 0x00000003 [ 187.841511] hdmitx: ddc w1b error 0x54 0x20 0x00 [ 187.841646] hdmitx: system: irq 80000001 [ 187.841686] Start = 0x10000100 End = 0x100001ff [ 187.841698] [0x10000104]: 0x00000001 [ 187.841703] [0x10000105]: 0x00000003 [ 187.841874] [0x10000170]: 0x00000004 [ 187.841901] [0x10000180]: 0x000000ff [ 187.841905] [0x10000181]: 0x000000ff [ 187.841910] [0x10000182]: 0x00000003 [ 187.841915] [0x10000183]: 0x00000007 [ 187.841920] [0x10000184]: 0x0000003f [ 187.841924] [0x10000185]: 0x00000002 [ 187.841931] [0x10000187]: 0x000000ff [ 187.841935] [0x10000188]: 0x00000003 [ 187.843533] hdmitx: ddc rd8b error 0x54 0x21 [ 187.959519] hdmitx: system: phy setting done [ 187.965261] Sink is HDMI device [ 187.965286] hdmitx: system: packet: can't get vendor data [ 187.965293] hdmtix: set audio [ 187.965304] hdmitx tx_aud_src = 0 [ 187.965333] hdmitx: fs = 3, cd = 4, tmds_clk = 148500 [ 187.965338] hdmitx aud_n_para = 6144 [ 187.965358] hdmitx set channel status [ 187.965419] hdmitx: audio: Audio Type: PCM [ 187.965429] fb: current vmode=1080p60hz [ 188.012678] fb: osd[0] enable: 1 (hdmi.sh) [ 188.040206] systemd[1]: Started Armbian enhanced Log2Ram. [ 188.069231] systemd[1]: Started HDMI init. [ 188.080808] systemd[1]: Starting Journal Service... [ 188.256850] systemd[1]: Started Journal Service. [ 188.303618] systemd-journald[2969]: Received request to flush runtime journal from PID 1 [ 190.072038] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 190.072054] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 190.072061] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0xe66bf0, operation is in [data] disk! [ 190.072080] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 190.072087] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 190.072092] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 190.072095] emmc: retry, rx_phase 2 -> 3 [ 190.072119] aml_sd_emmc_data_thread : 2563 [ 190.072127] emmc: req failed (CMD18): -110, retrying... [ 190.517681] libphy: stmmac-0:08 - Link is Up - 100/Full [ 191.465588] input: lircd-uinput as /devices/virtual/input/input5 [ 192.722665] fb: osd[0] canvas.idx =0x40 [ 192.722667] fb: osd[0] canvas.addr=0x3e000000 [ 192.722670] fb: osd[0] canvas.width=5760 [ 192.722671] fb: osd[0] canvas.height=1080 [ 192.722673] fb: osd[0] frame.width=1920 [ 192.722674] fb: osd[0] frame.height=1080 [ 192.729162] fb: osd[0] enable: 0 (Xorg) [ 194.166985] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 194.167000] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 194.167020] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 194.167027] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 194.167031] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 194.167035] emmc: retry, rx_phase 3 -> 0 [ 194.167058] aml_sd_emmc_data_thread : 2563 [ 194.167066] emmc: req failed (CMD18): -110, retrying... [ 195.266224] meson_uart c11084c0.serial: ttyS1 use xtal(8M) 24000000 change 0 to 9600 [ 195.266274] meson_uart c11084c0.serial: ttyS1 use xtal(8M) 24000000 change 9600 to 9600 [ 195.266296] meson_uart c11084c0.serial: ttyS1 use xtal(8M) 24000000 change 9600 to 115200 [ 195.439624] Bluetooth: Core ver 2.18 [ 195.439696] NET: Registered protocol family 31 [ 195.439700] Bluetooth: HCI device and connection manager initialized [ 195.439824] Bluetooth: HCI socket layer initialized [ 195.439838] Bluetooth: L2CAP socket layer initialized [ 195.440834] Bluetooth: SCO socket layer initialized [ 195.456665] Bluetooth: HCI UART driver ver 2.2 [ 195.456680] Bluetooth: HCI H4 protocol initialized [ 195.456684] Bluetooth: HCI BCSP protocol initialized [ 195.456688] Bluetooth: HCILL protocol initialized [ 195.456691] Bluetooth: HCIATH3K protocol initialized [ 195.456695] Bluetooth: HCI Three-wire UART (H5) protocol initialized [ 196.924832] Bluetooth: BNEP (Ethernet Emulation) ver 1.3 [ 196.924845] Bluetooth: BNEP filters: protocol multicast [ 196.924879] Bluetooth: BNEP socket layer initialized [ 197.457464] Bluetooth: hci0 command 0x1003 tx timeout [ 198.262033] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 198.262048] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 198.262054] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x8, operation is in [bootloader] disk! [ 198.262076] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 198.262085] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 198.262089] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 198.262092] emmc: retry, rx_phase 0 -> 1 [ 198.262115] aml_sd_emmc_data_thread : 2563 [ 198.262123] emmc: req failed (CMD18): -110, retrying... [ 199.457467] Bluetooth: hci0 command 0x1001 tx timeout [ 200.768736] meson_uart c81004c0.serial: ttyS0 use xtal(8M) 24000000 change 115200 to 115200 [ 200.769179] meson_uart c81004c0.serial: ttyS0 use xtal(8M) 24000000 change 115200 to 115200 [ 200.896659] meson_uart c81004c0.serial: ttyS0 use xtal(8M) 24000000 change 115200 to 115200 [ 200.897077] meson_uart c81004c0.serial: ttyS0 use xtal(8M) 24000000 change 115200 to 115200 [ 201.457480] Bluetooth: hci0 command 0x1009 tx timeout [ 202.357036] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 202.357050] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 202.357057] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0xe66bf8, operation is in [data] disk! [ 202.357085] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 202.357093] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 202.357098] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 202.357101] emmc: retry, rx_phase 1 -> 2 [ 202.357127] aml_sd_emmc_data_thread : 2563 [ 202.357136] emmc: req failed (CMD18): -110, retrying... [ 202.399060] fb: osd[0] enable: 1 (Xorg) [ 206.452038] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 206.452055] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 206.452062] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0xe66af8, operation is in [data] disk! [ 206.452088] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 206.452097] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 206.452101] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 206.452104] emmc: retry, rx_phase 2 -> 3 [ 206.452134] aml_sd_emmc_data_thread : 2563 [ 206.452144] emmc: req failed (CMD18): -110, retrying... [ 210.547025] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 210.547041] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 210.547048] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0xe66bc0, operation is in [data] disk! [ 210.547061] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 210.547068] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 210.547072] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 210.547076] emmc: retry, rx_phase 3 -> 0 [ 210.547097] aml_sd_emmc_data_thread : 2563 [ 210.547105] emmc: req failed (CMD18): -110, retrying... [ 214.641963] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 214.641977] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 214.641985] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0xe66b00, operation is in [data] disk! [ 214.641999] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 214.642006] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 214.642010] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 214.642014] emmc: retry, rx_phase 0 -> 1 [ 214.642035] aml_sd_emmc_data_thread : 2563 [ 214.642043] emmc: req failed (CMD18): -110, retrying... [ 218.737069] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 218.737086] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 218.737092] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0xe66a70, operation is in [data] disk! [ 218.737113] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 218.737120] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 218.737124] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 218.737127] emmc: retry, rx_phase 1 -> 2 [ 218.737150] aml_sd_emmc_data_thread : 2563 [ 218.737157] emmc: req failed (CMD18): -110, retrying... [ 222.831980] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 222.831996] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 222.832003] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0xe669b0, operation is in [data] disk! [ 222.832016] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 222.832023] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 222.832027] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 222.832031] emmc: retry, rx_phase 2 -> 3 [ 222.832050] aml_sd_emmc_data_thread : 2563 [ 222.832058] emmc: req failed (CMD18): -110, retrying... [ 226.927141] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 226.927170] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 226.927186] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0xe66958, operation is in [data] disk! [ 226.927219] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 226.927237] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 226.927249] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 226.927259] emmc: retry, rx_phase 3 -> 0 [ 226.927305] aml_sd_emmc_data_thread : 2563 [ 226.927325] emmc: req failed (CMD18): -110, retrying... [ 231.022040] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 231.022054] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 231.022061] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0xe66920, operation is in [data] disk! [ 231.022077] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 231.022085] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 231.022089] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 231.022093] emmc: retry, rx_phase 0 -> 1 [ 231.022115] aml_sd_emmc_data_thread : 2563 [ 231.022123] emmc: req failed (CMD18): -110, retrying... [ 235.116976] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 235.116990] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 235.116997] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0xe66870, operation is in [data] disk! [ 235.117011] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 235.117019] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 235.117024] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 235.117027] emmc: retry, rx_phase 1 -> 2 [ 235.117050] aml_sd_emmc_data_thread : 2563 [ 235.117058] emmc: req failed (CMD18): -110, retrying... [ 239.212127] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 239.212157] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 239.212172] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0xe66830, operation is in [data] disk! [ 239.212204] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 239.212222] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 239.212234] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 239.212243] emmc: retry, rx_phase 2 -> 3 [ 239.212290] aml_sd_emmc_data_thread : 2563 [ 239.212310] emmc: req failed (CMD18): -110, retrying... [ 243.307132] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 243.307160] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 243.307175] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0xe66820, operation is in [data] disk! [ 243.307208] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 243.307227] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 243.307239] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 243.307249] emmc: retry, rx_phase 3 -> 0 [ 243.307295] aml_sd_emmc_data_thread : 2563 [ 243.307316] emmc: req failed (CMD18): -110, retrying... [ 247.402163] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 247.402193] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 247.402208] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0xe66848, operation is in [data] disk! [ 247.402254] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 247.402272] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 247.402283] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 247.402293] emmc: retry, rx_phase 0 -> 1 [ 247.402347] aml_sd_emmc_data_thread : 2563 [ 247.402367] emmc: req failed (CMD18): -110, retrying... [ 251.497139] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 251.497167] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 251.497182] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0xe65ff0, operation is in [data] disk! [ 251.497213] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 251.497231] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 251.497243] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 251.497253] emmc: retry, rx_phase 1 -> 2 [ 251.497298] aml_sd_emmc_data_thread : 2563 [ 251.497317] emmc: req failed (CMD18): -110, retrying... [ 255.592276] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 255.592304] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 255.592318] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x800, operation is in [bootloader] disk! [ 255.592356] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 255.592374] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 255.592385] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 255.592395] emmc: retry, rx_phase 2 -> 3 [ 255.592444] aml_sd_emmc_data_thread : 2563 [ 255.592464] emmc: req failed (CMD18): -110, retrying... [ 259.687065] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 259.687082] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 259.687088] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x18, operation is in [bootloader] disk! [ 259.687117] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 259.687125] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 259.687129] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 259.687133] emmc: retry, rx_phase 3 -> 0 [ 259.687158] aml_sd_emmc_data_thread : 2563 [ 259.687165] emmc: req failed (CMD18): -110, retrying... [ 263.782018] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 263.782033] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 263.782039] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x38, operation is in [bootloader] disk! [ 263.782057] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 263.782064] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 263.782069] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 263.782073] emmc: retry, rx_phase 0 -> 1 [ 263.782095] aml_sd_emmc_data_thread : 2563 [ 263.782103] emmc: req failed (CMD18): -110, retrying... [ 267.877031] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 267.877048] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 267.877054] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x78, operation is in [bootloader] disk! [ 267.877078] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 267.877086] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 267.877090] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 267.877094] emmc: retry, rx_phase 1 -> 2 [ 267.877121] aml_sd_emmc_data_thread : 2563 [ 267.877129] emmc: req failed (CMD18): -110, retrying... [ 271.972912] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 271.972940] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 271.972955] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x10, operation is in [bootloader] disk! [ 271.972997] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 271.973016] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 271.973027] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 271.973037] emmc: retry, rx_phase 2 -> 3 [ 271.973087] aml_sd_emmc_data_thread : 2563 [ 271.973107] emmc: req failed (CMD18): -110, retrying... [ 276.067824] [aml_sd_emmc_irq] emmc: resp_timeout,vstat:0xe1ff0800,virqc:3fff [ 276.067841] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 276.067847] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x20, operation is in [bootloader] disk! [ 276.067860] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 276.067867] [aml_sd_emmc_data_thread] aml_sd_emmc_data_thread() 2632: set 1st retry! [ 276.067871] [aml_sd_emmc_data_thread] retry cmd 18 the 10-th time(s) [ 276.067875] emmc: retry, rx_phase 3 -> 0 [ 276.067894] aml_sd_emmc_data_thread : 2563 [ 276.067964] emmc: req failed (CMD18): -110, retrying... [ 280.162752] [aml_sd_emmc_irq] emmc: desc_timeout,vstat:0xe1ff1000,virqc:3fff [ 280.162769] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 280.162775] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x20, operation is in [bootloader] disk! [ 280.162816] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 280.162827] [aml_sd_emmc_data_thread] retry cmd 18 the 9-th time(s) [ 280.162830] emmc: retry, rx_phase 0 -> 1 [ 280.162877] aml_sd_emmc_data_thread : 2563 [ 280.162891] emmc: req failed (CMD18): -110, retrying... [ 284.257752] [aml_sd_emmc_irq] emmc: desc_timeout,vstat:0xe1ff1000,virqc:3fff [ 284.257769] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 284.257776] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x20, operation is in [bootloader] disk! [ 284.257806] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 284.257817] [aml_sd_emmc_data_thread] retry cmd 18 the 8-th time(s) [ 284.257821] emmc: retry, rx_phase 1 -> 2 [ 284.257858] aml_sd_emmc_data_thread : 2563 [ 284.257870] emmc: req failed (CMD18): -110, retrying... [ 285.433254] nf_conntrack: automatic helper assignment is deprecated and it will be removed soon. Use the iptables CT target to attach helpers instead. [ 288.352754] [aml_sd_emmc_irq] emmc: desc_timeout,vstat:0xe1ff1000,virqc:3fff [ 288.352770] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 288.352776] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x20, operation is in [bootloader] disk! [ 288.352809] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 288.352819] [aml_sd_emmc_data_thread] retry cmd 18 the 7-th time(s) [ 288.352823] emmc: retry, rx_phase 2 -> 3 [ 288.352862] aml_sd_emmc_data_thread : 2563 [ 288.352876] emmc: req failed (CMD18): -110, retrying... [ 292.447751] [aml_sd_emmc_irq] emmc: desc_timeout,vstat:0xe1ff1000,virqc:3fff [ 292.447768] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 292.447774] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x20, operation is in [bootloader] disk! [ 292.447807] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 292.447818] [aml_sd_emmc_data_thread] retry cmd 18 the 6-th time(s) [ 292.447822] emmc: retry, rx_phase 3 -> 0 [ 292.447857] aml_sd_emmc_data_thread : 2563 [ 292.447869] emmc: req failed (CMD18): -110, retrying... [ 296.542757] [aml_sd_emmc_irq] emmc: desc_timeout,vstat:0xe1ff1000,virqc:3fff [ 296.542775] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 296.542781] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x20, operation is in [bootloader] disk! [ 296.542833] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 296.542843] [aml_sd_emmc_data_thread] retry cmd 18 the 5-th time(s) [ 296.542847] emmc: retry, rx_phase 0 -> 1 [ 296.542892] aml_sd_emmc_data_thread : 2563 [ 296.542904] emmc: req failed (CMD18): -110, retrying... [ 300.637752] [aml_sd_emmc_irq] emmc: desc_timeout,vstat:0xe1ff1000,virqc:3fff [ 300.637768] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 300.637775] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x20, operation is in [bootloader] disk! [ 300.637806] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 300.637817] [aml_sd_emmc_data_thread] retry cmd 18 the 4-th time(s) [ 300.637821] emmc: retry, rx_phase 1 -> 2 [ 300.637858] aml_sd_emmc_data_thread : 2563 [ 300.637870] emmc: req failed (CMD18): -110, retrying... [ 304.732754] [aml_sd_emmc_irq] emmc: desc_timeout,vstat:0xe1ff1000,virqc:3fff [ 304.732771] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 304.732778] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x20, operation is in [bootloader] disk! [ 304.732819] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 304.732830] [aml_sd_emmc_data_thread] retry cmd 18 the 3-th time(s) [ 304.732834] emmc: retry, rx_phase 2 -> 3 [ 304.732884] aml_sd_emmc_data_thread : 2563 [ 304.732899] emmc: req failed (CMD18): -110, retrying... [ 308.827754] [aml_sd_emmc_irq] emmc: desc_timeout,vstat:0xe1ff1000,virqc:3fff [ 308.827769] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 308.827775] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x20, operation is in [bootloader] disk! [ 308.827809] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 308.827820] [aml_sd_emmc_data_thread] retry cmd 18 the 2-th time(s) [ 308.827824] emmc: retry, rx_phase 3 -> 0 [ 308.827853] aml_sd_emmc_data_thread : 2563 [ 308.827864] emmc: req failed (CMD18): -110, retrying... [ 312.922752] [aml_sd_emmc_irq] emmc: desc_timeout,vstat:0xe1ff1000,virqc:3fff [ 312.922769] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 312.922775] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x20, operation is in [bootloader] disk! [ 312.922823] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 312.922835] [aml_sd_emmc_data_thread] retry cmd 18 the 1-th time(s) [ 312.922839] emmc: retry, rx_phase 0 -> 1 [ 312.922879] aml_sd_emmc_data_thread : 2563 [ 312.922891] emmc: req failed (CMD18): -110, retrying... [ 317.017751] [aml_sd_emmc_irq] emmc: desc_timeout,vstat:0xe1ff1000,virqc:3fff [ 317.017767] [aml_host_bus_fsm_show] emmc: err: wait for irq service, bus_fsm:0x8 [ 317.017774] [mmc_cmd_LBA_show] emmc: cmd 18, arg 0x20, operation is in [bootloader] disk! [ 317.017802] aml_sd_emmc_data_thread 2616 emmc: cmd:18 [ 317.017813] [aml_sd_emmc_data_thread] Command retried failed line:2729, cmd:18 [ 317.017845] aml_sd_emmc_data_thread : 2563 [ 317.017882] mmcblk0: timed out sending r/w cmd command, card status 0x900 [ 317.017933] emmc: try set sd/emmc to DDR mode [ 317.047241] emmc: try set sd/emmc to DDR mode