[ 0.000000] Booting Linux on physical CPU 0x0 [ 0.000000] Linux version 4.9.180-g474dc98-dirty (root@BuildHost) (gcc version 6.3.1 20170109 (Linaro GCC 6.3-2017.02) ) #57 SMP PREEMPT Fri Mar 5 16:54:52 CST 2021 [ 0.000000] Boot CPU: AArch64 Processor [410fd034] [ 0.000000] efi: Getting EFI parameters from FDT: [ 0.000000] efi: UEFI not found. [ 0.000000] \x0907400000 - 07500000, 1024 KB, ramoops@0x07400000 [ 0.000000] __reserved_mem_alloc_size, start:0x0000000005000000, end:0x0000000007400000, len:36 MiB [ 0.000000] \x0905000000 - 07400000, 36864 KB, linux,secmon [ 0.000000] __reserved_mem_alloc_size, start:0x00000000bf800000, end:0x00000000c0000000, len:8 MiB [ 0.000000] \x09bf800000 - c0000000, 8192 KB, linux,meson-fb [ 0.000000] __reserved_mem_alloc_size, start:0x0000000078400000, end:0x0000000080400000, len:128 MiB [ 0.000000] \x0978400000 - 80400000, 131072 KB, linux,ion-dev [ 0.000000] __reserved_mem_alloc_size, start:0x000000006c400000, end:0x0000000078400000, len:192 MiB [ 0.000000] \x096c400000 - 78400000, 196608 KB, linux,di_cma [ 0.000000] Reserved memory: created DMA memory pool at 0x00000000bf800000, size 0 MiB [ 0.000000] \x09bf800000 - bf800000, 0 KB, linux,ppmgr [ 0.000000] __reserved_mem_alloc_size, start:0x0000000056000000, end:0x000000006c400000, len:356 MiB [ 0.000000] \x0956000000 - 6c400000, 364544 KB, linux,codec_mm_cma [ 0.000000] \x09bf800000 - bf800000, 0 KB, linux,codec_mm_reserved [ 0.000000] \x09bb800000 - bf800000, 65536 KB, linux,vdin0_cma [ 0.000000] \x09b7800000 - bb800000, 65536 KB, linux,vdin1_cma [ 0.000000] cma: Reserved 8 MiB at 0x00000000b7000000 [ 0.000000] On node 0 totalpages: 786176 [ 0.000000] DMA zone: 12284 pages used for memmap [ 0.000000] DMA zone: 0 pages reserved [ 0.000000] DMA zone: 786176 pages, LIFO batch:31 [ 0.000000] psci: probing for conduit method from DT. [ 0.000000] psci: PSCIv1.0 detected in firmware. [ 0.000000] psci: Using standard PSCI v0.2 function IDs [ 0.000000] psci: Trusted OS migration not required [ 0.000000] psci: SMC Calling Convention v1.1 [ 0.000000] percpu: Embedded 26 pages/cpu s69336 r8192 d28968 u106496 [ 0.000000] pcpu-alloc: s69336 r8192 d28968 u106496 alloc=26*4096 [ 0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 [ 0.000000] Detected VIPT I-cache on CPU0 [ 0.000000] CPU features: enabling workaround for ARM erratum 845719 [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 773892 [ 0.000000] Kernel command line: init=/init console=ttyS0,115200 no_console_suspend earlyprintk=aml-uart,0xff803000 ramoops.pstore_en=1 ramoops.record_size=0x8000 ramoops.console_size=0x4000 loglevel=1 hdr_priority= otg_device=1 reboot_mode_android=normal logo=osd0,loaded,0x3d800000 fb_width=1920 fb_height=1080 display_bpp=16 outputmode=1080p60hz vout=1080p60hz,enable panel_type=lcd_1 lcd_ctrl=0x00000000 hdmitx=,444,8bit hdmimode=1080p60hz hdmichecksum=0x68950000 dolby_vision_on=0 frac_rate_policy=1 hdmi_read_edid=1 cvbsmode=576cvbs osd_reverse=0 video_reverse=0 irq_check_en=0 ledsTrigger=1 androidboot.enableSystemReset=0 androidboot.enablePrivateRecovery=0 androidboot.selinux=enforcing androidboot.firstboot=0 jtag=disable androidboot.hardware=amlogic androidboot.bootloader=U-Boot 2015.01-g0fbe4d6 androidboot.build.expect.baseband=N/A androidboot.serialno=4669688001201904000070 mac=EC:5C:68:1D:BB:FF androidboot.mac=EC:5C:68:1D:BB:FF mac_bt=EC:5C:68:1D:BD:91 androidboot.mac_bt=EC:5C:68:1 [ 0.000000] fb: osd0 [ 0.000000] fb: loaded [ 0.000000] fb: 0x3d800000 [ 0.000000] fb: logo_info.fb_width=1920 [ 0.000000] fb: logo_info.fb_height=1080 [ 0.000000] vout: 1080p60hz [ 0.000000] vout: enable: 1 [ 0.000000] lcd: panel_type: lcd_1 [ 0.000000] lcd: lcd_ctrl: 0x00000000 [ 0.000000] get_dolby_on: 0 [ 0.000000] hdmitx: hdmitx boot frac_rate_policy: 1 [ 0.000000] vpp_axis_reverse: bootargs is 0 [ 0.000000] DI: di_read_canvas_reverse: bootargs is 0. [ 0.000000] vdin_get_video_reverse: bootargs is 0. [ 0.000000] phlock_phase_config: bootargs is 0. [ 0.000000] uboot leds trigger: 1 [ 0.000000] try to read bt mac from emmc key! [ 0.000000] PID hash table entries: 4096 (order: 3, 32768 bytes) [ 0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes) [ 0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes) [ 0.000000] Memory: 2180588K/3144704K available (14652K kernel code, 1988K rwdata, 5784K rodata, 5440K init, 1556K bss, 87572K reserved, 876544K cma-reserved) [ 0.000000] Virtual kernel memory layout: [ 0.000000] modules : 0xffffff8000000000 - 0xffffff8008000000 ( 128 MB) [ 0.000000] vmalloc : 0xffffff8008000000 - 0xffffffbebfff0000 ( 250 GB) [ 0.000000] .text : 0xffffff8009080000 - 0xffffff8009ed0000 ( 14656 KB) [ 0.000000] .rodata : 0xffffff8009ed0000 - 0xffffff800a480000 ( 5824 KB) [ 0.000000] .init : 0xffffff800a480000 - 0xffffff800a9d0000 ( 5440 KB) [ 0.000000] .data : 0xffffff800a9d0000 - 0xffffff800abc1200 ( 1989 KB) [ 0.000000] .bss : 0xffffff800abc1200 - 0xffffff800ad463ec ( 1557 KB) [ 0.000000] fixed : 0xffffffbefe7fd000 - 0xffffffbefec00000 ( 4108 KB) [ 0.000000] PCI I/O : 0xffffffbefee00000 - 0xffffffbeffe00000 ( 16 MB) [ 0.000000] vmemmap : 0xffffffbf00000000 - 0xffffffc000000000 ( 4 GB maximum) [ 0.000000] 0xffffffbf00004000 - 0xffffffbf03000000 ( 47 MB actual) [ 0.000000] memory : 0xffffffc000100000 - 0xffffffc0c0000000 ( 3071 MB) [ 0.000000] can't find symbol:arm_dma_alloc [ 0.000000] can't find symbol:__alloc_from_contiguous [ 0.000000] can't find symbol:cma_allocator_alloc [ 0.000000] 0, addr:ffffff8009b5f8c8 + 140, aml_cma_alloc_post_hook [ 0.000000] 1, addr:ffffff8009574650 + 78, dma_alloc_from_contiguous [ 0.000000] 2, addr:ffffff8009231758 + 388, cma_alloc [ 0.000000] 3, addr:ffffff8009221138 + 310, __kmalloc_track_caller [ 0.000000] 4, addr:ffffff800921e1a0 + 310, __kmalloc [ 0.000000] 5, addr:ffffff800921de38 + 2a0, kmem_cache_alloc_trace [ 0.000000] 6, addr:ffffff800921dba0 + 298, kmem_cache_alloc [ 0.000000] 7, addr:ffffff800921db18 + 88, __slab_alloc.isra.23.constprop.27 [ 0.000000] 8, addr:ffffff800921d790 + 388, ___slab_alloc.constprop.28 [ 0.000000] 9, addr:ffffff800921b278 + 5d8, new_slab [ 0.000000] 10, addr:ffffff800920e6f8 + 70, vmalloc [ 0.000000] 11, addr:ffffff800920e610 + 70, vzalloc [ 0.000000] 12, addr:ffffff800920e0b8 + 2a8, __vmalloc_node_range [ 0.000000] 13, addr:ffffff80091f23a8 + 110, kmalloc_order_trace [ 0.000000] 14, addr:ffffff80091f2238 + 170, kmalloc_order [ 0.000000] 15, addr:ffffff80091d24b8 + 170, __alloc_page_frag [ 0.000000] 16, addr:ffffff80091d2450 + 68, alloc_pages_exact [ 0.000000] 17, addr:ffffff80091d2420 + 30, get_zeroed_page [ 0.000000] 18, addr:ffffff80091d23c8 + 58, __get_free_pages [ 0.000000] 19, addr:ffffff80091d15b0 + e18, __alloc_pages_nodemask [ 0.000000] 20, addr:ffffff80090a06d8 + 250, __dma_alloc [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] Preemptible hierarchical RCU implementation. [ 0.000000] \x09Build-time adjustment of leaf fanout to 64. [ 0.000000] \x09RCU restricting CPUs from NR_CPUS=8 to nr_cpu_ids=4. [ 0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=64, nr_cpu_ids=4 [ 0.000000] NR_IRQS:64 nr_irqs:64 0 [ 0.000000] irq_meson_gpio: 100 to 8 gpio interrupt mux initialized [ 0.000000] g12a_aoclkc_init: register ao clk ok! [ 0.000000] Meson chip version = RevB (28:B - 40:0) [ 0.000000] meson_g12a_sdemmc_init: register amlogic sdemmc clk [ 0.000000] meson_g12a_sdemmc_init: register amlogic sdemmc clk [ 0.000000] meson_g12a_gpu_init: register meson gpu clk [ 0.000000] meson_g12a_media_init: register meson media clk [ 0.000000] meson_g12a_misc_init: register amlogic g12a misc clks [ 0.000000] meson_g12a_misc_init: done. [ 0.000000] g12a_clkc_init initialization complete [ 0.000000] arm_arch_timer: Architected cp15 timer(s) running at 24.00MHz (phys). [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x588fe9dc0, max_idle_ns: 440795202592 ns [ 0.000003] sched_clock: 56 bits at 24MHz, resolution 41ns, wraps every 4398046511097ns [ 0.000031] meson_bc_timer: mclk->mux_reg = (ptrval),mclk->reg = (ptrval) [ 0.000514] Console: colour dummy device 80x25 [ 0.000526] Calibrating delay loop (skipped), value calculated using timer frequency.. 48.00 BogoMIPS (lpj=96000) [ 0.000534] pid_max: default: 32768 minimum: 301 [ 0.000589] thread_stack_cache_init, vmap: (ptrval), bitmap: (ptrval), cache page:1a0 [ 0.000595] thread_stack_cache_init, allocation vm area: (ptrval), addr: (ptrval), size:20001000 [ 0.000598] cpu 0, vmap_stack:[ffffffc0b6f2bba0-ffffffc0b6f2fb90] [ 0.000601] cpu 0, irq_stack: [ffffffc0b6f21060-ffffffc0b6f25050] [ 0.000604] cpu 1, vmap_stack:[ffffffc0b6f45ba0-ffffffc0b6f49b90] [ 0.000607] cpu 1, irq_stack: [ffffffc0b6f3b060-ffffffc0b6f3f050] [ 0.000610] cpu 2, vmap_stack:[ffffffc0b6f5fba0-ffffffc0b6f63b90] [ 0.000613] cpu 2, irq_stack: [ffffffc0b6f55060-ffffffc0b6f59050] [ 0.000616] cpu 3, vmap_stack:[ffffffc0b6f79ba0-ffffffc0b6f7db90] [ 0.000619] cpu 3, irq_stack: [ffffffc0b6f6f060-ffffffc0b6f73050] [ 0.000677] Security Framework initialized [ 0.000682] SELinux: Initializing. [ 0.000717] SELinux: Starting in permissive mode [ 0.000749] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes) [ 0.000756] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes) [ 0.001393] ftrace: allocating 46179 entries in 181 pages [ 0.091502] sched-energy: CPU device node has no sched-energy-costs [ 0.091512] CPU0: update cpu_capacity 1024 [ 0.103149] ASID allocator initialised with 65536 entries [ 0.143563] secmon: can't fine clear_range [ 0.144270] EFI services will not be available. [ 0.191702] Detected VIPT I-cache on CPU1 [ 0.191749] CPU1: update cpu_capacity 1024 [ 0.191752] CPU1: Booted secondary processor [410fd034] [ 0.223756] Detected VIPT I-cache on CPU2 [ 0.223782] CPU2: update cpu_capacity 1024 [ 0.223784] CPU2: Booted secondary processor [410fd034] [ 0.255846] Detected VIPT I-cache on CPU3 [ 0.255869] CPU3: update cpu_capacity 1024 [ 0.255872] CPU3: Booted secondary processor [410fd034] [ 0.255956] Brought up 4 CPUs [ 0.255963] SMP: Total of 4 processors activated. [ 0.255970] CPU features: detected feature: 32-bit EL0 Support [ 0.256064] CPU: All CPU(s) started at EL2 [ 0.256091] alternatives: patching kernel code [ 0.256965] addr: (ptrval) is in kernel, size fix 4096->10, data:mode=0755 [ 0.257135] devtmpfs: initialized [ 0.284125] DMI not present or invalid. [ 0.284415] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns [ 0.284432] futex hash table entries: 1024 (order: 4, 65536 bytes) [ 0.284616] pinctrl core: initialized pinctrl subsystem [ 0.285672] NET: Registered protocol family 16 [ 0.289857] schedtune: init normalization constants... [ 0.289863] schedtune: no energy model data [ 0.289867] schedtune: disabled! [ 0.303879] cpuidle: using governor menu [ 0.303977] register canvas platform driver [ 0.304023] register rdma platform driver [ 0.308309] vdso: 2 pages (1 code @ (ptrval), 1 data @ (ptrval)) [ 0.308325] hw-breakpoint: found 6 breakpoint and 2 watchpoint registers. [ 0.308773] DMA: preallocated 256 KiB pool for atomic allocations [ 0.309100] clkmsr: clkmsr: driver init [ 0.309105] codec_mm_module_init [ 0.309150] media_configs_system_init [ 0.309459] aml_watch_point_probe, in, wp:2 [ 0.309921] pstore: using zlib compression [ 0.310000] console [pstore-1] enabled [ 0.310041] pstore: Registered ramoops as persistent store backend [ 0.310048] ramoops: attached 0x100000@0x7400000, ecc: 0/0 [ 0.310054] ramoops: ramoops_io_en:0 1 old:0x0 ftrace_size:0x40000 [ 0.312681] aml_iomap: amlogic iomap probe done [ 0.313329] vpu: driver version: v20190329(7-g12a) [ 0.313338] vpu: load vpu_clk: 666666667Hz(7) [ 0.313547] vpu: clktree_init [ 0.313607] vpu: vpu_probe OK [ 0.319594] clkmsr: msr_clk_reg0= (ptrval),msr_clk_reg2= (ptrval) [ 0.319607] clkmsr: msr_ring_reg0= (ptrval) [ 0.322724] audio_clocks: audio_clocks_probe done [ 0.327033] aml_vdac_config_probe: cpu_id:4, name:meson-g12ab-vdac [ 0.327230] aml_vdac_probe: ok [ 0.327421] canvas_probe reg= (ptrval),size=2000 [ 0.327442] canvas maped reg_base = (ptrval) [ 0.336395] rdma_probe,cpu_type:1, ver:0, len:8 [ 0.336611] rdma_register, rdma_table_addr (ptrval) rdma_table_addr_phy b7040000 reg_buf (ptrval) [ 0.336618] rdma_register success, handle 1 table_size 32768 [ 0.336623] set_rdma_handle video rdma handle = 1. [ 0.336654] classs created ok [ 0.336667] classs file created ok [ 0.337590] aml_snd_reg_map[0], reg:ff640000, size:2000 [ 0.337611] aml_snd_reg_map[1], reg:ff642000, size:2000 [ 0.337630] aml_snd_reg_map[2], reg:ff64a000, size:2000 [ 0.337649] aml_snd_reg_map[3], reg:ff642800, size:1800 [ 0.337671] aml_snd_reg_map[4], reg:ffd01000, size:1000 [ 0.337677] amlogic auge_snd_iomap probe done [ 0.339990] cvbs_out: cvbsout_probe, cpu_id:3,name:meson-g12a-cvbsout [ 0.340185] cvbs_out: clk path:0x0 [ 0.340198] cvbs_out: find performance_pal config [ 0.340221] cvbs_out: find performance_ntsc config [ 0.340242] vout: vout1: register server: cvbs_vout_server [ 0.340247] cvbs_out: register cvbs module server ok [ 0.340252] vout: vout2: register server: cvbs_vout2_server [ 0.340258] cvbs_out: register cvbs module vout2 server ok [ 0.340265] cvbs_out: chrdev devno 264241152 for disp [ 0.340483] cvbs_out: create cdev cvbs [ 0.340489] cvbs_out: cvbsout_probe OK [ 0.341267] codec_mm codec_mm: assigned reserved memory node linux,codec_mm_cma [ 0.341352] codec_mm codec_mm: assigned reserved memory node linux,codec_mm_cma [ 0.341357] codec_mm_probe ok [ 0.618243] vgaarb: loaded [ 0.618565] SCSI subsystem initialized [ 0.618863] usbcore: registered new interface driver usbfs [ 0.618927] usbcore: registered new interface driver hub [ 0.619021] usbcore: registered new device driver usb [ 0.619156] Linux video capture interface: v2.00 [ 0.619256] pps_core: LinuxPPS API ver. 1 registered [ 0.619261] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.619288] PTP clock support registered [ 0.624979] dmi: Firmware registration failed. [ 0.625365] secmon: reserve_mem_size:0x2300000 [ 0.625454] secmon secmon: assigned reserved memory node linux,secmon [ 0.626548] secmon: get page: (ptrval), 5000 [ 0.626559] secmon: share in base: 0xffffffc0050fe000, share out base: 0xffffffc0050ff000 [ 0.626564] secmon: phy_in_base: 0x50fe000, phy_out_base: 0x50ff000 [ 0.626960] fb: osd_init_module [ 0.627486] fb: viu vsync irq: 39 [ 0.627507] fb: viu2 vsync irq: 47 [ 0.627630] 0x000000d8:Y=d8,U=0,V=0 [ 0.627636] 0x000000d9:Y=d9,U=0,V=0 [ 0.627641] 0x000000da:Y=da,U=0,V=0 [ 0.627646] 0x000000db:Y=db,U=0,V=0 [ 0.627651] 0x000000dc:Y=dc,U=0,V=0 [ 0.627656] 0x000000dd:Y=dd,U=0,V=0 [ 0.627896] fb: osd_rdma_init: rdma_table p=0xb7048000,op=0xb7048000 , v=0x (ptrval) [ 0.627927] rdma_register, rdma_table_addr (ptrval) rdma_table_addr_phy b7049000 reg_buf (ptrval) [ 0.627933] rdma_register success, handle 2 table_size 4096 [ 0.627938] fb: osd_rdma_init:osd rdma handle = 2. [ 0.627954] fb: mem_size: 0x800000 [ 0.627959] fb: mem_size: 0x1980000 [ 0.627963] fb: mem_size: 0x100000 [ 0.627968] fb: mem_size: 0x100000 [ 0.627972] fb: mem_size: 0x800000 [ 0.628027] meson-fb meson-fb: assigned reserved memory node linux,meson-fb [ 0.628034] fb: reserved memory base:0x00000000bf800000, size:800000 [ 0.628252] vout: error: invalid vinfo1. current vmode is not supported [ 0.628261] fb: init fbdev bpp is:32 [ 0.629814] fb: set osd0 reverse as NONE [ 0.629830] vout: error: invalid vinfo1. current vmode is not supported [ 0.640689] fb: osd probe OK [ 0.641568] hdmitx: system: amhdmitx_probe start [ 0.641573] hdmitx: system: Ver: 20190815 [ 0.641605] hdmitx: system: hdmitx_device.chip_type : 10 [ 0.641611] hdmitx: system: hdmitx_device.dongle_mode: 0 [ 0.641648] hdmitx: system: not find match pwr-ctl [ 0.641691] hdmitx: system: not find drm_amhdmitx [ 0.641719] hdmitx: system: hpd irq = 33 [ 0.641825] hdmitx: system: hdcp22_tx_skp failed to probe [ 0.641833] hdmitx: system: hdcp22_tx_esm failed to probe [ 0.642402] hdmitx: hdmitx20: Mapped PHY: 0xffd00000 [ 0.642416] hdmitx: hdmitx20: Mapped PHY: 0xff634400 [ 0.642430] hdmitx: hdmitx20: Mapped PHY: 0xff900000 [ 0.642448] hdmitx: hdmitx20: Mapped PHY: 0xff800000 [ 0.642457] hdmitx: hdmitx20: Mapped PHY: 0xff63c000 [ 0.642465] hdmitx: hdmitx20: Mapped PHY: 0xffd00000 [ 0.642473] hdmitx: hdmitx20: Mapped PHY: 0xff608000 [ 0.642480] hdmitx: hdmitx20: Mapped PHY: 0xff600000 [ 0.642488] hdmitx: hdmitx20: Mapped PHY: 0xffe01000 [ 0.642500] hdmitx: hw: alread display in uboot 0x10 [ 0.642528] hdmitx: hw: avmute set to 1 [ 0.642537] vout: vout1: register server: hdmitx_vout_server [ 0.642543] vout: vout2: register server: hdmitx_vout2_server [ 0.643237] hdmitx: system: fmt_attr 444,8bit [ 0.643329] hdmitx: system: amhdmitx_probe end [ 0.644278] vout: create vout attribute OK [ 0.644431] vout: vout_fops_create OK [ 0.644437] vout: vout1: register server: nulldisp_vout_server [ 0.644567] hdmitx: hdmitx_set_current_vmode[5008] [ 0.644573] hdmitx: system: recalc before 1080p60hz 60 1 [ 0.644579] hdmitx: system: recalc after 1080p60hz 2997 50 [ 0.644584] hdmitx: alread display in uboot [ 0.644589] vout: init mode 1080p60hz set ok [ 0.644594] vout: aml_vout_probe OK [ 0.645737] chip type:0x28 [ 0.646275] MEMORY:[100000+bff00000] [ 0.646285] ramdump_probe, storage device:data [ 0.646290] NO valid ramdump args:0 0 [ 0.646309] ramdump_probe, set sticky to 8c00 [ 0.646773] Advanced Linux Sound Architecture Driver Initialized. [ 0.647322] Bluetooth: Core ver 2.22 [ 0.647381] NET: Registered protocol family 31 [ 0.647386] Bluetooth: HCI device and connection manager initialized [ 0.647400] Bluetooth: HCI socket layer initialized [ 0.647411] Bluetooth: L2CAP socket layer initialized [ 0.647457] Bluetooth: SCO socket layer initialized [ 0.647963] NetLabel: Initializing [ 0.647968] NetLabel: domain hash size = 128 [ 0.647973] NetLabel: protocols = UNLABELED CIPSOv4 [ 0.648030] NetLabel: unlabeled traffic allowed by default [ 0.652498] clocksource: Switched to clocksource arch_sys_counter [ 0.744893] VFS: Disk quotas dquot_6.6.0 [ 0.744982] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.758396] dtv_dmd:[amldtvdemod..]aml_dtvdemod_init. [ 0.759137] NET: Registered protocol family 2 [ 0.771665] hdmitx: edid: EDID Parser: [ 0.771674] hdmitx: hdmitx: reach vesa idx MAX [ 0.771679] hdmitx: hdmitx: reach vesa idx MAX [ 0.771684] hdmitx: hdmitx: reach vesa idx MAX [ 0.771696] hdmitx: hdmitx: reach vesa idx MAX [ 0.771701] hdmitx: hdmitx: reach vesa idx MAX [ 0.771706] hdmitx: hdmitx: reach vesa idx MAX [ 0.771713] hdmitx: hdmitx: reach vesa idx MAX [ 0.771718] hdmitx: hdmitx: reach vesa idx MAX [ 0.771723] hdmitx: hdmitx: reach vesa idx MAX [ 0.771728] hdmitx: hdmitx: reach vesa idx MAX [ 0.771741] [RX]-up_phy_addr = 3 [ 0.771763] hdmitx: edid: dump_dtd_info[2046] [ 0.771768] hdmitx: edid: pixel_clock: 29700 [ 0.771773] hdmitx: edid: h_active: 1920 [ 0.771778] hdmitx: edid: h_blank: 280 [ 0.771783] hdmitx: edid: v_active: 2160 [ 0.771787] hdmitx: edid: v_blank: 90 [ 0.771792] hdmitx: edid: h_sync_offset: 48 [ 0.771797] hdmitx: edid: h_sync: 32 [ 0.771802] hdmitx: edid: v_sync_offset: 3 [ 0.771806] hdmitx: edid: v_sync: 5 [ 0.771812] hdmitx: edid: dump_dtd_info[2046] [ 0.771817] hdmitx: edid: pixel_clock: 24150 [ 0.771822] hdmitx: edid: h_active: 2560 [ 0.771826] hdmitx: edid: h_blank: 160 [ 0.771831] hdmitx: edid: v_active: 1440 [ 0.771836] hdmitx: edid: v_blank: 41 [ 0.771841] hdmitx: edid: h_sync_offset: 48 [ 0.771845] hdmitx: edid: h_sync: 32 [ 0.771850] hdmitx: edid: v_sync_offset: 3 [ 0.771855] hdmitx: edid: v_sync: 5 [ 0.771862] hdmitx: hdmitx: get PMT vic: 97 [ 0.771867] hdmitx: hdmitx: reach vesa idx MAX [ 0.771872] hdmitx: edid: find IEEEOUT [ 0.771907] hdmitx: edid: check sum valid [ 0.771912] hdmitx: edid: check sum valid [ 0.771920] hdmitx: edid: check sum valid [ 0.771925] hdmitx: edid: check sum valid [ 0.771947] hdmitx: edid: blk0 raw data [ 0.771986] hdmitx: edid: \x0a00ffffffffffff00230d0028010000000e1e0103803f21782a5995af4f42af26\x0a0f505423080081008140818081c0a9c09500b300a94008e80030f2705a80b058\x0a4a006c552100001e662156aa51001e30468f3300c4fe1000001e023a80187138\x0a2d40582c450060632100001e000000fc0032383835550a202020202020200168\x0a\x0a [ 0.771993] hdmitx: edid: blk1 raw data [ 0.772030] hdmitx: edid: \x0a02034bf24d61605a10050403021f1312015f23097f07830100006d030c003000\x0a387820006001020367d85dc40178c800e305e301e20f7f00e6060701605000e2\x0a00f9681a000001013040ed0474801871705a803020350055502100001e565e00\x0aa0a0a029503020350055502100001e0000000000000000000000000000000095\x0a\x0a [ 0.772039] hdmitx: system: update rx hdr info 7 [ 0.772538] hdmitx: hdmitx: get vic 16 cscd 444,8bit [ 0.772548] hdmitx: hdmitx: mode name 1920x1080p60hz [ 0.772568] hdmitx: hdmitx: tmds clock 148 [ 0.772574] hdmitx: hdmitx: act clock: 148 [ 0.772662] hdmitx: system: irq 80000002 0 [ 0.784747] TCP established hash table entries: 32768 (order: 6, 262144 bytes) [ 0.784966] TCP bind hash table entries: 32768 (order: 7, 524288 bytes) [ 0.785425] TCP: Hash tables configured (established 32768 bind 32768) [ 0.785537] UDP hash table entries: 2048 (order: 4, 65536 bytes) [ 0.785618] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes) [ 0.785905] NET: Registered protocol family 1 [ 0.785940] PCI: CLS 0 bytes, default 64 [ 0.787967] aml_wifi wifi: [wifi_dev_probe] no interrupt pin [ 0.787977] aml_wifi wifi: [wifi_dev_probe] no power_on_pin [ 0.787985] wifi: power_on_pin_OD = 0; [ 0.787992] aml_wifi wifi: [wifi_dev_probe] no power_on_pin2 [ 0.788125] aml_wifi wifi: [pwm_double_channel_conf_dt] wifi pwm dt ok [ 0.788145] aml_wifi wifi: [pwm_double_channel_conf] wifi pwm conf ok [ 0.788153] aml_wifi wifi: [wifi_dev_probe] dhd_static_buf setup [ 0.788158] Wifi: bcmdhd_init_wlan_mem: bcmdhd_init_wlan_mem(): 100.10.545.3 [ 0.788812] Wifi: bcmdhd_init_wlan_mem: bcmdhd_init_wlan_mem prealloc ok [ 0.788821] aml_wifi wifi: [wifi_dev_probe] interrupt_pin=0 [ 0.788829] aml_wifi wifi: [wifi_dev_probe] irq_num=0, irq_trigger_type=0 [ 0.788835] aml_wifi wifi: [wifi_dev_probe] power_on_pin=0 [ 0.788842] aml_wifi wifi: [wifi_dev_probe] clock_32k_pin=0 [ 0.789135] aml_wifi wifi: [wifi_setup_dt] wifi_setup_dt [ 0.790593] Trying to unpack rootfs image as initramfs... [ 0.815719] Freeing initrd memory: 752K [ 0.820336] hw perfevents: clusterb_enabled = 0 [ 0.820345] hw perfevents: cpumasks 0xf, 0x0 [ 0.820381] hw perfevents: cluster A irq = 10 [ 0.820486] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 counters available [ 0.823866] audit: initializing netlink subsys (disabled) [ 0.823937] audit: type=2000 audit(0.752:1): initialized [ 0.825202] workingset: timestamp_bits=45 max_order=20 bucket_order=0 [ 0.838748] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ 0.839088] exFAT: Version 1.2.9 [ 0.840162] Registering sdcardfs 0.1 [ 0.840674] ntfs: driver 2.1.32 [Flags: R/O]. [ 0.841078] jffs2: version 2.2. (NAND) (SUMMARY) \xc2\xa9 2001-2006 Red Hat, Inc. [ 0.841909] fuse init (API version 7.26) [ 0.842920] SELinux: Registering netfilter hooks [ 0.847554] NET: Registered protocol family 38 [ 0.847569] Key type asymmetric registered [ 0.847576] Asymmetric key parser 'x509' registered [ 0.847904] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 243) [ 0.847913] io scheduler noop registered (default) [ 0.847920] io scheduler deadline registered [ 0.848139] io scheduler cfq registered [ 0.861438] random: fast init done [ 0.861482] random: crng init done [ 0.861892] Unable to detect cache hierarchy for CPU 0 [ 0.874736] brd: module loaded [ 0.889546] loop: module loaded [ 0.890423] zram: Added device: zram0 [ 0.890860] mtdoops: mtd device (mtddev=name/number) must be supplied [ 0.891996] libphy: Fixed MDIO Bus: probed [ 0.892347] tun: Universal TUN/TAP device driver, 1.6 [ 0.892353] tun: (C) 1999-2004 Max Krasnyansky [ 0.893499] REG0:Addr = 00000000e480eb31 [ 0.893515] ee eth reset:Addr = 0000000028cd17a0 [ 0.893532] read auto_cali_idx fail [ 0.893541] Not set cali_val for REG1 [ 0.894118] meson6-dwmac ff3f0000.ethernet: no reset control found [ 0.894127] stmmac - user ID: 0x11, Synopsys ID: 0x37 [ 0.894131] Ring mode enabled [ 0.894137] DMA HW capability register supported [ 0.894143] Normal descriptors [ 0.894148] RX Checksum Offload Engine supported [ 0.894152] \x09COE Type 2 [ 0.894157] TX Checksum insertion supported [ 0.894161] Wake-Up On Lan supported [ 0.894224] eth%d: device MAC address ec:5c:68:1d:bb:ff [ 0.894229] Enable RX Mitigation via HW Watchdog Timer [ 0.897622] libphy: stmmac: probed [ 0.897634] eth%d: PHY ID 001cc916 at 0 IRQ POLL (stmmac-0:00) active [ 0.897640] eth%d: PHY ID 001cc916 at 1 IRQ POLL (stmmac-0:01) [ 0.899377] PPP generic driver version 2.4.2 [ 0.899643] PPP BSD Compression module registered [ 0.899651] PPP Deflate Compression module registered [ 0.899675] PPP MPPE Compression module registered [ 0.899682] NET: Registered protocol family 24 [ 0.899710] PPTP driver version 0.8.5 [ 0.900245] usbcore: registered new interface driver r8152 [ 0.900329] usbcore: registered new interface driver asix [ 0.900436] usbcore: registered new interface driver ax88179_178a [ 0.900551] usbcore: registered new interface driver cdc_ether [ 0.900615] usbcore: registered new interface driver net1080 [ 0.900677] usbcore: registered new interface driver cdc_subset [ 0.900744] usbcore: registered new interface driver zaurus [ 0.900837] usbcore: registered new interface driver cdc_ncm [ 0.901711] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver [ 0.901717] ehci-pci: EHCI PCI platform driver [ 0.901806] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver [ 0.901841] ohci-pci: OHCI PCI platform driver [ 0.902543] usbcore: registered new interface driver cdc_acm [ 0.902549] cdc_acm: USB Abstract Control Model driver for USB modems and ISDN adapters [ 0.902632] usbcore: registered new interface driver usb-storage [ 0.902777] usbcore: registered new interface driver usbserial [ 0.903302] mousedev: PS/2 mouse device common for all mice [ 0.903641] usbcore: registered new interface driver xpad [ 0.903802] i2c /dev entries driver [ 0.904159] IR NEC protocol handler initialized [ 0.904165] IR RC5(x/sz) protocol handler initialized [ 0.904170] IR RC6 protocol handler initialized [ 0.904175] IR JVC protocol handler initialized [ 0.904180] IR Sony protocol handler initialized [ 0.904185] IR SANYO protocol handler initialized [ 0.904190] IR Sharp protocol handler initialized [ 0.904195] IR MCE Keyboard/mouse protocol handler initialized [ 0.904200] IR XMP protocol handler initialized [ 0.904318] usbcore: registered new interface driver uvcvideo [ 0.904323] USB Video Class driver (1.1.1) [ 0.904401] usbcore: registered new interface driver cx231xx [ 0.904410] md: linear personality registered for level -1 [ 0.904992] device-mapper: ioctl: 4.35.0-ioctl (2016-06-23) initialised: dm-devel@redhat.com [ 0.905193] device-mapper: verity-avb: AVB error handler initialized with vbmeta device: /dev/block/vbmeta [ 0.905201] Bluetooth: HCI UART driver ver 2.3 [ 0.905208] Bluetooth: HCI UART protocol H4 registered [ 0.908238] ledtrig-cpu: registered to indicate activity on CPUs [ 0.908969] hidraw: raw HID events driver (C) Jiri Kosina [ 0.909567] usbcore: registered new interface driver usbhid [ 0.909574] usbhid: USB HID core driver [ 0.909812] ashmem: initialized [ 0.911241] meson_cpufreq_init: ignor dsu clk! [ 0.911250] meson_cpufreq_init: ignor dsu pre parent clk! [ 0.911303] value of voltage_tolerance 0 [ 0.911310] meson_cpufreq_init:don't find the node [ 0.911315] value of gp1_clk_target 0 [ 0.913220] cpu cpu0: meson_cpufreq_init: CPU 0 initialized [ 0.914956] ff803000.serial: clock gate not found [ 0.915045] meson_uart ff803000.serial: ==uart0 reg addr = 00000000d03d3130 [ 0.915113] ff803000.serial: ttyS0 at MMIO 0xff803000 (irq = 22, base_baud = 1500000) is a meson_uart [ 0.915129] meson_uart ff803000.serial: ttyS0 use xtal(24M) 24000000 change 0 to 115200 [ 0.969596] console [ttyS0] enabled [ 0.970622] meson_uart ffd24000.serial: ==uart1 reg addr = 00000000355ff13f [ 0.970689] ffd24000.serial: ttyS1 at MMIO 0xffd24000 (irq = 32, base_baud = 1500000) is a meson_uart [ 0.972406] amlogic-new-usb2-v2 ffe09000.usb2phy: USB2 phy probe:phy_mem:0xffe09000, iomap phy_base:0xffffff80086d2000 [ 0.972940] amlogic-new-usb3-v2 ffe09080.usb3phy: set of GPIOC_7(459) as OTG ID pin [ 0.972978] amlogic-new-usb3-v2 ffe09080.usb3phy: ok to acquire gpio [ 0.973063] amlogic-new-usb3-v2 ffe09080.usb3phy: USB3 phy probe:phy_mem:0xffe09080, iomap phy_base:0xffffff80086dd080 [ 0.977072] aml_dma ff63e000.aml_dma: Aml dma [ 0.978838] aml_aes_dma ff63e000.aml_dma:aml_aes: Aml AES_dma [ 0.979383] aml_tdes_dma ff63e000.aml_dma:aml_tdes: Aml TDES_dma [ 0.980153] aml_sha_dma ff63e000.aml_dma:aml_sha: Aml SHA1/SHA224/SHA256 dma [ 0.983721] ion_dev soc:ion_dev: assigned reserved memory node linux,ion-dev [ 0.984352] ge2d: ge2d_init_module [ 0.984717] ge2d: ge2d_dev major:238 [ 0.985079] ge2d: clock source clk_ge2d_gate 00000000f454a147 [ 0.985114] ge2d: clock clk_ge2d source 00000000bc4ab8fc [ 0.985131] ge2d: clock source clk_vapb_0 0000000006be864a [ 0.985137] ge2d: ge2d init clock is 500000000 HZ, VPU clock is 666666656 HZ [ 0.985273] ge2d: ge2d clock is 499 MHZ [ 0.985291] ge2d: find address resource [ 0.985311] ge2d: map io source 0x00000000b881752e,size=65536 to 0x00000000c15f0a11 [ 0.985316] ge2d: reserved mem init failed [ 0.985320] ge2d: ge2d: pdev=00000000bbc38916, irq=38, clk=00000000f454a147 [ 0.985395] ge2d: ge2d start monitor [ 0.985473] ge2d: ge2d workqueue monitor start [ 0.986157] [tsync_pcr_init]init success. [ 0.986467] amvideom vsync irq: 39 [ 0.986519] create_ge2d_work_queue video task ok [ 0.987283] create_video_receiver video_render.0 0000000056aa92c3, path_id:2 success [ 0.987291] create_video_receiver video_render.1 00000000bd273e9a, path_id:3 success [ 0.987399] hdmitx: hdcp: hdmitx_hdcp_init [ 0.988172] vout: vout2: create vout2 attribute OK [ 0.988347] vout: vout2: vout2_fops_create OK [ 0.988675] vout: vout2: clktree_init [ 0.988681] vout: vout2: register server: nulldisp_vout2_server [ 0.988833] vout: vout2: init mode null set ok [ 0.988836] vout: vout2: aml_vout2_probe OK [ 0.989021] DI: di_module_init ok. [ 0.989327] dim:dim_module_init [ 0.989612] dim:dim_probe: [ 0.989620] dim:dim_probe: major 235 [ 0.989747] di_que_alloc:ok [ 0.989765] di_que_alloc:ok [ 0.989776] dim:qbuf_int:qbuf_blk:end [ 0.989790] dim:qbuf_int:qbuf_mem:end [ 0.989797] dim:qbuf_int:qbuf_pat:end [ 0.989806] dim:qbuf_int:qbuf_iat:end [ 0.989815] dim:qbuf_int:qbuf_blk:end [ 0.989823] dim:qbuf_int:qbuf_mem:end [ 0.989829] dim:qbuf_int:qbuf_pat:end [ 0.989841] dim:qbuf_int:qbuf_iat:end [ 0.989846] dim:di_cfg_top_init_val: [ 0.989851] dim:di_cfg_top_init_val:finish [ 0.989870] dev_vframe_init finish [ 0.990688] dim:match name: dim_g12a:id[16] [ 0.990846] di_multi multi-di: assigned reserved memory node linux,di_cma [ 0.990851] dim:di_cfg_top_dts [ 0.990857] dim:\x09flag_cma:1 [ 0.990868] dim:di_cfg_top_dts:en_dat:0x0 [ 0.990874] dim:mem size from dts:0xc000000 [ 0.990901] dim:pre_irq:52 [ 0.990913] dim:post_irq:53 [ 0.990917] DI: dim_probe allocate rdma channel 0. [ 0.990927] dim:err:dim_get_vpu_clkb: get clk vpu error. [ 0.990932] DI: vpu clkb <334000000, 667000000> [ 0.990988] dim:vpu clkb =666666656. [ 0.991226] DI: afbc_prob:ver[2],_g12a [ 0.991245] 0x000000e1:Y=e1,U=0,V=0 [ 0.991248] 0x000000e2:Y=e2,U=0,V=0 [ 0.991252] 0x000000e3:Y=e3,U=0,V=0 [ 0.991255] 0x000000f0:Y=f0,U=0,V=0 [ 0.991259] 0x000000f1:Y=f1,U=0,V=0 [ 0.991262] 0x000000f2:Y=f2,U=0,V=0 [ 0.991266] 0x000000f3:Y=f3,U=0,V=0 [ 0.991269] 0x000000f4:Y=f4,U=0,V=0 [ 0.991273] 0x000000f5:Y=f5,U=0,V=0 [ 0.991276] 0x000000f6:Y=f6,U=0,V=0 [ 0.991285] 0x000000f7:Y=f7,U=0,V=0 [ 0.991288] 0x000000f8:Y=f8,U=0,V=0 [ 0.991292] 0x000000f9:Y=f9,U=0,V=0 [ 0.991295] 0x000000fa:Y=fa,U=0,V=0 [ 0.991299] 0x000000fb:Y=fb,U=0,V=0 [ 0.991303] 0x000000fc:Y=fc,U=0,V=0 [ 0.991312] 0x000000fd:Y=fd,U=0,V=0 [ 0.991315] 0x000000fe:Y=fe,U=0,V=0 [ 0.991319] 0x000000ff:Y=ff,U=0,V=0 [ 0.991322] 0x0000003a:Y=3a,U=0,V=0 [ 0.991326] 0x0000003b:Y=3b,U=0,V=0 [ 0.991330] 0x0000003c:Y=3c,U=0,V=0 [ 0.991336] 0x0000003d:Y=3d,U=0,V=0 [ 0.991340] 0x0000003e:Y=3e,U=0,V=0 [ 0.991343] 0x0000003f:Y=3f,U=0,V=0 [ 0.991347] DI: support multi decoding 0x3d~0x3e~0x3f. [ 0.991509] dim:dcntr_prob [ 0.991513] . [ 0.991643] . [ 0.991761] dim_probe:ok [ 0.991891] dim:dim_module_init finish [ 0.991898] dil:dil_init. [ 0.992301] dil:dil_init ok. [ 0.992350] vdin_drv_init: major 511 [ 0.992832] rdma_register, rdma_table_addr 000000002ed11719 rdma_table_addr_phy b704a000 reg_buf 00000000d7202419 [ 0.992838] rdma_register success, handle 3 table_size 512 [ 0.992842] vdin_drv_probe:vdin.0 rdma hanld 3. [ 0.993277] vdin vdin0: assigned reserved memory node linux,vdin0_cma [ 0.993281] \x0a vdin memory resource done. [ 0.993289] vdin0 cma_mem_size = 64 MB [ 0.993294] vdin0 irq: 36 rdma irq: 2 [ 0.993301] set_canvas_manual = 0 [ 0.993335] get fclk_div5 err [ 0.993340] vdin_drv_probe: vdin cannot get msr clk !!! [ 0.993385] vdin_drv_probe: driver initialized ok [ 0.993516] rdma_register, rdma_table_addr 00000000817cb646 rdma_table_addr_phy b704b000 reg_buf 000000004b0283ac [ 0.993520] rdma_register success, handle 4 table_size 512 [ 0.993524] vdin_drv_probe:vdin.1 rdma hanld 4. [ 0.993849] vdin vdin1: assigned reserved memory node linux,vdin1_cma [ 0.993853] \x0a vdin memory resource done. [ 0.993859] vdin1 cma_mem_size = 64 MB [ 0.993864] vdin1 irq: 37 rdma irq: 4 [ 0.993869] set_canvas_manual = 0 [ 0.993897] get fclk_div5 err [ 0.993903] vdin_drv_probe: vdin cannot get msr clk !!! [ 0.993913] vdin_debugfs_init only support debug vdin0 1 [ 0.993917] vdin_drv_probe: driver initialized ok [ 0.994094] vdin_drv_init: vdin driver init done [ 0.994101] [viuin..]viuin_init_module viuin module init [ 0.994563] [viuin..]viuin_probe probe ok. [ 0.995200] [RX]-hdmirx: hdmirx_init. [ 0.995205] ESM HLD: Initializing... [ 0.996117] amvdec_csi module: init. [ 0.996128] amvdec_csi_init_module:major 509 [ 0.996339] amvdec_csi module: init. ok [ 0.996344] amlvid:info: amlvideo_init called [ 0.996349] amlvid:info: amlvideo_create_instance called [ 0.996356] amlvid:info: v4l2_dev.name=:amlvideo-000 [ 0.996684] amlvideo-000: V4L2 device registered as video10 [ 0.996690] amlvid:info: amlvideo_create_instance called [ 0.996696] amlvid:info: v4l2_dev.name=:amlvideo-001 [ 0.996871] amlvideo-001: V4L2 device registered as video23 [ 0.997161] amlvideo2 probe called [ 0.997169] amlvideo2_create_node [ 0.997399] amlvideo2: V4L2 device registered as video11 [ 0.997446] amlvideo2 probe called [ 0.997452] amlvideo2_create_node [ 0.997646] amlvideo2: V4L2 device registered as video12 [ 0.997735] PPMGRDRV: warn: ppmgr module init func called [ 0.998012] PPMGRDRV: info: ppmgr_driver_probe called [ 0.998152] Reserved memory: failed to init DMA memory pool at 0x00000000bf800000, size 0 MiB [ 0.998165] PPMGRDRV: info: ppmgr_dev major:508 [ 0.999197] ionvideo-000: V4L2 device registered as video13 [ 0.999340] ionvideo-001: V4L2 device registered as video14 [ 0.999487] ionvideo-002: V4L2 device registered as video15 [ 0.999621] ionvideo-003: V4L2 device registered as video16 [ 0.999776] ionvideo-004: V4L2 device registered as video17 [ 0.999911] ionvideo-005: V4L2 device registered as video18 [ 1.000041] ionvideo-006: V4L2 device registered as video19 [ 1.000171] ionvideo-007: V4L2 device registered as video20 [ 1.000304] ionvideo-008: V4L2 device registered as video21 [ 1.000309] ionvid: info: Video Technology Magazine Ion Video [ 1.000313] ionvid: info: Capture Board ver 1.0 successfully loaded [ 1.000831] picdec: picdec_driver_probe called. [ 1.001209] picdec: probe of picdec failed with error -22 [ 1.001481] videosync_create_instance dev_s 0000000081486bee,dev_s->dev 00000000798d14e3 [ 1.001486] videosync_create_instance reg videosync.0 [ 1.001583] videosync_thread started [ 1.001893] v4lvideo-000: V4L2 device registered as video30 [ 1.002036] v4lvideo-001: V4L2 device registered as video31 [ 1.002167] v4lvideo-002: V4L2 device registered as video32 [ 1.002306] v4lvideo-003: V4L2 device registered as video33 [ 1.002449] v4lvideo-004: V4L2 device registered as video34 [ 1.002585] v4lvideo-005: V4L2 device registered as video35 [ 1.002724] v4lvideo-006: V4L2 device registered as video36 [ 1.002864] v4lvideo-007: V4L2 device registered as video37 [ 1.002989] v4lvideo-008: V4L2 device registered as video38 [ 1.002996] video_composer_module_init_1 [ 1.003357] video_composer_probe_3.1:ports[i].name=video_composer.0, i=0 [ 1.003481] video_composer_probe_3.1:ports[i].name=video_composer.1, i=1 [ 1.003594] video_composer_probe num=2 [ 1.003762] videotunnel init [ 1.004304] aml_vecm_init:module init [ 1.004812] \x0a VECM probe start [ 1.005225] Can't find detect_colorbar. [ 1.005231] Can't find detect_face. [ 1.005235] Can't find detect_corn. [ 1.005238] Can't find wb_sel. [ 1.005243] hdr:Can't find cfg_en_osd_100. [ 1.005250] amlogic, vecm [ 1.005255] vlock dt support: 1 [ 1.005259] vlock dt new_fsm: 0 [ 1.005262] vlock dt hwver: 0 [ 1.005265] vlock dt phlock_en: 0 [ 1.005269] Can't find vlock_en. [ 1.005272] Can't find vlock_mode. [ 1.005276] Can't find vlock_pll_m_limit. [ 1.005280] Can't find vlock_line_limit. [ 1.005295] param_config vlock_en:1 md=0x4 [ 1.005327] vlock: maxLine 524,maxPixel 1715 [ 1.005331] vlock_status_init vlock_en:1 [ 1.005335] pixel_probe: vpp probe func error! [ 1.005372] aml_vecm_probe: ok [ 1.005445] amdolby_vision_init:module init [ 1.005854] \x0a amdolby_vision probe start & ver: 20181220 [ 1.005861] \x0a cpu_id=2 tvmode=0 [ 1.006075] dolby_vision_init_receiver(dvel) [ 1.006098] dolby_vision_init_receiver: dvel [ 1.006337] amdolby_vision_probe: ok [ 1.006342] g12 dovi disable in uboot [ 1.006424] prime_sl module init [ 1.007087] vm_init . [ 1.007784] hdmitx: hdmitx_set_drm_pkt: tf=16, cf=9, colormetry=0 [ 1.008241] meson-mmc: mmc driver version: 3.02, 2017-05-15: New Emmc Host Controller [ 1.009263] meson-mmc: >>>>>>>>hostbase 000000007f396c9d, dmode [ 1.009661] meson-mmc: actual_clock :400000, HHI_nand: 0x80 [ 1.009666] meson-mmc: [meson_mmc_clk_set_rate_v3] after clock: 0x1000033c [ 1.009712] meson-mmc: emmc: fixdiv calc done: adj = 2d2000 [ 1.052658] meson-mmc: meson_mmc_probe() : success! [ 1.061274] amlogic mtd driver init [ 1.062922] aml_vrtc rtc: rtc core: registered aml_vrtc as rtc0 [ 1.063125] input: aml_vkeypad as /devices/platform/rtc/input/input0 [ 1.065127] cectx ff80023c.aocec: cec driver date:2020/01/22:suspend get phy addr from tx and save\x0a [ 1.065505] cectx ff80023c.aocec: compatible:amlogic, aocec-g12a [ 1.065510] cectx ff80023c.aocec: cecb_ver:0x1 [ 1.065514] cectx ff80023c.aocec: line_reg:0x1 [ 1.065519] cectx ff80023c.aocec: line_bit:0x3 [ 1.065523] cectx ff80023c.aocec: ee_to_ao:0x1 [ 1.065679] input: cec_input as /devices/virtual/input/input1 [ 1.065838] cectx ff80023c.aocec: not find 'port_num' [ 1.065844] cectx ff80023c.aocec: using cec:0 [ 1.065880] cectx ff80023c.aocec: no hdmirx regs [ 1.065885] cectx ff80023c.aocec: no hhi regs [ 1.069094] irq cnt:2, a:35, b34 [ 1.069590] cectx ff80023c.aocec: wakeup_reason:0x0 [ 1.069660] cectx ff80023c.aocec: cev val1: 0x0;val2: 0x0 [ 1.069666] cectx ff80023c.aocec: aml_cec_probe success end [ 1.070155] unifykey: storage in base: 0xffffffc005000000 [ 1.070159] unifykey: storage out base: 0xffffffc005040000 [ 1.070163] unifykey: storage block base: 0xffffffc005080000 [ 1.070165] unifykey: probe done! [ 1.070727] unifykey: no efuse-version set, use default value: -1 [ 1.070731] unifykey: key unify config unifykey-num is 19 [ 1.070826] unifykey: key unify fact unifykey-num is 19 [ 1.070839] unifykey: unifykey_devno: 1f500000 [ 1.071086] unifykey: device unifykeys created ok [ 1.071166] unifykey: aml_unifykeys_init done! [ 1.071338] meson ts init [ 1.071410] tsensor id: 0 [ 1.071587] tsensor trim info: 0xda008107! [ 1.071593] tsensor hireboot: 0xc0ff2b00 [ 1.071721] meson ts init [ 1.071756] tsensor id: 1 [ 1.071911] tsensor trim info: 0xda0080d4! [ 1.071917] tsensor hireboot: 0xc0ff2af0 [ 1.072291] audio_dsp: [dsp]register dsp to char divece(257) [ 1.072599] amaudio: amaudio: driver amaudio init! [ 1.073149] amaudio: amaudio_init - amaudio: driver amaudio succuess! [ 1.074328] amlkaraoke init success! [ 1.074870] sysled: module init [ 1.075523] meson_wdt ffd0f0d0.watchdog: start watchdog [ 1.075530] meson_wdt ffd0f0d0.watchdog: creat work queue for watch dog [ 1.075979] meson_wdt ffd0f0d0.watchdog: AML Watchdog Timer probed done [ 1.077057] amlogic rfkill init [ 1.077403] enter bt_probe of_node [ 1.077438] not get gpio_en [ 1.077447] not get gpio_btwakeup [ 1.077452] power on valid level is high [ 1.077457] bt: power_on_pin_OD = 0; [ 1.077461] bt: power_off_flag = 1; [ 1.077464] dis power down = 0; [ 1.091428] clear:82000000, free:82000000, tick:414456 us [ 1.104637] request_irq error ret=-22 [ 1.104680] dev_pm_set_wake_irq failed: -22 [ 1.105485] dmc_monitor_probe [ 1.105646] page_trace_module_init, create sysfs failed [ 1.106546] atv_demod: aml_atvdemod_init: OK, atv demod version: V2.15. [ 1.106741] defendkey ff630218.defendkey: Reserved memory is not enough! [ 1.106755] defendkey: probe of ff630218.defendkey failed with error -22 [ 1.107174] bl40: bl40 probe [ 1.107842] usbcore: registered new interface driver snd-usb-audio [ 1.109245] aml_codec_T9015 ff632000.t9015: aml_T9015_audio_codec_probe [ 1.109268] T9015 acodec used by auge, tdmout:1 [ 1.111959] asoc debug: aml_audio_controller_probe-130 [ 1.112596] aml_tdm_platform_probe, tdm ID = 0, lane_cnt = 4 [ 1.112637] snd_tdm ff642000.audiobus:tdma: lane_mask_out = 1, lane_oe_mask_out = 0 [ 1.112692] snd_tdm ff642000.audiobus:tdma: neither mclk_pad nor mclk2pad set [ 1.112805] aml_tdm_platform_probe(), share en = 1 [ 1.112810] No channel mask node Channel_Mask [ 1.112964] aml_tdm_platform_probe, tdm ID = 1, lane_cnt = 4 [ 1.113040] TDM id 1 samesource_sel:3 [ 1.113049] snd_tdm ff642000.audiobus:tdmb: lane_mask_out = 1, lane_oe_mask_out = 0 [ 1.113208] TDM id 1 output clk enable:1 [ 1.113230] aml_tdm_platform_probe(), share en = 1 [ 1.113234] No channel mask node Channel_Mask [ 1.113243] TDM id 1 tuning clk enable:1 [ 1.113421] aml_tdm_platform_probe, tdm ID = 2, lane_cnt = 4 [ 1.113454] snd_tdm ff642000.audiobus:tdmc: lane_mask_out = 1, lane_oe_mask_out = 1 [ 1.113638] aml_tdm_platform_probe(), share en = 1 [ 1.113642] No channel mask node Channel_Mask [ 1.114245] aml_spdif_platform_probe, spdif ID = 0 [ 1.114443] snd_spdif ff642000.audiobus:spdif: aml_spdif_get_pins error! [ 1.114548] SPDIF id 0 asrc_id:0 auto_asrc:0 [ 1.114627] Spdif id 0 tuning clk enable:1 [ 1.114632] spdifout_play_with_zerodata, spdif id:0 enable:1 [ 1.114641] aml_spdif_platform_probe, register soc platform [ 1.114678] aml_spdif_platform_probe, spdif ID = 1 [ 1.114754] aml_spdif_platform_probe, register soc platform [ 1.115450] default set lane_mask_in as all lanes. [ 1.115455] aml_pdm_platform_probe pdm filter mode from dts:1 [ 1.115474] aml_pdm_platform_probe, register soc platform [ 1.115833] audio-ddr-manager ff642000.audiobus:ddr_manager: 0, irqs toddr 24, frddr 27 [ 1.115862] audio-ddr-manager ff642000.audiobus:ddr_manager: 1, irqs toddr 25, frddr 28 [ 1.115890] audio-ddr-manager ff642000.audiobus:ddr_manager: 2, irqs toddr 26, frddr 29 [ 1.116231] loopback ff642000.audiobus:loopback@0: check whether to update loopback chipinfo [ 1.116290] \x09datain_src:4, datain_chnum:4, datain_chumask:f [ 1.116294] \x09datalb_src:1, datalb_chnum:2, datalb_chmask:3 [ 1.116298] \x09datain_lane_mask:0x5, datalb_lane_mask:0x1 [ 1.116301] datalb_format: 1, chmask for lanes: 0x3 [ 1.116657] loopback_platform_probe, p_loopback->id:0 register soc platform [ 1.117043] audiolocker_platform_probe [ 1.117466] resample_platform_probe [ 1.117562] resample_clk_set, resample_pll:24575987, sclk:12287994, clk:12287994 [ 1.117566] audio_ddr_mngr: aml_set_resample(), toddr NULL [ 1.117570] resample id = 0, new resample = 0, resample_module = 4 [ 1.118633] Register vad [ 1.119106] asoc-aml-card auge_sound: aml_card_dai_link_of, dai-link idx:1, error getting codec dai name:(null) [ 1.119111] asoc-aml-card auge_sound: parse dai_link-1 fail [ 1.119116] asoc-aml-card auge_sound: aml_card_probe, aml_card_parse_of error -517 PROBE RETRY [ 1.119119] aml_card_probe error ret:-517 [ 1.119248] GACT probability NOT on [ 1.119259] Mirror/redirect action on [ 1.119268] u32 classifier [ 1.119271] Actions configured [ 1.119278] Netfilter messages via NETLINK v0.30. [ 1.119483] nf_conntrack version 0.5.0 (16384 buckets, 65536 max) [ 1.119604] ctnetlink v0.93: registering with nfnetlink. [ 1.119852] xt_time: kernel timezone is -0000 [ 1.119911] ipip: IPv4 and MPLS over IPv4 tunneling driver [ 1.120272] gre: GRE over IPv4 demultiplexor driver [ 1.120276] IPv4 over IPsec tunneling driver [ 1.120729] ip_tables: (C) 2000-2006 Netfilter Core Team [ 1.120886] arp_tables: arp_tables: (C) 2002 David S. Miller [ 1.120920] Initializing XFRM netlink socket [ 1.120938] IPsec XFRM device driver [ 1.121400] NET: Registered protocol family 10 [ 1.122343] mip6: Mobile IPv6 [ 1.122364] ip6_tables: (C) 2000-2006 Netfilter Core Team [ 1.122962] sit: IPv6, IPv4 and MPLS over IPv4 tunneling driver [ 1.123739] NET: Registered protocol family 17 [ 1.123759] NET: Registered protocol family 15 [ 1.123784] bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. [ 1.123852] Bluetooth: RFCOMM TTY layer initialized [ 1.123861] Bluetooth: RFCOMM socket layer initialized [ 1.123883] Bluetooth: RFCOMM ver 1.11 [ 1.123893] Bluetooth: BNEP (Ethernet Emulation) ver 1.3 [ 1.123896] Bluetooth: BNEP filters: protocol multicast [ 1.123908] Bluetooth: BNEP socket layer initialized [ 1.123912] Bluetooth: HIDP (Human Interface Emulation) ver 1.2 [ 1.123919] Bluetooth: HIDP socket layer initialized [ 1.123938] l2tp_core: L2TP core driver, V2.0 [ 1.123948] l2tp_ppp: PPPoL2TP kernel driver, V2.0 [ 1.123951] l2tp_ip: L2TP IP encapsulation support (L2TPv3) [ 1.123972] l2tp_netlink: L2TP netlink interface [ 1.123999] l2tp_eth: L2TP ethernet pseudowire support (L2TPv3) [ 1.124019] l2tp_debugfs: L2TP debugfs support [ 1.124022] l2tp_ip6: L2TP IP encapsulation support for IPv6 (L2TPv3) [ 1.124171] NET: Registered protocol family 35 [ 1.124317] Key type dns_resolver registered [ 1.127129] Registered swp emulation handler [ 1.127140] Registered cp15_barrier emulation handler [ 1.127149] Registered setend emulation handler [ 1.127191] disable EAS feature [ 1.127762] registered taskstats version 1 [ 1.137830] asoc-aml-card auge_sound: aml_card_dai_link_of, dai-link idx:1, error getting codec dai name:(null) [ 1.137837] asoc-aml-card auge_sound: parse dai_link-1 fail [ 1.137843] asoc-aml-card auge_sound: aml_card_probe, aml_card_parse_of error -517 PROBE RETRY [ 1.137847] aml_card_probe error ret:-517 [ 1.138470] dwc3 ff500000.dwc3: Configuration mismatch. dr_mode forced to host [ 1.141217] xhci-hcd xhci-hcd.0.auto: xHCI Host Controller [ 1.141234] xhci-hcd xhci-hcd.0.auto: new USB bus registered, assigned bus number 1 [ 1.141489] xhci-hcd xhci-hcd.0.auto: hcc params 0x0228fe6c hci version 0x110 quirks 0x20010010 [ 1.141533] xhci-hcd xhci-hcd.0.auto: irq 15, io mem 0xff500000 [ 1.142137] hub 1-0:1.0: USB hub found [ 1.142167] hub 1-0:1.0: 2 ports detected [ 1.143098] asoc-aml-card auge_sound: aml_card_dai_link_of, dai-link idx:1, error getting codec dai name:(null) [ 1.143104] asoc-aml-card auge_sound: parse dai_link-1 fail [ 1.143108] asoc-aml-card auge_sound: aml_card_probe, aml_card_parse_of error -517 PROBE RETRY [ 1.143112] aml_card_probe error ret:-517 [ 1.143775] asoc-aml-card auge_sound: aml_card_dai_link_of, dai-link idx:1, error getting codec dai name:(null) [ 1.143780] asoc-aml-card auge_sound: parse dai_link-1 fail [ 1.143784] asoc-aml-card auge_sound: aml_card_probe, aml_card_parse_of error -517 PROBE RETRY [ 1.143788] aml_card_probe error ret:-517 [ 1.143869] xhci-hcd xhci-hcd.0.auto: xHCI Host Controller [ 1.143881] xhci-hcd xhci-hcd.0.auto: new USB bus registered, assigned bus number 2 [ 1.143943] usb usb2: We don't know the algorithms for LPM for this host, disabling LPM. [ 1.144534] hub 2-0:1.0: USB hub found [ 1.144559] hub 2-0:1.0: 1 port detected [ 1.145398] asoc-aml-card auge_sound: aml_card_dai_link_of, dai-link idx:1, error getting codec dai name:(null) [ 1.145403] asoc-aml-card auge_sound: parse dai_link-1 fail [ 1.145408] asoc-aml-card auge_sound: aml_card_probe, aml_card_parse_of error -517 PROBE RETRY [ 1.145412] aml_card_probe error ret:-517 [ 1.146070] asoc-aml-card auge_sound: aml_card_dai_link_of, dai-link idx:1, error getting codec dai name:(null) [ 1.146074] asoc-aml-card auge_sound: parse dai_link-1 fail [ 1.146079] asoc-aml-card auge_sound: aml_card_probe, aml_card_parse_of error -517 PROBE RETRY [ 1.146082] aml_card_probe error ret:-517 [ 1.146653] asoc-aml-card auge_sound: aml_card_dai_link_of, dai-link idx:1, error getting codec dai name:(null) [ 1.146657] asoc-aml-card auge_sound: parse dai_link-1 fail [ 1.146662] asoc-aml-card auge_sound: aml_card_probe, aml_card_parse_of error -517 PROBE RETRY [ 1.146665] aml_card_probe error ret:-517 [ 1.147213] asoc-aml-card auge_sound: aml_card_dai_link_of, dai-link idx:1, error getting codec dai name:(null) [ 1.147218] asoc-aml-card auge_sound: parse dai_link-1 fail [ 1.147222] asoc-aml-card auge_sound: aml_card_probe, aml_card_parse_of error -517 PROBE RETRY [ 1.147226] aml_card_probe error ret:-517 [ 1.147528] aml_vrtc rtc: setting system clock to 2015-01-01 00:02:19 UTC (1420070539) [ 1.147825] dwc_otg ff400000.dwc2_a: dwc_otg_driver_probe(0000000076e7f35a) [ 1.147857] dwc_otg: usb0: type: 0 speed: 0, config: 0, dma: 0, id: 0, phy: ffe09000, ctrl: 0 [ 1.147876] dwc_otg ff400000.dwc2_a: base=0xffffff8008b00000 [ 1.147881] dwc_otg ff400000.dwc2_a: dwc_otg_device=0x00000000cb9ed98d [ 1.168020] meson-aml-mmc ffe07000.emmc: divider requested rate 200000000 != actual rate 199999997: ret=0 [ 1.168026] meson-mmc: actual_clock :199999997, HHI_nand: 0x80 [ 1.168030] meson-mmc: [meson_mmc_clk_set_rate_v3] after clock: 0x10000345 [ 1.168036] meson-mmc: Data 1 aligned delay is 0 [ 1.168042] meson-mmc: emmc: clk 199999997 tuning start [ 1.171574] meson-mmc: emmc: adj_win: < 0 1 3 4 > [ 1.171580] meson-mmc: step:4, delay1:0x4104104, delay2:0x4004104 [ 1.175306] meson-mmc: emmc: adj_win: < 0 1 3 4 > [ 1.175310] meson-mmc: step:8, delay1:0x8208208, delay2:0x8008208 [ 1.179029] meson-mmc: emmc: adj_win: < 0 1 2 4 > [ 1.179034] meson-mmc: left:3, right:0, mid:4, size:4 [ 1.179038] meson-mmc: step:0, delay1:0x0, delay2:0x0 [ 1.179043] meson-mmc: emmc: sd_emmc_regs->gclock=0x10000345,sd_emmc_regs->gadjust=0x2000 [ 1.179047] meson-mmc: delay1:0x0, delay2:0x0 [ 1.179140] emmc: new HS200 MMC card at address 0001 [ 1.179144] emmc: clock 199999997, 8-bit-bus-width\x0a [ 1.179594] mmcblk0: emmc:0001 8GTF4R 7.28 GiB [ 1.179761] mmcblk0boot0: emmc:0001 8GTF4R partition 1 4.00 MiB [ 1.179922] mmcblk0boot1: emmc:0001 8GTF4R partition 2 4.00 MiB [ 1.180085] mmcblk0rpmb: emmc:0001 8GTF4R partition 3 512 KiB [ 1.180897] meson-mmc: Enter aml_emmc_partition_ops [ 1.181551] meson-mmc: [mmc_read_partition_tbl] mmc read partition OK! [ 1.181554] meson-mmc: add_emmc_partition [ 1.181698] meson-mmc: [mmcblk0p01] bootloader offset 0x000000000000, size 0x000000400000 [ 1.181822] meson-mmc: [mmcblk0p02] reserved offset 0x000002400000, size 0x000004000000 [ 1.181936] meson-mmc: [mmcblk0p03] cache offset 0x000006c00000, size 0x000043800000 [ 1.182053] meson-mmc: [mmcblk0p04] env offset 0x00004ac00000, size 0x000000800000 [ 1.182166] meson-mmc: [mmcblk0p05] logo offset 0x00004bc00000, size 0x000000800000 [ 1.182281] meson-mmc: [mmcblk0p06] recovery offset 0x00004cc00000, size 0x000001800000 [ 1.182395] meson-mmc: [mmcblk0p07] misc offset 0x00004ec00000, size 0x000000800000 [ 1.182507] meson-mmc: [mmcblk0p08] dtbo offset 0x00004fc00000, size 0x000000800000 [ 1.182623] meson-mmc: [mmcblk0p09] cri_data offset 0x000050c00000, size 0x000000800000 [ 1.182739] meson-mmc: [mmcblk0p10] param offset 0x000051c00000, size 0x000001000000 [ 1.182849] meson-mmc: [mmcblk0p11] boot offset 0x000053400000, size 0x000001000000 [ 1.182966] meson-mmc: [mmcblk0p12] rsv offset 0x000054c00000, size 0x000001000000 [ 1.183079] meson-mmc: [mmcblk0p13] metadata offset 0x000056400000, size 0x000001000000 [ 1.183194] meson-mmc: [mmcblk0p14] vbmeta offset 0x000057c00000, size 0x000000200000 [ 1.183309] meson-mmc: [mmcblk0p15] tee offset 0x000058600000, size 0x000002000000 [ 1.183422] meson-mmc: [mmcblk0p16] factory offset 0x00005ae00000, size 0x000000800000 [ 1.183546] meson-mmc: [mmcblk0p17] super offset 0x00005be00000, size 0x000065200000 [ 1.183674] meson-mmc: [mmcblk0p18] factory_setting offset 0x0000c1800000, size 0x000001000000 [ 1.183789] meson-mmc: [mmcblk0p19] btv_home offset 0x0000c3000000, size 0x000006400000 [ 1.183904] meson-mmc: [mmcblk0p20] data offset 0x0000c9c00000, size 0x000108400000 [ 1.183923] card key: card_blk_probe. [ 1.183929] emmc_key_init:183 emmc key lba_start:0x12020,lba_end:0x12220 [ 1.183933] emmc key: emmc_key_init:205 ok. [ 1.183937] meson-mmc: amlmmc_dtb_init: register dtb chardev [ 1.186414] meson-mmc: calc 7967c8bd, store 7967c8bd [ 1.188204] meson-mmc: calc 7967c8bd, store 7967c8bd [ 1.188207] meson-mmc: total valid 2 [ 1.188388] meson-mmc: amlmmc_dtb_init: register dtb chardev OK [ 1.188424] meson-mmc: Exit aml_emmc_partition_ops OK. [ 1.190132] asoc-aml-card auge_sound: aml_card_dai_link_of, dai-link idx:1, error getting codec dai name:(null) [ 1.190139] asoc-aml-card auge_sound: parse dai_link-1 fail [ 1.190144] asoc-aml-card auge_sound: aml_card_probe, aml_card_parse_of error -517 PROBE RETRY [ 1.190147] aml_card_probe error ret:-517 [ 1.248125] dwc_otg: Core Release: 3.30a [ 1.248132] dwc_otg: Setting default values for core params [ 1.248144] dwc_otg: curmode: 0, host_only: 0 [ 1.248161] dwc_otg ff400000.dwc2_a: DMA config: BURST_DEFAULT [ 1.260398] dwc_otg: Using Buffer DMA mode [ 1.260403] dwc_otg: OTG VER PARAM: 1, OTG VER FLAG: 1 [ 1.260407] dwc_otg: Working on port type = SLAVE [ 1.260413] dwc_otg: Dedicated Tx FIFOs mode [ 1.262045] asoc-aml-card auge_sound: aml_card_dai_link_of, dai-link idx:1, error getting codec dai name:(null) [ 1.262051] asoc-aml-card auge_sound: parse dai_link-1 fail [ 1.262056] asoc-aml-card auge_sound: aml_card_probe, aml_card_parse_of error -517 PROBE RETRY [ 1.262060] aml_card_probe error ret:-517 [ 1.263708] meson_cdev probe [ 1.263722] thermal: read gpupp failed [ 1.263776] meson_cdev index: 0 [ 1.263901] thermal: read gpupp failed [ 1.263935] meson_cdev index: 1 [ 1.263942] cpucore_cooling_register, max_cpu_core_num:4 [ 1.264053] meson_cdev index: 2 [ 1.264059] thermal: read gpupp failed [ 1.264078] meson_cdev index: 3 [ 1.264114] find tzd id: 0 [ 1.264225] find tzd id: 0 [ 1.264264] meson_cdev probe done [ 1.265018] asoc-aml-card auge_sound: aml_card_dai_link_of, dai-link idx:1, error getting codec dai name:(null) [ 1.265023] asoc-aml-card auge_sound: parse dai_link-1 fail [ 1.265028] asoc-aml-card auge_sound: aml_card_probe, aml_card_parse_of error -517 PROBE RETRY [ 1.265032] aml_card_probe error ret:-517 [ 1.265259] gxbb_pm: enter meson_pm_probe! [ 1.265265] no vddio3v3_en pin [ 1.265278] pm-meson aml_pm: Can't get switch_clk81 [ 1.265307] gxbb_pm: meson_pm_probe done [ 1.265944] asoc-aml-card auge_sound: aml_card_dai_link_of, dai-link idx:1, error getting codec dai name:(null) [ 1.265949] asoc-aml-card auge_sound: parse dai_link-1 fail [ 1.265954] asoc-aml-card auge_sound: aml_card_probe, aml_card_parse_of error -517 PROBE RETRY [ 1.265957] aml_card_probe error ret:-517 [ 1.266456] ALSA device list: [ 1.266459] No soundcards found. [ 1.266643] meson_uart ff803000.serial: ttyS0 use xtal(24M) 24000000 change 115200 to 115200 [ 1.268639] Freeing unused kernel memory: 5440K [ 1.274415] init: init first stage started! [ 1.277365] init: Using Android DT directory /proc/device-tree/firmware/android/ [ 1.284603] hdmitx: system: plugin [ 1.315582] init: [libfs_mgr]Created logical partition product on device /dev/block/dm-0 [ 1.316639] init: [libfs_mgr]Created logical partition vendor on device /dev/block/dm-1 [ 1.317612] init: [libfs_mgr]Created logical partition system on device /dev/block/dm-2 [ 1.318491] init: [libfs_mgr]Created logical partition odm on device /dev/block/dm-3 [ 1.319032] init: [libfs_mgr]superblock s_max_mnt_count:65535,/dev/block/metadata [ 1.319840] init: [libfs_mgr]check_fs(): mount(/dev/block/metadata,/metadata,ext4)=-1: No such file or directory [ 1.319889] init: [libfs_mgr]Not running /system/bin/e2fsck on /dev/block/metadata (executable not in system image) [ 1.321012] EXT4-fs (mmcblk0p13): Ignoring removed nomblk_io_submit option [ 1.323136] EXT4-fs (mmcblk0p13): mounted filesystem with ordered data mode. Opts: nodelalloc,nomblk_io_submit,errors=panic [ 1.323205] init: [libfs_mgr]__mount(source=/dev/block/metadata,target=/metadata,type=ext4)=0: Success [ 1.330700] EXT4-fs (dm-2): mounted filesystem without journal. Opts: barrier=1,inode_readahead_blks=8 [ 1.335057] EXT4-fs (dm-3): mounted filesystem without journal. Opts: barrier=1,inode_readahead_blks=8 [ 1.338145] EXT4-fs (dm-0): mounted filesystem without journal. Opts: barrier=1,inode_readahead_blks=8 [ 1.341600] EXT4-fs (dm-1): mounted filesystem without journal. Opts: barrier=1,inode_readahead_blks=8 [ 1.351633] init: 16 output lines suppressed due to ratelimiting [ 1.416793] hdmitx: edid: EDID Parser: [ 1.416799] hdmitx: hdmitx: reach vesa idx MAX [ 1.416802] hdmitx: hdmitx: reach vesa idx MAX [ 1.416805] hdmitx: hdmitx: reach vesa idx MAX [ 1.416814] hdmitx: hdmitx: reach vesa idx MAX [ 1.416818] hdmitx: hdmitx: reach vesa idx MAX [ 1.416821] hdmitx: hdmitx: reach vesa idx MAX [ 1.416826] hdmitx: hdmitx: reach vesa idx MAX [ 1.416830] hdmitx: hdmitx: reach vesa idx MAX [ 1.416833] hdmitx: hdmitx: reach vesa idx MAX [ 1.416836] hdmitx: hdmitx: reach vesa idx MAX [ 1.416845] [RX]-up_phy_addr = 3 [ 1.416861] hdmitx: edid: dump_dtd_info[2046] [ 1.416865] hdmitx: edid: pixel_clock: 29700 [ 1.416868] hdmitx: edid: h_active: 1920 [ 1.416871] hdmitx: edid: h_blank: 280 [ 1.416874] hdmitx: edid: v_active: 2160 [ 1.416878] hdmitx: edid: v_blank: 90 [ 1.416881] hdmitx: edid: h_sync_offset: 48 [ 1.416884] hdmitx: edid: h_sync: 32 [ 1.416887] hdmitx: edid: v_sync_offset: 3 [ 1.416890] hdmitx: edid: v_sync: 5 [ 1.416894] hdmitx: edid: dump_dtd_info[2046] [ 1.416897] hdmitx: edid: pixel_clock: 24150 [ 1.416901] hdmitx: edid: h_active: 2560 [ 1.416904] hdmitx: edid: h_blank: 160 [ 1.416907] hdmitx: edid: v_active: 1440 [ 1.416911] hdmitx: edid: v_blank: 41 [ 1.416914] hdmitx: edid: h_sync_offset: 48 [ 1.416917] hdmitx: edid: h_sync: 32 [ 1.416920] hdmitx: edid: v_sync_offset: 3 [ 1.416923] hdmitx: edid: v_sync: 5 [ 1.416928] hdmitx: hdmitx: get PMT vic: 97 [ 1.416931] hdmitx: hdmitx: reach vesa idx MAX [ 1.416935] hdmitx: edid: find IEEEOUT [ 1.416958] hdmitx: edid: check sum valid [ 1.416961] hdmitx: edid: check sum valid [ 1.416967] hdmitx: edid: check sum valid [ 1.416970] hdmitx: edid: check sum valid [ 1.416976] hdmitx: edid: blk0 raw data [ 1.417002] hdmitx: edid: \x0a00ffffffffffff00230d0028010000000e1e0103803f21782a5995af4f42af26\x0a0f505423080081008140818081c0a9c09500b300a94008e80030f2705a80b058\x0a4a006c552100001e662156aa51001e30468f3300c4fe1000001e023a80187138\x0a2d40582c450060632100001e000000fc0032383835550a202020202020200168\x0a\x0a [ 1.417006] hdmitx: edid: blk1 raw data [ 1.417031] hdmitx: edid: \x0a02034bf24d61605a10050403021f1312015f23097f07830100006d030c003000\x0a387820006001020367d85dc40178c800e305e301e20f7f00e6060701605000e2\x0a00f9681a000001013040ed0474801871705a803020350055502100001e565e00\x0aa0a0a029503020350055502100001e0000000000000000000000000000000095\x0a\x0a [ 1.417036] hdmitx: system: update physcial size: 630 330 [ 1.417042] hdmitx: hw: set audio [ 1.417048] hdmitx: hw: hdmitx tx_aud_src = 0 [ 1.417061] hdmitx: fs = 0, cd = 4, tmds_clk = 148352 [ 1.417065] hdmitx: hw: aud_n_para = 5824 [ 1.417074] hdmitx: hw: set channel status [ 1.451974] init: Loading SELinux policy [ 1.462634] SELinux: 8192 avtab hash slots, 27113 rules. [ 1.477290] SELinux: 8192 avtab hash slots, 27113 rules. [ 1.477304] SELinux: 1 users, 4 roles, 1541 types, 0 bools, 1 sens, 1024 cats [ 1.477314] SELinux: 97 classes, 27113 rules [ 1.479725] SELinux: Completing initialization. [ 1.479731] SELinux: Setting up existing superblocks. [ 1.588973] audit: type=1403 audit(1420070539.940:2): policy loaded auid=4294967295 ses=4294967295 [ 1.589194] selinux: SELinux: Loaded policy from /odm/etc/selinux/precompiled_sepolicy\x0a [ 1.589681] audit: type=1404 audit(1420070539.940:3): enforcing=1 old_enforcing=0 auid=4294967295 ses=4294967295 [ 1.615893] selinux: SELinux: Skipping /product/etc/selinux/product_file_contexts: empty file\x0a [ 1.616107] selinux: SELinux: Loaded file_contexts\x0a [ 1.656085] init: init second stage started! [ 1.684324] init: Using Android DT directory /proc/device-tree/firmware/android/ [ 1.690187] selinux: SELinux: Skipping /product/etc/selinux/product_file_contexts: empty file\x0a [ 1.690405] selinux: SELinux: Loaded file_contexts\x0a [ 1.690430] init: Running restorecon... [ 1.705466] init: Overriding previous 'ro.' property 'persist.sys.usb.config':'adb' with new value 'mtp' [ 1.706639] selinux: avc: denied { set } for scontext=u:r:vendor_init:s0 tcontext=u:object_r:default_prop:s0 tclass=property_service permissive=0\x0a [ 1.706665] init: Do not have permissions to set 'ro.com.google.gmsversion' to 'Q_amlogic' in property file '/vendor/build.prop': SELinux permission check failed [ 1.706962] selinux: avc: denied { set } for scontext=u:r:vendor_init:s0 tcontext=u:object_r:default_prop:s0 tclass=property_service permissive=0\x0a [ 1.706980] init: Do not have permissions to set 'ro.camera.preview.MaxSize' to '1920x1080' in property file '/vendor/build.prop': SELinux permission check failed [ 1.853773] ueventd: ueventd started! [ 1.858396] selinux: SELinux: Skipping /product/etc/selinux/product_file_contexts: empty file\x0a [ 1.858765] selinux: SELinux: Loaded file_contexts\x0a [ 1.858950] ueventd: Parsing file /ueventd.rc... [ 1.860350] ueventd: Parsing file /vendor/ueventd.rc... [ 1.862024] ueventd: Parsing file /odm/ueventd.rc... [ 1.862061] ueventd: Unable to read config file '/odm/ueventd.rc': open() failed: No such file or directory [ 1.862090] ueventd: Parsing file /ueventd.amlogic.rc... [ 1.862115] ueventd: Unable to read config file '/ueventd.amlogic.rc': open() failed: No such file or directory [ 1.866060] apexd: Bootstrap subcommand detected [ 1.872889] apexd: Scanning /system/apex for embedded keys [ 1.873904] apexd: Scanning /product/apex for embedded keys [ 1.874057] apexd: ... does not exist. Skipping [ 1.874204] apexd: Scanning /system/apex looking for APEX packages. [ 1.874417] apexd: Found /system/apex/com.android.conscrypt [ 1.874706] apexd: Skipped when bootstrapping [ 1.874852] apexd: Found /system/apex/com.android.media [ 1.875122] apexd: Skipped when bootstrapping [ 1.875271] apexd: Found /system/apex/com.android.media.swcodec [ 1.879542] apexd: 9 output lines suppressed due to ratelimiting [ 1.960743] meson6-dwmac ff3f0000.ethernet eth0: fail to init PTP. [ 1.961179] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [ 1.970314] snd_soc_tlv320adc3101: loading out-of-tree module taints kernel. [ 1.971029] tlv320 adc3101_i2c_probe ... [ 1.971241] failed to get slot_number, set it default [ 1.971246] adc3101_i2c_probe i2c:000000004b510305 [ 1.971262] adc3101_i2c_probe 18 done [ 1.973292] adc3101_codec_probe ... [ 1.976841] adc3101_codec_probe done... [ 1.983521] aml_spdif_component_probe [ 1.983627] aml_spdif_component_probe [ 1.988553] optee_armtz: initialized driver [ 2.192648] asoc-aml-card auge_sound: control 2:0:0:I2SIn CLK:0 is already present [ 2.192658] snd_tdm ff642000.audiobus:tdmb: ASoC: Failed to add I2SIn CLK: -16 [ 2.192662] aml_dai_tdm_probe, failed add snd tdm controls [ 2.192673] asoc-aml-card auge_sound: control 2:0:0:I2SIn CLK:0 is already present [ 2.192678] snd_tdm ff642000.audiobus:tdmc: ASoC: Failed to add I2SIn CLK: -16 [ 2.192681] aml_dai_tdm_probe, failed add snd tdm controls [ 2.192690] aml_dai_set_tdm_slot(), txmask(0xff), rxmask(0xff) [ 2.192693] \x09lanes_out_cnt(1), lanes_in_cnt(1) [ 2.192696] \x09lanes_lb_cnt(0) [ 2.192700] \x09slots(8), slot_width(32) [ 2.192704] \x09lanes_oe_out_cnt(0), lanes_oe_in_cnt(0) [ 2.192722] asoc aml_dai_set_tdm_fmt, 0x4004, 0000000006e62c15, id(0), clksel(0) [ 2.192729] master_mode(1), binv(1), finv(0) out_skew(2), in_skew(3) [ 2.193387] asoc-aml-card auge_sound: multicodec <-> TDM-A mapping ok [ 2.193393] aml_dai_set_tdm_slot(), txmask(0x3), rxmask(0x3) [ 2.193396] \x09lanes_out_cnt(1), lanes_in_cnt(1) [ 2.193399] \x09lanes_lb_cnt(0) [ 2.193403] \x09slots(2), slot_width(32) [ 2.193407] \x09lanes_oe_out_cnt(0), lanes_oe_in_cnt(0) [ 2.193415] [adc3101_set_dai_fmt]:slot_number=0 [ 2.198645] asoc aml_dai_set_tdm_fmt, 0x4001, 00000000c06bac4c, id(1), clksel(1) [ 2.198656] master_mode(1), binv(1), finv(1) out_skew(2), in_skew(3) [ 2.199040] asoc-aml-card auge_sound: multicodec <-> TDM-B mapping ok [ 2.199048] aml_dai_set_tdm_slot(), txmask(0x3), rxmask(0x3) [ 2.199051] \x09lanes_out_cnt(1), lanes_in_cnt(1) [ 2.199054] \x09lanes_lb_cnt(0) [ 2.199058] \x09slots(2), slot_width(32) [ 2.199062] pin(1) should be selected for only one usage [ 2.199065] \x09lanes_oe_out_cnt(1), lanes_oe_in_cnt(0) [ 2.199076] asoc aml_dai_set_tdm_fmt, 0x4001, 00000000ecb21b3c, id(2), clksel(2) [ 2.199082] master_mode(1), binv(1), finv(1) out_skew(2), in_skew(3) [ 2.199397] asoc-aml-card auge_sound: multicodec <-> TDM-C mapping ok [ 2.199603] asoc-aml-card auge_sound: dummy <-> ff642000.audiobus:pdm mapping ok [ 2.199608] set normal 128fs [ 2.199639] \x09 set spdifout clk:6144000, mpll:24576000 [ 2.199643] \x09 get spdifout clk:6143997, mpll:24575987 [ 2.199647] aml_dai_set_spdif_fmt , fmt 0x4010 [ 2.199760] aml_spdif_new spdif_a, clk continuous:1 [ 2.199764] spdifout_play_with_zerodata_free, spdif id:0 [ 2.199944] asoc-aml-card auge_sound: dummy <-> SPDIF mapping ok [ 2.199949] set normal 128fs [ 2.199988] \x09 set spdifout clk:6144000, mpll:24576000 [ 2.199992] \x09 get spdifout clk:6143997, mpll:24575987 [ 2.199996] aml_dai_set_spdif_fmt , fmt 0x4010 [ 2.200080] aml_spdif_new spdif_b, clk continuous:1 [ 2.200083] spdifout_play_with_zerodata_free, spdif id:1 [ 2.200180] asoc-aml-card auge_sound: dummy <-> SPDIF-B mapping ok [ 2.200186] \x0aloopback_dai_set_sysclk, 0, 12288000, 0 [ 2.200191] asoc loopback_dai_set_fmt, 0x4010, 0000000095313087 [ 2.200461] asoc-aml-card auge_sound: dummy <-> ff642000.audiobus:loopback@0 mapping ok [ 2.211421] snd_card_add_kcontrols card:0000000057507aac [ 2.211454] effect_v2 is not init [ 2.211457] Not init vad [ 2.211460] Failed to add VAD controls [ 2.211488] eq/drc v1 function enable [ 2.752566] av out status: high [ 3.824533] lcd vlock_en=1, vlock_mode=0x4 [ 4.236768] ueventd: Coldboot took 2.373 seconds [ 4.295253] unifykey: amlkey_init_gen() enter! [ 4.297594] emmc_key_read:114, read ok [ 4.297606] unifykey: amlkey_init_gen() storagekey_info.buffer=000000005870c5ae, storagekey_info.size = 40000! [ 4.361350] logd.auditd: start [ 4.361376] logd.klogd: 4292877292 [ 4.362206] register clk_set_setting cpu[40] [ 4.369415] Registered firmware driver success. [ 4.370897] Try to load video/h264_enc.bin ... [ 4.373455] load firmware size : 76288, Name : video/h264_enc.bin. [ 4.374015] Try to load video/video_ucode.bin ... [ 4.401733] load firmware size : 1846016, Name : video/video_ucode.bin. [ 4.467135] Amlogic A/V streaming port init [ 4.469984] get gate demux control ok 000000004a2b42d5 [ 4.470003] get gate parser_top control ok 00000000c57688de [ 4.470034] get gate vdec control ok 00000000e95f4bf8 [ 4.470070] get gate clk_81 control ok 0000000053d0e963 [ 4.470112] get gate clk_vdec_mux control ok 0000000034b1b349 [ 4.470160] get gate clk_hcodec_mux control ok 00000000d4a82242 [ 4.470228] get gate clk_hevc_mux control ok 0000000011b175a7 [ 4.470289] get gate clk_hevcb_mux control ok 00000000f316fbb8 [ 4.470315] get gate ahbarb0 control ok 000000005485516c [ 4.470324] get gate asyncfifo control failed (null) [ 4.477442] amvdec_avs module init [ 4.484636] amvdec_h264 module init [ 4.499534] ammvdec_h264 module init [ 4.517337] amvdec_h265 module init [ 4.539574] ammvdec_mpeg12 module init [ 4.550497] ammvdec_mpeg4_driver_init_module [ 4.559667] amvdec_vc1 module init [ 4.569989] amvdec_vp9 module init [ 4.588756] amvenc_avc_probe -- reserved memory config fail. [ 4.588763] amvenc_avc - cma memory pool size: 60 MB [ 4.588788] encode_wq_init. [ 4.588795] encode start monitor. [ 4.588894] encode workqueue monitor start. [ 4.595541] vpu_init [ 4.595810] vpu_probe [ 4.595815] HevcEnc reserved memory config fail. [ 4.595820] HevcEnc - cma memory pool size: 64 MB [ 4.595847] HevcEnc - wave420l_irq: 45 [ 4.595893] vpu base address get from platform driver physical base addr=0xff610000, virtual base=0xffffff80089e0000 [ 4.596166] success to probe vpu device with video memory from cma [ 4.640143] decoder registered as /dev/video26 [ 4.645444] amlogic_fbc_lib: disagrees about version of symbol module_layout [ 4.645457] amlogic_fbc_lib: module license 'Copyright (C) 2015 Amlogic, Inc. All rights reserved.' taints kernel. [ 4.645461] Disabling lock debugging due to kernel taint [ 4.645630] amlogic_fbc_lib: disagrees about version of symbol register_amlogic_afbc_dec_fun [ 4.645641] amlogic_fbc_lib: disagrees about version of symbol register_amlogic_afbc_dec_fun_v1 [ 4.646074] register_amlogic_afbc_dec_fun [ 4.646079] register_amlogic_afbc_dec_fun [ 4.658565] EXT4-fs (mmcblk0p20): Ignoring removed nomblk_io_submit option [ 4.749185] EXT4-fs (mmcblk0p20): 1 orphan inode deleted [ 4.749192] EXT4-fs (mmcblk0p20): recovery complete [ 4.754701] EXT4-fs (mmcblk0p20): mounted filesystem with ordered data mode. Opts: errors=remount-ro,nomblk_io_submit [ 5.159856] e2fsck: e2fsck 1.44.4 (18-Aug-2018)\x0a [ 5.159877] e2fsck: Pass 1: Checking inodes, blocks, and sizes\x0a [ 5.159886] e2fsck: Inode 130768 extent tree (at level 1) could be shorter. Fix? yes\x0a [ 5.159894] e2fsck: \x0a [ 5.159902] e2fsck: Pass 1E: Optimizing extent trees\x0a [ 5.159909] e2fsck: Pass 2: Checking directory structure\x0a [ 5.159917] e2fsck: Pass 3: Checking directory connectivity\x0a [ 5.159925] e2fsck: Pass 4: Checking reference counts\x0a [ 5.159932] e2fsck: Pass 5: Checking group summary information\x0a [ 5.159941] e2fsck: [QUOTA WARNING] Usage inconsistent for ID 10056:actual (3502080, 55) != expected (3506176, 55)\x0a [ 5.161760] EXT4-fs (mmcblk0p20): Ignoring removed nomblk_io_submit option [ 5.165476] EXT4-fs (mmcblk0p20): mounted filesystem with ordered data mode. Opts: nodelalloc,nomblk_io_submit,errors=panic [ 5.167182] EXT4-fs (mmcblk0p3): Ignoring removed nomblk_io_submit option [ 5.168697] EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Opts: errors=remount-ro,nomblk_io_submit [ 5.209999] EXT4-fs (mmcblk0p3): Ignoring removed nomblk_io_submit option [ 5.211536] EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Opts: nodelalloc,nomblk_io_submit,errors=panic [ 5.213592] EXT4-fs (mmcblk0p19): Ignoring removed nomblk_io_submit option [ 5.218420] EXT4-fs (mmcblk0p19): recovery complete [ 5.218857] EXT4-fs (mmcblk0p19): mounted filesystem with ordered data mode. Opts: errors=remount-ro,nomblk_io_submit [ 5.289716] EXT4-fs (mmcblk0p19): Ignoring removed nomblk_io_submit option [ 5.291505] EXT4-fs (mmcblk0p19): mounted filesystem with ordered data mode. Opts: nodelalloc,nomblk_io_submit,errors=panic [ 5.337941] EXT4-fs (mmcblk0p10): Ignoring removed nomblk_io_submit option [ 5.339650] EXT4-fs (mmcblk0p10): mounted filesystem with ordered data mode. Opts: nodelalloc,nomblk_io_submit,errors=panic [ 5.341838] EXT4-fs (mmcblk0p15): Ignoring removed nomblk_io_submit option [ 5.344887] EXT4-fs (mmcblk0p15): recovery complete [ 5.345324] EXT4-fs (mmcblk0p15): mounted filesystem with ordered data mode. Opts: errors=remount-ro,nomblk_io_submit [ 5.405151] EXT4-fs (mmcblk0p15): Ignoring removed nomblk_io_submit option [ 5.406570] EXT4-fs (mmcblk0p15): mounted filesystem with ordered data mode. Opts: nodelalloc,nomblk_io_submit,errors=panic [ 5.419308] init: 35 output lines suppressed due to ratelimiting [ 5.641306] apexd: Marking APEXd as starting [ 5.642231] apexd: Scanning /system/apex for embedded keys [ 5.643510] apexd: Scanning /product/apex for embedded keys [ 5.643551] apexd: ... does not exist. Skipping [ 5.643578] apexd: Populating APEX database from mounts... [ 5.643810] apexd: Failed to walk /product/apex : Can't open /product/apex for reading : No such file or directory [ 5.644344] apexd: Found "/apex/com.android.tzdata@290000000" [ 5.644417] apexd: Found "/apex/com.android.runtime@1" [ 5.644614] apexd: 2 packages restored. [ 5.644671] apexd: Scanning /data/apex/sessions looking for sessions to be activated. [ 5.699287] vdc: Waited 0ms for vold [ 5.782708] mali ffe40000.bifrost: max pp is 2 [ 5.782718] mali ffe40000.bifrost: set min pp to default 1 [ 5.782722] mali ffe40000.bifrost: min pp is 1 [ 5.782727] mali ffe40000.bifrost: set min clk default to 0 [ 5.782731] mali ffe40000.bifrost: min clk is 0 [ 5.782752] mali ffe40000.bifrost: hiu io source 0x00000000255ea844 [ 5.782766] mali ffe40000.bifrost: hiu io source 0x0000000053a986fe [ 5.782772] mali ffe40000.bifrost: num of pp used most of time 1 [ 5.782777] mali ffe40000.bifrost: clock dvfs cfg table size is 4 [ 5.782840] mali ffe40000.bifrost: max clk set 2 [ 5.782845] mali ffe40000.bifrost: max clk is 2 [ 5.782850] mali ffe40000.bifrost: turbo clk set to 3 [ 5.782854] mali ffe40000.bifrost: turbo clk is 3 [ 5.782859] mali ffe40000.bifrost: default clk set to 2 [ 5.782864] mali ffe40000.bifrost: default clk is 2 [ 5.782871] mali ffe40000.bifrost: ====================0====================\x0aclk_freq= 500000000, clk_parent=fclk_div4, voltage=1150, keep_count=5, threshod=<38 194>, clk_sample=500 [ 5.782877] mali ffe40000.bifrost: ====================1====================\x0aclk_freq= 666666666, clk_parent=fclk_div3, voltage=1150, keep_count=5, threshod=<150 203>, clk_sample=666 [ 5.782884] mali ffe40000.bifrost: ====================2====================\x0aclk_freq= 846000000, clk_parent= gp0_pll, voltage=1150, keep_count=5, threshod=<156 255>, clk_sample=846 [ 5.782890] mali ffe40000.bifrost: ====================3====================\x0aclk_freq= 846000000, clk_parent= gp0_pll, voltage=1150, keep_count=5, threshod=<156 255>, clk_sample=846 [ 5.782894] mali ffe40000.bifrost: clock dvfs table size is 4 [ 5.783629] mali_plat=0000000028693579 [ 5.783877] thermal thermal_zone0: binding zone soc_thermal with cdev thermal-gpufreq-0 failed:-22 [ 5.783980] find tzd id: 0 [ 5.784062] gpu cooling register okay with err=0 [ 5.784276] find tzd id: 0 [ 5.784327] gpu core cooling register okay with err=0 [ 5.784358] shader_present=1, tiler_present=1, l2_present=1 [ 5.784440] Mali_pwr_on:gpu_irq : 200 [ 5.784666] mali ffe40000.bifrost: GPU identified as 0x3 arch 7.0.9 r0p0 status 0 [ 5.785004] mali ffe40000.bifrost: No memory group manager is configured [ 5.786450] mali ffe40000.bifrost: Probed as mali0 [ 5.802674] aml dvb init [ 5.810500] atvr_init: succeeded creating misc device snd_atvr_pcm [ 5.810641] atvr_init: succeeded creating misc device snd_atvr_adpcm [ 5.810769] atvr_init: succeeded creating misc device snd_atvr_msbc [ 5.822015] meson-remote: Driver init [ 5.822320] meson-remote: remote_probe [ 5.822344] meson-remote ff808040.rc: protocol = 0x1 [ 5.822350] meson-remote ff808040.rc: led_blink = 1 [ 5.822355] meson-remote ff808040.rc: led_blink_frq = 100 [ 5.822413] meson-remote ff808040.rc: platform_data irq =31 [ 5.822452] meson-remote ff808040.rc: custom_number = 3 [ 5.822467] meson-remote ff808040.rc: ptable->map_size = 235 [ 5.822472] meson-remote ff808040.rc: ptable->custom_name = amlogic-remote-1 [ 5.822477] meson-remote ff808040.rc: ptable->custom_code = 0x7f80 [ 5.822483] meson-remote ff808040.rc: ptable->release_delay = 80 [ 5.822630] meson-remote ff808040.rc: ptable->map_size = 235 [ 5.822636] meson-remote ff808040.rc: ptable->custom_name = amlogic-remote-2 [ 5.822641] meson-remote ff808040.rc: ptable->custom_code = 0xa0f5 [ 5.822646] meson-remote ff808040.rc: ptable->release_delay = 80 [ 5.822793] meson-remote ff808040.rc: ptable->map_size = 17 [ 5.822798] meson-remote ff808040.rc: ptable->custom_name = amlogic-remote-3 [ 5.822803] meson-remote ff808040.rc: ptable->custom_code = 0xbd02 [ 5.822808] meson-remote ff808040.rc: ptable->release_delay = 80 [ 5.822817] meson-remote ff808040.rc: default protocol = 0x1 and id = 0 [ 5.822822] meson-remote ff808040.rc: reg=0x0, val=0x1f40190 [ 5.822826] meson-remote ff808040.rc: reg=0x4, val=0x12c00c8 [ 5.822831] meson-remote ff808040.rc: reg=0x8, val=0x960050 [ 5.822836] meson-remote ff808040.rc: reg=0xc, val=0x480028 [ 5.822840] meson-remote ff808040.rc: reg=0x10, val=0x70fa0013 [ 5.822845] meson-remote ff808040.rc: reg=0x18, val=0x8616800 [ 5.822849] meson-remote ff808040.rc: reg=0x1c, val=0x9f00 [ 5.822854] meson-remote ff808040.rc: reg=0x20, val=0x0 [ 5.822859] meson-remote ff808040.rc: reg=0x24, val=0x0 [ 5.822863] meson-remote ff808040.rc: reg=0x28, val=0x0 [ 5.823456] input: aml_keypad as /devices/platform/ff808040.rc/input/input2 [ 5.827754] gpio-keypad gpio_keypad: ch+ key(402) registed. [ 5.827763] gpio-keypad gpio_keypad: ch- key(403) registed. [ 5.827946] input: gpio_keypad as /devices/platform/gpio_keypad/input/input3 [ 5.939377] type=1400 audit(1420070544.288:4): avc: denied { setattr } for comm="init" name="media" dev="mmcblk0p20" ino=127529 scontext=u:r:vendor_init:s0 tcontext=u:object_r:media_rw_data_file:s0 tclass=dir permissive=0 [ 5.942061] type=1400 audit(1420070544.288:4): avc: denied { setattr } for comm="init" name="media" dev="mmcblk0p20" ino=127529 scontext=u:r:vendor_init:s0 tcontext=u:object_r:media_rw_data_file:s0 tclass=dir permissive=0 [ 5.942095] type=1400 audit(1420070544.292:5): avc: denied { setattr } for comm="init" name="/" dev="mmcblk0p3" ino=2 scontext=u:r:vendor_init:s0 tcontext=u:object_r:cache_file:s0 tclass=dir permissive=0 [ 5.942197] type=1400 audit(1420070544.292:5): avc: denied { setattr } for comm="init" name="/" dev="mmcblk0p3" ino=2 scontext=u:r:vendor_init:s0 tcontext=u:object_r:cache_file:s0 tclass=dir permissive=0 [ 5.942214] type=1400 audit(1420070544.292:6): avc: denied { search } for comm="init" name="/" dev="mmcblk0p3" ino=2 scontext=u:r:vendor_init:s0 tcontext=u:object_r:cache_file:s0 tclass=dir permissive=0 [ 5.942324] type=1400 audit(1420070544.292:6): avc: denied { search } for comm="init" name="/" dev="mmcblk0p3" ino=2 scontext=u:r:vendor_init:s0 tcontext=u:object_r:cache_file:s0 tclass=dir permissive=0 [ 5.942345] type=1400 audit(1420070544.292:7): avc: denied { setattr } for comm="init" name="btv_home" dev="mmcblk0p20" ino=12 scontext=u:r:vendor_init:s0 tcontext=u:object_r:system_data_file:s0 tclass=lnk_file permissive=0 [ 5.945549] type=1400 audit(1420070544.292:8): avc: denied { setattr } for comm="init" name="btv_home" dev="mmcblk0p20" ino=12 scontext=u:r:vendor_init:s0 tcontext=u:object_r:system_data_file:s0 tclass=lnk_file permissive=0 [ 6.048869] meson6-dwmac ff3f0000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx [ 6.048896] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 6.080518] [TEE] MESSAGE: USER-TA:log_msg:68: KeymasterTA (info): app/ipc/keymaster_ipc.cpp, Line 963: Amlogic KEYMASTER 4.0! Build Time: Mar 30 2020 19:30:40 version: 345f6a5 [ 6.353044] healthd: BatteryTemperaturePath not found [ 6.353056] healthd: BatteryCycleCountPath not found [ 6.364024] hdmitx: system: set hdcp_pwr 1 [ 6.380234] healthd: battery l=42 v=4 t=42.4 h=2 st=2 c=1 fc=10000000 chg=u [ 6.642483] fb: osd_open, 1507, fb_index=0,fb_rmem_size=26738688 [ 6.642639] fb: osd_open, 1507, fb_index=1,fb_rmem_size=1048576 [ 6.642676] fb: osd_open, 1507, fb_index=2,fb_rmem_size=1048576 [ 6.642804] fb: vpu clkc clock is 199 MHZ [ 6.642818] vpu: switch_vpu_mem_pd: unsupport vpu mod: 53 [ 6.642828] fb: osd_open, 1507, fb_index=3,fb_rmem_size=8388608 [ 6.642967] video_composer_open iminor(inode) =0 [ 6.657331] video_composer_open iminor(inode) =1 [ 6.658781] init: Could not find 'vendor.amlogic.hardware.systemcontrol@1.1::ISystemControl/default' for ctl.interface_start [ 6.659260] init: Could not find 'vendor.amlogic.hardware.systemcontrol@1.1::ISystemControl/default' for ctl.interface_start [ 6.673721] init: Could not find 'vendor.amlogic.hardware.hdmicec@1.0::IDroidHdmiCEC/default' for ctl.interface_start [ 6.678261] hdmitx: system: restore hdcp_pwr 0 [ 6.678360] amhdmitx amhdmitx0: hdmitx20: stop14 [ 6.680703] amhdmitx amhdmitx0: hdmitx20: stop22 [ 6.680949] init: Could not find 'vendor.amlogic.hardware.systemcontrol@1.0::ISystemControl/default' for ctl.interface_start [ 6.683700] hdmitx: system: sname = 2160p60hz [ 6.683708] hdmitx: system: char_clk = 594000 [ 6.683711] hdmitx: system: cd = 4 [ 6.683714] hdmitx: system: cs = 3 [ 6.683719] hdmitx: RX tmds clk: 600 Calc clk: 297 [ 6.683952] vout: vmode set to null [ 6.684098] fb: current vmode=1080p60hz, cmd: 0x10000 [ 6.684104] vlock: event MODE_CHANGE_PRE 0 [ 6.684153] vout: new mode null set ok [ 6.684157] fb: current vmode=null, cmd: 0x20000 [ 6.692332] vout: vmode set to 2160p60hz [ 6.692479] fb: current vmode=null, cmd: 0x10000 [ 6.692525] hdmitx: hdmitx_set_current_vmode[5008] [ 6.692529] hdmitx: system: recalc before 2160p60hz 60 1 [ 6.692533] hdmitx: system: recalc after 2160p60hz 2997 50 [ 6.692541] hdmitx: system: get current mode: 2160p60hz [ 6.692545] hdmitx: system: update physcial size: 630 330 [ 6.694621] hdmitx: video: already init VIC = 0 Now VIC = 353 [ 6.694630] hdmitx: hw: div40: 0 [ 6.698010] vfm_map_store:rm default [ 6.701073] vfm_map_store:add default decoder ppmgr deinterlace amvideo [ 6.724727] hdmitx: frac_rate = 1 [ 6.724737] hdmitx: config HPLL = 5940000 frac_rate = 1 [ 6.724796] hdmitx: HPLLv1: 0xdb3a04f7 [ 6.724799] hdmitx: config HPLL done [ 6.724806] hdmitx: set_hpll_od3_clk_div[643] div = 6 [ 6.724813] hdmitx: j = 10 vid_clk_div = 1 [ 6.724827] hdmitx: set enc for VIC: 353 [ 6.725117] file system registered [ 6.725744] init: Could not find 'com.skb.btvpropertyservice@1.0::IBtvPropertyService/default' for ctl.interface_start [ 6.745411] init: Could not find 'com.skb.btvpropertyservice@1.0::IBtvPropertyService/default' for ctl.interface_start [ 6.746460] init: Could not find 'com.skb.btvpropertyservice@1.0::IBtvPropertyService/default' for ctl.interface_start [ 6.747406] init: Could not find 'com.skb.btvpropertyservice@1.0::IBtvPropertyService/default' for ctl.interface_start [ 6.751046] assign_ffs_buffer FFS_BUFFER_MAX=100!!! [ 6.760782] cpufreq_interactive: cpufreq_hmp_boost_start() [ 6.760788] cpufreq_interactive: no need to active hmp boost! [ 6.776305] hdmitx: hw: config hdmitx IP vic = 353 cd:4 cs: 3 [ 6.807782] hdmitx: video: Sink is HDMI device [ 6.807821] hdmitx: hw: set audio [ 6.807829] hdmitx: hw: hdmitx tx_aud_src = 0 [ 6.807843] hdmitx: fs = 0, cd = 4, tmds_clk = 593407 [ 6.807847] hdmitx: hw: aud_n_para = 5824 [ 6.807857] hdmitx: hw: set channel status [ 6.807890] hdmitx: system: update rx hdr info 7 [ 6.807896] vout: new mode 2160p60hz set ok [ 6.807902] fb: current vmode=2160p60hz, cmd: 0x20000 [ 6.807912] fb: outputmode changed to 2160p60hz, reset osd0, (0, 0, 1919, 1079) -> (0, 0, 3839, 2159) [ 6.808456] hdmitx: system: irq 80000001 0 [ 6.810381] init: Could not find 'vendor.amlogic.hardware.systemcontrol@1.1::ISystemControl/default' for ctl.interface_start [ 6.821823] selinux: avc: denied { set } for property=persist.sys.timezone pid=2631 uid=0 gid=0 scontext=u:r:vendor_init:s0 tcontext=u:object_r:exported_system_prop:s0 tclass=property_service permissive=0\x0a [ 6.824944] fb: osd[0] enable: 1 (systemcontrol) [ 6.843280] DOLBY: vout_notify_callback: VOUT_EVENT_MODE_CHANGE [ 6.843287] vlock: event MODE_CHANGE [ 6.886410] amlogic-new-usb3-v2 ffe09080.usb3phy: set to host mode [ 6.893265] hdmitx: system: set hdcp_pwr 1 [ 6.897308] hdmitx: hdmitx: set cedst_policy as 0 [ 6.898138] vout: vout_io_open [ 6.908548] hdmitx: [0x10000103]: 0x00000008 [ 6.908555] hdmitx: [0x10000104]: 0x00000001 [ 6.908561] hdmitx: [0x10000170]: 0x00000010 [ 6.908564] hdmitx: [0x10000180]: 0x000000ff [ 6.908568] hdmitx: [0x10000181]: 0x000000ff [ 6.908572] hdmitx: [0x10000182]: 0x00000003 [ 6.908576] hdmitx: [0x10000183]: 0x00000007 [ 6.908580] hdmitx: [0x10000184]: 0x0000003f [ 6.908583] hdmitx: [0x10000185]: 0x00000002 [ 6.908588] hdmitx: [0x10000187]: 0x000000ff [ 6.908591] hdmitx: [0x10000188]: 0x00000003 [ 6.967849] dim:load 0x3a00 pq table len 246 later. [ 7.059139] \x0a[amvideo..] saturation_post:0 hue_post:0 mab:1000000 [ 7.080062] read descriptors [ 7.080077] read strings [ 7.104524] [TEE] the package has 88 fws totally. [ 7.104529] [TEE] the fw pack ver v0.2 is too lower. [ 7.104531] [TEE] it may work abnormally so need to be update in time. [ 7.104532] [TEE] the fw with 488 KB will be loaded. [ 7.142488] hdmitx: system: restore hdcp_pwr 0 [ 7.142567] amhdmitx amhdmitx0: hdmitx20: stop14 [ 7.144743] amhdmitx amhdmitx0: hdmitx20: stop22 [ 7.148892] hdmitx: system: hdcp: set mode as 2 [ 7.222580] dim:load 0x3a00 pq table len 246 later. [ 7.222608] dim:remove 0x3a00 table. [ 7.282546] vout: vout_io_open [ 7.282557] vout: vout_ioctl: cmd_dir = 0x2, cmd_nr = 0x0 [ 7.282565] vout: vout_io_release [ 7.287454] vout: vout_io_open [ 7.287466] vout: vout_ioctl: cmd_dir = 0x2, cmd_nr = 0x0 [ 7.287473] vout: vout_io_release [ 7.292680] vout: vout_io_open [ 7.292693] vout: vout_ioctl: cmd_dir = 0x2, cmd_nr = 0x0 [ 7.292759] vout: vout_io_release [ 7.341293] \x0a[amvideo..] saturation_post:0 hue_post:0 mab:1000000 [ 7.637040] the esm code address is 00000000d2719aae [ 7.640033] the esm data address is 0000000066fc23da [ 7.640151] info.hpi_base = 0xffe01000 region_name:ESM-FFE01000 [ 7.640191] esm data = 0000000066fc23da size:131072 [ 7.643948] hdmitx: system: irq 80000008 0 [ 7.643959] hdmitx: hw: hdcp22: Nonce HW Vld: 1 [ 7.763627] selinux: SELinux: Could not set context for /sys/devices/virtual/net/ipsec_test/statistics/rx_compressed: No such file or directory\x0a [ 7.763895] selinux: SELinux: Could not set context for /sys/devices/virtual/net/ipsec_test/statistics/rx_fifo_errors: No such file or directory\x0a [ 7.764067] selinux: SELinux: Could not set context for /sys/devices/virtual/net/ipsec_test/statistics/tx_bytes: No such file or directory\x0a [ 7.768449] selinux: SELinux: Could not set context for /sys/devices/virtual/net/ipsec_test/statistics/rx_over_errors: No such file or directory\x0a [ 7.768763] selinux: SELinux: Could not set context for /sys/devices/virtual/net/ipsec_test/statistics/rx_length_errors: No such file or directory\x0a [ 7.768966] selinux: SELinux: Could not set context for /sys/devices/virtual/net/ipsec_test/statistics/rx_dropped: No such file or directory\x0a [ 7.769139] selinux: SELinux: Could not set context for /sys/devices/virtual/net/ipsec_test/statistics/rx_errors: No such file or directory\x0a [ 7.772157] selinux: SELinux: Could not set context for /sys/devices/virtual/net/ipsec_test/statistics/multicast: No such file or directory\x0a [ 7.772358] selinux: SELinux: Could not set context for /sys/devices/virtual/net/ipsec_test/statistics/tx_window_errors: No such file or directory\x0a [ 7.772560] selinux: SELinux: Could not set context for /sys/devices/virtual/net/ipsec_test/statistics/rx_packets: No such file or directory\x0a [ 8.028660] avc open [ 8.028669] amvenc_avc check CMA pool success, max instance: 3. [ 8.030102] allocating phys 0x56000000, size 20480k, wq:00000000e38d1500. [ 8.030112] amvenc_avc memory config success, buff start:0x56000000, size is 0x1400000, wq:00000000e38d1500. [ 8.030237] avc release, wq:00000000e38d1500 [ 8.030244] remove encode_work_queue 00000000e38d1500 success, _destroy_encode_work_queue line 3772. [ 8.031448] [+] vpu_open [ 8.033844] allocating phys 0x56000000, virt addr 0x0, size 65536k [ 8.034093] the vdec clock on, ref cnt: 1 [ 8.034128] [-] vpu_open, ret: 0 [ 8.034164] vpu_release [ 8.034168] vpu_free_buffers [ 8.034172] vpu_free_instances [ 8.034175] vpu_release, s_video_memory 0x56000000 [ 8.037170] the vdec clock off, ref cnt: 0 [ 8.128536] [TEE] [HDCP-TA] hdcp_load_key: read hdcp key(hdcp_tx22.bin) ret = 0xFFFF0008 [ 8.128541] [TEE] [HDCP-TA] hdcp_load_key: read hdcp key(hdcp_tx14.bin) ret = 0xFFFF0008 [ 8.128543] [TEE] [HDCP-TA] hdcp_load_key: read hdcp key(hdcp_rx14.bin) ret = 0xFFFF0008 [ 8.128545] [TEE] [HDCP-TA] hdcp_load_key: read hdcp key(hdcp_rx22_fw_priv.bin) ret = 0xFFFF0008 [ 8.128547] [TEE] [HDCP-TA] cmd_hdcp_read_key: hdcp_read_key(hdcp_rx22_fw.bin) failed, ret = 0xffff0008 [ 8.541799] loopback_dai_startup [ 8.543274] audio_ddr_mngr: toddrs[0] registered by device ff642000.audiobus:loopback@0 [ 8.544002] loopback_dai_shutdown [ 8.544314] audio_ddr_mngr: toddrs[0] released by device ff642000.audiobus:loopback@0 [ 8.545340] aml_spdif_open [ 8.546643] audio_ddr_mngr: toddrs[0] registered by device ff642000.audiobus:spdif [ 8.549320] aml_spdif_close [ 8.549490] audio_ddr_mngr: toddrs[0] released by device ff642000.audiobus:spdif [ 8.551098] audio_ddr_mngr: toddrs[0] registered by device ff642000.audiobus:pdm [ 8.551521] audio_ddr_mngr: toddrs[0] released by device ff642000.audiobus:pdm [ 8.552068] aml_tdm_open [ 8.552300] audio_ddr_mngr: toddrs[0] registered by device ff642000.audiobus:tdmc [ 8.552891] tdm capture mute: 1 [ 8.553014] audio_ddr_mngr: toddrs[0] released by device ff642000.audiobus:tdmc [ 8.553653] aml_tdm_open [ 8.554038] audio_ddr_mngr: toddrs[0] registered by device ff642000.audiobus:tdmb [ 8.554342] tdm capture mute: 1 [ 8.554439] audio_ddr_mngr: toddrs[0] released by device ff642000.audiobus:tdmb [ 8.554773] aml_tdm_open [ 8.554931] audio_ddr_mngr: toddrs[0] registered by device ff642000.audiobus:tdma [ 8.555219] tdm capture mute: 1 [ 8.555332] audio_ddr_mngr: toddrs[0] released by device ff642000.audiobus:tdma [ 8.605704] aml_tdm_open [ 8.605711] Not init audio effects [ 8.605893] audio_ddr_mngr: frddrs[0] registered by device ff642000.audiobus:tdmb [ 8.605964] adc3101_set_dai_sysclk freq:12288000 [ 8.605969] aml_dai_set_tdm_sysclk(), mpll no change, keep clk [ 8.605973] aml_dai_set_tdm_sysclk(), mclk no change, keep clk [ 8.605978] set mclk:12288000, mpll:24576000, get mclk:12287994, mpll:24575987 [ 8.605985] asoc aml_dai_set_tdm_fmt, 0x4001, 00000000c06bac4c, id(1), clksel(1) [ 8.605989] aml_dai_set_tdm_fmt(), fmt not change [ 8.605994] adc3101_hw_params ... [ 8.613848] adc3101_hw_params NADC = 0x81 [ 8.616560] adc3101_hw_params MADC = 0x82 [ 8.618264] adc3101_hw_params AOSR=80 [ 8.619985] adc3101_hw_params iface1 = 00 [ 8.621168] adc3101_hw_params differential pair [ 8.628800] adc3101_hw_params ADCSETUP = c2 [ 8.629714] adc3101_hw_params DOUTCTL=12 [ 8.630982] adc3101_hw_params MICBIAS=50 [ 8.630995] dump_pcm_setting(00000000c06bac4c) [ 8.630999] \x09pcm_mode(1) [ 8.631002] \x09sysclk(12288000) [ 8.631006] \x09sysclk_bclk_ratio(4) [ 8.631009] \x09bclk(3072000) [ 8.631012] \x09bclk_lrclk_ratio(64) [ 8.631015] \x09lrclk(48000) [ 8.631018] \x09tx_mask(0x3) [ 8.631021] \x09rx_mask(0x3) [ 8.631024] \x09slots(2) [ 8.631028] \x09slot_width(32) [ 8.631031] \x09lane_mask_in(0x4) [ 8.631034] \x09lane_mask_out(0x1) [ 8.631037] \x09lane_oe_mask_in(0x0) [ 8.631040] \x09lane_oe_mask_out(0x0) [ 8.631043] \x09lane_lb_mask_in(0x0) [ 8.631047] aml_dai_set_tdm_sysclk(), mpll no change, keep clk [ 8.631051] aml_dai_set_tdm_sysclk(), mclk no change, keep clk [ 8.631056] set mclk:12288000, mpll:24576000, get mclk:12287994, mpll:24575987 [ 8.631060] aml_dai_set_clkdiv, div 4, clksel(1) [ 8.631069] aml_dai_set_bclk_ratio, select I2S mode [ 8.631079] aml_dai_tdm_hw_params(), enable mclk for TDM-B [ 8.642278] spdif_a fifo ctrl, frddr:0 type:1, 16 bits, chmask 0x3, swap 0x10 [ 8.642291] spdif_info: rate: 48000, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x200, ch1_r:0x200 [ 8.642299] hdmitx: audio: aout notify format CT_PCM [ 8.642304] hdmitx: hw: set audio [ 8.642307] hdmitx: hw: hdmitx tx_aud_src = 0 [ 8.642323] hdmitx: fs = 3, cd = 4, tmds_clk = 593407 [ 8.642327] hdmitx: hw: aud_n_para = 5824 [ 8.642337] hdmitx: hw: set channel status [ 8.642369] hdmitx: audio: Audio Type: PCM [ 8.642373] hdmitx: audio: set audio param [ 8.642378] audio_ddr_mngr: frddr_set_sharebuffer_enable sel:1, dst_src:3 [ 8.656967] tdm playback mute: 0, lane_cnt = 4 [ 8.666252] asoc-aml-card auge_sound: tdm playback enable [ 8.666263] spdif_a is set to enable [ 9.097255] hdmitx: hdcptx: 2 auth: 1 [ 9.104593] hdmitx: store_avmute -1 [ 9.104602] hdmitx: hw: avmute set to 1 [ 9.342294] hdmitx: hdmitx: set hdcp22 content type 1 [ 9.971475] fb: osd[0] enable: 1 scale:0x10001 (composer@2.3-se) [ 9.971482] fb: osd[0] enable: 1 scale:0x10001 (composer@2.3-se) [ 9.978069] fb: free_scale_switch to fb0, mode: 0x10001 [ 9.978109] fb: set logo loaded [ 10.627749] early_suspend_state=0 [ 11.010647] apexd: Can't open /product/apex for reading : No such file or directory [ 22.702184] the demux clock on, ref cnt: 1 [ 22.702193] the parser_top clock on, ref cnt: 1 [ 22.702199] the vdec clock on, ref cnt: 1 [ 22.702222] the clk_hevc_mux clock on, ref cnt: 1 [ 22.702227] the clk_hevcb_mux clock on, ref cnt: 1 [ 22.702296] hevc mux clock is 499999992 Hz [ 22.702327] hevc back mux clock is 499999992 Hz [ 22.702409] vdec_create instance 00000000b277acd8, total 1 [ 22.702433] vdec_disable_DMC input->target= 0x0 [ 22.702438] vdec_release instance 00000000b277acd8, total 1 [ 22.702463] the clk_hevc_mux clock off, ref cnt: 0 [ 22.702468] the clk_hevcb_mux clock off, ref cnt: 0 [ 22.702474] the vdec clock off, ref cnt: 0 [ 22.702479] the parser_top clock off, ref cnt: 0 [ 22.702484] the demux clock off, ref cnt: 0 [ 22.702575] the demux clock on, ref cnt: 1 [ 22.702580] the parser_top clock on, ref cnt: 1 [ 22.702585] the vdec clock on, ref cnt: 1 [ 22.702603] the clk_vdec_mux clock on, ref cnt: 1 [ 22.702647] vdec mux clock is 499999992 Hz [ 22.702705] vdec_create instance 0000000080e2f0f1, total 1 [ 22.702724] vdec_disable_DMC input->target= 0x0 [ 22.702729] vdec_release instance 0000000080e2f0f1, total 1 [ 22.702752] the clk_vdec_mux clock off, ref cnt: 0 [ 22.702758] the vdec clock off, ref cnt: 0 [ 22.702763] the parser_top clock off, ref cnt: 0 [ 22.702768] the demux clock off, ref cnt: 0 [ 22.715453] the demux clock on, ref cnt: 1 [ 22.715463] the parser_top clock on, ref cnt: 1 [ 22.715469] the vdec clock on, ref cnt: 1 [ 22.715490] the clk_hevc_mux clock on, ref cnt: 1 [ 22.715495] the clk_hevcb_mux clock on, ref cnt: 1 [ 22.715566] hevc mux clock is 499999992 Hz [ 22.715595] hevc back mux clock is 499999992 Hz [ 22.715682] vdec_create instance 00000000c1610fed, total 1 [ 22.715705] vdec_disable_DMC input->target= 0x0 [ 22.715711] vdec_release instance 00000000c1610fed, total 1 [ 22.715737] the clk_hevc_mux clock off, ref cnt: 0 [ 22.715743] the clk_hevcb_mux clock off, ref cnt: 0 [ 22.715749] the vdec clock off, ref cnt: 0 [ 22.715754] the parser_top clock off, ref cnt: 0 [ 22.715758] the demux clock off, ref cnt: 0 [ 22.715853] the demux clock on, ref cnt: 1 [ 22.715858] the parser_top clock on, ref cnt: 1 [ 22.715863] the vdec clock on, ref cnt: 1 [ 22.715880] the clk_vdec_mux clock on, ref cnt: 1 [ 22.715931] vdec mux clock is 499999992 Hz [ 22.715992] vdec_create instance 00000000d6988b82, total 1 [ 22.716011] vdec_disable_DMC input->target= 0x0 [ 22.716016] vdec_release instance 00000000d6988b82, total 1 [ 22.716040] the clk_vdec_mux clock off, ref cnt: 0 [ 22.716046] the vdec clock off, ref cnt: 0 [ 22.716051] the parser_top clock off, ref cnt: 0 [ 22.716055] the demux clock off, ref cnt: 0 [ 22.804285] the demux clock on, ref cnt: 1 [ 22.804294] the parser_top clock on, ref cnt: 1 [ 22.804299] the vdec clock on, ref cnt: 1 [ 22.804320] the clk_hevc_mux clock on, ref cnt: 1 [ 22.804325] the clk_hevcb_mux clock on, ref cnt: 1 [ 22.804355] hevc mux clock is 499999992 Hz [ 22.804369] hevc back mux clock is 499999992 Hz [ 22.804441] vdec_create instance 000000003adeddad, total 1 [ 22.804458] vdec_disable_DMC input->target= 0x0 [ 22.804463] vdec_release instance 000000003adeddad, total 1 [ 22.804544] the clk_hevc_mux clock off, ref cnt: 0 [ 22.804551] the clk_hevcb_mux clock off, ref cnt: 0 [ 22.804562] the vdec clock off, ref cnt: 0 [ 22.804570] the parser_top clock off, ref cnt: 0 [ 22.804577] the demux clock off, ref cnt: 0 [ 22.804657] the demux clock on, ref cnt: 1 [ 22.804662] the parser_top clock on, ref cnt: 1 [ 22.804667] the vdec clock on, ref cnt: 1 [ 22.804683] the clk_vdec_mux clock on, ref cnt: 1 [ 22.804704] vdec mux clock is 499999992 Hz [ 22.804761] vdec_create instance 000000002a0b3cf8, total 1 [ 22.804775] vdec_disable_DMC input->target= 0x0 [ 22.804779] vdec_release instance 000000002a0b3cf8, total 1 [ 22.804800] the clk_vdec_mux clock off, ref cnt: 0 [ 22.804808] the vdec clock off, ref cnt: 0 [ 22.804815] the parser_top clock off, ref cnt: 0 [ 22.804822] the demux clock off, ref cnt: 0 [ 22.840924] the demux clock on, ref cnt: 1 [ 22.840934] the parser_top clock on, ref cnt: 1 [ 22.840939] the vdec clock on, ref cnt: 1 [ 22.840961] the clk_hevc_mux clock on, ref cnt: 1 [ 22.840966] the clk_hevcb_mux clock on, ref cnt: 1 [ 22.840999] hevc mux clock is 499999992 Hz [ 22.841014] hevc back mux clock is 499999992 Hz [ 22.841094] vdec_create instance 00000000cfc5e58a, total 1 [ 22.841117] vdec_disable_DMC input->target= 0x0 [ 22.841122] vdec_release instance 00000000cfc5e58a, total 1 [ 22.841150] the clk_hevc_mux clock off, ref cnt: 0 [ 22.841155] the clk_hevcb_mux clock off, ref cnt: 0 [ 22.841161] the vdec clock off, ref cnt: 0 [ 22.841166] the parser_top clock off, ref cnt: 0 [ 22.841171] the demux clock off, ref cnt: 0 [ 22.841258] the demux clock on, ref cnt: 1 [ 22.841264] the parser_top clock on, ref cnt: 1 [ 22.841269] the vdec clock on, ref cnt: 1 [ 22.841285] the clk_vdec_mux clock on, ref cnt: 1 [ 22.841308] vdec mux clock is 499999992 Hz [ 22.841366] vdec_create instance 00000000799e309a, total 1 [ 22.841383] vdec_disable_DMC input->target= 0x0 [ 22.841387] vdec_release instance 00000000799e309a, total 1 [ 22.841409] the clk_vdec_mux clock off, ref cnt: 0 [ 22.841415] the vdec clock off, ref cnt: 0 [ 22.841420] the parser_top clock off, ref cnt: 0 [ 22.841425] the demux clock off, ref cnt: 0 [ 22.861578] the demux clock on, ref cnt: 1 [ 22.861588] the parser_top clock on, ref cnt: 1 [ 22.861594] the vdec clock on, ref cnt: 1 [ 22.861615] the clk_hevc_mux clock on, ref cnt: 1 [ 22.861620] the clk_hevcb_mux clock on, ref cnt: 1 [ 22.861650] hevc mux clock is 499999992 Hz [ 22.861666] hevc back mux clock is 499999992 Hz [ 22.861739] vdec_create instance 00000000f2c44d9f, total 1 [ 22.861757] vdec_disable_DMC input->target= 0x0 [ 22.861762] vdec_release instance 00000000f2c44d9f, total 1 [ 22.861786] the clk_hevc_mux clock off, ref cnt: 0 [ 22.861792] the clk_hevcb_mux clock off, ref cnt: 0 [ 22.861798] the vdec clock off, ref cnt: 0 [ 22.861803] the parser_top clock off, ref cnt: 0 [ 22.861807] the demux clock off, ref cnt: 0 [ 22.861869] the demux clock on, ref cnt: 1 [ 22.861874] the parser_top clock on, ref cnt: 1 [ 22.861879] the vdec clock on, ref cnt: 1 [ 22.861896] the clk_vdec_mux clock on, ref cnt: 1 [ 22.861915] vdec mux clock is 499999992 Hz [ 22.861980] vdec_create instance 000000001fa2338b, total 1 [ 22.861994] vdec_disable_DMC input->target= 0x0 [ 22.861998] vdec_release instance 000000001fa2338b, total 1 [ 22.862018] the clk_vdec_mux clock off, ref cnt: 0 [ 22.862023] the vdec clock off, ref cnt: 0 [ 22.862028] the parser_top clock off, ref cnt: 0 [ 22.862032] the demux clock off, ref cnt: 0 [ 22.867604] the demux clock on, ref cnt: 1 [ 22.867614] the parser_top clock on, ref cnt: 1 [ 22.867619] the vdec clock on, ref cnt: 1 [ 22.867641] the clk_hevc_mux clock on, ref cnt: 1 [ 22.867646] the clk_hevcb_mux clock on, ref cnt: 1 [ 22.867674] hevc mux clock is 499999992 Hz [ 22.867690] hevc back mux clock is 499999992 Hz [ 22.867775] vdec_create instance 00000000111228d9, total 1 [ 22.867796] vdec_disable_DMC input->target= 0x0 [ 22.867801] vdec_release instance 00000000111228d9, total 1 [ 22.867827] the clk_hevc_mux clock off, ref cnt: 0 [ 22.867832] the clk_hevcb_mux clock off, ref cnt: 0 [ 22.867838] the vdec clock off, ref cnt: 0 [ 22.867843] the parser_top clock off, ref cnt: 0 [ 22.867848] the demux clock off, ref cnt: 0 [ 22.867931] the demux clock on, ref cnt: 1 [ 22.867937] the parser_top clock on, ref cnt: 1 [ 22.867942] the vdec clock on, ref cnt: 1 [ 22.867959] the clk_vdec_mux clock on, ref cnt: 1 [ 22.867982] vdec mux clock is 499999992 Hz [ 22.868038] vdec_create instance 000000003ec01c63, total 1 [ 22.868055] vdec_disable_DMC input->target= 0x0 [ 22.868059] vdec_release instance 000000003ec01c63, total 1 [ 22.868082] the clk_vdec_mux clock off, ref cnt: 0 [ 22.868088] the vdec clock off, ref cnt: 0 [ 22.868093] the parser_top clock off, ref cnt: 0 [ 22.868098] the demux clock off, ref cnt: 0 [ 23.305627] type=1400 audit(1420070547.396:505): avc: denied { sys_module } for comm="com.skb.btvserv" capability=16 scontext=u:r:btvservice_hal:s0 tcontext=u:r:btvservice_hal:s0 tclass=capability permissive=0 [ 23.305663] type=1400 audit(1614935348.220:506): avc: denied { getattr } for comm="webview_zygote" path="/data/data/com.google.android.webview" dev="mmcblk0p20" ino=129289 scontext=u:r:webview_zygote:s0 tcontext=u:object_r:app_data_file:s0:c38,c256,c512,c768 tclass=dir permissive=0 [ 23.488520] [TEE] Playready TA Start [ 23.488526] [TEE] Playready TA Exit! [ 23.488527] [TEE] Playready TA_DestroyEntryPoint! [ 23.999881] BT_RADIO going: on [ 23.999888] AML_BT: going ON [ 24.358384] input: virtual-search as /devices/virtual/input/input4 [ 24.408429] aml_audio_set_spdif_mute(), no pinctrl [ 24.413158] meson_uart ffd24000.serial: ttyS1 use xtal(24M) 24000000 change 0 to 9600 [ 24.413356] meson_uart ffd24000.serial: ttyS1 use xtal(24M) 24000000 change 9600 to 9600 [ 24.413388] meson_uart ffd24000.serial: ttyS1 use xtal(24M) 24000000 change 9600 to 115200 [ 24.422271] meson_uart ffd24000.serial: ttyS1 use xtal(24M) 24000000 change 115200 to 2000000 [ 24.426246] asoc-aml-card auge_sound: tdm playback stop [ 24.426262] spdif_a is set to disable [ 24.426292] audio_ddr_mngr: i: 0, fifo cnt:[56] cnt1:[56] cnt2:[56] [ 24.426297] audio_ddr_mngr: aml_frddr_burst_finished(), i (0) cnt(56) break out [ 24.426354] spdif_a fifo ctrl, frddr:0 type:1, 16 bits, chmask 0x3, swap 0x10 [ 24.426362] spdif_info: rate: 48000, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x200, ch1_r:0x200 [ 24.426371] audio_ddr_mngr: frddr_set_sharebuffer_enable sel:1, dst_src:3 [ 24.428318] tdm playback mute: 0, lane_cnt = 4 [ 24.428443] aml_audio_set_spdif_mute(), no pinctrl [ 24.450258] asoc-aml-card auge_sound: tdm playback enable [ 24.450269] spdif_a is set to enable [ 24.474265] asoc-aml-card auge_sound: tdm playback stop [ 24.474281] spdif_a is set to disable [ 24.474310] audio_ddr_mngr: i: 0, fifo cnt:[55] cnt1:[55] cnt2:[55] [ 24.474315] audio_ddr_mngr: aml_frddr_burst_finished(), i (0) cnt(55) break out [ 24.474405] spdif_a fifo ctrl, frddr:0 type:1, 16 bits, chmask 0x3, swap 0x10 [ 24.474414] spdif_info: rate: 48000, channel status ch0_l:0x100, ch0_r:0x100, ch1_l:0x200, ch1_r:0x200 [ 24.474424] audio_ddr_mngr: frddr_set_sharebuffer_enable sel:1, dst_src:3 [ 24.476366] tdm playback mute: 0, lane_cnt = 4 [ 24.498255] asoc-aml-card auge_sound: tdm playback enable [ 24.498266] spdif_a is set to enable [ 24.512527] [TEE] MESSAGE: USER-TA:log_msg:68: KeymasterTA (err): keymaster/key_blob_utils/ocb_utils.cpp, Line 186: Failed to validate authentication tag during key decryption [ 24.512535] [TEE] MESSAGE: USER-TA:log_msg:68: KeymasterTA (err): keymaster/key_blob_utils/ocb_utils.cpp, Line 186: Failed to validate authentication tag during key decryption [ 24.708887] meson_uart ffd24000.serial: ttyS1 use xtal(24M) 24000000 change 2000000 to 115200 [ 24.790411] type=1400 audit(1614935348.224:509): avc: denied { getattr } for comm="webview_zygote" path="/data/data/com.google.android.webview" dev="mmcblk0p20" ino=129289 scontext=u:r:webview_zygote:s0 tcontext=u:object_r:app_data_file:s0:c38,c256,c512,c768 tclass=dir permissive=0 duplicate messages suppressed [ 24.790464] type=1400 audit(1614939837.000:510): avc: denied { dac_override } for comm="skb_rdate" capability=1 scontext=u:r:skb_rdate:s0 tcontext=u:r:skb_rdate:s0 tclass=capability permissive=0 [ 24.918214] meson_uart ffd24000.serial: ttyS1 use xtal(24M) 24000000 change 115200 to 2000000 [ 30.033424] zram0: detected capacity change from 0 to 268435456 [ 30.058817] sdcardfs version 2.0 [ 30.058826] sdcardfs: dev_name -> /data/media [ 30.058831] sdcardfs: options -> fsuid=1023,fsgid=1023,multiuser,derive_gid,default_normal,unshared_obb,mask=6,userid=0,gid=1015 [ 30.058837] sdcardfs: mnt -> 00000000d0ca5ccb [ 30.058910] sdcardfs: mounted on top of /data/media type ext4 [ 30.060641] Remount options were mask=23,gid=9997 for vfsmnt 000000008c6b047a. [ 30.060655] sdcardfs : options - debug:1 [ 30.060659] sdcardfs : options - gid:9997 [ 30.060663] sdcardfs : options - mask:23 [ 30.061802] Remount options were mask=7,gid=9997 for vfsmnt 0000000059fab690. [ 30.061811] sdcardfs : options - debug:1 [ 30.061816] sdcardfs : options - gid:9997 [ 30.061820] sdcardfs : options - mask:7 [ 30.062937] Remount options were mask=7,gid=9997 for vfsmnt 0000000064726d82. [ 30.062945] sdcardfs : options - debug:1 [ 30.062949] sdcardfs : options - gid:9997 [ 30.062953] sdcardfs : options - mask:7 [ 30.067599] mkswap: Swapspace size: 262140k, UUID=5f9de9a4-5bca-4827-8904-9ccf569b9586 [ 30.069067] Adding 262140k swap on /dev/block/zram0. Priority:-1 extents:1 across:262140k SS [ 30.263443] zram: Cannot change disksize for initialized device [ 30.289874] mkswap: Swapspace size: 262140k, UUID=c91a3c78-92cb-4d9d-a155-0f5fe2ef7f3b [ 30.290892] init: [libfs_mgr]swapon failed for /dev/block/zram0 [ 30.296408] android_work: did not send uevent (0 0 (null)) [ 30.432395] read descriptors [ 30.432408] read strings [ 30.449388] selinux: SELinux: Skipping restorecon on directory(/data/system_ce/0)\x0a [ 30.458014] selinux: SELinux: Skipping restorecon on directory(/data/vendor_ce/0)\x0a [ 30.466411] selinux: SELinux: Skipping restorecon on directory(/data/misc_ce/0)\x0a [ 31.470718] audio_dsp: dts_dec_control/0x0 [ 31.584239] type=1400 audit(1614939837.000:510): avc: denied { dac_override } for comm="skb_rdate" capability=1 scontext=u:r:skb_rdate:s0 tcontext=u:r:skb_rdate:s0 tclass=capability permissive=0 [ 31.584276] type=1400 audit(1614939843.772:511): avc: denied { read } for comm="HwBinder:3455_2" name="u:object_r:system_prop:s0" dev="tmpfs" ino=12136 scontext=u:r:system_control:s0 tcontext=u:object_r:system_prop:s0 tclass=file permissive=0 [ 31.598160] type=1400 audit(1614939843.772:511): avc: denied { read } for comm="HwBinder:3455_2" name="u:object_r:system_prop:s0" dev="tmpfs" ino=12136 scontext=u:r:system_control:s0 tcontext=u:object_r:system_prop:s0 tclass=file permissive=0 [ 31.598193] type=1400 audit(1614939843.772:512): avc: denied { execute } for comm="SubTitleService" path="/vendor/framework/oat/arm/droidlogic.odex" dev="dm-1" ino=434 scontext=u:r:system_app:s0 tcontext=u:object_r:vendor_framework_file:s0 tclass=file permissive=0 [ 31.617583] logd: logdr: UID=0 GID=1000 PID=4802 b tail=0 logMask=19 pid=0 start=0ns timeout=0ns [ 34.293495] init: cannot execve('/system/bin/settings'): Permission denied [ 34.307409] \x0a[amvideo..] saturation_post:0 hue_post:0 mab:1000000 [ 34.321321] \x0a[amvideo..] saturation_post:0 hue_post:0 mab:1000000 [ 37.334456] audit: audit_lost=1 audit_rate_limit=5 audit_backlog_limit=64 [ 37.334462] audit: rate limit exceeded [ 37.375805] init: cannot execve('/system/bin/settings'): Permission denied [ 37.768666] type=1400 audit(1614939843.776:513): avc: denied { execute } for comm="SubTitleService" path="/vendor/framework/oat/arm/droidlogic.odex" dev="dm-1" ino=434 scontext=u:r:system_app:s0 tcontext=u:object_r:vendor_framework_file:s0 tclass=file permissive=0 [ 37.768697] type=1400 audit(1614939846.500:514): avc: denied { entrypoint } for comm="init" path="/system/bin/settings" dev="dm-2" ino=779 scontext=u:r:shell:s0 tcontext=u:object_r:system_file:s0 tclass=file permissive=0 [ 37.768933] type=1400 audit(1614939846.500:514): avc: denied { entrypoint } for comm="init" path="/system/bin/settings" dev="dm-2" ino=779 scontext=u:r:shell:s0 tcontext=u:object_r:system_file:s0 tclass=file permissive=0 [ 37.768960] type=1400 audit(1614939846.640:515): avc: denied { read } for comm="HwBinder:3522_3" name="u:object_r:shell_prop:s0" dev="tmpfs" ino=12133 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:shell_prop:s0 tclass=file permissive=0 [ 37.782244] type=1400 audit(1614939846.640:515): avc: denied { read } for comm="HwBinder:3522_3" name="u:object_r:shell_prop:s0" dev="tmpfs" ino=12133 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:shell_prop:s0 tclass=file permissive=0 [ 37.782276] type=1400 audit(1614939846.704:516): avc: denied { search } for comm="ScionFrontendAp" name="com.google.android.gms" dev="mmcblk0p20" ino=129341 scontext=u:r:skbframework_app:s0 tcontext=u:object_r:privapp_data_file:s0:c512,c768 tclass=dir permissive=0 [ 37.782699] type=1400 audit(1614939846.704:517): avc: denied { search } for comm="ScionFrontendAp" name="com.google.android.gms" dev="mmcblk0p20" ino=129341 scontext=u:r:skbframework_app:s0 tcontext=u:object_r:privapp_data_file:s0:c512,c768 tclass=dir permissive=0 [ 37.782730] type=1400 audit(1614939846.844:518): avc: denied { write } for comm="ScionFrontendAp" name="com.google.android.gms-iybsB9YpvPjiMKGgHlsLhw==" dev="mmcblk0p20" ino=2240 scontext=u:r:skbframework_app:s0 tcontext=u:object_r:apk_data_file:s0 tclass=dir permissive=0 [ 37.782839] type=1400 audit(1614939846.844:518): avc: denied { write } for comm="ScionFrontendAp" name="com.google.android.gms-iybsB9YpvPjiMKGgHlsLhw==" dev="mmcblk0p20" ino=2240 scontext=u:r:skbframework_app:s0 tcontext=u:object_r:apk_data_file:s0 tclass=dir permissive=0 [ 37.782880] type=1400 audit(1614939846.852:519): avc: denied { read } for comm="HwBinder:3522_3" name="u:object_r:shell_prop:s0" dev="tmpfs" ino=12133 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:shell_prop:s0 tclass=file permissive=0 [ 38.037040] nf_conntrack: default automatic helper assignment has been turned off for security reasons and CT-based firewall rule not found. Use the iptables CT target to attach helpers instead. [ 38.563874] audit: audit_lost=7 audit_rate_limit=5 audit_backlog_limit=64 [ 38.563882] audit: rate limit exceeded [ 41.162596] vc:[0]vc: set enable index=0, val=1 [ 41.162615] dev->index =0, val=2 [ 41.162620] VID: VD1 off [ 41.162627] VID: VD1 set global output as 1 [ 41.162648] VID: store VD0 path_id changed -1->2 [ 41.497995] v4lvid: dbg: v4lvideo open [ 41.498007] v4lvideo:[0]open [ 41.498402] [store_mode]tsync_mode=1, buf=1 [ 41.498530] the demux clock on, ref cnt: 1 [ 41.498537] the parser_top clock on, ref cnt: 1 [ 41.498542] the vdec clock on, ref cnt: 1 [ 41.498563] the clk_vdec_mux clock on, ref cnt: 1 [ 41.498593] vdec mux clock is 499999992 Hz [ 41.498657] vdec_create instance 0000000075b900de, total 1 [ 41.498742] no drmmode [ 41.498842] vdec_init, dev_name:ammvdec_h264, vdec_type=VDEC_TYPE_FRAME_BLOCK [ 41.499736] ammvdec_h264_mmu_init tvp = 0x0 mmu_enable 0 [ 41.499744] decoder_bmmu_box_alloc_box, tvp_flags = 0 [ 41.499755] 0: ammvdec_h264_probe mmu_enable 0 double_write_mode 0x0 [ 41.506488] 0: ammvdec_h264 mem-addr=0,buff_offset=55010000,buf_start=56000000 [ 41.506535] vdec mux clock is 666666656 Hz [ 41.506540] vdec1 video changed to 3840 x 2160 60 fps clk->667MHZ [ 41.506545] H264 sysinfo: 1920x1080 duration=4000, pts_outside=0 [ 41.506549] sync_outside=0, use_idr_framerate=0, is_used_v4l: 0 [ 41.506610] [TEE], the fw (h264_multi) will be loaded. [ 41.507334] vh264_init, phy_addr=b7064000 vaddr=000000000a9fba43 [ 41.507441] == vdec urgent clear ! [ 41.507458] vfm map vdec-map-0 created [ 41.507475] dim:ch[1]:di_receiver_event_fun,8:_REG [ 41.507479] dim:reg:vdec.h264.00[1] [ 41.507554] dim:ch[1]:reg end [ 41.507568] reg:v4lvideo [ 41.507575] dim:ch[1]:di_receiver_event_fun,3:_START [ 41.507581] vdec_init, vf_provider_name = vdec.h264.00 [ 41.508179] vdec->port_flag=0x102, port_flag=0x10b [ 41.560949] the demux clock on, ref cnt: 2 [ 41.560958] the parser_top clock on, ref cnt: 2 [ 41.874402] alloc: alloc=1, release=0 [ 41.874557] alloc: alloc=2, release=0 [ 41.874611] alloc: alloc=3, release=0 [ 41.874654] alloc: alloc=4, release=0 [ 41.874674] 0: AV_SCRATCH_1 = 41fe078, AV_SCRATCH_2 12077\x0d [ 41.874748] 0: frame_mbs_only_flag 0, crop_bottom 2, frame_height 1080, [ 41.874754] 0: mb_height 68,crop_right 0, frame_width 1920, mb_width 120 [ 41.874759] 0: mb height/widht/total: 44/78/1fe0 level_idc 28 max_ref_num 4 [ 41.874764] 0: restriction_flag=1, max_dec_frame_buffering=4, reorder_pic_num=5 [ 41.874767] 0: set reorder_pic_num to 4 [ 41.874772] 0: vh264_set_params active_buf_spec_num 13 reorder_pic_num 4 collocate_buf_num 8\x0d [ 41.875049] alloc: alloc=5, release=0 [ 41.875166] alloc: alloc=6, release=0 [ 41.875213] alloc: alloc=7, release=0 [ 41.875252] alloc: alloc=8, release=0 [ 41.875292] alloc: alloc=9, release=0 [ 41.875377] alloc: alloc=10, release=0 [ 41.875420] alloc: alloc=11, release=0 [ 41.875451] alloc: alloc=12, release=0 [ 41.875490] alloc: alloc=13, release=0 [ 41.875530] alloc: alloc=14, release=0 [ 41.896837] 0: num_ref_frames change from 0 to 4\x0d [ 41.914552] dim:dip_init_value_reg:ch[1]:fix_buf:0 [ 41.914572] dim:di_cnt_i_buf1:tvp:0 [ 41.914632] dim:pre_sec_alloc:no size [ 41.914637] dim:pst_sec_alloc:not alloc:0,0x0 [ 41.914643] dimh_patch_post_update_mc_sw:0x0->0x2 [ 41.914720] [DI]dimh_load_regs hw load 0x3a00 pq table len 246. [ 41.936669] dim_pre_de_buf_config:ch[1]:4294709168ms 1th source change: [ 41.936677] source change:0x0/0/0/0=>0x8009/1920/1080/0 [ 41.936690] dimh_patch_post_update_mc_sw:0x2->0x3 [ 41.961445] v4lvideo: provider name: vdec.h264.00 [ 43.547926] Now can use cma, free:13623, wm:13677 [ 62.496588] fb: mem_free_work, free memory: addr:800000 [ 63.528136] type=1400 audit(1614939875.124:574): avc: denied { read } for comm="HwBinder:3527_2" name="u:object_r:default_prop:s0" dev="tmpfs" ino=12060 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:default_prop:s0 tclass=file permissive=0 duplicate messages suppressed [ 63.529406] type=1400 audit(1614939875.732:575): avc: denied { read } for comm="HwBinder:3522_3" name="u:object_r:shell_prop:s0" dev="tmpfs" ino=12133 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:shell_prop:s0 tclass=file permissive=0 [ 63.541200] type=1400 audit(1614939875.732:575): avc: denied { read } for comm="HwBinder:3522_3" name="u:object_r:shell_prop:s0" dev="tmpfs" ino=12133 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:shell_prop:s0 tclass=file permissive=0 [ 63.545845] type=1400 audit(1614939875.744:576): avc: denied { read } for comm="HwBinder:3522_2" name="u:object_r:shell_prop:s0" dev="tmpfs" ino=12133 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:shell_prop:s0 tclass=file permissive=0 [ 63.749401] type=1400 audit(1614939875.832:578): avc: denied { read } for comm="HwBinder:3522_2" name="u:object_r:shell_prop:s0" dev="tmpfs" ino=12133 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:shell_prop:s0 tclass=file permissive=0 duplicate messages suppressed [ 63.749457] type=1400 audit(1614939875.956:579): avc: denied { read } for comm="HwBinder:3522_3" name="u:object_r:shell_prop:s0" dev="tmpfs" ino=12133 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:shell_prop:s0 tclass=file permissive=0 [ 63.763355] type=1400 audit(1614939875.956:579): avc: denied { read } for comm="HwBinder:3522_3" name="u:object_r:shell_prop:s0" dev="tmpfs" ino=12133 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:shell_prop:s0 tclass=file permissive=0 [ 63.770081] type=1400 audit(1614939875.968:580): avc: denied { read } for comm="HwBinder:3522_2" name="u:object_r:shell_prop:s0" dev="tmpfs" ino=12133 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:shell_prop:s0 tclass=file permissive=0 [ 63.830751] audit: audit_lost=13 audit_rate_limit=5 audit_backlog_limit=64 [ 63.830761] audit: rate limit exceeded [ 64.941076] type=1400 audit(1614939876.024:581): avc: denied { read } for comm="HwBinder:3522_2" name="u:object_r:shell_prop:s0" dev="tmpfs" ino=12133 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:shell_prop:s0 tclass=file permissive=0 [ 64.941116] type=1400 audit(1614939877.124:586): avc: denied { read } for comm="HwBinder:3527_2" name="u:object_r:default_prop:s0" dev="tmpfs" ino=12060 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:default_prop:s0 tclass=file permissive=0 [ 66.384895] healthd: battery l=42 v=4 t=42.4 h=2 st=2 c=1 fc=10000000 chg=u [ 68.920033] type=1400 audit(1614939880.204:592): avc: denied { read } for comm="HwBinder:3522_2" name="u:object_r:shell_prop:s0" dev="tmpfs" ino=12133 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:shell_prop:s0 tclass=file permissive=0 [ 68.920082] type=1400 audit(1614939881.124:593): avc: denied { read } for comm="HwBinder:3527_2" name="u:object_r:default_prop:s0" dev="tmpfs" ino=12060 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:default_prop:s0 tclass=file permissive=0 [ 70.090772] timestamp_apts_enable enable:0, [ 70.110320] dim:ch[1]:di_receiver_event_fun,1:_UNREG [ 70.110326] dev_vframe_unreg:ch[dimulti.1]:begin [ 70.110336] unreg:v4lvideo [ 70.110342] v4lvideo:[0]unreg get=1664, put=1655, release=0 [ 70.110351] dev_vframe_unreg:ch[dimulti.1]:end [ 70.116188] dpre_can_exit:ch[1]:curr[1]:stat[IDLE] ret[1] [ 70.116194] dpst_can_exit:ch[1]:curr[1]:stat[IDLE] ret[1] [ 70.124557] di_unreg_variable: [ 70.124583] dim:mem_release:blk_mst[0x3f380] [ 70.124585] dim:mem_release:pat_mst[0x0] [ 70.124601] dim:qiat_all_back2_ready:len[0] [ 70.124606] dimh_patch_post_update_mc_sw:0x3->0x0 [ 70.135600] vdec_disable_DMC input->target= 0x0 [ 70.135730] 0: vh264_stop [ 70.139313] vdec_release instance 0000000075b900de, total 1 [ 70.139575] the clk_vdec_mux clock off, ref cnt: 0 [ 70.139605] the vdec clock off, ref cnt: 0 [ 70.139613] the parser_top clock off, ref cnt: 1 [ 70.139619] the demux clock off, ref cnt: 1 [ 70.139878] the demux clock on, ref cnt: 2 [ 70.139886] the parser_top clock on, ref cnt: 2 [ 70.139895] the vdec clock on, ref cnt: 1 [ 70.139914] the clk_vdec_mux clock on, ref cnt: 1 [ 70.139948] vdec mux clock is 499999992 Hz [ 70.140015] vdec_create instance 00000000f1a069c3, total 1 [ 70.140097] no drmmode [ 70.140205] vdec_init, dev_name:ammvdec_h264, vdec_type=VDEC_TYPE_FRAME_BLOCK [ 70.142237] ammvdec_h264_mmu_init tvp = 0x0 mmu_enable 0 [ 70.142245] decoder_bmmu_box_alloc_box, tvp_flags = 0 [ 70.142256] 0: ammvdec_h264_probe mmu_enable 0 double_write_mode 0x0 [ 70.143592] 0: ammvdec_h264 mem-addr=0,buff_offset=55010000,buf_start=56000000 [ 70.143633] vdec mux clock is 666666656 Hz [ 70.143639] vdec1 video changed to 3840 x 2160 60 fps clk->667MHZ [ 70.143645] H264 sysinfo: 1920x1080 duration=4000, pts_outside=0 [ 70.143648] sync_outside=0, use_idr_framerate=0, is_used_v4l: 0 [ 70.143776] [TEE], the fw (h264_multi) will be loaded. [ 70.144051] vh264_init, phy_addr=b7064000 vaddr=000000001647c439 [ 70.144144] == vdec urgent clear ! [ 70.144160] vfm map vdec-map-0 created [ 70.144177] dim:ch[1]:di_receiver_event_fun,8:_REG [ 70.144181] dim:reg:vdec.h264.00[2] [ 70.145040] dim:ch[1]:reg end [ 70.145062] reg:v4lvideo [ 70.145070] dim:ch[1]:di_receiver_event_fun,3:_START [ 70.145076] vdec_init, vf_provider_name = vdec.h264.00 [ 70.145276] vdec->port_flag=0x102, port_flag=0x10b [ 70.145855] v4lvideo:[0]di release1 get=1664, put=1655, release=1 [ 70.145891] v4lvideo:[0]di release1 get=1664, put=1655, release=2 [ 70.145917] v4lvideo:[0]di release1 get=1664, put=1655, release=3 [ 70.145943] v4lvideo:[0]di release1 get=1664, put=1655, release=4 [ 70.145970] v4lvideo:[0]di release1 get=1664, put=1655, release=5 [ 70.145996] v4lvideo:[0]di release1 get=1664, put=1655, release=6 [ 70.165068] dim:ch[1]:di_receiver_event_fun,1:_UNREG [ 70.165075] dev_vframe_unreg:ch[dimulti.1]:begin [ 70.165081] unreg:v4lvideo [ 70.165087] v4lvideo:[0]unreg get=1664, put=1655, release=6 [ 70.165095] dev_vframe_unreg:ch[dimulti.1]:end [ 70.165192] vdec_disable_DMC input->target= 0x0 [ 70.165301] 0: vh264_stop [ 70.165877] vdec_release instance 00000000f1a069c3, total 1 [ 70.167110] the clk_vdec_mux clock off, ref cnt: 0 [ 70.167119] the vdec clock off, ref cnt: 0 [ 70.167124] the parser_top clock off, ref cnt: 1 [ 70.167127] the demux clock off, ref cnt: 1 [ 70.167292] the demux clock on, ref cnt: 2 [ 70.167298] the parser_top clock on, ref cnt: 2 [ 70.167306] the vdec clock on, ref cnt: 1 [ 70.167325] the clk_vdec_mux clock on, ref cnt: 1 [ 70.167356] vdec mux clock is 499999992 Hz [ 70.167423] vdec_create instance 0000000037b99dc8, total 1 [ 70.167544] no drmmode [ 70.167646] vdec_init, dev_name:ammvdec_h264, vdec_type=VDEC_TYPE_FRAME_BLOCK [ 70.168333] ammvdec_h264_mmu_init tvp = 0x0 mmu_enable 0 [ 70.168340] decoder_bmmu_box_alloc_box, tvp_flags = 0 [ 70.168351] 0: ammvdec_h264_probe mmu_enable 0 double_write_mode 0x0 [ 70.172814] 0: ammvdec_h264 mem-addr=0,buff_offset=55010000,buf_start=56000000 [ 70.172858] vdec mux clock is 666666656 Hz [ 70.172863] vdec1 video changed to 3840 x 2160 60 fps clk->667MHZ [ 70.172869] H264 sysinfo: 1920x1080 duration=4000, pts_outside=0 [ 70.172873] sync_outside=0, use_idr_framerate=0, is_used_v4l: 0 [ 70.173416] [TEE], the fw (h264_multi) will be loaded. [ 70.174524] vh264_init, phy_addr=b7064000 vaddr=00000000fde76da4 [ 70.174704] == vdec urgent clear ! [ 70.174722] vfm map vdec-map-0 created [ 70.174740] dim:ch[1]:di_receiver_event_fun,8:_REG [ 70.174744] dim:reg:vdec.h264.00[3] [ 70.177037] dim:ch[1]:reg end [ 70.177060] reg:v4lvideo [ 70.177068] dim:ch[1]:di_receiver_event_fun,3:_START [ 70.177074] vdec_init, vf_provider_name = vdec.h264.00 [ 70.178874] vdec->port_flag=0x102, port_flag=0x10b [ 70.182670] the parser_top clock off, ref cnt: 1 [ 70.182677] the demux clock off, ref cnt: 1 [ 70.196130] v4lvid: dbg: vidioc_close!!!! [ 70.196139] v4lvideo_release_map 0 OK [ 70.196146] v4lvideo:[0]close get=1664, put=1655, release=6, 3 [ 70.199065] dim:ch[1]:di_receiver_event_fun,1:_UNREG [ 70.199071] dev_vframe_unreg:ch[dimulti.1]:begin [ 70.199076] unreg:v4lvideo [ 70.199082] v4lvideo:[0]unreg get=1664, put=1655, release=6 [ 70.199090] dev_vframe_unreg:ch[dimulti.1]:end [ 70.200083] vdec_disable_DMC input->target= 0x0 [ 70.200223] 0: vh264_stop [ 70.204219] vdec_release instance 0000000037b99dc8, total 1 [ 70.204426] the clk_vdec_mux clock off, ref cnt: 0 [ 70.204435] the vdec clock off, ref cnt: 0 [ 70.204441] the parser_top clock off, ref cnt: 0 [ 70.204446] the demux clock off, ref cnt: 0 [ 70.208677] release: alloc=14, release=1 [ 70.208699] release: alloc=14, release=2 [ 70.208710] release: alloc=14, release=3 [ 70.208747] v4lvideo:[0]di release1 get=1664, put=1655, release=7 [ 70.208752] release: alloc=14, release=4 [ 70.208764] release: alloc=14, release=5 [ 70.208808] release: alloc=14, release=6 [ 70.208821] release: alloc=14, release=7 [ 70.208833] release: alloc=14, release=8 [ 70.208844] release: alloc=14, release=9 [ 70.208854] release: alloc=14, release=10 [ 70.208864] release: alloc=14, release=11 [ 70.208876] release: alloc=14, release=12 [ 70.208893] v4lvideo:[0]di release1 get=1664, put=1655, release=8 [ 70.208898] release: alloc=14, release=13 [ 70.210312] vc:[0]vc: set enable index=0, val=0 [ 70.210332] dev->index =0, val=1 [ 70.210336] VID: VD1 off [ 70.210342] VID: VD1 set global output as 0 [ 70.210357] common_vf_unreg_provider video_render.0: vd1 used: true, vd2 used: false, black_out:0, cur_buf:00000000014def77 [ 70.248574] sleep_time=20 [ 70.248677] v4lvideo:[0]di release1 get=1664, put=1655, release=9 [ 70.248683] release: alloc=14, release=14 [ 70.248707] vc:[0]vc: set enable index=0, val=1 [ 70.248724] dev->index =0, val=2 [ 70.248728] VID: VD1 off [ 70.248733] VID: VD1 set global output as 1 [ 70.374532] type=1400 audit(1614939882.124:594): avc: denied { read } for comm="HwBinder:3527_2" name="u:object_r:default_prop:s0" dev="tmpfs" ino=12060 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:default_prop:s0 tclass=file permissive=0 [ 70.374564] type=1400 audit(1614939882.576:595): avc: denied { read } for comm="HwBinder:3522_3" name="u:object_r:shell_prop:s0" dev="tmpfs" ino=12133 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:shell_prop:s0 tclass=file permissive=0 [ 77.251483] type=1400 audit(1614939882.908:598): avc: denied { read } for comm="HwBinder:3522_3" name="u:object_r:shell_prop:s0" dev="tmpfs" ino=12133 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:shell_prop:s0 tclass=file permissive=0 duplicate messages suppressed [ 77.251517] type=1400 audit(1614939889.456:599): avc: denied { read } for comm="HwBinder:3527_1" name="u:object_r:default_prop:s0" dev="tmpfs" ino=12060 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:default_prop:s0 tclass=file permissive=0 [ 77.323245] v4lvid: dbg: v4lvideo open [ 77.323257] v4lvideo:[0]open [ 77.323477] [store_mode]tsync_mode=1, buf=1 [ 77.323592] the demux clock on, ref cnt: 1 [ 77.323599] the parser_top clock on, ref cnt: 1 [ 77.323605] the vdec clock on, ref cnt: 1 [ 77.323625] the clk_vdec_mux clock on, ref cnt: 1 [ 77.323658] vdec mux clock is 499999992 Hz [ 77.323724] vdec_create instance 000000003d5f53b3, total 1 [ 77.323800] no drmmode [ 77.323913] vdec_init, dev_name:ammvdec_h264, vdec_type=VDEC_TYPE_FRAME_BLOCK [ 77.324721] ammvdec_h264_mmu_init tvp = 0x0 mmu_enable 0 [ 77.324728] decoder_bmmu_box_alloc_box, tvp_flags = 0 [ 77.324741] 0: ammvdec_h264_probe mmu_enable 0 double_write_mode 0x0 [ 77.327709] 0: ammvdec_h264 mem-addr=0,buff_offset=55010000,buf_start=56000000 [ 77.327751] vdec mux clock is 666666656 Hz [ 77.327756] vdec1 video changed to 3840 x 2160 60 fps clk->667MHZ [ 77.327762] H264 sysinfo: 1920x1080 duration=4000, pts_outside=0 [ 77.327765] sync_outside=0, use_idr_framerate=0, is_used_v4l: 0 [ 77.327829] [TEE], the fw (h264_multi) will be loaded. [ 77.328168] vh264_init, phy_addr=b7064000 vaddr=00000000bd4b2eea [ 77.328339] == vdec urgent clear ! [ 77.328354] vfm map vdec-map-0 created [ 77.328371] dim:ch[1]:di_receiver_event_fun,8:_REG [ 77.328374] dim:reg:vdec.h264.00[4] [ 77.328434] dim:ch[1]:reg end [ 77.328448] reg:v4lvideo [ 77.328454] dim:ch[1]:di_receiver_event_fun,3:_START [ 77.328460] vdec_init, vf_provider_name = vdec.h264.00 [ 77.336557] vdec->port_flag=0x102, port_flag=0x10b [ 77.339714] vc:[0]vc: set enable index=0, val=0 [ 77.339731] dev->index =0, val=1 [ 77.339735] VID: VD1 off [ 77.339741] VID: VD1 set global output as 0 [ 77.339753] common_vf_unreg_provider video_render.0: vd1 used: false, vd2 used: false, black_out:0, cur_buf: (null) [ 77.339756] sleep_time=0 [ 77.339806] vc:[0]vc: set enable index=0, val=1 [ 77.339815] dev->index =0, val=2 [ 77.339818] VID: VD1 off [ 77.339847] VID: VD1 set global output as 1 [ 77.389420] the demux clock on, ref cnt: 2 [ 77.389429] the parser_top clock on, ref cnt: 2 [ 77.570046] alloc: alloc=15, release=14 [ 77.570054] 0: AV_SCRATCH_1 = 841fe078, AV_SCRATCH_2 1a077\x0d [ 77.570102] 0: frame_mbs_only_flag 1, crop_bottom 4, frame_height 1080, [ 77.570107] 0: mb_height 68,crop_right 0, frame_width 1920, mb_width 120 [ 77.570112] 0: mb height/widht/total: 44/78/1fe0 level_idc 28 max_ref_num 4 [ 77.570113] alloc: alloc=16, release=14 [ 77.570117] 0: restriction_flag=1, max_dec_frame_buffering=4, reorder_pic_num=5 [ 77.570121] 0: set reorder_pic_num to 4 [ 77.570126] 0: vh264_set_params active_buf_spec_num 13 reorder_pic_num 4 collocate_buf_num 8\x0d [ 77.570143] alloc: alloc=17, release=14 [ 77.570175] alloc: alloc=18, release=14 [ 77.570201] alloc: alloc=19, release=14 [ 77.570229] alloc: alloc=20, release=14 [ 77.570260] alloc: alloc=21, release=14 [ 77.570352] alloc: alloc=22, release=14 [ 77.570379] alloc: alloc=23, release=14 [ 77.570435] alloc: alloc=24, release=14 [ 77.570770] alloc: alloc=25, release=14 [ 77.570812] alloc: alloc=26, release=14 [ 77.570844] alloc: alloc=27, release=14 [ 77.571006] alloc: alloc=28, release=14 [ 77.630972] 0: num_ref_frames change from 0 to 4\x0d [ 77.639450] dim:dip_init_value_reg:ch[1]:fix_buf:0 [ 77.639461] dim:1920x1080-0x9000. [ 77.641337] v4lvideo: provider name: vdec.h264.00 [ 77.731127] type=1400 audit(1614939889.456:600): avc: denied { read } for comm="HwBinder:3527_1" name="u:object_r:default_prop:s0" dev="tmpfs" ino=12060 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:default_prop:s0 tclass=file permissive=0 [ 77.731160] type=1400 audit(1614939889.936:601): avc: denied { read } for comm="HwBinder:3522_3" name="u:object_r:shell_prop:s0" dev="tmpfs" ino=12133 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:shell_prop:s0 tclass=file permissive=0 [ 77.889374] type=1400 audit(1614939890.084:604): avc: denied { read } for comm="HwBinder:3522_3" name="u:object_r:shell_prop:s0" dev="tmpfs" ino=12133 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:shell_prop:s0 tclass=file permissive=0 duplicate messages suppressed [ 77.889416] type=1400 audit(1614939890.096:605): avc: denied { search } for comm="apm-plan-3-thrd" name="com.google.android.gms" dev="mmcblk0p20" ino=129338 scontext=u:r:system_app:s0 tcontext=u:object_r:privapp_data_file:s0:c512,c768 tclass=dir permissive=0 [ 77.889534] audit: audit_lost=17 audit_rate_limit=5 audit_backlog_limit=64 [ 77.889541] audit: rate limit exceeded [ 79.992714] binder_alloc: 4434: binder_alloc_buf size 1056768 failed, no address space [ 79.992722] binder_alloc: allocated: 8136 (num: 12 largest: 2880), free: 1032248 (num: 4 largest: 1031328) [ 79.992732] binder: 4603:7396 transaction failed 29201/-28, size 1056768-0 line 3287 [ 80.765132] logd: logdr: UID=10005 GID=10005 PID=4603 n tail=0 logMask=4 pid=0 start=0ns timeout=0ns [ 82.673486] type=1400 audit(1614939890.096:605): avc: denied { search } for comm="apm-plan-3-thrd" name="com.google.android.gms" dev="mmcblk0p20" ino=129338 scontext=u:r:system_app:s0 tcontext=u:object_r:privapp_data_file:s0:c512,c768 tclass=dir permissive=0 [ 82.677072] type=1400 audit(1614939894.876:610): avc: denied { search } for comm="IntentService[D" name="vendor" dev="tmpfs" ino=12956 scontext=u:r:priv_app:s0:c512,c768 tcontext=u:object_r:mnt_vendor_file:s0 tclass=dir permissive=0 app=com.google.android.gms [ 82.710170] logd: logdr: UID=10005 GID=10005 PID=4434 n tail=0 logMask=4 pid=0 start=0ns timeout=0ns [ 84.028889] logd: logdr: UID=10005 GID=10005 PID=4434 n tail=0 logMask=4 pid=0 start=1614939888451000000ns timeout=1614947096194635278ns [ 84.175696] type=1400 audit(1614939894.880:612): avc: denied { search } for comm="IntentService[D" name="vendor" dev="tmpfs" ino=12956 scontext=u:r:priv_app:s0:c512,c768 tcontext=u:object_r:mnt_vendor_file:s0 tclass=dir permissive=0 app=com.google.android.gms duplicate messages suppressed [ 84.175730] type=1400 audit(1614939896.368:613): avc: denied { read } for comm="btvpropertyserv" name="u:object_r:shell_prop:s0" dev="tmpfs" ino=12133 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:shell_prop:s0 tclass=file permissive=0 [ 85.207954] type=1400 audit(1614939896.368:613): avc: denied { read } for comm="btvpropertyserv" name="u:object_r:shell_prop:s0" dev="tmpfs" ino=12133 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:shell_prop:s0 tclass=file permissive=0 [ 85.209472] type=1400 audit(1614939897.412:614): avc: denied { getattr } for comm="IntentService[D" path="/dev/__properties__/u:object_r:media_prop:s0" dev="tmpfs" ino=12114 scontext=u:r:priv_app:s0:c512,c768 tcontext=u:object_r:media_prop:s0 tclass=file permissive=0 app=com.google.android.gms [ 85.466857] type=1400 audit(1614939897.412:614): avc: denied { getattr } for comm="IntentService[D" path="/dev/__properties__/u:object_r:media_prop:s0" dev="tmpfs" ino=12114 scontext=u:r:priv_app:s0:c512,c768 tcontext=u:object_r:media_prop:s0 tclass=file permissive=0 app=com.google.android.gms [ 85.468826] type=1400 audit(1614939897.672:615): avc: denied { search } for comm="Binder:7444_3" name="vendor" dev="tmpfs" ino=12956 scontext=u:r:priv_app:s0:c512,c768 tcontext=u:object_r:mnt_vendor_file:s0 tclass=dir permissive=0 app=com.google.android.gms [ 86.976522] [TEE] MESSAGE: USER-TA:log_msg:68: KeymasterTA (err): ./keymaster/include/keymaster/attestation_record.h, Line 248: Cannot open attestationdevidbox, return KM_ERROR_UNIMPLEMENTED [ 86.976529] [TEE] MESSAGE: USER-TA:log_msg:68: KeymasterTA (err): keymaster/key_blob_utils/ocb_utils.cpp, Line 186: Failed to validate authentication tag during key decryption [ 90.048528] [TEE] MESSAGE: USER-TA:log_msg:68: KeymasterTA (err): ./keymaster/include/keymaster/attestation_record.h, Line 248: Cannot open attestationdevidbox, return KM_ERROR_UNIMPLEMENTED [ 97.557322] logd: logdr: UID=10005 GID=10005 PID=4434 n tail=0 logMask=4 pid=0 start=0ns timeout=0ns [ 100.794679] timestamp_apts_enable enable:0, [ 100.807382] dim:ch[1]:di_receiver_event_fun,1:_UNREG [ 100.807390] dev_vframe_unreg:ch[dimulti.1]:begin [ 100.807428] unreg:v4lvideo [ 100.807435] v4lvideo:[0]unreg get=1664, put=1655, release=9 [ 100.807444] dev_vframe_unreg:ch[dimulti.1]:end [ 100.807469] di_unreg_variable: [ 100.807478] dim:mem_release:blk_mst[0x0] [ 100.807480] dim:mem_release:pat_mst[0x0] [ 100.807489] dim:qiat_all_back2_ready:len[0] [ 100.818664] vdec_disable_DMC input->target= 0x0 [ 100.818776] 0: vh264_stop [ 100.820138] vdec_release instance 000000003d5f53b3, total 1 [ 100.820375] the clk_vdec_mux clock off, ref cnt: 0 [ 100.820384] the vdec clock off, ref cnt: 0 [ 100.820388] the parser_top clock off, ref cnt: 1 [ 100.820392] the demux clock off, ref cnt: 1 [ 100.821019] the demux clock on, ref cnt: 2 [ 100.821027] the parser_top clock on, ref cnt: 2 [ 100.821037] the vdec clock on, ref cnt: 1 [ 100.821058] the clk_vdec_mux clock on, ref cnt: 1 [ 100.821091] vdec mux clock is 499999992 Hz [ 100.821159] vdec_create instance 00000000764e4edf, total 1 [ 100.821228] no drmmode [ 100.821335] vdec_init, dev_name:ammvdec_h264, vdec_type=VDEC_TYPE_FRAME_BLOCK [ 100.822562] ammvdec_h264_mmu_init tvp = 0x0 mmu_enable 0 [ 100.822570] decoder_bmmu_box_alloc_box, tvp_flags = 0 [ 100.822586] 0: ammvdec_h264_probe mmu_enable 0 double_write_mode 0x0 [ 100.823780] 0: ammvdec_h264 mem-addr=0,buff_offset=55010000,buf_start=56000000 [ 100.823821] vdec mux clock is 666666656 Hz [ 100.823826] vdec1 video changed to 3840 x 2160 60 fps clk->667MHZ [ 100.823832] H264 sysinfo: 1920x1080 duration=4000, pts_outside=0 [ 100.823836] sync_outside=0, use_idr_framerate=0, is_used_v4l: 0 [ 100.823898] [TEE], the fw (h264_multi) will be loaded. [ 100.825459] vh264_init, phy_addr=b7064000 vaddr=000000000aa8979b [ 100.826457] == vdec urgent clear ! [ 100.826475] vfm map vdec-map-0 created [ 100.826491] dim:ch[1]:di_receiver_event_fun,8:_REG [ 100.826495] dim:reg:vdec.h264.00[5] [ 100.827046] dim:ch[1]:reg end [ 100.827068] reg:v4lvideo [ 100.827076] dim:ch[1]:di_receiver_event_fun,3:_START [ 100.827083] vdec_init, vf_provider_name = vdec.h264.00 [ 100.827321] vdec->port_flag=0x102, port_flag=0x10b [ 100.843152] dim:ch[1]:di_receiver_event_fun,1:_UNREG [ 100.843159] dev_vframe_unreg:ch[dimulti.1]:begin [ 100.843164] unreg:v4lvideo [ 100.843170] v4lvideo:[0]unreg get=1664, put=1655, release=9 [ 100.843178] dev_vframe_unreg:ch[dimulti.1]:end [ 100.844655] vdec_disable_DMC input->target= 0x0 [ 100.844757] 0: vh264_stop [ 100.845188] vdec_release instance 00000000764e4edf, total 1 [ 100.845314] the clk_vdec_mux clock off, ref cnt: 0 [ 100.845323] the vdec clock off, ref cnt: 0 [ 100.845328] the parser_top clock off, ref cnt: 1 [ 100.845331] the demux clock off, ref cnt: 1 [ 100.845467] the demux clock on, ref cnt: 2 [ 100.845473] the parser_top clock on, ref cnt: 2 [ 100.845481] the vdec clock on, ref cnt: 1 [ 100.845499] the clk_vdec_mux clock on, ref cnt: 1 [ 100.845530] vdec mux clock is 499999992 Hz [ 100.845595] vdec_create instance 0000000056da272b, total 1 [ 100.845664] no drmmode [ 100.845743] vdec_init, dev_name:ammvdec_h264, vdec_type=VDEC_TYPE_FRAME_BLOCK [ 100.846593] ammvdec_h264_mmu_init tvp = 0x0 mmu_enable 0 [ 100.846599] decoder_bmmu_box_alloc_box, tvp_flags = 0 [ 100.846610] 0: ammvdec_h264_probe mmu_enable 0 double_write_mode 0x0 [ 100.847533] 0: ammvdec_h264 mem-addr=0,buff_offset=55010000,buf_start=56000000 [ 100.847577] vdec mux clock is 666666656 Hz [ 100.847582] vdec1 video changed to 3840 x 2160 60 fps clk->667MHZ [ 100.847588] H264 sysinfo: 1920x1080 duration=4000, pts_outside=0 [ 100.847591] sync_outside=0, use_idr_framerate=0, is_used_v4l: 0 [ 100.847658] [TEE], the fw (h264_multi) will be loaded. [ 100.848020] vh264_init, phy_addr=b7064000 vaddr=000000007b50e3bb [ 100.848111] == vdec urgent clear ! [ 100.848207] vfm map vdec-map-0 created [ 100.848224] dim:ch[1]:di_receiver_event_fun,8:_REG [ 100.848228] dim:reg:vdec.h264.00[6] [ 100.848884] dim:ch[1]:reg end [ 100.848907] reg:v4lvideo [ 100.849306] dim:ch[1]:di_receiver_event_fun,3:_START [ 100.849314] vdec_init, vf_provider_name = vdec.h264.00 [ 100.850705] vdec->port_flag=0x102, port_flag=0x10b [ 100.856127] the parser_top clock off, ref cnt: 1 [ 100.856134] the demux clock off, ref cnt: 1 [ 100.862423] v4lvid: dbg: vidioc_close!!!! [ 100.862429] v4lvideo_release_map 0 OK [ 100.862435] v4lvideo:[0]close get=1664, put=1655, release=9, 0 [ 100.867387] dim:ch[1]:di_receiver_event_fun,1:_UNREG [ 100.867394] dev_vframe_unreg:ch[dimulti.1]:begin [ 100.867399] unreg:v4lvideo [ 100.867406] v4lvideo:[0]unreg get=1664, put=1655, release=9 [ 100.867414] dev_vframe_unreg:ch[dimulti.1]:end [ 100.867484] vdec_disable_DMC input->target= 0x0 [ 100.867608] 0: vh264_stop [ 100.868435] vdec_release instance 0000000056da272b, total 1 [ 100.868698] the clk_vdec_mux clock off, ref cnt: 0 [ 100.868709] the vdec clock off, ref cnt: 0 [ 100.868716] the parser_top clock off, ref cnt: 0 [ 100.868721] the demux clock off, ref cnt: 0 [ 100.868754] selinux: SELinux: Could not read /sys/devices/platform/vdec/ammvdec_h264.0: No such file or directory.\x0a [ 100.870118] vc:[0]vc: set enable index=0, val=0 [ 100.870152] dev->index =0, val=1 [ 100.870156] VID: VD1 off [ 100.870162] VID: VD1 set global output as 0 [ 100.870178] common_vf_unreg_provider video_render.0: vd1 used: true, vd2 used: false, black_out:0, cur_buf:00000000014def77 [ 100.871001] release: alloc=28, release=15 [ 100.871023] release: alloc=28, release=16 [ 100.871034] release: alloc=28, release=17 [ 100.871048] release: alloc=28, release=18 [ 100.871059] release: alloc=28, release=19 [ 100.871071] release: alloc=28, release=20 [ 100.871085] release: alloc=28, release=21 [ 100.871100] release: alloc=28, release=22 [ 100.871111] release: alloc=28, release=23 [ 100.871120] release: alloc=28, release=24 [ 100.871133] release: alloc=28, release=25 [ 100.871143] release: alloc=28, release=26 [ 100.871154] release: alloc=28, release=27 [ 100.908560] sleep_time=20 [ 100.908645] release: alloc=28, release=28 [ 100.908670] vc:[0]vc: set enable index=0, val=1 [ 100.908679] dev->index =0, val=2 [ 100.908684] VID: VD1 off [ 100.908689] VID: VD1 set global output as 1 [ 101.084868] type=1400 audit(1614939901.956:623): avc: denied { search } for comm="Binder:7444_2" name="vendor" dev="tmpfs" ino=12956 scontext=u:r:priv_app:s0:c512,c768 tcontext=u:object_r:mnt_vendor_file:s0 tclass=dir permissive=0 app=com.google.android.gms duplicate messages suppressed [ 101.084899] type=1400 audit(1614939913.288:624): avc: denied { read } for comm="HwBinder:3527_1" name="u:object_r:default_prop:s0" dev="tmpfs" ino=12060 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:default_prop:s0 tclass=file permissive=0 [ 101.170450] v4lvid: dbg: v4lvideo open [ 101.170462] v4lvideo:[0]open [ 101.170674] [store_mode]tsync_mode=1, buf=1 [ 101.170771] the demux clock on, ref cnt: 1 [ 101.170777] the parser_top clock on, ref cnt: 1 [ 101.170783] the vdec clock on, ref cnt: 1 [ 101.170803] the clk_vdec_mux clock on, ref cnt: 1 [ 101.170835] vdec mux clock is 499999992 Hz [ 101.170913] vdec_create instance 000000009ef0a644, total 1 [ 101.170978] no drmmode [ 101.171066] vdec_init, dev_name:ammvdec_h264, vdec_type=VDEC_TYPE_FRAME_BLOCK [ 101.171786] ammvdec_h264_mmu_init tvp = 0x0 mmu_enable 0 [ 101.171832] decoder_bmmu_box_alloc_box, tvp_flags = 0 [ 101.171844] 0: ammvdec_h264_probe mmu_enable 0 double_write_mode 0x0 [ 101.181404] 0: ammvdec_h264 mem-addr=0,buff_offset=55010000,buf_start=56000000 [ 101.181445] vdec mux clock is 666666656 Hz [ 101.181451] vdec1 video changed to 3840 x 2160 60 fps clk->667MHZ [ 101.181457] H264 sysinfo: 1920x1080 duration=4000, pts_outside=0 [ 101.181460] sync_outside=0, use_idr_framerate=0, is_used_v4l: 0 [ 101.181529] [TEE], the fw (h264_multi) will be loaded. [ 101.182312] vh264_init, phy_addr=b7064000 vaddr=00000000706d5dd5 [ 101.182409] == vdec urgent clear ! [ 101.182425] vfm map vdec-map-0 created [ 101.182440] dim:ch[1]:di_receiver_event_fun,8:_REG [ 101.182444] dim:reg:vdec.h264.00[7] [ 101.182685] dim:ch[1]:reg end [ 101.182703] reg:v4lvideo [ 101.182711] dim:ch[1]:di_receiver_event_fun,3:_START [ 101.182717] vdec_init, vf_provider_name = vdec.h264.00 [ 101.185006] vdec->port_flag=0x102, port_flag=0x10b [ 101.237929] the demux clock on, ref cnt: 2 [ 101.237938] the parser_top clock on, ref cnt: 2 [ 101.445459] 0: AV_SCRATCH_1 = 41fe078, AV_SCRATCH_2 12077\x0d [ 101.445513] 0: frame_mbs_only_flag 0, crop_bottom 2, frame_height 1080, [ 101.445518] 0: mb_height 68,crop_right 0, frame_width 1920, mb_width 120 [ 101.445523] 0: mb height/widht/total: 44/78/1fe0 level_idc 28 max_ref_num 4 [ 101.445527] 0: restriction_flag=1, max_dec_frame_buffering=4, reorder_pic_num=5 [ 101.445531] 0: set reorder_pic_num to 4 [ 101.445536] 0: vh264_set_params active_buf_spec_num 13 reorder_pic_num 4 collocate_buf_num 8\x0d [ 101.446077] alloc: alloc=29, release=28 [ 101.446140] alloc: alloc=30, release=28 [ 101.446173] alloc: alloc=31, release=28 [ 101.446205] alloc: alloc=32, release=28 [ 101.446266] alloc: alloc=33, release=28 [ 101.446311] alloc: alloc=34, release=28 [ 101.446351] alloc: alloc=35, release=28 [ 101.446388] alloc: alloc=36, release=28 [ 101.446427] alloc: alloc=37, release=28 [ 101.446523] alloc: alloc=38, release=28 [ 101.446564] alloc: alloc=39, release=28 [ 101.446598] alloc: alloc=40, release=28 [ 101.446631] alloc: alloc=41, release=28 [ 101.446663] alloc: alloc=42, release=28 [ 101.465674] 0: num_ref_frames change from 0 to 4\x0d [ 101.492582] dim:dip_init_value_reg:ch[1]:fix_buf:0 [ 101.492602] dim:di_cnt_i_buf1:tvp:0 [ 101.492653] dim:pre_sec_alloc:no size [ 101.492658] dim:pst_sec_alloc:not alloc:0,0x0 [ 101.492663] dimh_patch_post_update_mc_sw:0x0->0x2 [ 101.600697] dim_pre_de_buf_config:ch[1]:4294768832ms 1th source change: [ 101.600705] source change:0x0/0/0/0=>0x8009/1920/1080/0 [ 101.600717] dimh_patch_post_update_mc_sw:0x2->0x3 [ 101.623071] v4lvideo: provider name: vdec.h264.00 [ 102.090943] logd: logdr: UID=10005 GID=10005 PID=4434 n tail=0 logMask=4 pid=0 start=0ns timeout=0ns [ 104.166287] type=1400 audit(1614939915.892:628): avc: denied { read } for comm="HwBinder:3527_1" name="u:object_r:default_prop:s0" dev="tmpfs" ino=12060 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:default_prop:s0 tclass=file permissive=0 duplicate messages suppressed [ 104.166332] type=1400 audit(1614939916.372:629): avc: denied { read } for comm="HwBinder:3522_3" name="u:object_r:shell_prop:s0" dev="tmpfs" ino=12133 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:shell_prop:s0 tclass=file permissive=0 [ 104.684670] type=1400 audit(1614939916.372:629): avc: denied { read } for comm="HwBinder:3522_3" name="u:object_r:shell_prop:s0" dev="tmpfs" ino=12133 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:shell_prop:s0 tclass=file permissive=0 [ 104.684743] type=1400 audit(1614939916.888:630): avc: denied { read } for comm="HwBinder:3527_1" name="u:object_r:default_prop:s0" dev="tmpfs" ino=12060 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:default_prop:s0 tclass=file permissive=0 [ 107.886177] type=1400 audit(1614939919.892:633): avc: denied { read } for comm="HwBinder:3527_1" name="u:object_r:default_prop:s0" dev="tmpfs" ino=12060 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:default_prop:s0 tclass=file permissive=0 duplicate messages suppressed [ 107.886214] type=1400 audit(1614939920.092:634): avc: denied { read } for comm="btvpropertyserv" name="u:object_r:shell_prop:s0" dev="tmpfs" ino=12133 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:shell_prop:s0 tclass=file permissive=0 [ 108.123527] audit: audit_lost=21 audit_rate_limit=5 audit_backlog_limit=64 [ 108.123535] audit: rate limit exceeded [ 108.210732] timestamp_apts_enable enable:0, [ 108.226901] dim:ch[1]:di_receiver_event_fun,1:_UNREG [ 108.226909] dev_vframe_unreg:ch[dimulti.1]:begin [ 108.227060] unreg:v4lvideo [ 108.227071] v4lvideo:[0]unreg get=2044, put=2026, release=9 [ 108.227081] dev_vframe_unreg:ch[dimulti.1]:end [ 108.236554] dpre_can_exit:ch[1]:curr[1]:stat[IDLE] ret[1] [ 108.236562] dpst_can_exit:ch[1]:curr[1]:stat[IDLE] ret[1] [ 108.239811] di_unreg_variable: [ 108.239838] dim:mem_release:blk_mst[0x19de0] [ 108.239840] dim:mem_release:pat_mst[0x0] [ 108.239856] dim:qiat_all_back2_ready:len[0] [ 108.239861] dimh_patch_post_update_mc_sw:0x3->0x0 [ 108.252727] vdec_disable_DMC input->target= 0x0 [ 108.252838] 0: vh264_stop [ 108.255555] vdec_release instance 000000009ef0a644, total 1 [ 108.255712] the clk_vdec_mux clock off, ref cnt: 0 [ 108.255722] the vdec clock off, ref cnt: 0 [ 108.255727] the parser_top clock off, ref cnt: 1 [ 108.255731] the demux clock off, ref cnt: 1 [ 108.255857] the demux clock on, ref cnt: 2 [ 108.255862] the parser_top clock on, ref cnt: 2 [ 108.255870] the vdec clock on, ref cnt: 1 [ 108.255889] the clk_vdec_mux clock on, ref cnt: 1 [ 108.255920] vdec mux clock is 499999992 Hz [ 108.255991] vdec_create instance 0000000073add39b, total 1 [ 108.256059] no drmmode [ 108.256161] vdec_init, dev_name:ammvdec_h264, vdec_type=VDEC_TYPE_FRAME_BLOCK [ 108.256920] ammvdec_h264_mmu_init tvp = 0x0 mmu_enable 0 [ 108.256926] decoder_bmmu_box_alloc_box, tvp_flags = 0 [ 108.256941] 0: ammvdec_h264_probe mmu_enable 0 double_write_mode 0x0 [ 108.259029] 0: ammvdec_h264 mem-addr=0,buff_offset=55010000,buf_start=56000000 [ 108.259073] vdec mux clock is 666666656 Hz [ 108.259077] vdec1 video changed to 3840 x 2160 60 fps clk->667MHZ [ 108.259084] H264 sysinfo: 1920x1080 duration=4000, pts_outside=0 [ 108.259087] sync_outside=0, use_idr_framerate=0, is_used_v4l: 0 [ 108.259158] [TEE], the fw (h264_multi) will be loaded. [ 108.260828] vh264_init, phy_addr=b7064000 vaddr=00000000e100ad33 [ 108.260951] == vdec urgent clear ! [ 108.260968] vfm map vdec-map-0 created [ 108.260983] dim:ch[1]:di_receiver_event_fun,8:_REG [ 108.260987] dim:reg:vdec.h264.00[8] [ 108.261044] dim:ch[1]:reg end [ 108.261059] reg:v4lvideo [ 108.261065] dim:ch[1]:di_receiver_event_fun,3:_START [ 108.261071] vdec_init, vf_provider_name = vdec.h264.00 [ 108.261651] vdec->port_flag=0x102, port_flag=0x10b [ 108.262427] v4lvideo:[0]di release1 get=2044, put=2026, release=10 [ 108.262621] v4lvideo:[0]di release1 get=2044, put=2026, release=11 [ 108.262859] v4lvideo:[0]di release1 get=2044, put=2026, release=12 [ 108.262962] v4lvideo:[0]di release1 get=2044, put=2026, release=13 [ 108.263137] v4lvideo:[0]di release1 get=2044, put=2026, release=14 [ 108.263199] v4lvideo:[0]di release1 get=2044, put=2026, release=15 [ 108.277366] dim:ch[1]:di_receiver_event_fun,1:_UNREG [ 108.277372] dev_vframe_unreg:ch[dimulti.1]:begin [ 108.277378] unreg:v4lvideo [ 108.277383] v4lvideo:[0]unreg get=2044, put=2026, release=15 [ 108.277391] dev_vframe_unreg:ch[dimulti.1]:end [ 108.277493] vdec_disable_DMC input->target= 0x0 [ 108.277595] 0: vh264_stop [ 108.278170] vdec_release instance 0000000073add39b, total 1 [ 108.278330] the clk_vdec_mux clock off, ref cnt: 0 [ 108.278340] the vdec clock off, ref cnt: 0 [ 108.278345] the parser_top clock off, ref cnt: 1 [ 108.278349] the demux clock off, ref cnt: 1 [ 108.278488] the demux clock on, ref cnt: 2 [ 108.278493] the parser_top clock on, ref cnt: 2 [ 108.278501] the vdec clock on, ref cnt: 1 [ 108.278521] the clk_vdec_mux clock on, ref cnt: 1 [ 108.278554] vdec mux clock is 499999992 Hz [ 108.278630] vdec_create instance 00000000fceac455, total 1 [ 108.278713] no drmmode [ 108.278816] vdec_init, dev_name:ammvdec_h264, vdec_type=VDEC_TYPE_FRAME_BLOCK [ 108.279555] ammvdec_h264_mmu_init tvp = 0x0 mmu_enable 0 [ 108.279562] decoder_bmmu_box_alloc_box, tvp_flags = 0 [ 108.279571] 0: ammvdec_h264_probe mmu_enable 0 double_write_mode 0x0 [ 108.281370] 0: ammvdec_h264 mem-addr=0,buff_offset=55010000,buf_start=56000000 [ 108.281459] vdec mux clock is 666666656 Hz [ 108.281465] vdec1 video changed to 3840 x 2160 60 fps clk->667MHZ [ 108.281470] H264 sysinfo: 1920x1080 duration=4000, pts_outside=0 [ 108.281474] sync_outside=0, use_idr_framerate=0, is_used_v4l: 0 [ 108.281539] [TEE], the fw (h264_multi) will be loaded. [ 108.282229] vh264_init, phy_addr=b7064000 vaddr=000000002df0cb1d [ 108.285067] == vdec urgent clear ! [ 108.285307] vfm map vdec-map-0 created [ 108.285324] dim:ch[1]:di_receiver_event_fun,8:_REG [ 108.285328] dim:reg:vdec.h264.00[9] [ 108.285894] dim:ch[1]:reg end [ 108.285915] reg:v4lvideo [ 108.285924] dim:ch[1]:di_receiver_event_fun,3:_START [ 108.285930] vdec_init, vf_provider_name = vdec.h264.00 [ 108.288889] vdec->port_flag=0x102, port_flag=0x10b [ 108.297259] the parser_top clock off, ref cnt: 1 [ 108.297266] the demux clock off, ref cnt: 1 [ 108.302512] v4lvid: dbg: vidioc_close!!!! [ 108.302520] v4lvideo_release_map 0 OK [ 108.302527] v4lvideo:[0]close get=2044, put=2026, release=15, 3 [ 108.313982] dim:ch[1]:di_receiver_event_fun,1:_UNREG [ 108.313990] dev_vframe_unreg:ch[dimulti.1]:begin [ 108.313996] unreg:v4lvideo [ 108.314002] v4lvideo:[0]unreg get=2044, put=2026, release=15 [ 108.314011] dev_vframe_unreg:ch[dimulti.1]:end [ 108.314597] vdec_disable_DMC input->target= 0x0 [ 108.314733] 0: vh264_stop [ 108.316806] vdec_release instance 00000000fceac455, total 1 [ 108.316953] the clk_vdec_mux clock off, ref cnt: 0 [ 108.316961] the vdec clock off, ref cnt: 0 [ 108.316967] the parser_top clock off, ref cnt: 0 [ 108.316973] the demux clock off, ref cnt: 0 [ 108.318684] vc:[0]vc: set enable index=0, val=0 [ 108.318704] dev->index =0, val=1 [ 108.318708] VID: VD1 off [ 108.318714] VID: VD1 set global output as 0 [ 108.318728] common_vf_unreg_provider video_render.0: vd1 used: true, vd2 used: false, black_out:0, cur_buf:00000000014def77 [ 108.319002] release: alloc=42, release=29 [ 108.319019] release: alloc=42, release=30 [ 108.319033] release: alloc=42, release=31 [ 108.319044] release: alloc=42, release=32 [ 108.319058] release: alloc=42, release=33 [ 108.319068] release: alloc=42, release=34 [ 108.319100] v4lvideo:[0]di release1 get=2044, put=2026, release=16 [ 108.319104] release: alloc=42, release=35 [ 108.319115] release: alloc=42, release=36 [ 108.319127] release: alloc=42, release=37 [ 108.319138] release: alloc=42, release=38 [ 108.319148] release: alloc=42, release=39 [ 108.319172] v4lvideo:[0]di release1 get=2044, put=2026, release=17 [ 108.319176] release: alloc=42, release=40 [ 108.319186] release: alloc=42, release=41 [ 108.356879] sleep_time=20 [ 108.358082] v4lvideo:[0]di release1 get=2044, put=2026, release=18 [ 108.358165] release: alloc=42, release=42 [ 108.358193] vc:[0]vc: set enable index=0, val=1 [ 108.358223] dev->index =0, val=2 [ 108.358227] VID: VD1 off [ 108.358233] VID: VD1 set global output as 1 [ 109.924715] type=1400 audit(1614939920.296:639): avc: denied { read } for comm="btvpropertyserv" name="u:object_r:shell_prop:s0" dev="tmpfs" ino=12133 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:shell_prop:s0 tclass=file permissive=0 duplicate messages suppressed [ 109.924764] type=1400 audit(1614939922.128:645): avc: denied { read } for comm="HwBinder:3522_3" name="u:object_r:shell_prop:s0" dev="tmpfs" ino=12133 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:shell_prop:s0 tclass=file permissive=0 [ 110.178140] audit: audit_lost=26 audit_rate_limit=5 audit_backlog_limit=64 [ 110.178148] audit: rate limit exceeded [ 116.576987] type=1400 audit(1614939923.948:654): avc: denied { read } for comm="HwBinder:3522_3" name="u:object_r:shell_prop:s0" dev="tmpfs" ino=12133 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:shell_prop:s0 tclass=file permissive=0 duplicate messages suppressed [ 116.577034] type=1400 audit(1614939928.784:655): avc: denied { read } for comm="HwBinder:3522_2" name="u:object_r:shell_prop:s0" dev="tmpfs" ino=12133 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:shell_prop:s0 tclass=file permissive=0 [ 119.602725] type=1400 audit(1614939928.784:656): avc: denied { read } for comm="HwBinder:3522_2" name="u:object_r:shell_prop:s0" dev="tmpfs" ino=12133 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:shell_prop:s0 tclass=file permissive=0 [ 119.602775] type=1400 audit(1614939931.808:657): avc: denied { read } for comm="btvpropertyserv" name="u:object_r:shell_prop:s0" dev="tmpfs" ino=12133 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:shell_prop:s0 tclass=file permissive=0 [ 121.213879] type=1400 audit(1614939933.324:660): avc: denied { read } for comm="btvpropertyserv" name="u:object_r:shell_prop:s0" dev="tmpfs" ino=12133 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:shell_prop:s0 tclass=file permissive=0 duplicate messages suppressed [ 121.213911] type=1400 audit(1614939933.420:661): avc: denied { read } for comm="HwBinder:3522_2" name="u:object_r:shell_prop:s0" dev="tmpfs" ino=12133 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:shell_prop:s0 tclass=file permissive=0 [ 124.141649] type=1400 audit(1614939933.936:662): avc: denied { read } for comm="HwBinder:3522_2" name="u:object_r:shell_prop:s0" dev="tmpfs" ino=12133 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:shell_prop:s0 tclass=file permissive=0 [ 124.141696] type=1400 audit(1614939936.348:663): avc: denied { read } for comm="btvpropertyserv" name="u:object_r:shell_prop:s0" dev="tmpfs" ino=12133 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:shell_prop:s0 tclass=file permissive=0 [ 125.049163] type=1400 audit(1614939936.348:663): avc: denied { read } for comm="btvpropertyserv" name="u:object_r:shell_prop:s0" dev="tmpfs" ino=12133 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:shell_prop:s0 tclass=file permissive=0 [ 125.049213] type=1400 audit(1614939937.252:664): avc: denied { read } for comm="HwBinder:3522_2" name="u:object_r:shell_prop:s0" dev="tmpfs" ino=12133 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:shell_prop:s0 tclass=file permissive=0 [ 125.520089] type=1400 audit(1614939937.252:664): avc: denied { read } for comm="HwBinder:3522_2" name="u:object_r:shell_prop:s0" dev="tmpfs" ino=12133 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:shell_prop:s0 tclass=file permissive=0 [ 125.520123] type=1400 audit(1614939937.724:665): avc: denied { read } for comm="HwBinder:3527_3" name="u:object_r:default_prop:s0" dev="tmpfs" ino=12060 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:default_prop:s0 tclass=file permissive=0 [ 125.597214] v4lvid: dbg: v4lvideo open [ 125.597226] v4lvideo:[0]open [ 125.597463] [store_mode]tsync_mode=1, buf=1 [ 125.597571] the demux clock on, ref cnt: 1 [ 125.597579] the parser_top clock on, ref cnt: 1 [ 125.597584] the vdec clock on, ref cnt: 1 [ 125.597605] the clk_vdec_mux clock on, ref cnt: 1 [ 125.597636] vdec mux clock is 499999992 Hz [ 125.597706] vdec_create instance 000000005be669f4, total 1 [ 125.597764] no drmmode [ 125.597843] vdec_init, dev_name:ammvdec_h264, vdec_type=VDEC_TYPE_FRAME_BLOCK [ 125.598561] ammvdec_h264_mmu_init tvp = 0x0 mmu_enable 0 [ 125.598568] decoder_bmmu_box_alloc_box, tvp_flags = 0 [ 125.598579] 0: ammvdec_h264_probe mmu_enable 0 double_write_mode 0x0 [ 125.599577] 0: ammvdec_h264 mem-addr=0,buff_offset=55010000,buf_start=56000000 [ 125.599618] vdec mux clock is 666666656 Hz [ 125.599623] vdec1 video changed to 3840 x 2160 60 fps clk->667MHZ [ 125.599629] H264 sysinfo: 1920x1080 duration=4000, pts_outside=0 [ 125.599632] sync_outside=0, use_idr_framerate=0, is_used_v4l: 0 [ 125.599701] [TEE], the fw (h264_multi) will be loaded. [ 125.599959] vh264_init, phy_addr=b7064000 vaddr=00000000323c6464 [ 125.600150] == vdec urgent clear ! [ 125.600167] vfm map vdec-map-0 created [ 125.600184] dim:ch[1]:di_receiver_event_fun,8:_REG [ 125.600188] dim:reg:vdec.h264.00[10] [ 125.600659] type=1400 audit(1614939937.736:667): avc: denied { read } for comm="HwBinder:3527_3" name="u:object_r:default_prop:s0" dev="tmpfs" ino=12060 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:default_prop:s0 tclass=file permissive=0 duplicate messages suppressed [ 125.600696] type=1400 audit(1614939937.804:668): avc: denied { read } for comm="btvpropertyserv" name="u:object_r:shell_prop:s0" dev="tmpfs" ino=12133 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:shell_prop:s0 tclass=file permissive=0 [ 125.608715] dim:ch[1]:reg end [ 125.608736] reg:v4lvideo [ 125.608745] dim:ch[1]:di_receiver_event_fun,3:_START [ 125.608752] vdec_init, vf_provider_name = vdec.h264.00 [ 125.609916] vdec->port_flag=0x102, port_flag=0x10b [ 125.669955] the demux clock on, ref cnt: 2 [ 125.669964] the parser_top clock on, ref cnt: 2 [ 125.960382] alloc: alloc=43, release=42 [ 125.960443] alloc: alloc=44, release=42 [ 125.960542] alloc: alloc=45, release=42 [ 125.960596] alloc: alloc=46, release=42 [ 125.960638] alloc: alloc=47, release=42 [ 125.960678] alloc: alloc=48, release=42 [ 125.960717] alloc: alloc=49, release=42 [ 125.960757] alloc: alloc=50, release=42 [ 125.960796] alloc: alloc=51, release=42 [ 125.960862] alloc: alloc=52, release=42 [ 125.960909] alloc: alloc=53, release=42 [ 125.960951] alloc: alloc=54, release=42 [ 125.960990] alloc: alloc=55, release=42 [ 125.961029] alloc: alloc=56, release=42 [ 125.961083] 0: AV_SCRATCH_1 = 41fe078, AV_SCRATCH_2 12077\x0d [ 125.961139] 0: frame_mbs_only_flag 0, crop_bottom 2, frame_height 1080, [ 125.961147] 0: mb_height 68,crop_right 0, frame_width 1920, mb_width 120 [ 125.961154] 0: mb height/widht/total: 44/78/1fe0 level_idc 28 max_ref_num 4 [ 125.961160] 0: restriction_flag=1, max_dec_frame_buffering=4, reorder_pic_num=5 [ 125.961166] 0: set reorder_pic_num to 4 [ 125.961173] 0: vh264_set_params active_buf_spec_num 13 reorder_pic_num 4 collocate_buf_num 8\x0d [ 126.025824] 0: num_ref_frames change from 0 to 4\x0d [ 126.041378] dim:dip_init_value_reg:ch[1]:fix_buf:0 [ 126.041395] dim:di_cnt_i_buf1:tvp:0 [ 126.041451] dim:pre_sec_alloc:no size [ 126.041456] dim:pst_sec_alloc:not alloc:0,0x0 [ 126.041462] dimh_patch_post_update_mc_sw:0x0->0x2 [ 126.088762] dim_pre_de_buf_config:ch[1]:4294793320ms 1th source change: [ 126.088770] source change:0x0/0/0/0=>0x8009/1920/1080/0 [ 126.088783] dimh_patch_post_update_mc_sw:0x2->0x3 [ 126.109332] v4lvideo: provider name: vdec.h264.00 [ 126.381472] healthd: battery l=42 v=4 t=42.4 h=2 st=2 c=1 fc=10000000 chg=u [ 127.070340] type=1400 audit(1614939937.804:668): avc: denied { read } for comm="btvpropertyserv" name="u:object_r:shell_prop:s0" dev="tmpfs" ino=12133 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:shell_prop:s0 tclass=file permissive=0 [ 127.070420] type=1400 audit(1614939939.276:669): avc: denied { read } for comm="HwBinder:3527_3" name="u:object_r:default_prop:s0" dev="tmpfs" ino=12060 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:default_prop:s0 tclass=file permissive=0 [ 144.136547] type=1400 audit(1614939956.276:686): avc: denied { read } for comm="HwBinder:3527_3" name="u:object_r:default_prop:s0" dev="tmpfs" ino=12060 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:default_prop:s0 tclass=file permissive=0 duplicate messages suppressed [ 144.136580] type=1400 audit(1614939956.340:687): avc: denied { read } for comm="btvpropertyserv" name="u:object_r:shell_prop:s0" dev="tmpfs" ino=12133 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:shell_prop:s0 tclass=file permissive=0 [ 145.070967] type=1400 audit(1614939956.340:687): avc: denied { read } for comm="btvpropertyserv" name="u:object_r:shell_prop:s0" dev="tmpfs" ino=12133 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:shell_prop:s0 tclass=file permissive=0 [ 145.071002] type=1400 audit(1614939957.276:688): avc: denied { read } for comm="HwBinder:3527_3" name="u:object_r:default_prop:s0" dev="tmpfs" ino=12060 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:default_prop:s0 tclass=file permissive=0 [ 186.382678] healthd: battery l=42 v=4 t=42.4 h=2 st=2 c=1 fc=10000000 chg=u [ 246.380626] healthd: battery l=42 v=4 t=42.4 h=2 st=2 c=1 fc=10000000 chg=u [ 306.381945] healthd: battery l=42 v=4 t=42.4 h=2 st=2 c=1 fc=10000000 chg=u [ 366.381105] healthd: battery l=42 v=4 t=42.4 h=2 st=2 c=1 fc=10000000 chg=u [ 426.380730] healthd: battery l=42 v=4 t=42.4 h=2 st=2 c=1 fc=10000000 chg=u [ 486.381417] healthd: battery l=42 v=4 t=42.4 h=2 st=2 c=1 fc=10000000 chg=u [ 546.380748] healthd: battery l=42 v=4 t=42.4 h=2 st=2 c=1 fc=10000000 chg=u [ 606.381519] healthd: battery l=42 v=4 t=42.4 h=2 st=2 c=1 fc=10000000 chg=u [ 666.382052] healthd: battery l=42 v=4 t=42.4 h=2 st=2 c=1 fc=10000000 chg=u [ 725.419414] type=1400 audit(1614940537.308:1268): avc: denied { read } for comm="HwBinder:3527_3" name="u:object_r:default_prop:s0" dev="tmpfs" ino=12060 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:default_prop:s0 tclass=file permissive=0 duplicate messages suppressed [ 725.419464] type=1400 audit(1614940537.624:1269): avc: denied { read } for comm="HwBinder:3522_3" name="u:object_r:shell_prop:s0" dev="tmpfs" ino=12133 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:shell_prop:s0 tclass=file permissive=0 [ 726.102579] type=1400 audit(1614940537.624:1269): avc: denied { read } for comm="HwBinder:3522_3" name="u:object_r:shell_prop:s0" dev="tmpfs" ino=12133 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:shell_prop:s0 tclass=file permissive=0 [ 726.102620] type=1400 audit(1614940538.308:1270): avc: denied { read } for comm="HwBinder:3527_3" name="u:object_r:default_prop:s0" dev="tmpfs" ino=12060 scontext=u:r:btvservice_hal:s0 tcontext=u:object_r:default_prop:s0 tclass=file permissive=0 [ 726.381235] healthd: battery l=42 v=4 t=42.4 h=2 st=2 c=1 fc=10000000 chg=u [ 753.344590] vdec_ready_to_run vdec[ffffff800bbd5000]: 227059 > 227058 [ 753.345793] vdec_ready_to_run vdec[ffffff800bbd5000]: 227059 > 227058 [ 786.381200] healthd: battery l=42 v=4 t=42.4 h=2 st=2 c=1 fc=10000000 chg=u [ 846.380806] healthd: battery l=42 v=4 t=42.4 h=2 st=2 c=1 fc=10000000 chg=u [ 859.279542] vdec_ready_to_run vdec[ffffff800bbd5000]: 265469 > 265468 [ 874.359569] vdec_ready_to_run vdec[ffffff800bbd5000]: 270923 > 270922 [ 906.380948] healthd: battery l=42 v=4 t=42.4 h=2 st=2 c=1 fc=10000000 chg=u [ 966.381083] healthd: battery l=42 v=4 t=42.4 h=2 st=2 c=1 fc=10000000 chg=u [ 988.237174] vdec_ready_to_run vdec[ffffff800bbd5000]: 312105 > 312104 [ 1026.381598] healthd: battery l=42 v=4 t=42.4 h=2 st=2 c=1 fc=10000000 chg=u [ 1086.380878] healthd: battery l=42 v=4 t=42.4 h=2 st=2 c=1 fc=10000000 chg=u [ 1146.381380] healthd: battery l=42 v=4 t=42.4 h=2 st=2 c=1 fc=10000000 chg=u [ 1196.223907] logd: logdr: UID=10005 GID=10005 PID=4603 n tail=0 logMask=4 pid=0 start=0ns timeout=0ns [ 1206.380748] healthd: battery l=42 v=4 t=42.4 h=2 st=2 c=1 fc=10000000 chg=u [ 1266.380986] healthd: battery l=42 v=4 t=42.4 h=2 st=2 c=1 fc=10000000 chg=u [ 1282.587695] android_work: did not send uevent (0 0 (null)) [ 1282.665182] read descriptors [ 1282.665200] read strings [ 1290.241879] vdec_ready_to_run vdec[ffffff800bbd5000]: 421394 > 421393