TinkerBoard / android-7.1.2_kernel

Android Kernel source for Tinker Board
Other
13 stars 10 forks source link

HDMI CEC #16

Open metropt opened 5 years ago

metropt commented 5 years ago

HDMI CEC isn't working on a LG TV and an HDMI cable that support HDMI CEC (it is working with other devices).

I got this message "[ 1589.659823] Info: dw_hdmi_cec_hardirq stat = 2" on dmesg. Can you help me to identify the problem??

jamess-huang commented 5 years ago

Can you give us the fail log ? including the whole kernel log and android logcat.

jamess-huang commented 5 years ago

HI, metropt Just found your POST on the forum. Have you reworked the CEC H/W on Tinker Board by yourself ?

metropt commented 5 years ago

Hi @jamess-huang Please see below the dmesg output. Yes, I have reworked the CEC H/W on Tinker Board.

[    1.403079] dwmmc_rockchip ff0d0000.dwmmc: No vqmmc regulator found
[    1.403095] dwmmc_rockchip ff0d0000.dwmmc: GPIO lookup for consumer wp
[    1.403103] dwmmc_rockchip ff0d0000.dwmmc: using device tree for GPIO lookup
[    1.403111] of_get_named_gpiod_flags: can't parse 'wp-gpios' property of node '/dwmmc@ff0d0000[0]'
[    1.403119] of_get_named_gpiod_flags: can't parse 'wp-gpio' property of node '/dwmmc@ff0d0000[0]'
[    1.403126] dwmmc_rockchip ff0d0000.dwmmc: using lookup tables for GPIO lookup
[    1.403135] dwmmc_rockchip ff0d0000.dwmmc: lookup for GPIO wp failed
[    1.403658] of_get_named_gpiod_flags: can't parse 'maskrom_gpio' property of node '/dwmmc@ff0f0000[0]'
[    1.403673] dwmmc_rockchip ff0f0000.dwmmc: IDMAC supports 32-bit address mode.
[    1.403714] dwmmc_rockchip ff0f0000.dwmmc: Using internal DMA controller.
[    1.403730] dwmmc_rockchip ff0f0000.dwmmc: Version ID is 270a
[    1.403768] dwmmc_rockchip ff0f0000.dwmmc: DW MMC controller at irq 31,32 bit host data width,256 deep fifo
[    1.403787] dwmmc_rockchip ff0f0000.dwmmc: 'clock-freq-min-max' property was deprecated.
[    1.403815] dwmmc_rockchip ff0f0000.dwmmc: No vmmc regulator found
[    1.404845] dwmmc_rockchip ff0f0000.dwmmc: No vqmmc regulator found
[    1.404861] dwmmc_rockchip ff0f0000.dwmmc: GPIO lookup for consumer wp
[    1.404869] dwmmc_rockchip ff0f0000.dwmmc: using device tree for GPIO lookup
[    1.404878] of_get_named_gpiod_flags: can't parse 'wp-gpios' property of node '/dwmmc@ff0f0000[0]'
[    1.404886] of_get_named_gpiod_flags: can't parse 'wp-gpio' property of node '/dwmmc@ff0f0000[0]'
[    1.404894] dwmmc_rockchip ff0f0000.dwmmc: using lookup tables for GPIO lookup
[    1.404902] dwmmc_rockchip ff0f0000.dwmmc: lookup for GPIO wp failed
[    1.419538] mmc_host mmc1: Bus speed (slot 0) = 400000Hz (slot req 400000Hz, actual 400000HZ div = 0)
[    1.421409] rockchip-iodomain ff770000.syscon:io-domains: Setting to 3300000 done
[    1.421519] rockchip-iodomain ff770000.syscon:io-domains: Setting to 1800000 done
[    1.433865] dwmmc_rockchip ff0f0000.dwmmc: 1 slots initialized
[    1.434183] of_get_named_gpiod_flags: parsed 'gpios' property of node '/gpio-leds/pwr-led[0]' - status (0)
[    1.436307] of_get_named_gpiod_flags: parsed 'gpios' property of node '/gpio-leds/act-led[0]' - status (0)
[    1.436407] of_get_named_gpiod_flags: parsed 'gpios' property of node '/gpio-leds/led1-led[0]' - status (0)
[    1.441909] mmc_host mmc0: Bus speed (slot 0) = 148500000Hz (slot req 150000000Hz, actual 148500000HZ div = 0)
[    1.446189] hidraw: raw HID events driver (C) Jiri Kosina
[    1.449873] input: Generic USB Audio as /devices/platform/ff500000.usb/usb2/2-1/2-1:1.255/0003:0BDA:481A.0001/input/input1
[    1.502984] hid-generic 0003:0BDA:481A.0001: input,hiddev0,hidraw0: USB HID v1.11 Device [Generic USB Audio] on usb-ff500000.usb-1/input255
[    1.503037] usbcore: registered new interface driver usbhid
[    1.503043] usbhid: USB HID core driver
[    1.503153] inv_mpu_iio: inv_mpu_init:746
[    1.503526] ashmem: initialized
[    1.505542] rknandbase v1.1 2016-11-08
[    1.505679] rknand: probe of ff400000.nandc failed with error -1
[    1.505713] [board_info] create Board_info_proc_file sucessed!
[    1.505763] project_id_2:0x1, project_id_1:0x1, project_id_0:0x1
[    1.505796] ram_id_2:0x0, ram_id_1:0x1, ram_id_0:0x0
[    1.505828] pcb_id_2:0x0, pcb_id_1:0x1, pcb_id_0:0x0
[    1.506034] find panel: asus,tc358762
[    1.506051] ff960000.dsi.0 supply power not found, using dummy regulator
[    1.506083] bridge-tc358762-dsi ff960000.dsi.0: GPIO lookup for consumer enable
[    1.506090] bridge-tc358762-dsi ff960000.dsi.0: using device tree for GPIO lookup
[    1.506096] of_get_named_gpiod_flags: can't parse 'enable-gpios' property of node '/dsi@ff960000/mipi-panel[0]'
[    1.506101] of_get_named_gpiod_flags: can't parse 'enable-gpio' property of node '/dsi@ff960000/mipi-panel[0]'
[    1.506107] bridge-tc358762-dsi ff960000.dsi.0: using lookup tables for GPIO lookup
[    1.506137] bridge-tc358762-dsi ff960000.dsi.0: lookup for GPIO enable failed
[    1.506219] rockchip-drm display-subsystem: devfreq is not set
[    1.506373] rockchip-vop ff930000.vop: invalid resource
[    1.506382] rockchip-vop ff930000.vop: failed to get vop cabc lut registers
[    1.506716] rockchip-drm display-subsystem: bound ff930000.vop (ops vop_component_ops)
[    1.506750] rockchip-vop ff940000.vop: invalid resource
[    1.506758] rockchip-vop ff940000.vop: failed to get vop cabc lut registers
[    1.507065] rockchip-drm display-subsystem: bound ff940000.vop (ops vop_component_ops)
[    1.507277] i2c i2c-6: of_i2c: modalias failure on /hdmi@ff980000/ports
[    1.507294] dwhdmi-rockchip ff980000.hdmi: registered DesignWare HDMI I2C bus driver
[    1.507347] dwhdmi-rockchip ff980000.hdmi: Detected HDMI TX controller v2.00a with HDCP (DWC MHL PHY)
[    1.508191] rockchip-drm display-subsystem: bound ff980000.hdmi (ops dw_hdmi_rockchip_ops)
[    1.508248] panel doesn't be connected
[    1.508264] rockchip-drm display-subsystem: bound ff960000.dsi (ops dw_mipi_dsi_ops)
[    1.508272] [drm] Supports vblank timestamp caching Rev 2 (21.10.2013).
[    1.508277] [drm] No driver support for vblank timestamp query.
[    1.509466] usb 1-1.2: new low-speed USB device number 3 using dwc2
[    1.585669] dwmmc_rockchip ff0c0000.dwmmc: Successfully tuned phase to 335
[    1.585686] mmc0: new ultra high speed SDR104 SDHC card at address 0007
[    1.585952] mmcblk0: mmc0:0007 SD16G 14.5 GiB
[    1.586215]      uboot: 0x000400000 -- 0x000800000 (4 MB)
[    1.586223]      trust: 0x000800000 -- 0x000c00000 (4 MB)
[    1.586230]       misc: 0x000c00000 -- 0x001000000 (4 MB)
[    1.586236]   resource: 0x001000000 -- 0x002000000 (16 MB)
[    1.586242]     kernel: 0x002000000 -- 0x003800000 (24 MB)
[    1.586248]       boot: 0x003800000 -- 0x005800000 (32 MB)
[    1.586253]   recovery: 0x005800000 -- 0x007800000 (32 MB)
[    1.586259]     backup: 0x007800000 -- 0x00e800000 (112 MB)
[    1.586265]      cache: 0x00e800000 -- 0x016800000 (128 MB)
[    1.586270]     system: 0x016800000 -- 0x096800000 (2048 MB)
[    1.586276]   metadata: 0x096800000 -- 0x097800000 (16 MB)
[    1.586282]    vendor0: 0x097800000 -- 0x09aa00000 (50 MB)
[    1.586288]    vendor1: 0x09aa00000 -- 0x09dc00000 (50 MB)
[    1.586293]   userdata: 0x09dc00000 -- 0x3a1000000 (12340 MB)
[    1.586298]  mmcblk0: p1 p2 p3 p4 p5 p6 p7 p8 p9 p10 p11 p12 p13 p14
[    1.642993] usb 1-1.2: New USB device found, idVendor=15ca, idProduct=00c3
[    1.643006] usb 1-1.2: New USB device strings: Mfr=0, Product=2, SerialNumber=0
[    1.643013] usb 1-1.2: Product: USB Optical Mouse
[    1.696934] input: USB Optical Mouse as /devices/platform/ff540000.usb/usb1/1-1/1-1.2/1-1.2:1.0/0003:15CA:00C3.0002/input/input2
[    1.749870] hid-generic 0003:15CA:00C3.0002: input,hidraw1: USB HID v1.10 Mouse [USB Optical Mouse] on usb-ff540000.usb-1.2/input0
[    1.758422] rockchip-drm display-subsystem: fb0:  frame buffer device
[    1.770234] ALSA sound/usb/card.c:391 onboard usb card
[    1.939452] dwmmc_rockchip ff0f0000.dwmmc: Busy; trying anyway
[    1.939464] mmc_host mmc1: Timeout sending command (cmd 0x202000 arg 0x0 status 0x0)
[    2.153446] random: nonblocking pool is initialized
[    3.891258] usbcore: registered new interface driver snd-usb-audio
[    3.899029] of_get_named_gpiod_flags: can't parse 'realtek,ldo1-en-gpios' property of node '/i2c@ff660000/rt5640@1c[0]'
[    3.914556] u32 classifier
[    3.914572]     Actions configured
[    3.914606] Netfilter messages via NETLINK v0.30.
[    3.914658] nf_conntrack version 0.5.0 (16384 buckets, 65536 max)
[    3.915037] ctnetlink v0.93: registering with nfnetlink.
[    3.915565] xt_time: kernel timezone is -0000
[    3.915971] ip_tables: (C) 2000-2006 Netfilter Core Team
[    3.916164] arp_tables: (C) 2002 David S. Miller
[    3.916284] Initializing XFRM netlink socket
[    3.916697] NET: Registered protocol family 10
[    3.917417] mip6: Mobile IPv6
[    3.917447] ip6_tables: (C) 2000-2006 Netfilter Core Team
[    3.917845] sit: IPv6 over IPv4 tunneling driver
[    3.918291] NET: Registered protocol family 17
[    3.918318] NET: Registered protocol family 15
[    3.918354] bridge: automatic filtering via arp/ip/ip6tables has been deprecated. Update your scripts to load br_netfilter if you need this.
[    3.918535] Bridge firewalling registered
[    3.918550] Ebtables v2.0 registered
[    3.918682] Bluetooth: RFCOMM TTY layer initialized
[    3.918700] Bluetooth: RFCOMM socket layer initialized
[    3.918723] Bluetooth: RFCOMM ver 1.11
[    3.918742] Bluetooth: BNEP (Ethernet Emulation) ver 1.3
[    3.918751] Bluetooth: BNEP filters: protocol multicast
[    3.918763] Bluetooth: BNEP socket layer initialized
[    3.918774] Bluetooth: HIDP (Human Interface Emulation) ver 1.2
[    3.918786] Bluetooth: HIDP socket layer initialized
[    3.918815] l2tp_core: L2TP core driver, V2.0
[    3.918833] l2tp_ppp: PPPoL2TP kernel driver, V2.0
[    3.918849] [WLAN_RFKILL]: Enter rfkill_wlan_init
[    3.919047] [WLAN_RFKILL]: Enter rfkill_wlan_probe
[    3.919079] [WLAN_RFKILL]: wlan_platdata_parse_dt: wifi_chip_type = rtl8723bs
[    3.919089] [WLAN_RFKILL]: wlan_platdata_parse_dt: enable wifi power control.
[    3.919097] [WLAN_RFKILL]: wlan_platdata_parse_dt: wifi power controled by gpio.
[    3.919107] of_get_named_gpiod_flags: can't parse 'WIFI,poweren_gpio' property of node '/wireless-wlan[0]'
[    3.919115] of_get_named_gpiod_flags: can't parse 'WIFI,vbat_gpio' property of node '/wireless-wlan[0]'
[    3.919122] of_get_named_gpiod_flags: can't parse 'WIFI,reset_gpio' property of node '/wireless-wlan[0]'
[    3.919150] of_get_named_gpiod_flags: parsed 'WIFI,host_wake_irq' property of node '/wireless-wlan[0]' - status (0)
[    3.919158] [WLAN_RFKILL]: wlan_platdata_parse_dt: get property: WIFI,host_wake_irq = 150, flags = 0.
[    3.919168] [WLAN_RFKILL]: rfkill_wlan_probe: init gpio
[    3.919178] [WLAN_RFKILL]: Exit rfkill_wlan_probe
[    3.919248] [BT_RFKILL]: Enter rfkill_rk_init
[    3.919563] of_get_named_gpiod_flags: parsed 'uart_rts_gpios' property of node '/wireless-bluetooth[0]' - status (0)
[    3.919573] [BT_RFKILL]: bluetooth_platdata_parse_dt: get property: uart_rts_gpios = 139.
[    3.919586] of_get_named_gpiod_flags: can't parse 'BT,power_gpio' property of node '/wireless-bluetooth[0]'
[    3.919607] of_get_named_gpiod_flags: parsed 'BT,reset_gpio' property of node '/wireless-bluetooth[0]' - status (0)
[    3.919614] [BT_RFKILL]: bluetooth_platdata_parse_dt: get property: BT,reset_gpio = 149.
[    3.919635] of_get_named_gpiod_flags: parsed 'BT,wake_gpio' property of node '/wireless-bluetooth[0]' - status (0)
[    3.919642] [BT_RFKILL]: bluetooth_platdata_parse_dt: get property: BT,wake_gpio = 146.
[    3.919663] of_get_named_gpiod_flags: parsed 'BT,wake_host_irq' property of node '/wireless-bluetooth[0]' - status (0)
[    3.919670] [BT_RFKILL]: bluetooth_platdata_parse_dt: get property: BT,wake_host_irq = 151.
[    3.919683] [BT_RFKILL]: bluetooth_platdata_parse_dt: clk_get failed!!!.
[    3.919728] [BT_RFKILL]: Request irq for bt wakeup host
[    3.919758] [BT_RFKILL]: BT_WAKE_HOST IRQ fired
[    3.919775] [BT_RFKILL]: ** disable irq
[    3.919892] [BT_RFKILL]: bt_default device registered.
[    3.920041] sensor_register_slave:mpu6880_gyro,id=49
[    3.921443] Registering SWP/SWPB emulation handler
[    3.922020] registered taskstats version 1
[    3.922481] rockchip ion idev is NULL
[    3.922496] rga2 ff920000.rga: rga ion client create success!
[    3.922656] rga: Driver loaded successfully ver:2.00
[    3.923671] W : [File] : drivers/gpu/arm/midgard/platform/rk/mali_kbase_config_rk.c; [Line] : 113; [Func] : kbase_platform_rk_init(); power-off-delay-ms not available.
[    3.923945] mali ffa30000.gpu: GPU identified as 0x0750 r0p0 status 1
[    3.924094] mali ffa30000.gpu: Protected mode not available
[    3.924424] mali ffa30000.gpu: Error -22, no DT entry: mali-simple-power-model.static-coefficient = 1*[0]
[    3.924444] mali ffa30000.gpu: Error -22, no DT entry: mali-simple-power-model.dynamic-coefficient = 1*[0]
[    3.924470] mali ffa30000.gpu: Using configured power model mali-simple-power-model, and fallback mali-simple-power-model
[    3.924574] I : [File] : drivers/gpu/arm/midgard/backend/gpu/mali_kbase_devfreq.c; [Line] : 381; [Func] : kbase_devfreq_init(); success initing power_model_simple.
[    3.924997] mali ffa30000.gpu: Probed as mali0
[    3.925651] rk_gmac-dwmac ff290000.ethernet: clock input or output? (input).
[    3.925667] rk_gmac-dwmac ff290000.ethernet: TX delay(0x30).
[    3.925679] rk_gmac-dwmac ff290000.ethernet: RX delay(0x10).
[    3.925700] rk_gmac-dwmac ff290000.ethernet: integrated PHY? (no).
[    3.925805] rk_gmac-dwmac ff290000.ethernet: cannot get clock clk_mac_speed
[    3.925815] rk_gmac-dwmac ff290000.ethernet: clock input from PHY
[    3.930833] rk_gmac-dwmac ff290000.ethernet: init for RGMII
[    3.930921] stmmac - user ID: 0x10, Synopsys ID: 0x35
[    3.930929]  Ring mode enabled
[    3.930937]  DMA HW capability register supported
[    3.930944]  Normal descriptors
[    3.930952]  RX Checksum Offload Engine supported (type 2)
[    3.930958]  TX Checksum insertion supported
[    3.930964]  Wake-Up On Lan supported
[    3.931004]  Enable RX Mitigation via HW Watchdog Timer
[    3.931104] of_get_named_gpiod_flags: parsed 'snps,reset-gpio' property of node '/ethernet@ff290000[0]' - status (0)
[    3.943001] devfreq ffa30000.gpu: Couldn't update frequency transition information.
[    4.952302] libphy: stmmac: probed
[    4.952452] eth%d: PHY ID 001cc915 at 0 IRQ POLL (stmmac-0:00) active
[    4.952537] eth%d: PHY ID 001cc915 at 5 IRQ POLL (stmmac-0:05)
[    4.958957] rockchip-thermal ff280000.tsadc: Missing rockchip,grf property
[    4.959367] rk_tsadcv2_temp_to_code: Invalid conversion table: code=4095, temperature=2147483647
[    4.963802] of_get_named_gpiod_flags: can't parse 'maskrom_gpio' property of node '/dwmmc@ff0d0000[0]'
[    4.963905] dwmmc_rockchip ff0d0000.dwmmc: IDMAC supports 32-bit address mode.
[    4.964621] dwmmc_rockchip ff0d0000.dwmmc: Using internal DMA controller.
[    4.964737] dwmmc_rockchip ff0d0000.dwmmc: Version ID is 270a
[    4.964922] dwmmc_rockchip ff0d0000.dwmmc: DW MMC controller at irq 30,32 bit host data width,256 deep fifo
[    4.965106] dwmmc_rockchip ff0d0000.dwmmc: 'clock-freq-min-max' property was deprecated.
[    4.965332] dwmmc_rockchip ff0d0000.dwmmc: No vmmc regulator found
[    4.965411] dwmmc_rockchip ff0d0000.dwmmc: No vqmmc regulator found
[    4.965523] dwmmc_rockchip ff0d0000.dwmmc: GPIO lookup for consumer wp
[    4.965582] dwmmc_rockchip ff0d0000.dwmmc: using device tree for GPIO lookup
[    4.965647] of_get_named_gpiod_flags: can't parse 'wp-gpios' property of node '/dwmmc@ff0d0000[0]'
[    4.965707] of_get_named_gpiod_flags: can't parse 'wp-gpio' property of node '/dwmmc@ff0d0000[0]'
[    4.965766] dwmmc_rockchip ff0d0000.dwmmc: using lookup tables for GPIO lookup
[    4.965825] dwmmc_rockchip ff0d0000.dwmmc: lookup for GPIO wp failed
[    4.966887] platform sdio-pwrseq: GPIO lookup for consumer reset
[    4.966931] platform sdio-pwrseq: using device tree for GPIO lookup
[    4.967024] of_get_named_gpiod_flags: parsed 'reset-gpios' property of node '/sdio-pwrseq[0]' - status (0)
[    4.967122] platform sdio-pwrseq: GPIO lookup for consumer reset
[    4.967159] platform sdio-pwrseq: using device tree for GPIO lookup
[    4.967294] of_get_named_gpiod_flags: parsed 'reset-gpios' property of node '/sdio-pwrseq[1]' - status (0)
[    4.967373] dwmmc_rockchip ff0d0000.dwmmc: allocated mmc-pwrseq
[    4.979659] mmc_host mmc2: Bus speed (slot 0) = 400000Hz (slot req 400000Hz, actual 400000HZ div = 0)
[    4.993148] dwmmc_rockchip ff0d0000.dwmmc: 1 slots initialized
[    4.993750] of_get_named_gpiod_flags: can't parse 'realtek,ldo1-en-gpios' property of node '/i2c@ff660000/rt5640@1c[0]'
[    4.999232] of_get_named_gpiod_flags: parsed 'simple-audio-card,hp-det-gpio' property of node '/sound-simple-card[0]' - status (0)
[    4.999284] of_get_named_gpiod_flags: can't parse 'simple-audio-card,mic-det-gpio' property of node '/sound-simple-card[0]'
[    5.000261] asoc-simple-card sound-simple-card: audio jack plug out
[    5.000435] asoc-simple-card sound-simple-card: call_usermodehelper fail, ret=-2, status=0
[    5.000451] asoc-simple-card sound-simple-card: ASoC: DAPM unknown pin Headphones
[    5.001205] asoc-simple-card sound-simple-card: i2s-hifi <-> ff890000.i2s mapping ok
[    5.001726] input: rockchip,miniarm-codec Headphones as /devices/platform/sound-simple-card/sound/card0/input3
[    5.002085] of_get_named_gpiod_flags: can't parse 'realtek,ldo1-en-gpios' property of node '/i2c@ff660000/rt5640@1c[0]'
[    5.002492]
[    5.002502] =======================================================
[    5.002510] ==== Launching Wi-Fi driver! (Powered by Rockchip) ====
[    5.002517] =======================================================
[    5.002526] Realtek 8723BS SDIO WiFi driver (Powered by Rockchip,Ver v5.1.7.4_24878.20171031_BTCOEX20170728-6b4e) init.
[    5.002536] [WLAN_RFKILL]: rockchip_wifi_power: 1
[    5.002544] [WLAN_RFKILL]: wifi turn on power. -1
[    5.002552] mmc2:mmc host rescan start!
[    5.009140] mmc_host mmc2: Bus speed (slot 0) = 49500000Hz (slot req 50000000Hz, actual 49500000HZ div = 0)
[    5.009845] mmc2: new high speed SDIO card at address 0001
[    5.049697] of_get_named_gpiod_flags: can't parse 'realtek,ldo1-en-gpios' property of node '/i2c@ff660000/rt5640@1c[0]'
[    5.149472] asoc-simple-card sound-simple-card: audio jack plug out
[    5.149618] asoc-simple-card sound-simple-card: call_usermodehelper fail, ret=-2, status=0
[    5.149628] asoc-simple-card sound-simple-card: ASoC: DAPM unknown pin Headphones
[    6.003078] otg_wakelock_init: No USB transceiver found
[    6.006355] rk808-rtc rk808-rtc: setting system clock to 2013-01-18 08:50:12 UTC (1358499012)
[    6.048160] vcc_sd: disabling
[    6.048332] I : [File] : drivers/gpu/arm/mali400/mali/linux/mali_kernel_linux.c; [Line] : 415; [Func] : mali_module_init(); svn_rev_string_from_arm of this mali_ko is '-607f6fc1c627', rk_ko_ver is '5', built at '11:19:12', on 'Jan  3 2019'.
[    6.048559] Mali: Mali device driver loaded
[    6.048817] of_get_named_gpiod_flags: parsed 'gpios' property of node '/rockchip-key/power-key[0]' - status (0)
[    6.048839] of_get_named_gpiod_flags: parsed 'gpios' property of node '/rockchip-key/power-key[0]' - status (0)
[    6.048994] input: rk29-keypad as /devices/platform/rockchip-key/input/input4
[    6.049496] of_get_named_gpiod_flags: can't parse 'realtek,ldo1-en-gpios' property of node '/i2c@ff660000/rt5640@1c[0]'
[    6.049645] ALSA device list:
[    6.049657]   #0: rockchip,miniarm-codec
[    6.049665]   #3: Generic USB Audio at usb-ff500000.usb-1, high speed
[    6.050681] Freeing unused kernel memory: 1024K
[    6.053412] init: init first stage started!
[    6.057015] SELinux: 2048 avtab hash slots, 7922 rules.
[    6.061327] SELinux: 2048 avtab hash slots, 7922 rules.
[    6.061345] SELinux:  1 users, 2 roles, 738 types, 0 bools, 1 sens, 1024 cats
[    6.061358] SELinux:  63 classes, 7922 rules
[    6.062880] SELinux:  Completing initialization.
[    6.062890] SELinux:  Setting up existing superblocks.
[    6.102926] audit: type=1403 audit(1358499012.593:2): policy loaded auid=4294967295 ses=4294967295
[    6.103391] init: (Initializing SELinux non-enforcing took 0.05s.)
[    6.106486] init: init second stage started!
[    6.111013] init: Setting ro.rk.soc=rk3288
[    6.111120] init: OK,SD DRIVERS INIT OK
[    6.111300] init: property_set("ro.hardware", "rk30board") failed
[    6.113476] init: Running restorecon...
[    6.150964] init: waitpid failed: No child processes
[    6.151332] init: (Loading properties from /default.prop took 0.00s.)
[    6.153534] init: (Parsing /init.environ.rc took 0.00s.)
[    6.154040] init: (Parsing /init.usb.rc took 0.00s.)
[    6.155075] init: (Parsing init.rk30board.bootmode.sd.rc took 0.00s.)
[    6.156071] init: (Parsing init.rk30board.usb.rc took 0.00s.)
[    6.156197] init: (Parsing init.rk30board.environment.rc took 0.00s.)
[    6.156239] init: could not import file '/init.debug.rc' from 'init.rockchip.rc': No such file or directory
[    6.156257] init: (Parsing init.rockchip.rc took 0.00s.)
[    6.156785] init: (Parsing init.connectivity.rc took 0.00s.)
[    6.156822] init: could not import file 'init.box.samba.rc' from '/init.rk30board.rc': No such file or directory
[    6.157027] init: (Parsing init.rk3288.rc took 0.00s.)
[    6.157062] init: could not import file 'init.tablet.rc' from '/init.rk30board.rc': No such file or directory
[    6.157091] init: could not import file 'init.car.rc' from '/init.rk30board.rc': No such file or directory
[    6.157143] init: (Parsing init.optee.rc took 0.00s.)
[    6.157217] init: (Parsing init.asus.rc took 0.00s.)
[    6.157235] init: (Parsing /init.rk30board.rc took 0.00s.)
[    6.158046] init: (Parsing /init.usb.configfs.rc took 0.00s.)
[    6.158145] init: (Parsing /init.zygote32.rc took 0.00s.)
[    6.158164] init: (Parsing /init.rc took 0.01s.)
[    6.158599] init: Starting service 'ueventd'...
[    6.160332] audit: type=1400 audit(1358499012.650:3): avc:  denied  { getattr } for  pid=1 comm="init" path="/sys/kernel/debug/tracing/trace_marker" dev="tracefs" ino=2059 scontext=u:r:init:s0 tcontext=u:object_r:debugfs_trace_marker:s0 tclass=file permissive=1
[    6.160689] ueventd: ueventd started!
[    6.161374] ueventd: invalid gid 'trace'
[    6.332070] ueventd: Coldboot took 0.17s.
[    6.482930] init: Waiting for /dev/.coldboot_done...
[    6.482979] init: Waiting for /dev/.coldboot_done took 0.00s.
[    6.483016] init: /dev/hw_random not found
[    6.536122] keychord: using input dev Generic USB Audio for fevent
[    6.536140] keychord: using input dev rk29-keypad for fevent
[    6.546299] init: write_file: Unable to open '/proc/sys/abi/swp': No such file or directory
[    6.546469] init: write_file: Unable to open '/sys/module/rockchip_pm/parameters/policy': No such file or directory
[    6.546862] fs_mgr: Warning: unknown flag resize
[    6.547049] init: /dev/hw_random not found
[    6.547659] fs_mgr: Warning: unknown flag resize
[    6.555800] EXT4-fs (mmcblk0p10): mounted filesystem with ordered data mode. Opts: noauto_da_alloc
[    6.555904] fs_mgr: __mount(source=/dev/block/platform/ff0c0000.dwmmc/by-name/system,target=/system,type=ext4)=0
[    6.560035] EXT4-fs (mmcblk0p12): mounted filesystem with ordered data mode. Opts: noauto_da_alloc,discard
[    6.560087] fs_mgr: __mount(source=/dev/block/platform/ff0c0000.dwmmc/by-name/vendor0,target=/vendor,type=ext4)=0
[    6.560418] fs_mgr: check_fs(): mount(/dev/block/platform/ff0c0000.dwmmc/by-name/cache,/cache,ext4)=-1: No such file or directory
[    6.561914] fs_mgr: Running /system/bin/e2fsck on /dev/block/platform/ff0c0000.dwmmc/by-name/cache
[    6.643284] audit: type=1400 audit(1358499013.133:4): avc:  denied  { getattr } for  pid=169 comm="e2fsck" path="/dev/block/mmcblk0p9" dev="tmpfs" ino=8936 scontext=u:r:fsck:s0 tcontext=u:object_r:block_device:s0 tclass=blk_file permissive=1
[    6.643418] audit: type=1400 audit(1358499013.133:5): avc:  denied  { read } for  pid=169 comm="e2fsck" name="mmcblk0p9" dev="tmpfs" ino=8936 scontext=u:r:fsck:s0 tcontext=u:object_r:block_device:s0 tclass=blk_file permissive=1
[    6.643443] audit: type=1400 audit(1358499013.133:6): avc:  denied  { open } for  pid=169 comm="e2fsck" path="/dev/block/mmcblk0p9" dev="tmpfs" ino=8936 scontext=u:r:fsck:s0 tcontext=u:object_r:block_device:s0 tclass=blk_file permissive=1
[    6.643523] audit: type=1400 audit(1358499013.133:7): avc:  denied  { write } for  pid=169 comm="e2fsck" name="mmcblk0p9" dev="tmpfs" ino=8936 scontext=u:r:fsck:s0 tcontext=u:object_r:block_device:s0 tclass=blk_file permissive=1
[    6.643564] audit: type=1400 audit(1358499013.133:8): avc:  denied  { ioctl } for  pid=169 comm="e2fsck" path="/dev/block/mmcblk0p9" dev="tmpfs" ino=8936 ioctlcmd=127c scontext=u:r:fsck:s0 tcontext=u:object_r:block_device:s0 tclass=blk_file permissive=1
[    6.939463] vendor storage:20160801 ret = -1
[    8.749456] [otg id chg] last id -1 current id 1
[    8.749481] PortPower off
[    8.749491] rk_battery_charger_detect_cb , battery_charger_detect 6
[    8.850526] Using Buffer DMA mode
[    8.850536] Periodic Transfer Interrupt Enhancement - disabled
[    8.850542] Multiprocessor Interrupt Enhancement - disabled
[    8.850548] OTG VER PARAM: 0, OTG VER FLAG: 0
[    8.850553] ^^^^^^^^^^^^^^^^^Device Mode
[    8.850565] dwc_otg_hcd_resume, usb device mode
[    8.952812] dwc_otg_hcd_suspend, usb device mode
[    9.349454] ***************vbus detect*****************
[    9.394900] e2fsck: e2fsck 1.42.9 (28-Dec-2013)
[    9.394900]
[    9.394940] e2fsck: Superblock last mount time is in the future.
[    9.394940]
[    9.394952] e2fsck:  (by less than a day, probably due to the hardware clock being incorrectly set)  Fix? yes
[    9.394952]
[    9.394963] e2fsck:
[    9.394963]
[    9.394972] e2fsck: Superblock last write time (__bionic_open_tzdata_path: ANDROID_DATA not set!
[    9.394972]
[    9.394982] e2fsck: __bionic_open_tzdata_path: ANDROID_ROOT not set!
[    9.394982]
[    9.394992] e2fsck: Sat Apr 13 23:23:47 2019,
[    9.394992]
[    9.395001] e2fsck:  now = Fri Jan 18 08:50:13 2013) is in the future.
[    9.395001]
[    9.395010] e2fsck: Fix? yes
[    9.395010]
[    9.395019] e2fsck:
[    9.395019]
[    9.395028] e2fsck: /dev/block/platform/ff0c0000.dwmmc/by-name/cache: clean, 19/8192 files, 1570/32768 blocks
[    9.395028]
[    9.560360] EXT4-fs (mmcblk0p9): mounted filesystem with ordered data mode. Opts: noauto_da_alloc,discard
[    9.560438] fs_mgr: __mount(source=/dev/block/platform/ff0c0000.dwmmc/by-name/cache,target=/cache,type=ext4)=0
[    9.562538] EXT4-fs (mmcblk0p11): Ignoring removed nomblk_io_submit option
[    9.697812] EXT4-fs (mmcblk0p11): mounted filesystem with ordered data mode. Opts: errors=remount-ro,nomblk_io_submit
[    9.697863] fs_mgr: check_fs(): mount(/dev/block/platform/ff0c0000.dwmmc/by-name/metadata,/metadata,ext4)=0: Success
[    9.749662] rk_battery_charger_detect_cb , battery_charger_detect 2
[    9.870873] fs_mgr: check_fs(): unmount(/metadata) succeeded
[    9.870905] fs_mgr: Running /system/bin/e2fsck on /dev/block/platform/ff0c0000.dwmmc/by-name/metadata
[    9.891684] e2fsck: e2fsck 1.42.9 (28-Dec-2013)
[    9.891684]
[    9.891720] e2fsck: /dev/block/platform/ff0c0000.dwmmc/by-name/metadata: clean, 12/1024 files, 1103/4096 blocks
[    9.891720]
[   10.055500] EXT4-fs (mmcblk0p11): mounted filesystem with ordered data mode. Opts: noauto_da_alloc,discard
[   10.055571] fs_mgr: __mount(source=/dev/block/platform/ff0c0000.dwmmc/by-name/metadata,target=/metadata,type=ext4)=0
[   10.055624] fs_mgr: Running /system/bin/fsck.f2fs -a /dev/block/platform/ff0c0000.dwmmc/by-name/userdata
[   10.109948] fsck.f2fs: Info: Fix the reported corruption.
[   10.109948]
[   10.109984] fsck.f2fs: c->start_sector=0
[   10.109984]
[   10.109995] fsck.f2fs: Info: Segments per section = 1
[   10.109995]
[   10.110005] fsck.f2fs: Info: Sections per zone = 1
[   10.110005]
[   10.110014] fsck.f2fs: Info: sector size = 512
[   10.110014]
[   10.110024] fsck.f2fs: Info: total sectors = 25272320 (12340 MB)
[   10.110024]
[   10.110033] fsck.f2fs: Info: MKFS version
[   10.110033]
[   10.110044] fsck.f2fs:   "Linux version 4.4.112 (jenkins@fdc-06) (gcc version 4.9 20150123 (prerelease) (GCC) ) #1 SMP PREEMPT Thu Jan 3 11:20:52 CST 2019"
[   10.110044]
[   10.110060] fsck.f2fs: Info: FSCK version
[   10.110060]
[   10.110071] fsck.f2fs:   from "Linux version 4.4.112 (jenkins@fdc-06) (gcc version 4.9 20150123 (prerelease) (GCC) ) #1 SMP PREEMPT Thu Jan 3 11:20:52 CST 2019"
[   10.110071]
[   10.110083] fsck.f2fs:     to "Linux version 4.4.112 (jenkins@fdc-06) (gcc version 4.9 20150123 (prerelease) (GCC) ) #1 SMP PREEMPT Thu Jan 3 11:20:52 CST 2019"
[   10.110083]
[   10.110095] fsck.f2fs: Info: superblock features = 0 :
[   10.110095]
[   10.110105] fsck.f2fs: Info: superblock encrypt level = 0, salt = 00000000000000000000000000000000
[   10.110105]
[   10.110116] fsck.f2fs: Info: total FS sectors = 25272320 (12340 MB)
[   10.110116]
[   10.110125] fsck.f2fs: Info: CKPT version = 8c4
[   10.110125]
[   10.110134] fsck.f2fs: Info: No error was reported
[   10.110134]
[   10.141457] F2FS-fs (mmcblk0p14): Mounted with checkpoint version = 8c4
[   10.142150] fs_mgr: __mount(source=/dev/block/platform/ff0c0000.dwmmc/by-name/userdata,target=/data,type=f2fs)=0
[   10.142172] fs_mgr: mount_with_alternatives(): skipping fstab dup mountpoint=/data rec[5].fs_type=ext4 already mounted as f2fs.
[   10.150476] init: (Parsing /system/etc/init/atrace.rc took 0.00s.)
[   10.151070] init: (Parsing /system/etc/init/audioserver.rc took 0.00s.)
[   10.151615] init: (Parsing /system/etc/init/bootanim.rc took 0.00s.)
[   10.152222] init: (Parsing /system/etc/init/bootstat.rc took 0.00s.)
[   10.152799] init: (Parsing /system/etc/init/cameraserver.rc took 0.00s.)
[   10.153339] init: (Parsing /system/etc/init/debuggerd.rc took 0.00s.)
[   10.153866] init: (Parsing /system/etc/init/drmserver.rc took 0.00s.)
[   10.154469] init: (Parsing /system/etc/init/dumpstate.rc took 0.00s.)
[   10.154979] init: (Parsing /system/etc/init/gatekeeperd.rc took 0.00s.)
[   10.155505] init: (Parsing /system/etc/init/init-debug.rc took 0.00s.)
[   10.156017] init: (Parsing /system/etc/init/installd.rc took 0.00s.)
[   10.156534] init: (Parsing /system/etc/init/keystore.rc took 0.00s.)
[   10.157055] init: (Parsing /system/etc/init/lmkd.rc took 0.00s.)
[   10.157717] init: (Parsing /system/etc/init/logcatd.rc took 0.00s.)
[   10.158278] init: (Parsing /system/etc/init/logd.rc took 0.00s.)
[   10.158825] init: (Parsing /system/etc/init/mdnsd.rc took 0.00s.)
[   10.159361] init: (Parsing /system/etc/init/mediacodec.rc took 0.00s.)
[   10.159902] init: (Parsing /system/etc/init/mediadrmserver.rc took 0.00s.)
[   10.160420] init: (Parsing /system/etc/init/mediaextractor.rc took 0.00s.)
[   10.160953] init: (Parsing /system/etc/init/mediaserver.rc took 0.00s.)
[   10.161472] init: (Parsing /system/etc/init/mtpd.rc took 0.00s.)
[   10.161990] init: (Parsing /system/etc/init/netd.rc took 0.00s.)
[   10.162518] init: (Parsing /system/etc/init/perfprofd.rc took 0.00s.)
[   10.163042] init: (Parsing /system/etc/init/racoon.rc took 0.00s.)
[   10.163599] init: (Parsing /system/etc/init/servicemanager.rc took 0.00s.)
[   10.164115] init: (Parsing /system/etc/init/surfaceflinger.rc took 0.00s.)
[   10.164665] init: (Parsing /system/etc/init/uncrypt.rc took 0.00s.)
[   10.165222] init: (Parsing /system/etc/init/vdc.rc took 0.00s.)
[   10.165766] init: (Parsing /system/etc/init/vold.rc took 0.00s.)
[   10.167618] init: Starting service 'logd'...
[   10.174909] init: insmod: open("/system/lib/modules/ump.ko") failed: No such file or directoryinit: insmod: open("/system/lib/modules/mali.ko") failed: No such file or directoryinit: insmod: open("/system/lib/modules/mali_kbase.ko") failed: No such file or directoryinit: insmod: open("/system/lib/modules/rk30_mirroring.ko") failed: No such file or directoryinit: finit_module for "/system/lib/modules/rk29-ipp.ko" failed: Exec format errorinit: insmod: open("/system/lib/modules/pvrsrvkm.ko") failed: No such file or directoryinit: finit_module for "/drmboot.ko" failed: Exec format errorfs_mgr: Warning: unknown flag resize
[   10.177484] zram0: detected capacity change from 0 to 533413888
[   10.203872] Adding 520908k swap on /dev/block/zram0.  Priority:-1 extents:1 across:520908k SS
[   10.204758] logd.auditd: start
[   10.204783] logd.klogd: 10091998815
[   10.206826] init: ASUS change ro.product.model from rk3288 to Tinker Board (length=12)
[   10.206982] init: property_set("ro.board.platform", "rk3288") failed
[   10.207367] init: property_set("ro.target.product", "tablet") failed
[   10.207555] init: property_set("ro.rk.screenoff_time", "60000") failed
[   10.207734] init: property_set("ro.rk.screenshot_enable", "true") failed
[   10.207869] init: (Loading properties from /system/build.prop took 0.00s.)
[   10.212282] init: (Loading properties from /vendor/build.prop took 0.00s.)
[   10.212317] init: (Loading properties from /factory/factory.prop took 0.00s.)
[   10.212406] fs_mgr: Warning: unknown flag resize
[   10.212487] init: /recovery not specified in fstab
[   10.212910] init: Starting service 'debuggerd'...
[   10.213250] init: do_start: Service debuggerd64 not found
[   10.213522] init: Starting service 'vold'...
[   10.216391] init: Not bootcharting.
[   10.372625] fs_mgr: Warning: unknown flag resize
[   10.402445] init: Starting service 'exec 1 (/system/bin/tzdatacheck)'...
[   10.415253] init: Service 'exec 1 (/system/bin/tzdatacheck)' (pid 197) exited with status 0
[   10.423991] type=1400 audit(1358499016.913:9): avc: denied { setattr } for pid=1 comm="init" name="cifsmanager" dev="mmcblk0p14" ino=86 scontext=u:r:init:s0 tcontext=u:object_r:cifsmanager_exec:s0 tclass=dir permissive=1
[   10.425665] F2FS-fs (mmcblk0p14): acl options not supported
[   10.425680] F2FS-fs (mmcblk0p14): Unrecognized mount option "errors=panic" or missing value
[   10.427846] init: (Loading properties from /data/local.prop took 0.00s.)
[   12.008324] init: Starting service 'logd-reinit'...
[   12.008922] init: Starting service 'asuscustomize'...
[   12.009877] init: write_file: Unable to open '/proc/sys/vm/min_free_order_shift': No such file or directory
[   12.011222] init: Starting service 'healthd'...
[   12.011871] init: Starting service 'displayd'...
[   12.012325] init: Starting service 'tee-supplicant'...
[   12.012933] type=1400 audit(1358499018.500:10): avc: denied { entrypoint } for pid=199 comm="init" path="/system/bin/sh" dev="mmcblk0p10" ino=370 scontext=u:r:asuscustomize:s0 tcontext=u:object_r:shell_exec:s0 tclass=file permissive=1
[   12.012952] init: Starting service 'lmkd'...
[   12.013588] init: Starting service 'servicemanager'...
[   12.014204] init: Starting service 'surfaceflinger'...
[   12.014803] init: SELinux:  Could not stat /sys/devices/system/cpu/cpufreq/interactive: No such file or directory.
[   12.015363] binder: 200:200 transaction failed 29189/-22, size 0-0 line 2948
[   12.016338] init: write_file: Unable to open '/proc/sys/vm/lazy_vfree_tlb_flush_all_threshold': No such file or directory
[   12.017694] init: SELinux: Could not get canonical path for /dev/block/platform/fe330000.sdhci/by-name/ restorecon: No such file or directory.
[   12.018754] [BT_RFKILL]: bt shut off power
[   12.020593] type=1400 audit(1358499018.506:11): avc: denied { getattr } for pid=199 comm="sh" path="/system/bin/sh" dev="mmcblk0p10" ino=370 scontext=u:r:asuscustomize:s0 tcontext=u:object_r:shell_exec:s0 tclass=file permissive=1
[   12.020714] type=1400 audit(1358499018.506:12): avc: denied { read } for pid=199 comm="sh" path="/system/bin/sh" dev="mmcblk0p10" ino=370 scontext=u:r:asuscustomize:s0 tcontext=u:object_r:shell_exec:s0 tclass=file permissive=1
[   12.028019] logd.daemon: reinit
[   12.039672] init: Service 'logd-reinit' (pid 198) exited with status 0
[   12.039808] init: Service 'asuscustomize' (pid 199) exited with status 127
[   12.042386] init: property 'ro.serialno' doesn't exist while expanding '${ro.serialno}'
[   12.042408] init: write: cannot expand '${ro.serialno}'
[   12.043126] file system registered
[   12.045926] using random self ethernet address
[   12.045942] using random host ethernet address
[   12.046018] init: write_file: Unable to open '/config/usb_gadget/g1/functions/rndis.gs4/wceis': Permission denied
[   12.048447] init: avc:  denied  { set } for property=security.tee_supplicant pid=202 uid=0 gid=0 scontext=u:r:tee:s0 tcontext=u:object_r:default_prop:s0 tclass=property_service permissive=1
[   12.061153] type=1400 audit(1358499018.523:13): avc: denied { read } for pid=201 comm="displayd" name="psched" dev="proc" ino=4026531942 scontext=u:r:displayd:s0 tcontext=u:object_r:proc_net:s0 tclass=file permissive=1
[   12.061272] type=1400 audit(1358499018.523:14): avc: denied { open } for pid=201 comm="displayd" path="/proc/201/net/psched" dev="proc" ino=4026531942 scontext=u:r:displayd:s0 tcontext=u:object_r:proc_net:s0 tclass=file permissive=1
[   12.061347] type=1400 audit(1358499018.523:15): avc: denied { getattr } for pid=201 comm="displayd" path="/proc/201/net/psched" dev="proc" ino=4026531942 scontext=u:r:displayd:s0 tcontext=u:object_r:proc_net:s0 tclass=file permissive=1
[   12.061431] type=1400 audit(1358499018.536:16): avc: denied { write } for pid=202 comm="tee-supplicant" name="property_service" dev="tmpfs" ino=11488 scontext=u:r:tee:s0 tcontext=u:object_r:property_socket:s0 tclass=sock_file permissive=1
[   12.061500] type=1400 audit(1358499018.536:17): avc: denied { connectto } for pid=202 comm="tee-supplicant" path="/dev/socket/property_service" scontext=u:r:tee:s0 tcontext=u:r:init:s0 tclass=unix_stream_socket permissive=1
[   12.067262] init: write_file: Unable to write to '/dev/cpuset/foreground/boost/cpus': Permission denied
[   12.068380] init: Starting service 'console'...
[   12.068811] init: Starting service 'adbd'...
[   12.069204] init: do_stop: Service ril-daemon not found
[   12.069317] init: do_start: Service ril-false not found
[   12.069709] init: cannot find '/system/bin/update_verifier' (No such file or directory), disabling 'exec 2 (/system/bin/update_verifier)'
[   12.070027] init: Starting service 'flash_recovery'...
[   12.070679] init: Starting service 'drmservice'...
[   12.071084] init: cannot find '/system/bin/bplus_helper' (No such file or directory), disabling 'bplus_helper'
[   12.071320] init: Service up_eth0 does not have a SELinux domain defined.
[   12.071347] init: cannot find '/system/bin/rk_store_keybox' (No such file or directory), disabling 'rk_store_keybox'
[   12.071466] init: Starting service 'akmd'...
[   12.072210] init: Starting service 'zygote'...
[   12.072940] init: Starting service 'audioserver'...
[   12.073647] init: Starting service 'cameraserver'...
[   12.074322] init: Starting service 'drm'...
[   12.074964] init: Starting service 'installd'...
[   12.075624] init: Starting service 'keystore'...
[   12.077559] init: Starting service 'mediacodec'...
[   12.078236] init: Starting service 'mediadrm'...
[   12.078901] init: Starting service 'mediaextractor'...
[   12.079698] init: Starting service 'media'...
[   12.080442] init: Starting service 'netd'...
[   12.081215] init: Starting service 'gatekeeperd'...
[   12.081309] init: couldn't write 218 to /dev/cpuset/camera-daemon/tasks: No such file or directory
[   12.371794] init: Starting service 'perfprofd'...
[   12.390111] init: Service 'akmd' (pid 215) exited with status 254
[   12.416400] init: Service 'drmservice' (pid 214) exited with status 0
[   12.455029] fs_mgr: Warning: unknown flag resize
[   12.459561] type=1400 audit(1358499018.943:18): avc: denied { write } for pid=228 comm="applypatch" name="kmsg" dev="tmpfs" ino=8796 scontext=u:r:install_recovery:s0 tcontext=u:object_r:kmsg_device:s0 tclass=chr_file permissive=1
[   12.460027] type=1400 audit(1358499018.943:19): avc: denied { open } for pid=228 comm="applypatch" path="/dev/kmsg" dev="tmpfs" ino=8796 scontext=u:r:install_recovery:s0 tcontext=u:object_r:kmsg_device:s0 tclass=chr_file permissive=1
[   12.460111] type=1400 audit(1358499018.943:20): avc: denied { read } for pid=228 comm="applypatch" name="mmcblk0p7" dev="tmpfs" ino=8928 scontext=u:r:install_recovery:s0 tcontext=u:object_r:block_device:s0 tclass=blk_file permissive=1
[   12.460188] type=1400 audit(1358499018.943:21): avc: denied { open } for pid=228 comm="applypatch" path="/dev/block/mmcblk0p7" dev="tmpfs" ino=8928 scontext=u:r:install_recovery:s0 tcontext=u:object_r:block_device:s0 tclass=blk_file permissive=1
[   12.482994] read descriptors
[   12.483020] read strings
[   12.483881] pcd_pullup, is_on 1
[   12.562905] type=1400 audit(1358499019.046:22): avc: denied { getattr } for pid=228 comm="applypatch" path="/dev/block/mmcblk0p7" dev="tmpfs" ino=8928 scontext=u:r:install_recovery:s0 tcontext=u:object_r:block_device:s0 tclass=blk_file permissive=1
[   12.759475] **************soft reconnect**************
[   12.905763] Using Buffer DMA mode
[   12.905795] Periodic Transfer Interrupt Enhancement - disabled
[   12.905803] Multiprocessor Interrupt Enhancement - disabled
[   12.905810] OTG VER PARAM: 0, OTG VER FLAG: 0
[   12.905816] ^^^^^^^^^^^^^^^^^Device Mode
[   12.905858] *******************soft connect!!!*******************
[   13.016388] healthd: No battery devices found
[   13.016499] healthd: battery l=100 v=0 t=42.4 h=2 st=2 chg=a
[   13.302536] init: Service 'flash_recovery' (pid 213) exited with status 0
[   13.762818] **************soft reconnect**************
[   13.891570] Using Buffer DMA mode
[   13.891598] Periodic Transfer Interrupt Enhancement - disabled
[   13.891605] Multiprocessor Interrupt Enhancement - disabled
[   13.891611] OTG VER PARAM: 0, OTG VER FLAG: 0
[   13.891617] ^^^^^^^^^^^^^^^^^Device Mode
[   13.891659] *******************soft connect!!!*******************
[   14.233545] init: Starting service 'bootanim'...
[   14.542592] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   14.542616] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   14.555503] E:camsys_i2c_write(84): i2c write dev(addr:0x6c) failed!,err = -6
[   14.571351] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   14.571374] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   14.571381] gpio-229 (camsys_gpio): gpiod_request: status -16
[   14.585587] E:camsys_i2c_write(84): i2c write dev(addr:0x6c) failed!,err = -6
[   14.587088] E:camsys_i2c_write(84): i2c write dev(addr:0x20) failed!,err = -6
[   14.652837] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   14.652861] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   14.652867] gpio-229 (camsys_gpio): gpiod_request: status -16
[   14.666868] E:camsys_i2c_write(84): i2c write dev(addr:0x20) failed!,err = -6
[   14.669495] E:camsys_i2c_write(84): i2c write dev(addr:0x6c) failed!,err = -6
[   14.690922] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   14.690949] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   14.690955] gpio-229 (camsys_gpio): gpiod_request: status -16
[   14.703838] E:camsys_i2c_write(84): i2c write dev(addr:0x6c) failed!,err = -6
[   14.706288] E:camsys_i2c_write(84): i2c write dev(addr:0x6c) failed!,err = -6
[   14.743947] rockchip-vop ff930000.vop: wait win close timeout
[   14.743976] rockchip-vop ff930000.vop: [drm:vop_crtc_enable] Update mode to 1920*1080, close all win
[   14.766206] [drm:hdmi_config_hdr_infoframe] *ERROR* Not support DRM Infoframe
[   14.778195] E:camsys_i2c_write(84): i2c write dev(addr:0x6c) failed!,err = -6
[   14.780718] E:camsys_i2c_write(84): i2c write dev(addr:0x6c) failed!,err = -6
[   14.862390] E:camsys_i2c_write(84): i2c write dev(addr:0x60) failed!,err = -6
[   14.898479] E:camsys_i2c_write(84): i2c write dev(addr:0x78) failed!,err = -6
[   14.946792] gpio-56 (camsys_gpio): gpiod_request: status -16
[   14.946814] E:camsys_extdev_register(258): Request RK30_PIN2_PA0(56) failed
[   14.946898] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   14.946914] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   14.946925] gpio-229 (camsys_gpio): gpiod_request: status -16
[   14.946968] rockchip-pinctrl pinctrl: not freeing pin 67 (gpio2-11) as part of deactivating group isp-mipi - it is already used for some other setting
[   14.962576] E:camsys_i2c_write(84): i2c write dev(addr:0x20) failed!,err = -6
[   14.962748] E:camsys_i2c_write(84): i2c write dev(addr:0x20) failed!,err = -6
[   14.973666] ------------[ cut here ]------------
[   14.973697] WARNING: CPU: 2 PID: 218 at drivers/gpio/gpiolib.c:1002 camsys_extdev_deregister+0x10c/0x2fc()
[   14.973705] Modules linked in:
[   14.973715] CPU: 2 PID: 218 Comm: cameraserver Not tainted 4.4.112 #1
[   14.973721] Hardware name: Rockchip (Device Tree)
[   14.973742] [<c010f844>] (unwind_backtrace) from [<c010bb84>] (show_stack+0x10/0x14)
[   14.973754] [<c010bb84>] (show_stack) from [<c03dde74>] (dump_stack+0x7c/0x9c)
[   14.973766] [<c03dde74>] (dump_stack) from [<c01263e0>] (warn_slowpath_common+0x88/0xb4)
[   14.973776] [<c01263e0>] (warn_slowpath_common) from [<c01264ec>] (warn_slowpath_null+0x18/0x20)
[   14.973787] [<c01264ec>] (warn_slowpath_null) from [<c0773118>] (camsys_extdev_deregister+0x10c/0x2fc)
[   14.973799] [<c0773118>] (camsys_extdev_deregister) from [<c0774efc>] (camsys_ioctl+0x57c/0x874)
[   14.973811] [<c0774efc>] (camsys_ioctl) from [<c0245d50>] (do_vfs_ioctl+0x564/0x6a0)
[   14.973821] [<c0245d50>] (do_vfs_ioctl) from [<c0245ed8>] (SyS_ioctl+0x4c/0x74)
[   14.973832] [<c0245ed8>] (SyS_ioctl) from [<c01074c0>] (ret_fast_syscall+0x0/0x48)
[   14.973839] ---[ end trace 2254119995b00a64 ]---
[   14.998313] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   14.998335] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   14.998343] gpio-229 (camsys_gpio): gpiod_request: status -16
[   15.015068] E:camsys_i2c_write(84): i2c write dev(addr:0x20) failed!,err = -6
[   15.015256] E:camsys_i2c_write(84): i2c write dev(addr:0x20) failed!,err = -6
[   15.052626] E:camsys_i2c_write(84): i2c write dev(addr:0x1f) failed!,err = -6
[   15.052906] E:camsys_i2c_write(84): i2c write dev(addr:0x3f) failed!,err = -6
[   15.080932] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   15.080956] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   15.080963] gpio-229 (camsys_gpio): gpiod_request: status -16
[   15.093774] E:camsys_i2c_write(84): i2c write dev(addr:0x6c) failed!,err = -6
[   15.105495] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   15.105516] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   15.105523] gpio-229 (camsys_gpio): gpiod_request: status -16
[   15.121200] E:camsys_i2c_write(84): i2c write dev(addr:0x6c) failed!,err = -6
[   15.121386] E:camsys_i2c_write(84): i2c write dev(addr:0x20) failed!,err = -6
[   15.133233] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   15.133255] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   15.133261] gpio-229 (camsys_gpio): gpiod_request: status -16
[   15.144135] Freeing drm_logo memory: 348K
[   15.146077] E:camsys_i2c_write(84): i2c write dev(addr:0x20) failed!,err = -6
[   15.146267] E:camsys_i2c_write(84): i2c write dev(addr:0x6c) failed!,err = -6
[   15.158211] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   15.158236] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   15.158244] gpio-229 (camsys_gpio): gpiod_request: status -16
[   15.171040] E:camsys_i2c_write(84): i2c write dev(addr:0x6c) failed!,err = -6
[   15.171218] E:camsys_i2c_write(84): i2c write dev(addr:0x6c) failed!,err = -6
[   15.195929] E:camsys_i2c_write(84): i2c write dev(addr:0x6c) failed!,err = -6
[   15.196096] E:camsys_i2c_write(84): i2c write dev(addr:0x6c) failed!,err = -6
[   15.221291] E:camsys_i2c_write(84): i2c write dev(addr:0x60) failed!,err = -6
[   15.246336] E:camsys_i2c_write(84): i2c write dev(addr:0x78) failed!,err = -6
[   15.258057] gpio-56 (camsys_gpio): gpiod_request: status -16
[   15.258069] E:camsys_extdev_register(258): Request RK30_PIN2_PA0(56) failed
[   15.258139] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   15.258153] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   15.258159] gpio-229 (camsys_gpio): gpiod_request: status -16
[   15.258201] rockchip-pinctrl pinctrl: not freeing pin 67 (gpio2-11) as part of deactivating group isp-mipi - it is already used for some other setting
[   15.271002] E:camsys_i2c_write(84): i2c write dev(addr:0x20) failed!,err = -6
[   15.271166] E:camsys_i2c_write(84): i2c write dev(addr:0x20) failed!,err = -6
[   15.281830] ------------[ cut here ]------------
[   15.281862] WARNING: CPU: 3 PID: 218 at drivers/gpio/gpiolib.c:1002 camsys_extdev_deregister+0x10c/0x2fc()
[   15.281870] Modules linked in:
[   15.281881] CPU: 3 PID: 218 Comm: cameraserver Tainted: G        W       4.4.112 #1
[   15.281887] Hardware name: Rockchip (Device Tree)
[   15.281908] [<c010f844>] (unwind_backtrace) from [<c010bb84>] (show_stack+0x10/0x14)
[   15.281920] [<c010bb84>] (show_stack) from [<c03dde74>] (dump_stack+0x7c/0x9c)
[   15.281933] [<c03dde74>] (dump_stack) from [<c01263e0>] (warn_slowpath_common+0x88/0xb4)
[   15.281943] [<c01263e0>] (warn_slowpath_common) from [<c01264ec>] (warn_slowpath_null+0x18/0x20)
[   15.281953] [<c01264ec>] (warn_slowpath_null) from [<c0773118>] (camsys_extdev_deregister+0x10c/0x2fc)
[   15.281965] [<c0773118>] (camsys_extdev_deregister) from [<c0774efc>] (camsys_ioctl+0x57c/0x874)
[   15.281979] [<c0774efc>] (camsys_ioctl) from [<c0245d50>] (do_vfs_ioctl+0x564/0x6a0)
[   15.281993] [<c0245d50>] (do_vfs_ioctl) from [<c0245ed8>] (SyS_ioctl+0x4c/0x74)
[   15.282004] [<c0245ed8>] (SyS_ioctl) from [<c01074c0>] (ret_fast_syscall+0x0/0x48)
[   15.282012] ---[ end trace 2254119995b00a65 ]---
[   15.283139] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   15.283161] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   15.283167] gpio-229 (camsys_gpio): gpiod_request: status -16
[   15.295957] E:camsys_i2c_write(84): i2c write dev(addr:0x20) failed!,err = -6
[   15.296155] E:camsys_i2c_write(84): i2c write dev(addr:0x20) failed!,err = -6
[   15.313750] E:camsys_i2c_write(84): i2c write dev(addr:0x1f) failed!,err = -6
[   15.313955] E:camsys_i2c_write(84): i2c write dev(addr:0x3f) failed!,err = -6
[   15.342890] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   15.342916] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   15.342928] gpio-229 (camsys_gpio): gpiod_request: status -16
[   15.355777] E:camsys_i2c_write(84): i2c write dev(addr:0x6c) failed!,err = -6
[   15.367790] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   15.367818] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   15.367829] gpio-229 (camsys_gpio): gpiod_request: status -16
[   15.380677] E:camsys_i2c_write(84): i2c write dev(addr:0x6c) failed!,err = -6
[   15.380849] E:camsys_i2c_write(84): i2c write dev(addr:0x20) failed!,err = -6
[   15.392635] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   15.392660] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   15.392667] gpio-229 (camsys_gpio): gpiod_request: status -16
[   15.405595] E:camsys_i2c_write(84): i2c write dev(addr:0x20) failed!,err = -6
[   15.405761] E:camsys_i2c_write(84): i2c write dev(addr:0x6c) failed!,err = -6
[   15.417611] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   15.417634] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   15.417641] gpio-229 (camsys_gpio): gpiod_request: status -16
[   15.430439] E:camsys_i2c_write(84): i2c write dev(addr:0x6c) failed!,err = -6
[   15.430606] E:camsys_i2c_write(84): i2c write dev(addr:0x6c) failed!,err = -6
[   15.455031] E:camsys_i2c_write(84): i2c write dev(addr:0x6c) failed!,err = -6
[   15.455201] E:camsys_i2c_write(84): i2c write dev(addr:0x6c) failed!,err = -6
[   15.479606] E:camsys_i2c_write(84): i2c write dev(addr:0x60) failed!,err = -6
[   15.503811] E:camsys_i2c_write(84): i2c write dev(addr:0x78) failed!,err = -6
[   15.515157] gpio-56 (camsys_gpio): gpiod_request: status -16
[   15.515165] E:camsys_extdev_register(258): Request RK30_PIN2_PA0(56) failed
[   15.515228] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   15.515243] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   15.515248] gpio-229 (camsys_gpio): gpiod_request: status -16
[   15.515274] rockchip-pinctrl pinctrl: not freeing pin 67 (gpio2-11) as part of deactivating group isp-mipi - it is already used for some other setting
[   15.527980] E:camsys_i2c_write(84): i2c write dev(addr:0x20) failed!,err = -6
[   15.528143] E:camsys_i2c_write(84): i2c write dev(addr:0x20) failed!,err = -6
[   15.538730] ------------[ cut here ]------------
[   15.538754] WARNING: CPU: 0 PID: 218 at drivers/gpio/gpiolib.c:1002 camsys_extdev_deregister+0x10c/0x2fc()
[   15.538761] Modules linked in:
[   15.538772] CPU: 0 PID: 218 Comm: cameraserver Tainted: G        W       4.4.112 #1
[   15.538777] Hardware name: Rockchip (Device Tree)
[   15.538795] [<c010f844>] (unwind_backtrace) from [<c010bb84>] (show_stack+0x10/0x14)
[   15.538806] [<c010bb84>] (show_stack) from [<c03dde74>] (dump_stack+0x7c/0x9c)
[   15.538818] [<c03dde74>] (dump_stack) from [<c01263e0>] (warn_slowpath_common+0x88/0xb4)
[   15.538828] [<c01263e0>] (warn_slowpath_common) from [<c01264ec>] (warn_slowpath_null+0x18/0x20)
[   15.538838] [<c01264ec>] (warn_slowpath_null) from [<c0773118>] (camsys_extdev_deregister+0x10c/0x2fc)
[   15.538849] [<c0773118>] (camsys_extdev_deregister) from [<c0774efc>] (camsys_ioctl+0x57c/0x874)
[   15.538861] [<c0774efc>] (camsys_ioctl) from [<c0245d50>] (do_vfs_ioctl+0x564/0x6a0)
[   15.538871] [<c0245d50>] (do_vfs_ioctl) from [<c0245ed8>] (SyS_ioctl+0x4c/0x74)
[   15.538882] [<c0245ed8>] (SyS_ioctl) from [<c01074c0>] (ret_fast_syscall+0x0/0x48)
[   15.538893] ---[ end trace 2254119995b00a66 ]---
[   15.540047] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   15.540075] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   15.540083] gpio-229 (camsys_gpio): gpiod_request: status -16
[   15.552906] E:camsys_i2c_write(84): i2c write dev(addr:0x20) failed!,err = -6
[   15.553071] E:camsys_i2c_write(84): i2c write dev(addr:0x20) failed!,err = -6
[   15.570295] E:camsys_i2c_write(84): i2c write dev(addr:0x1f) failed!,err = -6
[   15.570462] E:camsys_i2c_write(84): i2c write dev(addr:0x3f) failed!,err = -6
[   16.407092] init: Service 'zygote' (pid 216) killed by signal 9
[   16.407127] init: Service 'zygote' (pid 216) killing any children in process group
[   16.407281] init: write_file: Unable to open '/sys/android_power/request_state': No such file or directory
[   16.407361] init: write_file: Unable to write to '/sys/power/state': Invalid argument
[   16.407395] init: Service 'audioserver' is being killed...
[   16.407523] init: Service 'cameraserver' is being killed...
[   16.407609] init: Service 'media' is being killed...
[   16.407697] init: Service 'netd' is being killed...
[   16.408904] init: Starting service 'zygote'...
[   16.409950] init: Service 'audioserver' (pid 217) killed by signal 9
[   16.409976] init: Service 'audioserver' (pid 217) killing any children in process group
[   16.410367] init: Service 'media' (pid 225) killed by signal 9
[   16.410410] init: Service 'media' (pid 225) killing any children in process group
[   16.410785] init: Service 'cameraserver' (pid 218) killed by signal 9
[   16.410813] init: Service 'cameraserver' (pid 218) killing any children in process group
[   16.411723] init: Starting service 'audioserver'...
[   16.413352] init: Starting service 'cameraserver'...
[   16.414031] init: Starting service 'media'...
[   16.414652] init: Service 'netd' (pid 226) killed by signal 9
[   16.414674] init: Service 'netd' (pid 226) killing any children in process group
[   16.415664] init: Starting service 'netd'...
[   16.419725] init: couldn't write 525 to /dev/cpuset/camera-daemon/tasks: No such file or directory
[   17.215388] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   17.215411] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   17.215418] gpio-229 (camsys_gpio): gpiod_request: status -16
[   17.228282] E:camsys_i2c_write(84): i2c write dev(addr:0x6c) failed!,err = -6
[   17.240233] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   17.240258] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   17.240269] gpio-229 (camsys_gpio): gpiod_request: status -16
[   17.253059] E:camsys_i2c_write(84): i2c write dev(addr:0x6c) failed!,err = -6
[   17.253245] E:camsys_i2c_write(84): i2c write dev(addr:0x20) failed!,err = -6
[   17.265088] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   17.265111] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   17.265118] gpio-229 (camsys_gpio): gpiod_request: status -16
[   17.277917] E:camsys_i2c_write(84): i2c write dev(addr:0x20) failed!,err = -6
[   17.278096] E:camsys_i2c_write(84): i2c write dev(addr:0x6c) failed!,err = -6
[   17.290104] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   17.290126] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   17.290133] gpio-229 (camsys_gpio): gpiod_request: status -16
[   17.302951] E:camsys_i2c_write(84): i2c write dev(addr:0x6c) failed!,err = -6
[   17.303124] E:camsys_i2c_write(84): i2c write dev(addr:0x6c) failed!,err = -6
[   17.327598] E:camsys_i2c_write(84): i2c write dev(addr:0x6c) failed!,err = -6
[   17.327783] E:camsys_i2c_write(84): i2c write dev(addr:0x6c) failed!,err = -6
[   17.352196] E:camsys_i2c_write(84): i2c write dev(addr:0x60) failed!,err = -6
[   17.376804] E:camsys_i2c_write(84): i2c write dev(addr:0x78) failed!,err = -6
[   17.388629] gpio-56 (camsys_gpio): gpiod_request: status -16
[   17.388641] E:camsys_extdev_register(258): Request RK30_PIN2_PA0(56) failed
[   17.388704] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   17.388718] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   17.388724] gpio-229 (camsys_gpio): gpiod_request: status -16
[   17.388759] rockchip-pinctrl pinctrl: not freeing pin 67 (gpio2-11) as part of deactivating group isp-mipi - it is already used for some other setting
[   17.401567] E:camsys_i2c_write(84): i2c write dev(addr:0x20) failed!,err = -6
[   17.401736] E:camsys_i2c_write(84): i2c write dev(addr:0x20) failed!,err = -6
[   17.412433] ------------[ cut here ]------------
[   17.412464] WARNING: CPU: 0 PID: 525 at drivers/gpio/gpiolib.c:1002 camsys_extdev_deregister+0x10c/0x2fc()
[   17.412472] Modules linked in:
[   17.412487] CPU: 0 PID: 525 Comm: cameraserver Tainted: G        W       4.4.112 #1
[   17.412496] Hardware name: Rockchip (Device Tree)
[   17.412517] [<c010f844>] (unwind_backtrace) from [<c010bb84>] (show_stack+0x10/0x14)
[   17.412529] [<c010bb84>] (show_stack) from [<c03dde74>] (dump_stack+0x7c/0x9c)
[   17.412545] [<c03dde74>] (dump_stack) from [<c01263e0>] (warn_slowpath_common+0x88/0xb4)
[   17.412560] [<c01263e0>] (warn_slowpath_common) from [<c01264ec>] (warn_slowpath_null+0x18/0x20)
[   17.412570] [<c01264ec>] (warn_slowpath_null) from [<c0773118>] (camsys_extdev_deregister+0x10c/0x2fc)
[   17.412583] [<c0773118>] (camsys_extdev_deregister) from [<c0774efc>] (camsys_ioctl+0x57c/0x874)
[   17.412597] [<c0774efc>] (camsys_ioctl) from [<c0245d50>] (do_vfs_ioctl+0x564/0x6a0)
[   17.412608] [<c0245d50>] (do_vfs_ioctl) from [<c0245ed8>] (SyS_ioctl+0x4c/0x74)
[   17.412620] [<c0245ed8>] (SyS_ioctl) from [<c01074c0>] (ret_fast_syscall+0x0/0x48)
[   17.412634] ---[ end trace 2254119995b00a67 ]---
[   17.413833] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   17.413855] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   17.413862] gpio-229 (camsys_gpio): gpiod_request: status -16
[   17.426678] E:camsys_i2c_write(84): i2c write dev(addr:0x20) failed!,err = -6
[   17.426852] E:camsys_i2c_write(84): i2c write dev(addr:0x20) failed!,err = -6
[   17.444567] E:camsys_i2c_write(84): i2c write dev(addr:0x1f) failed!,err = -6
[   17.444739] E:camsys_i2c_write(84): i2c write dev(addr:0x3f) failed!,err = -6
[   17.472074] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   17.472096] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   17.472102] gpio-229 (camsys_gpio): gpiod_request: status -16
[   17.484945] E:camsys_i2c_write(84): i2c write dev(addr:0x6c) failed!,err = -6
[   17.497025] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   17.497047] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   17.497054] gpio-229 (camsys_gpio): gpiod_request: status -16
[   17.509835] E:camsys_i2c_write(84): i2c write dev(addr:0x6c) failed!,err = -6
[   17.510007] E:camsys_i2c_write(84): i2c write dev(addr:0x20) failed!,err = -6
[   17.522115] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   17.522145] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   17.522152] gpio-229 (camsys_gpio): gpiod_request: status -16
[   17.534941] E:camsys_i2c_write(84): i2c write dev(addr:0x20) failed!,err = -6
[   17.535108] E:camsys_i2c_write(84): i2c write dev(addr:0x6c) failed!,err = -6
[   17.546983] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   17.547006] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   17.547012] gpio-229 (camsys_gpio): gpiod_request: status -16
[   17.559844] E:camsys_i2c_write(84): i2c write dev(addr:0x6c) failed!,err = -6
[   17.560018] E:camsys_i2c_write(84): i2c write dev(addr:0x6c) failed!,err = -6
[   17.584469] E:camsys_i2c_write(84): i2c write dev(addr:0x6c) failed!,err = -6
[   17.584640] E:camsys_i2c_write(84): i2c write dev(addr:0x6c) failed!,err = -6
[   17.609111] E:camsys_i2c_write(84): i2c write dev(addr:0x60) failed!,err = -6
[   17.634511] E:camsys_i2c_write(84): i2c write dev(addr:0x78) failed!,err = -6
[   17.646316] gpio-56 (camsys_gpio): gpiod_request: status -16
[   17.646330] E:camsys_extdev_register(258): Request RK30_PIN2_PA0(56) failed
[   17.646418] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   17.646438] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   17.646444] gpio-229 (camsys_gpio): gpiod_request: status -16
[   17.646482] rockchip-pinctrl pinctrl: not freeing pin 67 (gpio2-11) as part of deactivating group isp-mipi - it is already used for some other setting
[   17.659478] E:camsys_i2c_write(84): i2c write dev(addr:0x20) failed!,err = -6
[   17.659656] E:camsys_i2c_write(84): i2c write dev(addr:0x20) failed!,err = -6
[   17.670353] ------------[ cut here ]------------
[   17.670381] WARNING: CPU: 1 PID: 525 at drivers/gpio/gpiolib.c:1002 camsys_extdev_deregister+0x10c/0x2fc()
[   17.670387] Modules linked in:
[   17.670398] CPU: 1 PID: 525 Comm: cameraserver Tainted: G        W       4.4.112 #1
[   17.670403] Hardware name: Rockchip (Device Tree)
[   17.670421] [<c010f844>] (unwind_backtrace) from [<c010bb84>] (show_stack+0x10/0x14)
[   17.670432] [<c010bb84>] (show_stack) from [<c03dde74>] (dump_stack+0x7c/0x9c)
[   17.670444] [<c03dde74>] (dump_stack) from [<c01263e0>] (warn_slowpath_common+0x88/0xb4)
[   17.670454] [<c01263e0>] (warn_slowpath_common) from [<c01264ec>] (warn_slowpath_null+0x18/0x20)
[   17.670465] [<c01264ec>] (warn_slowpath_null) from [<c0773118>] (camsys_extdev_deregister+0x10c/0x2fc)
[   17.670476] [<c0773118>] (camsys_extdev_deregister) from [<c0774efc>] (camsys_ioctl+0x57c/0x874)
[   17.670488] [<c0774efc>] (camsys_ioctl) from [<c0245d50>] (do_vfs_ioctl+0x564/0x6a0)
[   17.670498] [<c0245d50>] (do_vfs_ioctl) from [<c0245ed8>] (SyS_ioctl+0x4c/0x74)
[   17.670508] [<c0245ed8>] (SyS_ioctl) from [<c01074c0>] (ret_fast_syscall+0x0/0x48)
[   17.670515] ---[ end trace 2254119995b00a68 ]---
[   17.671598] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   17.671616] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   17.671623] gpio-229 (camsys_gpio): gpiod_request: status -16
[   17.684414] E:camsys_i2c_write(84): i2c write dev(addr:0x20) failed!,err = -6
[   17.684589] E:camsys_i2c_write(84): i2c write dev(addr:0x20) failed!,err = -6
[   17.702126] E:camsys_i2c_write(84): i2c write dev(addr:0x1f) failed!,err = -6
[   17.702296] E:camsys_i2c_write(84): i2c write dev(addr:0x3f) failed!,err = -6
[   17.729429] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   17.729482] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   17.729491] gpio-229 (camsys_gpio): gpiod_request: status -16
[   17.743016] E:camsys_i2c_write(84): i2c write dev(addr:0x6c) failed!,err = -6
[   17.755322] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   17.755346] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   17.755354] gpio-229 (camsys_gpio): gpiod_request: status -16
[   17.768306] E:camsys_i2c_write(84): i2c write dev(addr:0x6c) failed!,err = -6
[   17.768476] E:camsys_i2c_write(84): i2c write dev(addr:0x20) failed!,err = -6
[   17.781012] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   17.781036] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   17.781042] gpio-229 (camsys_gpio): gpiod_request: status -16
[   17.794262] E:camsys_i2c_write(84): i2c write dev(addr:0x20) failed!,err = -6
[   17.794466] E:camsys_i2c_write(84): i2c write dev(addr:0x6c) failed!,err = -6
[   17.806417] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   17.806440] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   17.806447] gpio-229 (camsys_gpio): gpiod_request: status -16
[   17.819793] E:camsys_i2c_write(84): i2c write dev(addr:0x6c) failed!,err = -6
[   17.819989] E:camsys_i2c_write(84): i2c write dev(addr:0x6c) failed!,err = -6
[   17.844509] E:camsys_i2c_write(84): i2c write dev(addr:0x6c) failed!,err = -6
[   17.844677] E:camsys_i2c_write(84): i2c write dev(addr:0x6c) failed!,err = -6
[   17.869372] E:camsys_i2c_write(84): i2c write dev(addr:0x60) failed!,err = -6
[   17.894193] E:camsys_i2c_write(84): i2c write dev(addr:0x78) failed!,err = -6
[   17.906018] gpio-56 (camsys_gpio): gpiod_request: status -16
[   17.906035] E:camsys_extdev_register(258): Request RK30_PIN2_PA0(56) failed
[   17.906181] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   17.906204] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   17.906215] gpio-229 (camsys_gpio): gpiod_request: status -16
[   17.906254] rockchip-pinctrl pinctrl: not freeing pin 67 (gpio2-11) as part of deactivating group isp-mipi - it is already used for some other setting
[   17.919070] E:camsys_i2c_write(84): i2c write dev(addr:0x20) failed!,err = -6
[   17.919245] E:camsys_i2c_write(84): i2c write dev(addr:0x20) failed!,err = -6
[   17.929931] ------------[ cut here ]------------
[   17.929961] WARNING: CPU: 2 PID: 525 at drivers/gpio/gpiolib.c:1002 camsys_extdev_deregister+0x10c/0x2fc()
[   17.929968] Modules linked in:
[   17.929979] CPU: 2 PID: 525 Comm: cameraserver Tainted: G        W       4.4.112 #1
[   17.929987] Hardware name: Rockchip (Device Tree)
[   17.930007] [<c010f844>] (unwind_backtrace) from [<c010bb84>] (show_stack+0x10/0x14)
[   17.930019] [<c010bb84>] (show_stack) from [<c03dde74>] (dump_stack+0x7c/0x9c)
[   17.930032] [<c03dde74>] (dump_stack) from [<c01263e0>] (warn_slowpath_common+0x88/0xb4)
[   17.930042] [<c01263e0>] (warn_slowpath_common) from [<c01264ec>] (warn_slowpath_null+0x18/0x20)
[   17.930052] [<c01264ec>] (warn_slowpath_null) from [<c0773118>] (camsys_extdev_deregister+0x10c/0x2fc)
[   17.930064] [<c0773118>] (camsys_extdev_deregister) from [<c0774efc>] (camsys_ioctl+0x57c/0x874)
[   17.930077] [<c0774efc>] (camsys_ioctl) from [<c0245d50>] (do_vfs_ioctl+0x564/0x6a0)
[   17.930087] [<c0245d50>] (do_vfs_ioctl) from [<c0245ed8>] (SyS_ioctl+0x4c/0x74)
[   17.930099] [<c0245ed8>] (SyS_ioctl) from [<c01074c0>] (ret_fast_syscall+0x0/0x48)
[   17.930107] ---[ end trace 2254119995b00a69 ]---
[   17.931360] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   17.931382] of_get_named_gpiod_flags: parsed 'rockchip,gpios' property of node '/isp@ff910000[0]' - status (0)
[   17.931389] gpio-229 (camsys_gpio): gpiod_request: status -16
[   17.944408] E:camsys_i2c_write(84): i2c write dev(addr:0x20) failed!,err = -6
[   17.944587] E:camsys_i2c_write(84): i2c write dev(addr:0x20) failed!,err = -6
[   17.962566] E:camsys_i2c_write(84): i2c write dev(addr:0x1f) failed!,err = -6
[   17.962734] E:camsys_i2c_write(84): i2c write dev(addr:0x3f) failed!,err = -6
[   18.031805] capability: warning: `main' uses 32-bit capabilities (legacy support in use)
[   23.476169] mmcblk0: error -110 transferring data, sector 8205736, nr 2048, cmd response 0x900, card status 0xb00
[   23.478665] rockchip-iodomain ff770000.syscon:io-domains: Setting to 3300000 done
[   23.478781] rockchip-iodomain ff770000.syscon:io-domains: Setting to 3300000 done
[   23.489488] mmc_host mmc0: Bus speed (slot 0) = 400000Hz (slot req 400000Hz, actual 400000HZ div = 0)
[   23.523106] rockchip-iodomain ff770000.syscon:io-domains: Setting to 3300000 done
[   23.523218] rockchip-iodomain ff770000.syscon:io-domains: Setting to 1800000 done
[   23.537666] mmc_host mmc0: Bus speed (slot 0) = 148500000Hz (slot req 150000000Hz, actual 148500000HZ div = 0)
[   23.679052] dwmmc_rockchip ff0c0000.dwmmc: Successfully tuned phase to 335
[   23.679074] mmc0: tried to reset card
[   25.403036] healthd: battery l=100 v=0 t=42.4 h=2 st=2 chg=a
[   27.308885] acc_open
[   27.308916] acc_release
[   27.369579] type=1400 audit(1358499033.856:23): avc: denied { read write } for pid=759 comm="system_server" name="cec0" dev="tmpfs" ino=8858 scontext=u:r:system_server:s0 tcontext=u:object_r:device:s0 tclass=chr_file permissive=1
[   27.384996] type=1400 audit(1358499033.856:24): avc: denied { open } for pid=759 comm="system_server" path="/dev/cec0" dev="tmpfs" ino=8858 scontext=u:r:system_server:s0 tcontext=u:object_r:device:s0 tclass=chr_file permissive=1
[   27.385090] type=1400 audit(1358499033.860:25): avc: denied { ioctl } for pid=759 comm="system_server" path="/dev/cec0" dev="tmpfs" ino=8858 ioctlcmd=6104 scontext=u:r:system_server:s0 tcontext=u:object_r:device:s0 tclass=chr_file permissive=1
[   27.785867] Read the Ethernet MAC address from EEPROM:2c:4d:54:42:ed:6d
[   27.786914] eth0: device MAC address 2c:4d:54:42:ed:6d
[   27.787189] of_get_named_gpiod_flags: can't parse 'realtek,ldo1-en-gpios' property of node '/i2c@ff660000/rt5640@1c[0]'
[   27.940002] Info: dw_hdmi_cec_transmit
[   27.941115] type=1400 audit(1358499034.430:26): avc: denied { ioctl } for pid=759 comm="system_server" path="/dev/cec0" dev="tmpfs" ino=8858 ioctlcmd=6101 scontext=u:r:system_server:s0 tcontext=u:object_r:device:s0 tclass=chr_file permissive=1
[   27.969051] Info: dw_hdmi_cec_hardirq stat = 4
[   27.969142] Info: dw_hdmi_cec_transmit
[   27.993042] dwc_otg_hcd_resume, usb device mode
[   27.993358] dwc_otg_hcd_suspend, usb device mode
[   28.105975] Info: dw_hdmi_cec_hardirq stat = 1
[   28.159666] type=1400 audit(1358499034.646:27): avc: denied { search } for pid=526 comm="Binder:526_1" name="759" dev="proc" ino=16510 scontext=u:r:mediaserver:s0 tcontext=u:r:system_server:s0 tclass=dir permissive=1
[   28.159817] type=1400 audit(1358499034.646:28): avc: denied { read } for pid=526 comm="Binder:526_1" name="cmdline" dev="proc" ino=16516 scontext=u:r:mediaserver:s0 tcontext=u:r:system_server:s0 tclass=file permissive=1
[   28.159902] type=1400 audit(1358499034.646:29): avc: denied { open } for pid=526 comm="Binder:526_1" path="/proc/759/cmdline" dev="proc" ino=16516 scontext=u:r:mediaserver:s0 tcontext=u:r:system_server:s0 tclass=file permissive=1
[   29.759586] type=1400 audit(1358499036.243:30): avc: denied { read } for pid=524 comm="AudioOut_D" name="audioformat" dev="sysfs" ino=16906 scontext=u:r:audioserver:s0 tcontext=u:object_r:sysfs:s0 tclass=file permissive=1
[   29.775621] type=1400 audit(1358499036.243:31): avc: denied { open } for pid=524 comm="AudioOut_D" path="/sys/devices/platform/display-subsystem/drm/card0/card0-HDMI-A-1/audioformat" dev="sysfs" ino=16906 scontext=u:r:audioserver:s0 tcontext=u:object_r:sysfs:s0 tclass=file permissive=1
[   29.775839] type=1400 audit(1358499036.243:32): avc: denied { getattr } for pid=524 comm="AudioOut_D" path="/sys/devices/platform/display-subsystem/drm/card0/card0-HDMI-A-1/audioformat" dev="sysfs" ino=16906 scontext=u:r:audioserver:s0 tcontext=u:object_r:sysfs:s0 tclass=file permissive=1
[   29.788261] init: Service 'bootanim' is being killed...
[   29.834545] init: Service 'bootanim' (pid 360) killed by signal 9
[   29.901493] init: write_file: Unable to open '/sys/devices/system/cpu/cpu4/cpufreq/scaling_min_freq': No such file or directory
[   29.906433] init: cannot find '/system/bin/glgps' (No such file or directory), disabling 'gpsd'
[   29.907606] init: Starting service 'exec 3 (/system/bin/bootstat)'...
[   29.977086] init: Service 'exec 3 (/system/bin/bootstat)' (pid 1189) exited with status 0
[   29.985796] init: Starting service 'exec 4 (/system/bin/bootstat)'...
[   30.008480] init: Service 'exec 4 (/system/bin/bootstat)' (pid 1200) exited with status 0
[   30.008775] init: Starting service 'exec 5 (/system/bin/bootstat)'...
[   30.030960] init: Service 'exec 5 (/system/bin/bootstat)' (pid 1201) exited with status 0
[   30.031307] init: Starting service 'exec 6 (/system/bin/bootstat)'...
[   30.045085] init: Service 'exec 6 (/system/bin/bootstat)' (pid 1202) exited with status 0
[   30.597443] type=1400 audit(1358499037.086:33): avc: denied { read } for pid=524 comm="FastMixer" name="audioformat" dev="sysfs" ino=16906 scontext=u:r:audioserver:s0 tcontext=u:object_r:sysfs:s0 tclass=file permissive=1
[   30.606930] type=1400 audit(1358499037.086:34): avc: denied { open } for pid=524 comm="FastMixer" path="/sys/devices/platform/display-subsystem/drm/card0/card0-HDMI-A-1/audioformat" dev="sysfs" ino=16906 scontext=u:r:audioserver:s0 tcontext=u:object_r:sysfs:s0 tclass=file permissive=1
[   30.607033] type=1400 audit(1358499037.086:35): avc: denied { getattr } for pid=524 comm="FastMixer" path="/sys/devices/platform/display-subsystem/drm/card0/card0-HDMI-A-1/audioformat" dev="sysfs" ino=16906 scontext=u:r:audioserver:s0 tcontext=u:object_r:sysfs:s0 tclass=file permissive=1
[ 4982.583035] type=1400 audit(1358503989.073:36): avc: denied { ioctl } for pid=759 comm="HdmiCecThread" path="/dev/cec0" dev="tmpfs" ino=8858 ioctlcmd=6107 scontext=u:r:system_server:s0 tcontext=u:object_r:device:s0 tclass=chr_file permissive=1
[ 4986.135268] Info: dw_hdmi_cec_transmit
[ 4986.164386] Info: dw_hdmi_cec_hardirq stat = 4
[ 4986.164981] Info: dw_hdmi_cec_transmit
[ 4986.301367] Info: dw_hdmi_cec_hardirq stat = 1
[ 4986.301770] Info: dw_hdmi_cec_transmit
[ 4986.443050] Info: dw_hdmi_cec_hardirq stat = 1
[ 4986.443387] Info: dw_hdmi_cec_transmit
[ 4986.580009] Info: dw_hdmi_cec_hardirq stat = 1
[ 4986.580217] Info: dw_hdmi_cec_transmit
[ 4986.692525] Info: dw_hdmi_cec_hardirq stat = 1
[ 4986.692698] Info: dw_hdmi_cec_transmit
[ 4986.731830] Info: dw_hdmi_cec_hardirq stat = 4
[ 4986.731917] Info: dw_hdmi_cec_transmit
[ 4986.771136] Info: dw_hdmi_cec_hardirq stat = 4
[ 4986.771364] Info: dw_hdmi_cec_transmit
[ 4986.773462] rockchip-vop ff930000.vop: wait win close timeout
[ 4986.773474] rockchip-vop ff930000.vop: [drm:vop_crtc_enable] Update mode to 1920*1080, close all win
[ 4986.797773] [drm:hdmi_config_hdr_infoframe] *ERROR* Not support DRM Infoframe
[ 4986.810442] Info: dw_hdmi_cec_hardirq stat = 4
[ 4986.810547] Info: dw_hdmi_cec_transmit
[ 4986.849750] Info: dw_hdmi_cec_hardirq stat = 4
[ 4986.850170] Info: dw_hdmi_cec_transmit
[ 4986.962337] Info: dw_hdmi_cec_hardirq stat = 1
[ 4986.964335] Info: dw_hdmi_cec_transmit
[ 4987.001630] Info: dw_hdmi_cec_hardirq stat = 4
[ 4987.002759] Info: dw_hdmi_cec_transmit
[ 4987.040964] Info: dw_hdmi_cec_hardirq stat = 4
[ 4988.112373] Info: dw_hdmi_cec_hardirq stat = 2
[ 4988.219531] Info: dw_hdmi_cec_transmit
[ 4988.253590] Info: dw_hdmi_cec_hardirq stat = 2
[ 4988.316838] Info: dw_hdmi_cec_hardirq stat = 1
[ 4988.454113] Info: dw_hdmi_cec_hardirq stat = 2
[ 4988.784091] Info: dw_hdmi_cec_hardirq stat = 2
[ 4988.794823] Info: dw_hdmi_cec_transmit
[ 4988.897215] Info: dw_hdmi_cec_hardirq stat = 1
[ 4989.610526] Info: dw_hdmi_cec_hardirq stat = 2
[ 4989.694875] Info: dw_hdmi_cec_hardirq stat = 2
[ 4989.700897] Info: dw_hdmi_cec_transmit
[ 4989.832249] Info: dw_hdmi_cec_hardirq stat = 1
[ 4989.897588] Info: dw_hdmi_cec_hardirq stat = 2
[ 4989.902928] Info: dw_hdmi_cec_transmit
[ 4989.986125] Info: dw_hdmi_cec_hardirq stat = 1
[ 4990.098495] Info: dw_hdmi_cec_hardirq stat = 2
[ 4990.104366] Info: dw_hdmi_cec_transmit
[ 4990.235863] Info: dw_hdmi_cec_hardirq stat = 1
[ 4990.349153] Info: dw_hdmi_cec_hardirq stat = 2
[ 4990.356106] Info: dw_hdmi_cec_transmit
[ 4990.462100] Info: dw_hdmi_cec_hardirq stat = 1
[ 4992.571917] Info: dw_hdmi_cec_hardirq stat = 2
[ 4992.579581] Info: dw_hdmi_cec_transmit
[ 4992.684888] Info: dw_hdmi_cec_hardirq stat = 1
[ 4992.750213] Info: dw_hdmi_cec_hardirq stat = 2
[ 4992.755838] Info: dw_hdmi_cec_transmit
[ 4992.862240] Info: dw_hdmi_cec_hardirq stat = 1
[ 4992.864396] Info: dw_hdmi_cec_transmit
[ 4992.950355] Info: dw_hdmi_cec_hardirq stat = 1
[ 4994.566132] Info: dw_hdmi_cec_hardirq stat = 2
[ 4994.720843] Info: dw_hdmi_cec_hardirq stat = 2
[ 4994.843986] Info: dw_hdmi_cec_hardirq stat = 2
[ 4994.849903] Info: dw_hdmi_cec_transmit
[ 4994.956962] Info: dw_hdmi_cec_hardirq stat = 1
[ 5000.301680] type=1400 audit(1358504006.783:37): avc: denied { read } for pid=524 comm="AudioOut_D" name="audioformat" dev="sysfs" ino=16906 scontext=u:r:audioserver:s0 tcontext=u:object_r:sysfs:s0 tclass=file permissive=1
[ 5000.302244] type=1400 audit(1358504006.783:38): avc: denied { open } for pid=524 comm="AudioOut_D" path="/sys/devices/platform/display-subsystem/drm/card0/card0-HDMI-A-1/audioformat" dev="sysfs" ino=16906 scontext=u:r:audioserver:s0 tcontext=u:object_r:sysfs:s0 tclass=file permissive=1
[ 5000.302356] type=1400 audit(1358504006.783:39): avc: denied { getattr } for pid=524 comm="AudioOut_D" path="/sys/devices/platform/display-subsystem/drm/card0/card0-HDMI-A-1/audioformat" dev="sysfs" ino=16906 scontext=u:r:audioserver:s0 tcontext=u:object_r:sysfs:s0 tclass=file permissive=1
[ 5002.437817] Info: dw_hdmi_cec_hardirq stat = 2
[ 5002.438853] Info: dw_hdmi_cec_transmit
[ 5002.550609] Info: dw_hdmi_cec_hardirq stat = 1
[ 5005.486888] init: Starting service 'p2p_supp_rtl'...
[ 5006.102727] IPv6: ADDRCONF(NETDEV_UP): p2p0: link is not ready
[ 5010.136596] Info: dw_hdmi_cec_hardirq stat = 2
[ 5010.138861] type=1400 audit(1358504016.627:40): avc: denied { ioctl } for pid=759 comm="HdmiCecThread" path="/dev/cec0" dev="tmpfs" ino=8858 ioctlcmd=6106 scontext=u:r:system_server:s0 tcontext=u:object_r:device:s0 tclass=chr_file permissive=1
[ 5010.290857] Info: dw_hdmi_cec_hardirq stat = 2
[ 5010.414093] Info: dw_hdmi_cec_hardirq stat = 2
[ 5010.420654] Info: dw_hdmi_cec_transmit
[ 5010.527056] Info: dw_hdmi_cec_hardirq stat = 1
[ 5017.675876] Info: dw_hdmi_cec_hardirq stat = 2
[ 5017.680016] Info: dw_hdmi_cec_transmit
[ 5017.788865] Info: dw_hdmi_cec_hardirq stat = 1
[ 5025.375248] Info: dw_hdmi_cec_hardirq stat = 2
[ 5025.528932] Info: dw_hdmi_cec_hardirq stat = 2
[ 5025.652161] Info: dw_hdmi_cec_hardirq stat = 2
[ 5025.658961] Info: dw_hdmi_cec_transmit
[ 5025.765274] Info: dw_hdmi_cec_hardirq stat = 1
[ 5032.913936] Info: dw_hdmi_cec_hardirq stat = 2
[ 5032.920391] Info: dw_hdmi_cec_transmit
[ 5033.026878] Info: dw_hdmi_cec_hardirq stat = 1
[ 5040.625441] Info: dw_hdmi_cec_hardirq stat = 2
[ 5040.779982] Info: dw_hdmi_cec_hardirq stat = 2
[ 5040.903123] Info: dw_hdmi_cec_hardirq stat = 2
[ 5040.909330] Info: dw_hdmi_cec_transmit
[ 5041.016091] Info: dw_hdmi_cec_hardirq stat = 1
[ 5042.959005] type=1400 audit(1555456418.493:41): avc: denied { write } for pid=1742 comm="m.android.music" name="property_service" dev="tmpfs" ino=11488 scontext=u:r:untrusted_app:s0:c512,c768 tcontext=u:object_r:property_socket:s0 tclass=sock_file permissive=1
[ 5042.960077] type=1400 audit(1555456418.493:42): avc: denied { connectto } for pid=1742 comm="m.android.music" path="/dev/socket/property_service" scontext=u:r:untrusted_app:s0:c512,c768 tcontext=u:r:init:s0 tclass=unix_stream_socket permissive=1
[ 5042.964891] init: avc:  denied  { set } for property=media.video.player pid=1742 uid=10040 gid=10040 scontext=u:r:untrusted_app:s0:c512,c768 tcontext=u:object_r:media_prop:s0 tclass=property_service permissive=1
[ 5048.154095] Info: dw_hdmi_cec_hardirq stat = 2
[ 5048.161374] Info: dw_hdmi_cec_transmit
[ 5048.267060] Info: dw_hdmi_cec_hardirq stat = 1
[ 5055.866512] Info: dw_hdmi_cec_hardirq stat = 2
[ 5056.021016] Info: dw_hdmi_cec_hardirq stat = 2
[ 5056.144179] Info: dw_hdmi_cec_hardirq stat = 2
[ 5056.151417] Info: dw_hdmi_cec_transmit
[ 5056.257155] Info: dw_hdmi_cec_hardirq stat = 1
[ 5063.406026] Info: dw_hdmi_cec_hardirq stat = 2
[ 5063.413455] Info: dw_hdmi_cec_transmit
[ 5063.518995] Info: dw_hdmi_cec_hardirq stat = 1
[ 5071.104746] Info: dw_hdmi_cec_hardirq stat = 2
[ 5071.259035] Info: dw_hdmi_cec_hardirq stat = 2
[ 5071.382169] Info: dw_hdmi_cec_hardirq stat = 2
[ 5071.389314] Info: dw_hdmi_cec_transmit
[ 5071.495154] Info: dw_hdmi_cec_hardirq stat = 1
[ 5078.643251] Info: dw_hdmi_cec_hardirq stat = 2
[ 5078.651310] Info: dw_hdmi_cec_transmit
[ 5078.756219] Info: dw_hdmi_cec_hardirq stat = 1
[ 5086.344492] Info: dw_hdmi_cec_hardirq stat = 2
[ 5086.500103] Info: dw_hdmi_cec_hardirq stat = 2
[ 5086.623268] Info: dw_hdmi_cec_hardirq stat = 2
[ 5086.629530] Info: dw_hdmi_cec_transmit
[ 5086.736245] Info: dw_hdmi_cec_hardirq stat = 1
[ 5093.883161] Info: dw_hdmi_cec_hardirq stat = 2
[ 5093.891003] Info: dw_hdmi_cec_transmit
[ 5093.996099] Info: dw_hdmi_cec_hardirq stat = 1
[ 5101.593810] Info: dw_hdmi_cec_hardirq stat = 2
[ 5101.748224] Info: dw_hdmi_cec_hardirq stat = 2
[ 5101.871388] Info: dw_hdmi_cec_hardirq stat = 2
[ 5101.879080] Info: dw_hdmi_cec_transmit
[ 5101.984343] Info: dw_hdmi_cec_hardirq stat = 1
metropt commented 5 years ago

Can you tell me from the output if it is ok or not?

jamess-huang commented 5 years ago

Dear, metropt We saw the [ 4987.001630] Info: dw_hdmi_cec_hardirq stat = 4 in the kernel log sometimes. In our normal case, it should not output this stat. It is difficult to check the CEC issue w/o the android logcat. In addition, you reworked the H/W by yourself. It will be more difficult to clarify the issue since we cannot ensure the H/W is OK or not. Do you consider to get 1 Tinker Board S to check the CEC issue ?

metropt commented 5 years ago

I attached the android logcat. I can't buy a Tinker Board S right now.

logcat.txt

EDIT: I just realize that If I turn off my TV the board also powers off.

Thank you

jamess-huang commented 5 years ago

Dear, Metropt If you can turn off the tinker by the remote controller, the CEC function should be work. In addition, from your logcat, we also see the tinker receives the cec command successfully.

05-04 16:43:28.211 760 831 D hdmicec : poll revent:41 05-04 16:43:28.211 760 831 D hdmicec : poll receive msg 05-04 16:43:28.211 760 831 D hdmicec : poll receive msg[0]:04 05-04 16:43:28.212 760 831 D hdmicec : poll receive msg[1]:89 05-04 16:43:28.212 760 831 D hdmicec : poll receive msg[2]:01 05-04 16:43:28.214 760 760 I HdmiControlService: handleCecCommand: src: 0, dst: 4, params: 01 05-04 16:43:28.216 760 829 I hdmicec : send msg LEN:4,opcode:00,addr:40 05-04 16:43:28.323 760 829 E hdmicec : HDMI_RESULT_SUCCESS

metropt commented 5 years ago

Do you know which type of command is that? Press different buttons at the remote control doesn't produce any output on logcat, do you know why this happen?

jamess-huang commented 5 years ago

Dear metropt The current status is that Tinker can receive all the command that TV send by HDMI. After receiving the command ,Tinker needs to analyze the command and perform the related action, such as cursor move, launch App... etc. Currently, Tinker will perform the action of "left, right, up, down, enter” command.

metropt commented 5 years ago

But shouldn't I see on the logcat some info when press the tv remote control keys (left, right, etc)?

jamess-huang commented 5 years ago

Your logcat will output the log like below : 05-04 16:41:28.023 760 829 I hdmicec : send msg LEN:4,opcode:82,addr:4f

The opcode will be different when you press different button on the remote control.

metropt commented 5 years ago

There is a list where I can check what does opcode means?

jamess-huang commented 5 years ago

This is the information that we found. Maybe you can reference it https://github.com/sphinx02/AppStarter/issues/11#issuecomment-141822094 By the way, the opcode you saw in logcat is Hexadecimal

jtothehop commented 3 days ago

Does anyone know how to pull a MAC ID address through HDMI CEC using a Chromecast?