Stuck at waiting for vehicle - Herelink Air unit 1.1

I was using Herelink airunit v1 and the vehicle was showing up with that setup. I’m now trying to use airunit v1.1 with the same cubeorange + same remote, but the vehicle never shows up. I checked the logs in the airunit and there are errors related to m2o_collectMessagePack - “m2o_collectMessagePack: m2o.messagePackEnc.MsgPackSize 1 msgs 0 0 1 0 0 0 FAIL/ERROR”

Firmware version: AU01230714 (Latest)
Does anyone have any idea on what might be wrong?

Complete logs(repeat section):
01-13 16:56:02.977 414 415 D DroneIDGen: Generate drone id data seq no: 15, crc32: 8C307D85
01-13 16:56:02.978 414 415 D DroneIDGen: Lock success
01-13 16:56:02.979 414 415 D BoardControl: thermal sensor temperature max 57┬░C, report 53┬░C
01-13 16:56:03.025 412 412 I H264or5VideoServerMediaSubsession: [CameraID: 0-0] Get AuxSDPLine failed, Try again later.
01-13 16:56:03.040 414 416 D D2dTracker: received bandwidth is 17039, report 17039 for id: 0
01-13 16:56:03.074 250 250 D drone_id_read: New drone id seq no: 15, len: 38340, gen time: 24385, crc32: 8C307D85 8C307D85 PASS
01-13 16:56:03.186 231 258 I rc_service: radio status r:-67, cr:-66, s:34, cs:32, fs:0
01-13 16:56:03.186 231 258 I rc_service: radio threshold filter:0.25, snr_hmin:-10, snr_hmax:-5, rssi_hmin:-130, rssi_hmax:-125
01-13 16:56:03.193 412 412 I H264or5VideoServerMediaSubsession: [CameraID: 0-0] Get AuxSDPLine failed, Try again later.
01-13 16:56:03.341 414 416 D D2dTracker: received bandwidth is 16268, report 16268 for id: 0
01-13 16:56:03.360 412 412 I H264or5VideoServerMediaSubsession: [CameraID: 0-0] Get AuxSDPLine failed, Try again later.
01-13 16:56:03.485 231 257 I rc_service: sbus:0 total frame number(1s):25, loss frame number(1s):0
01-13 16:56:03.485 231 257 I rc_service: sbus:1 total frame number(1s):25, loss frame number(1s):0
01-13 16:56:03.528 412 412 I H264or5VideoServerMediaSubsession: [CameraID: 0-0] Get AuxSDPLine failed, Try again later.
01-13 16:56:03.644 414 416 D D2dTracker: received bandwidth is 16869, report 16869 for id: 0
01-13 16:56:03.695 412 412 I H264or5VideoServerMediaSubsession: [CameraID: 0-0] Get AuxSDPLine failed, Try again later.
01-13 16:56:03.863 412 412 I H264or5VideoServerMediaSubsession: [CameraID: 0-0] Get AuxSDPLine failed, Try again later.
01-13 16:56:03.939 414 415 I DroneIDGen: Starting Drone ID Generation
01-13 16:56:03.939 414 415 E DroneIDGen: m2o_collectMessagePack: m2o.messagePackEnc.MsgPackSize 1 msgs 0 0 1 0 0 0 FAIL/ERROR
01-13 16:56:03.940 414 415 D DroneIDGen: dsInformation: FA0BBC0D10F21901220000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000

@Michael_Oborne

Adding the complete logs. Seems like the modem is kaput. This airunit has been used only once to test whether it was working. Tagging @philip for assistance.

01-01 00:03:16.750   188   188 W auditd  : type=2000 audit(0.0:1): initialized
01-01 00:03:19.560   188   188 I auditd  : type=1403 audit(0.0:2): policy loaded auid=4294967295 ses=4294967295
01-01 00:03:19.986     1     1 I init    : type=1400 audit(0.0:3): avc: denied { create } for name="cpu.rt_period_us" scontext=u:r:init:s0 tcontext=u:object_r:cgroup:s0 tclass=file permissive=1
01-01 00:03:19.993     1     1 I init    : type=1400 audit(0.0:4): avc: denied { write } for name="vibrator" dev="sysfs" ino=14294 scontext=u:r:init:s0 tcontext=u:object_r:sysfs:s0 tclass=dir permissive=1
01-01 00:03:19.993     1     1 I init    : type=1400 audit(0.0:5): avc: denied { add_name } for name="trigger" scontext=u:r:init:s0 tcontext=u:object_r:sysfs:s0 tclass=dir permissive=1
01-01 00:03:19.993     1     1 I init    : type=1400 audit(0.0:6): avc: denied { create } for name="trigger" scontext=u:r:init:s0 tcontext=u:object_r:sysfs:s0 tclass=file permissive=1
01-01 00:03:20.266   179   179 I e2fsck  : type=1400 audit(0.0:7): avc: denied { getattr } for path="/dev/block/mmcblk1p10" dev="tmpfs" ino=10404 scontext=u:r:fsck:s0 tcontext=u:object_r:block_device:s0 tclass=blk_file permissive=1
01-01 00:03:20.266   179   179 I e2fsck  : type=1400 audit(0.0:8): avc: denied { read } for name="mmcblk1p10" dev="tmpfs" ino=10404 scontext=u:r:fsck:s0 tcontext=u:object_r:block_device:s0 tclass=blk_file permissive=1
01-01 00:03:20.266   179   179 I e2fsck  : type=1400 audit(0.0:9): avc: denied { open } for path="/dev/block/mmcblk1p10" dev="tmpfs" ino=10404 scontext=u:r:fsck:s0 tcontext=u:object_r:block_device:s0 tclass=blk_file permissive=1
01-01 00:03:20.266   179   179 I e2fsck  : type=1400 audit(0.0:10): avc: denied { write } for name="mmcblk1p10" dev="tmpfs" ino=10404 scontext=u:r:fsck:s0 tcontext=u:object_r:block_device:s0 tclass=blk_file permissive=1
01-01 00:03:20.403   198   198 I busybox : type=1400 audit(0.0:12): avc: denied { getattr } for path="/dev/block/mmcblk1p20" dev="tmpfs" ino=10400 scontext=u:r:shell:s0 tcontext=u:object_r:block_device:s0 tclass=blk_file permissive=1
01-01 00:03:20.403   198   198 I busybox : type=1400 audit(0.0:13): avc: denied { mounton } for path="/sdcard" dev="rootfs" ino=10445 scontext=u:r:shell:s0 tcontext=u:object_r:rootfs:s0 tclass=dir permissive=1
01-01 00:03:20.406   198   198 I busybox : type=1400 audit(0.0:14): avc: denied { mount } for name="/" dev="mmcblk1p20" ino=1 scontext=u:r:shell:s0 tcontext=u:object_r:vfat:s0 tclass=filesystem permissive=1
01-01 00:03:20.432     1     1 I vdc     : executing /system/bin/vdc failed: No such file or directory
01-01 00:03:20.432   199   199 E logwrapper: executing /system/bin/vdc failed: No such file or directory
01-01 00:03:20.433     1     1 I vdc     : vdc terminated by exit(255)
01-01 00:03:20.503   195   195 I         : debuggerd: starting
01-01 00:03:20.540   194   194 I         : debuggerd: starting
01-01 00:03:20.546   206   206 I init_logcontrol: type=1400 audit(0.0:15): avc: denied { getattr } for path="/vendor" dev="rootfs" ino=5203 scontext=u:r:init_logcontrol:s0 tcontext=u:object_r:rootfs:s0 tclass=lnk_file permissive=1
01-01 00:03:20.556   206   206 I init_logcontrol: type=1400 audit(0.0:16): avc: denied { write } for name="property_service" dev="tmpfs" ino=9230 scontext=u:r:init_logcontrol:s0 tcontext=u:object_r:property_socket:s0 tclass=sock_file permissive=1
01-01 00:03:20.556   206   206 I init_logcontrol: type=1400 audit(0.0:17): avc: denied { connectto } for path="/dev/socket/property_service" scontext=u:r:init_logcontrol:s0 tcontext=u:r:init:s0 tclass=unix_stream_socket permissive=1
01-01 00:03:20.558   206   206 I Init_LogControl: offline log disabled
01-01 00:03:20.573   213   213 I check_config: type=1400 audit(0.0:18): avc: denied { getattr } for path="/vendor" dev="rootfs" ino=5203 scontext=u:r:check_config:s0 tcontext=u:object_r:rootfs:s0 tclass=lnk_file permissive=1
01-01 00:03:20.583   213   213 I check_config: type=1400 audit(0.0:19): avc: denied { write } for name="/" dev="tmpfs" ino=10483 scontext=u:r:check_config:s0 tcontext=u:object_r:tmpfs:s0 tclass=dir permissive=1
01-01 00:03:20.583   213   213 I check_config: type=1400 audit(0.0:20): avc: denied { add_name } for name="lampsignal.json" scontext=u:r:check_config:s0 tcontext=u:object_r:tmpfs:s0 tclass=dir permissive=1
01-01 00:03:20.583   213   213 I check_config: type=1400 audit(0.0:21): avc: denied { create } for name="lampsignal.json" scontext=u:r:check_config:s0 tcontext=u:object_r:tmpfs:s0 tclass=lnk_file permissive=1
01-01 00:03:20.586   213   213 D check_config: check access of /system/etc/lampsignal-telepathy-air.json
01-01 00:03:20.586   213   213 D check_config: Link to config path : /system/etc/lampsignal-telepathy-air.json
01-01 00:03:20.587   213   213 D check_config: check access of /system/etc/rc_service_config_telepathy-air.ini
01-01 00:03:20.587   213   213 D check_config: Link to config path : /system/etc/rc_service_config_telepathy-air.ini
01-01 00:03:20.587   213   213 D check_config: check access of /system/etc/mavlink-router.telepathy-air.conf
01-01 00:03:20.588   213   213 D check_config: Link to config path : /system/etc/mavlink-router.telepathy-air.conf
01-01 00:03:20.588   213   213 D check_config: check access of /system/etc/system-control.telepathy-air.conf
01-01 00:03:20.588   213   213 D check_config: Link to config path : /system/etc/system-control.telepathy-air.conf
01-01 00:03:20.588   213   213 D check_config: check access of /system/etc/device_manager_config.telepathy-air.ini
01-01 00:03:20.588   213   213 D check_config: check access of /system/etc/device_manager_config.ini
01-01 00:03:20.588   213   213 D check_config: Failed to find config path for: device_manager
01-01 00:03:20.588   213   213 D check_config: check access of /data/rc-service/joystickconfig.ini
01-01 00:03:20.588   213   213 D check_config: preload file not exist: /system/etc/joystickconfig.telepathy-air.ini
01-01 00:03:20.588   213   213 D check_config: check access of /data/rc-service/keyconfig.ini
01-01 00:03:20.589   213   213 D check_config: preload file not exist: /system/etc/keyconfig.telepathy-air.ini
01-01 00:03:20.613     1     1 I init    : type=1400 audit(0.0:22): avc: denied { module_request } for kmod="usbfunc:audio_source" scontext=u:r:init:s0 tcontext=u:r:kernel:s0 tclass=system permissive=1
01-01 00:03:20.616     1     1 I init    : type=1400 audit(0.0:23): avc: denied { write } for name="mmcblk1p20" dev="tmpfs" ino=10400 scontext=u:r:init:s0 tcontext=u:object_r:block_device:s0 tclass=blk_file permissive=1
01-01 00:03:20.616     1     1 I init    : type=1400 audit(0.0:24): avc: denied { create } for name="schedtune.prefer_idle" scontext=u:r:init:s0 tcontext=u:object_r:cgroup:s0 tclass=file permissive=1
01-01 00:03:20.616     1     1 I init    : type=1400 audit(0.0:25): avc: denied { write } for name="gpio" dev="sysfs" ino=4669 scontext=u:r:init:s0 tcontext=u:object_r:sysfs:s0 tclass=dir permissive=1
01-01 00:03:20.616     1     1 I init    : type=1400 audit(0.0:26): avc: denied { add_name } for name="export" scontext=u:r:init:s0 tcontext=u:object_r:sysfs:s0 tclass=dir permissive=1
01-01 00:03:20.616     1     1 I init    : type=1400 audit(0.0:27): avc: denied { create } for name="export" scontext=u:r:init:s0 tcontext=u:object_r:sysfs:s0 tclass=file permissive=1
--------- beginning of system
01-01 00:03:20.634   196   196 I vold    : Vold 3.0 (the awakening) firing up
01-01 00:03:20.634   196   196 V vold    : Detected support for: ext4 vfat
01-01 00:03:20.648   210   210 E connect_manager: is_restart 0, product value is 0, passthrough setting is 0, device id id 10
01-01 00:03:20.648   210   210 D connect_manager: get_ip_form_device_id: uav ip=192.168.0.10,192.168.144.10 gcs ip=192.168.0.11,192.168.144.11 vxlan id=-1
01-01 00:03:20.648   212   212 I SurfaceFlinger: SurfaceFlinger is starting
01-01 00:03:20.648   212   212 I SurfaceFlinger: SurfaceFlinger's main thread ready to run. Initializing graphics H/W...
01-01 00:03:20.648   212   212 E cutils-trace: Error opening trace file: Permission denied (13)
01-01 00:03:20.656   232   232 I lampsignal: type=1400 audit(0.0:28): avc: denied { getattr } for path="/vendor" dev="rootfs" ino=5203 scontext=u:r:lampsignal:s0 tcontext=u:object_r:rootfs:s0 tclass=lnk_file permissive=1
01-01 00:03:20.662   228   228 D song-mla-manager:
01-01 00:03:20.662   228   228 D song-mla-manager:     song-mla-manager, version 1.0.0
01-01 00:03:20.662   228   228 D song-mla-manager:     COPYRIGHT (C) 2015 Beijing Pinecone Electronics Co., Ltd
01-01 00:03:20.662   228   228 D song-mla-manager: PID of song-mla-manager: 228
01-01 00:03:20.662   228   228 D song-mla-manager: Current usb state: [0]
01-01 00:03:20.662   228   228 D song-mla-manager: usb state not correct,exit
01-01 00:03:20.670   233   233 I usbethx : type=1400 audit(0.0:29): avc: denied { read } for name="psched" dev="proc" ino=4026532030 scontext=u:r:usbethx:s0 tcontext=u:object_r:proc_net:s0 tclass=file permissive=1
01-01 00:03:20.673   245   245 I mediacodec: type=1400 audit(0.0:30): avc: denied { getattr } for path="/vendor" dev="rootfs" ino=5203 scontext=u:r:mediacodec:s0 tcontext=u:object_r:rootfs:s0 tclass=lnk_file permissive=1
01-01 00:03:20.676   233   233 I usbethx : type=1400 audit(0.0:31): avc: denied { open } for path="/proc/233/net/psched" dev="proc" ino=4026532030 scontext=u:r:usbethx:s0 tcontext=u:object_r:proc_net:s0 tclass=file permissive=1
01-01 00:03:20.676   233   233 I usbethx : type=1400 audit(0.0:32): avc: denied { getattr } for path="/proc/233/net/psched" dev="proc" ino=4026532030 scontext=u:r:usbethx:s0 tcontext=u:object_r:proc_net:s0 tclass=file permissive=1
01-01 00:03:20.676   235   235 I rc_service: type=1400 audit(0.0:33): avc: denied { read } for name="rc_service_config.ini" dev="tmpfs" ino=10554 scontext=u:r:rc_service:s0 tcontext=u:object_r:tmpfs:s0 tclass=lnk_file permissive=1
01-01 00:03:20.683   233   233 I usbethx : usbethx starting
01-01 00:03:20.683   235   235 I rc_service: starting air rc service
01-01 00:03:20.683   235   235 I rc_service: config info -> filter:0.25, snr_hmin:-10, snr_hmax:-5, rssi_hmin:-130, rssi_hmax:-125, is_low_speed:1,sbus1_port:/dev/ttyS1, sbus2_port:/dev/ttyS0, rc_inet_udp_port:16666, radio_unix_udp_name:/tmp/unix_radio
01-01 00:03:20.683   235   235 I rc_service: /dev/ttyS1 sbus uart init success
01-01 00:03:20.683   235   235 I rc_service: /dev/ttyS1 sbus init success
01-01 00:03:20.684   235   235 I rc_service: /dev/ttyS0 sbus uart init success
01-01 00:03:20.684   235   235 I rc_service: /dev/ttyS0 sbus init success
01-01 00:03:20.690   210   210 I connect_manager: type=1400 audit(0.0:34): avc: denied { read } for name="modem_status" dev="sysfs" ino=12185 scontext=u:r:connect_daemon:s0 tcontext=u:object_r:sysfs:s0 tclass=file permissive=1
01-01 00:03:20.690   210   210 I connect_manager: type=1400 audit(0.0:35): avc: denied { open } for path="/sys/devices/platform/soc/0.modem/modem_status" dev="sysfs" ino=12185 scontext=u:r:connect_daemon:s0 tcontext=u:object_r:sysfs:s0 tclass=file permissive=1
01-01 00:03:20.690   210   210 E connect_manager: camera mode is 1, camera test mode is 0, passthrough 0, start camera service normal
01-01 00:03:20.692   210   210 E connect_manager: modem not ready, retrying...
01-01 00:03:20.693   255   255 I vendorservice.s: type=1400 audit(0.0:36): avc: denied { read execute } for path="/system/bin/sh" dev="mmcblk1p17" ino=229 scontext=u:r:vendorservice:s0 tcontext=u:object_r:shell_exec:s0 tclass=file permissive=1
01-01 00:03:20.696   234   234 I key_service: type=1400 audit(0.0:37): avc: denied { read } for name="event2" dev="tmpfs" ino=10324 scontext=u:r:key_service:s0 tcontext=u:object_r:input_device:s0 tclass=chr_file permissive=1
01-01 00:03:20.696   255   255 I vendorservice.s: type=1400 audit(0.0:38): avc: denied { getattr } for path="/system/bin/sh" dev="mmcblk1p17" ino=229 scontext=u:r:vendorservice:s0 tcontext=u:object_r:shell_exec:s0 tclass=file permissive=1
01-01 00:03:20.696   255   255 I vendorservice.s: type=1400 audit(0.0:39): avc: denied { getattr } for path="/vendor" dev="rootfs" ino=5203 scontext=u:r:vendorservice:s0 tcontext=u:object_r:rootfs:s0 tclass=lnk_file permissive=1
01-01 00:03:20.699   234   234 I key_service: name = spmu_pwron
01-01 00:03:20.699   234   234 I key_service:
01-01 00:03:20.699   227   227 D song-oms-pub: pub_util_get_pid_and_check_run()
01-01 00:03:20.699   227   227 D song-oms-pub: pub_util_get_pid_and_check_run pid_file_ptr[/tmp/song-oms-sa.pid] name_ptr[song-oms-sa]
01-01 00:03:20.699   234   234 I key_service: name = pwm-ir
01-01 00:03:20.699   234   234 I key_service:
01-01 00:03:20.699   227   227 D song-oms-pub: FILE-vendor/pinecone/services/song-oms-serv/song-oms-sa/../song-oms-pub/util/util.c, LINE-806, FUNC-pub_util_get_pid_and_check_run(), error_code=-118, errno=2
01-01 00:03:20.699   227   227 D song-oms-pub: Open file "/tmp/song-oms-sa.pid" fail: 2 - No such file or directory
01-01 00:03:20.699   227   227 D song-oms-pub: pub_util_get_pid_and_check_run return is_run_ptr[0] pid_ptr[0]
01-01 00:03:20.699   234   234 I key_service: name = gpio_keys
01-01 00:03:20.699   234   234 I key_service:
01-01 00:03:20.699   227   227 D song-oms-sa:
01-01 00:03:20.699   227   227 D song-oms-sa:     song-oms-sa, version 001.001
01-01 00:03:20.699   227   227 D song-oms-sa:     COPYRIGHT (C) 2015 Beijing Pinecone Electronics Co., Ltd
01-01 00:03:20.699   234   234 I key_service: Find it at 2
01-01 00:03:20.699   227   227 D song-oms-pub: pub_util_create_pid_file()
01-01 00:03:20.700   234   234 I key_service: type=1400 audit(0.0:40): avc: denied { open } for path="/dev/input/event2" dev="tmpfs" ino=10324 scontext=u:r:key_service:s0 tcontext=u:object_r:input_device:s0 tclass=chr_file permissive=1
01-01 00:03:20.703   257   257 I usbethx : type=1400 audit(0.0:41): avc: denied { execute } for name="busybox" dev="rootfs" ino=5139 scontext=u:r:usbethx:s0 tcontext=u:object_r:rootfs:s0 tclass=file permissive=1
01-01 00:03:20.703   257   257 I usbethx : type=1400 audit(0.0:42): avc: denied { read open } for path="/bin/busybox" dev="rootfs" ino=5139 scontext=u:r:usbethx:s0 tcontext=u:object_r:rootfs:s0 tclass=file permissive=1
01-01 00:03:20.703   257   257 I usbethx : type=1400 audit(0.0:43): avc: denied { execute_no_trans } for path="/bin/busybox" dev="rootfs" ino=5139 scontext=u:r:usbethx:s0 tcontext=u:object_r:rootfs:s0 tclass=file permissive=1
01-01 00:03:20.703   257   257 I busybox : type=1400 audit(0.0:44): avc: denied { execmem } for scontext=u:r:usbethx:s0 tcontext=u:r:usbethx:s0 tclass=process permissive=1
01-01 00:03:20.704   257   257 I usbethx : /bin/busybox brctl addbr br-vxlan
01-01 00:03:20.706   255   255 I vendorservice.s: type=1400 audit(0.0:45): avc: denied { getattr } for path="/system/bin/toolbox" dev="mmcblk1p17" ino=267 scontext=u:r:vendorservice:s0 tcontext=u:object_r:toolbox_exec:s0 tclass=file permissive=1
01-01 00:03:20.706   255   255 I vendorservice.s: type=1400 audit(0.0:46): avc: denied { execute } for name="toolbox" dev="mmcblk1p17" ino=267 scontext=u:r:vendorservice:s0 tcontext=u:object_r:toolbox_exec:s0 tclass=file permissive=1
01-01 00:03:20.710   268   268 I vendorservice.s: type=1400 audit(0.0:47): avc: denied { read open } for path="/system/bin/toolbox" dev="mmcblk1p17" ino=267 scontext=u:r:vendorservice:s0 tcontext=u:object_r:toolbox_exec:s0 tclass=file permissive=1
01-01 00:03:20.710   268   268 I vendorservice.s: type=1400 audit(0.0:48): avc: denied { execute_no_trans } for path="/system/bin/toolbox" dev="mmcblk1p17" ino=267 scontext=u:r:vendorservice:s0 tcontext=u:object_r:toolbox_exec:s0 tclass=file permissive=1
01-01 00:03:20.710   257   257 I busybox : type=1400 audit(0.0:49): avc: denied { create } for scontext=u:r:usbethx:s0 tcontext=u:r:usbethx:s0 tclass=tcp_socket permissive=1
01-01 00:03:20.713   257   257 I busybox : type=1400 audit(0.0:50): avc: denied { net_raw } for capability=13 scontext=u:r:usbethx:s0 tcontext=u:r:usbethx:s0 tclass=capability permissive=1
01-01 00:03:20.716   233   233 D usbethx : Open file /data/mac.txt failed
01-01 00:03:20.747   269   269 I usbethx : ifconfig br-vxlan hw ether (B8:8D:F1:FF:63:b3)
01-01 00:03:20.766   229   229 I SONG-ELOG: set config path(/data/song-elog/song-elog.cfg).
01-01 00:03:20.769   260   260 I perfprofd: starting Android Wide Profiling daemon
01-01 00:03:20.771   268   268 I vendorservice.sh: start
01-01 00:03:20.771   227   227 D song-oms-pub: PID of song-oms-sa: 227
01-01 00:03:20.773   229   229 E SONG-ELOG: remove file(/data/song-elog/song-elog.pid) error:2-No such file or directory

01-01 00:03:20.773   229   229 I SONG-ELOG: pid_file_delete success
01-01 00:03:20.773   229   229 I SONG-ELOG: Has '-p' Parameter
01-01 00:03:20.775   227   227 D song-oms-sa: buffer.bavail:240489 buffer.f_bsize:4096 low_size:3145728
01-01 00:03:20.775   227   227 D song-oms-sa: sa_cfg_init()
01-01 00:03:20.775   227   227 D song-oms-sa: parse_sa_cfg()
01-01 00:03:20.778   260   260 E perfprofd: unable to open configuration file /data/data/com.google.android.gms/files/perfprofd.conf
01-01 00:03:20.778   260   260 I perfprofd: random seed set to 3453744259
01-01 00:03:20.782   227   227 D song-oms-sa: [cfg]song.tty.cmd = /dev/ttySA
01-01 00:03:20.782   227   227 D song-oms-sa: [cfg]song.log.size = 1048576
01-01 00:03:20.782   227   227 D song-oms-sa: sa_handle_init()
01-01 00:03:20.782   227   227 D song-oms-sa: auto_start_service_list_read()
01-01 00:03:20.784   259   259 E drone_id_read: Error open file
01-01 00:03:20.810   227   227 D song-oms-sa: FILE-vendor/pinecone/services/song-oms-serv/song-oms-sa/./sa/sa-handle.c, LINE-438, FUNC-auto_start_service_list_read(), error_code=-118, errno=2
01-01 00:03:20.810   227   227 D song-oms-sa: open file "/data/song-oms-sa/auto-start.lst" fail: 2 - No such file or directory
01-01 00:03:20.810   227   227 D song-oms-sa: auto_start_service_list_run()
01-01 00:03:20.810   227   227 D song-oms-sa: sa_handle_init m_pts_mapping_name_a[/dev/ttySA]
01-01 00:03:20.810   227   227 D song-oms-sa: sa_is_can_start_log_service()
01-01 00:03:20.810   227   227 D song-oms-sa: sa_get_data_space_info()
01-01 00:03:20.810   227   227 D song-oms-sa: data space, total[1015704KB], used[53752KB], available[961952KB].
01-01 00:03:20.810   227   227 D song-oms-sa: sa_start_log_proc()
01-01 00:03:20.810   227   227 D song-oms-sa: get_song_log_config()
01-01 00:03:20.810   227   227 D song-oms-sa: get_song_log_config song_log_config_value=[/data/local/log,I1,0,0,I2,0,0,I3,0,0,I4,0,0,I5,0,0,I6,0,0]
01-01 00:03:20.810   227   227 D song-oms-sa: parse_song_log_config()
01-01 00:03:20.810   227   227 D song-oms-sa: parse_song_log_config g_song_log_svc[0]: type[I1] type_id[1] file_num[0] file_num_val[0] file_size[0] file_size_val[85899345920]
01-01 00:03:20.810   227   227 D song-oms-sa: parse_song_log_config g_song_log_svc[1]: type[I2] type_id[2] file_num[0] file_num_val[0] file_size[0] file_size_val[85899345920]
01-01 00:03:20.810   227   227 D song-oms-sa: parse_song_log_config g_song_log_svc[2]: type[I3] type_id[3] file_num[0] file_num_val[0] file_size[0] file_size_val[85899345920]
01-01 00:03:20.810   227   227 D song-oms-sa: parse_song_log_config g_song_log_svc[3]: type[I4] type_id[4] file_num[0] file_num_val[0] file_size[0] file_size_val[85899345920]
01-01 00:03:20.811   227   227 D song-oms-sa: parse_song_log_config g_song_log_svc[4]: type[I5] type_id[5] file_num[0] file_num_val[0] file_size[0] file_size_val[85899345920]
01-01 00:03:20.811   227   227 D song-oms-sa: parse_song_log_config g_song_log_svc[5]: type[I6] type_id[6] file_num[0] file_num_val[0] file_size[0] file_size_val[85899345920]
01-01 00:03:20.811   227   227 D song-oms-sa: parse_song_log_config g_song_log_svc[6]: type[] type_id[0] file_num[] file_num_val[0] file_size[] file_size_val[85899345920]
01-01 00:03:20.811   227   227 D song-oms-sa: check_song_log_path()
01-01 00:03:20.811   227   227 D song-oms-sa: check_song_log_path log_path=[/data/local/log]
01-01 00:03:20.811   227   227 D song-oms-sa: LC log path "/data/local/log" exist.
01-01 00:03:20.811   227   227 D song-oms-sa: start_ipdata_log_service()
01-01 00:03:20.811   227   227 D song-oms-sa: start_ipdata_log_service type_id[2] file_num_val[0] file_size_val[0]
01-01 00:03:20.811   227   227 D song-oms-sa: start_ipdata_log_service need no ipdata
01-01 00:03:20.811   227   227 D song-oms-sa: start_kernel_log_service()
01-01 00:03:20.811   227   227 D song-oms-sa: start_kernel_log_service type_id[3] file_num_val[0] file_size_val[0]
01-01 00:03:20.811   227   227 D song-oms-sa: start_kernel_log_service need no kmsg
01-01 00:03:20.811   227   227 D song-oms-sa: start_logcat_services()
01-01 00:03:20.811   227   227 D song-oms-sa: start_logcat_services type[I4] file_num_val[0] file_size_val[0]
01-01 00:03:20.811   227   227 D song-oms-sa: start_logcat_services need no logcat
01-01 00:03:20.811   227   227 D song-oms-sa: start_logcat_services()
01-01 00:03:20.811   227   227 D song-oms-sa: start_logcat_services type[I5] file_num_val[0] file_size_val[0]
01-01 00:03:20.811   227   227 D song-oms-sa: start_logcat_services need no logcat
01-01 00:03:20.811   227   227 D song-oms-sa: start_logcat_services()
01-01 00:03:20.811   227   227 D song-oms-sa: start_logcat_services type[I6] file_num_val[0] file_size_val[0]
01-01 00:03:20.811   227   227 D song-oms-sa: start_logcat_services need no logcat
01-01 00:03:20.811   227   227 D song-oms-sa: sa_handle_init m_read_cmd_thread_id[483313841232] ret_val[0]
01-01 00:03:20.814   227   280 D song-oms-sa: sa_handle_read_cmd_loop()
01-01 00:03:20.814   227   280 D song-oms-pub: pub_pty_open()
01-01 00:03:20.815   227   280 D song-oms-pub: pub_pty_open m_ptm_fd[0]
01-01 00:03:20.815   227   280 D song-oms-pub: pub_pty_open m_ptm_fd[5]
01-01 00:03:20.815   227   280 D song-oms-pub: create_pts_mapping()
01-01 00:03:20.815   227   280 D song-oms-pub: create_pts_mapping pts_name_ptr[/dev/pts/0]
01-01 00:03:20.815   227   280 D song-oms-pub: create_pts_mapping m_pts_name_a[/dev/pts/0] ret_val[0]
01-01 00:03:20.815   227   280 D song-oms-pub: create_pts_mapping unlink(/dev/ttySA) ret_val[-1]
01-01 00:03:20.815   227   280 D song-oms-pub: create_pts_mapping symlink(/dev/pts/0, /dev/ttySA) ret_val[0]
01-01 00:03:20.815   227   280 D song-oms-pub: create_pts_mapping chmod(/dev/ttySA, 432) ret_val[0]
01-01 00:03:20.815   227   280 D song-oms-pub: create_pts_mapping chown(/dev/ttySA, 1000, 1001) ret_val[0]
01-01 00:03:20.815   227   280 D song-oms-pub: create_pts_mapping m_pts_mapping_name_a[/dev/ttySA] ret_val[0]
01-01 00:03:20.815   227   280 D song-oms-pub: set_ptm_attr()
01-01 00:03:20.815   227   280 D song-oms-pub: set_ptm_attr fd[5]
01-01 00:03:20.815   227   280 D song-oms-pub: set_ptm_attr tcgetattr(5) ret_val[0]
01-01 00:03:20.815   227   280 D song-oms-pub: set_ptm_attr tcsetattr(5) ret_val[0]
01-01 00:03:20.815   227   280 D song-oms-pub: set_ptm_attr grantpt(5) ret_val[0]
01-01 00:03:20.815   227   280 D song-oms-pub: set_ptm_attr unlockpt(5) ret_val[0]
01-01 00:03:20.816   227   280 D song-oms-pub: set_ptm_attr fd[5] ret_val[0]
01-01 00:03:20.816   227   280 D song-oms-pub: pub_pty_open "/dev/ttySA" exists
01-01 00:03:20.816   227   280 D song-oms-pub: pub_pty_open m_ptm_fd[5]; m_pts_name_a[/dev/pts/0] m_pts_mapping_name_a[/dev/ttySA]
01-01 00:03:20.816   227   280 D song-oms-sa: sa_handle_read_cmd_loop pub_pty_open m_ptm_fd[5] pts_name_a[/dev/pts/0] pts_mapping_name_a[/dev/ttySA] is_nonblock_mode[0] ret_val[0]
01-01 00:03:20.845   249   249 D libgps  : Init: created thread tid(0xe93f7450)
01-01 00:03:20.848   249   286 D libgps  : ipc_thread_proc: IPC thread started by Java framework
01-01 00:03:20.858   229   229 I SONG-ELOG: get property: "persist.sys.elog.auto.run=0", result(0)
01-01 00:03:20.858   229   229 I SONG-ELOG: property(persist.sys.elog.auto.run) value:0.
01-01 00:03:20.858   229   229 I SONG-ELOG: Has '-p' Parameter; and property(persist.sys.elog.auto.run) value is '0', so directly exit.
01-01 00:03:20.858   229   229 D SONG-ELOG: connect_and_send am broadcast -a android.intent.action.SONG_ELOG_EXIT_STATUS --ei Status 0, length is 73
01-01 00:03:20.859   229   229 D SONG-ELOG: Error connecting (Connection refused)
01-01 00:03:20.859   229   229 I SONG-ELOG: system cmd:am broadcast -a android.intent.action.SONG_ELOG_EXIT_STATUS --ei Status 0
01-01 00:03:20.880   212   212 D libEGL  : loaded /vendor/lib64/egl/libGLES_1_mali.so
01-01 00:03:20.885   259   259 E drone_id_read: Error open file
01-01 00:03:20.885   244   244 I keystore: Could not find any keystore module, using software-only implementation.
01-01 00:03:20.885   244   244 I SoftKeymaster: system/keymaster/soft_keymaster_device.cpp, Line 131: Creating device
01-01 00:03:20.885   244   244 D SoftKeymaster: system/keymaster/soft_keymaster_device.cpp, Line 132: Device address: 0x7875a3e000
01-01 00:03:20.885   244   244 I SoftKeymaster: system/keymaster/soft_keymaster_device.cpp, Line 131: Creating device
01-01 00:03:20.885   244   244 D SoftKeymaster: system/keymaster/soft_keymaster_device.cpp, Line 132: Device address: 0x7875a3e400
01-01 00:03:20.907   242   242 D wpa_supplicant: wpa_supplicant v2.6-devel-7.1.2
01-01 00:03:20.915   242   242 D wpa_supplicant: random: Added entropy from /data/misc/wifi/entropy.bin (own_pool_ready=0)
01-01 00:03:20.915   242   242 D wpa_supplicant: random: Trying to read entropy from /dev/random
01-01 00:03:20.915   242   242 D wpa_supplicant: Get randomness: len=20 entropy=1
01-01 00:03:20.917   233   233 I usbethx : change@/devices/virtual/android_usb/android0
01-01 00:03:20.918   233   233 I usbethx : ACTION=change
01-01 00:03:20.918   233   233 I usbethx : DEVPATH=/devices/virtual/android_usb/android0
01-01 00:03:20.918   233   233 I usbethx : SUBSYSTEM=android_usb
01-01 00:03:20.918   233   233 I usbethx : USB_STATE=CONNECTED
01-01 00:03:20.918   233   233 I usbethx : SEQNUM=1681
01-01 00:03:20.926   242   242 D wpa_supplicant: random: Updated entropy file /data/misc/wifi/entropy.bin (own_pool_ready=0)
01-01 00:03:20.937   242   242 D wpa_supplicant: Global control interface '@android:wpa_wlan0'
01-01 00:03:20.937   242   242 D wpa_supplicant: Using Android control socket 'wpa_wlan0'
01-01 00:03:20.937   242   242 I wpa_supplicant: Successfully initialized wpa_supplicant
01-01 00:03:20.937   242   242 D wpa_supplicant: Initializing interface 'wlan0' conf '/data/misc/wifi/wpa_supplicant.conf' driver 'nl80211' ctrl_interface 'N/A' bridge 'N/A'
01-01 00:03:20.937   242   242 D wpa_supplicant: Configuration file '/data/misc/wifi/wpa_supplicant.conf' -> '/data/misc/wifi/wpa_supplicant.conf'
01-01 00:03:20.937   242   242 D wpa_supplicant: Reading configuration file '/data/misc/wifi/wpa_supplicant.conf'
01-01 00:03:20.938   242   242 D wpa_supplicant: update_config=1
01-01 00:03:20.938   242   242 D wpa_supplicant: Reading configuration file '/system/etc/wifi/p2p_supplicant_overlay.conf'
01-01 00:03:20.938   233   233 I usbethx : change@/devices/virtual/android_usb/android0
01-01 00:03:20.938   233   233 I usbethx : ACTION=change
01-01 00:03:20.938   233   233 I usbethx : DEVPATH=/devices/virtual/android_usb/android0
01-01 00:03:20.938   233   233 I usbethx : SUBSYSTEM=android_usb
01-01 00:03:20.938   233   233 I usbethx : USB_STATE=CONFIGURED
01-01 00:03:20.938   233   233 I usbethx : SEQNUM=1682
01-01 00:03:20.945   242   242 D wpa_supplicant: disable_scan_offload=1
01-01 00:03:20.945   242   242 D wpa_supplicant: wowlan_triggers='any'
01-01 00:03:20.945   242   242 D wpa_supplicant: P2P: p2p_no_go_freq with 1 items
01-01 00:03:20.945   242   242 D wpa_supplicant: p2p_search_delay=0
01-01 00:03:20.945   242   242 D wpa_supplicant: no_ctrl_interface -> ctrl_interface=NULL
01-01 00:03:20.953   242   242 E wpa_supplicant: Could not read interface wlan0 flags: No such device
01-01 00:03:20.953   242   242 I wpa_supplicant: nl80211: Driver does not support authentication/association or connect commands
01-01 00:03:20.953   242   242 I wpa_supplicant: nl80211: deinit ifname=wlan0 disabled_11b_rates=0
01-01 00:03:20.953   242   242 D wpa_supplicant: nl80211: Remove monitor interface: refcount=0
01-01 00:03:20.953   242   242 D wpa_supplicant: netlink: Operstate: ifindex=0 linkmode=0 (kernel-control), operstate=6 (IF_OPER_UP)
01-01 00:03:20.955   242   242 E wpa_supplicant: Could not read interface wlan0 flags: No such device
01-01 00:03:20.955   242   242 D wpa_supplicant: nl80211: Set mode ifindex 0 iftype 2 (STATION)
01-01 00:03:20.955   242   242 D wpa_supplicant: nl80211: Failed to set interface 0 to mode 2: -19 (No such device)
01-01 00:03:20.955   242   242 E wpa_supplicant: wlan0: Failed to initialize driver interface
01-01 00:03:20.955   242   242 D wpa_supplicant: Failed to add interface wlan0
01-01 00:03:20.955   242   242 D wpa_supplicant: wlan0: Cancelling scan request
01-01 00:03:20.955   242   242 D wpa_supplicant: wlan0: Cancelling authentication timeout
01-01 00:03:20.955   242   242 D wpa_supplicant: Off-channel: Clear pending Action frame TX (pending_action_tx=0x0
01-01 00:03:20.955   253   253 D gpsd    : main()
01-01 00:03:20.955   253   253 D gpsd    : argv[0] = '/system/bin/glgps'
01-01 00:03:20.955   253   253 D gpsd    : argv[1] = '-c'
01-01 00:03:20.955   253   253 D gpsd    : argv[2] = '/system/etc/gpsconfig.xml'
01-01 00:03:20.958   242   242 D wpa_supplicant: Get randomness: len=20 entropy=0
01-01 00:03:20.959   242   242 D wpa_supplicant: random: Updated entropy file /data/misc/wifi/entropy.bin (own_pool_ready=0)
01-01 00:03:20.984   253   253 D gpsd    : WakeLock(Release,gpsGPSD)
01-01 00:03:20.985   259   259 E drone_id_read: Error open file
01-01 00:03:21.014   249   286 D libgps  : OnIpcConnectionEstablished:
01-01 00:03:21.014   249   286 D libgps  : GeofenceControllerStateWaitForConnection: EXIT
01-01 00:03:21.014   249   286 D libgps  : GeofenceControllerStateConnected: ENTRY
01-01 00:03:21.037   253   253 D gpsd    : WakeLock(Release,gpsSUPL)
01-01 00:03:21.037   253   253 D gpsd    : WakeLock(Acquire,gpsGPSD)
01-01 00:03:21.037   253   253 D gpsd    : WakeLock(Release,gpsGPSD)
01-01 00:03:21.037   253   253 D gpsd    : WakeLock(Acquire,gpsGPSD)
01-01 00:03:21.038   253   253 D gpsd    : WakeLock(Release,gpsGPSD)
01-01 00:03:21.038   249   286 D libgps  : proxy_set_system_info_cb: called.
01-01 00:03:21.038   249   286 I gps_manager: set gnss year_of_hw: 2016
01-01 00:03:21.085   211   211 E SELinux : avc:  denied  { add } for service=LampSignalService pid=232 uid=0 scontext=u:r:lampsignal:s0 tcontext=u:object_r:default_android_service:s0 tclass=service_manager permissive=1
01-01 00:03:21.085   259   259 E drone_id_read: Error open file
01-01 00:03:21.088   211   211 E SELinux : avc:  denied  { find } for service=LampSignalService pid=265 uid=0 scontext=u:r:d2d_config:s0 tcontext=u:object_r:default_android_service:s0 tclass=service_manager permissive=1
01-01 00:03:21.122   212   212 E [Gralloc-ERROR]: int framebuffer_device_open(const hw_module_t *, const char *, hw_device_t **):566 Framebuffer HAL not support/disabled with MALI display enable
01-01 00:03:21.124   227   227 D song-oms-sa: handle_init exit()!
01-01 00:03:21.124   227   227 D song-oms-sa: sa_listener_loop()
01-01 00:03:21.124   227   227 D song-oms-sa: open_ptm symname[/dev/ttysa1]
01-01 00:03:21.125   227   227 D song-oms-sa: open_ptm ptm[6]
01-01 00:03:21.125   227   227 D song-oms-sa: open_ptm devname[/dev/pts/1]
01-01 00:03:21.125   227   227 D song-oms-sa: open_ptm ret[0]
01-01 00:03:21.125   227   227 D song-oms-sa: sa_listener_loop fd[6]
01-01 00:03:21.138   212   212 I hwcomposer: display max_rotate_size = 69120
01-01 00:03:21.139   212   212 I SurfaceFlinger: Using composer version 1.4
01-01 00:03:21.139   212   212 E hwcomposer: Unknown display attribute 6
01-01 00:03:21.139   212   212 W SurfaceFlinger: no suitable EGLConfig found, trying a simpler query
01-01 00:03:21.139   212   212 I SurfaceFlinger: EGL information:
01-01 00:03:21.139   212   212 I SurfaceFlinger: vendor    : Android
01-01 00:03:21.139   212   212 I SurfaceFlinger: version   : 1.4 Android META-EGL
01-01 00:03:21.139   212   212 I SurfaceFlinger: extensions: EGL_KHR_get_all_proc_addresses EGL_ANDROID_presentation_time EGL_KHR_swap_buffers_with_damage EGL_ANDROID_create_native_client_buffer EGL_ANDROID_front_buffer_auto_refresh EGL_KHR_image EGL_KHR_image_base EGL_KHR_gl_texture_2D_image EGL_KHR_gl_texture_cubemap_image EGL_KHR_gl_renderbuffer_image EGL_KHR_fence_sync EGL_KHR_create_context EGL_KHR_config_attribs EGL_KHR_surfaceless_context EGL_EXT_create_context_robustness EGL_ANDROID_image_native_buffer EGL_KHR_wait_sync EGL_ANDROID_recordable EGL_KHR_partial_update EGL_KHR_mutable_render_buffer EGL_EXT_protected_content
01-01 00:03:21.139   212   212 I SurfaceFlinger: Client API: OpenGL_ES
01-01 00:03:21.139   212   212 I SurfaceFlinger: EGLSurface: 8-8-8-8, config=0x72aab06008
01-01 00:03:21.147   263   263 I /system/bin/webservd: [INFO:config.cc(107)] Loading server configuration from /system/etc/webservd.json
01-01 00:03:21.160   263   263 I /system/bin/webservd: [INFO:utils.cc(144)] Loading certificate from /data/misc/webservd/certificate
01-01 00:03:21.162   245   245 I mediacodec: @@@ mediacodecservice starting
01-01 00:03:21.163   245   245 W /system/bin/mediacodec: libminijail: allowing syscall: clock_gettime
01-01 00:03:21.163   245   245 W /system/bin/mediacodec: libminijail: allowing syscall: connect
01-01 00:03:21.163   245   245 W /system/bin/mediacodec: libminijail: allowing syscall: fcntl64
01-01 00:03:21.163   245   245 W /system/bin/mediacodec: libminijail: allowing syscall: socket
01-01 00:03:21.163   245   245 W /system/bin/mediacodec: libminijail: allowing syscall: writev
01-01 00:03:21.163   256   256 I         : [0101/000321:INFO:webtools.cc(174)] remote ip:
01-01 00:03:21.163   256   256 I         :
01-01 00:03:21.164   256   256 I         : [0101/000321:INFO:webtools.cc(175)] supereth  d2r:2d2d:1devid: 0
01-01 00:03:21.164   256   256 I         :
01-01 00:03:21.164   256   256 E         : [0101/000321:ERROR:real_binder_wrapper.cc(61)] Unable to get "android.webservd.Server" service
01-01 00:03:21.164   256   256 I         : [0101/000321:INFO:binder_server.cc(227)] Webservd has not registered with service manager.
01-01 00:03:21.165   245   245 W /system/bin/mediacodec: libminijail: logging seccomp filter failures
01-01 00:03:21.169   263   263 W /system/bin/webservd: [WARNING:utils.cc(49)] Current time (2000-01-01 00:03:21.169 UTC) is earlier than the application build time. Using 2008-12-31 14:00:00.000 UTC instead!
01-01 00:03:21.172   263   263 I /system/bin/webservd: [INFO:protocol_handler.cc(167)] Starting HTTP protocol handler on port: 80
01-01 00:03:21.172   263   263 I /system/bin/webservd: [INFO:protocol_handler.cc(272)] Protocol handler started
01-01 00:03:21.173   211   211 E SELinux : avc:  denied  { add } for service=android.webservd.Server pid=263 uid=0 scontext=u:r:webservd_daemon:s0 tcontext=u:object_r:default_android_service:s0 tclass=service_manager permissive=1
01-01 00:03:21.178   212   212 I SurfaceFlinger: OpenGL ES informations:
01-01 00:03:21.178   212   212 I SurfaceFlinger: vendor    : ARM
01-01 00:03:21.179   212   212 I SurfaceFlinger: renderer  : Mali-T860
01-01 00:03:21.179   212   212 I SurfaceFlinger: version   : OpenGL ES 3.2 v1.r18p0-01rel0.889d5233b4f748cd5bf6eb32484aa574
01-01 00:03:21.179   212   212 I SurfaceFlinger: extensions: GL_EXT_debug_marker GL_ARM_rgba8 GL_ARM_mali_shader_binary GL_OES_depth24 GL_OES_depth_texture GL_OES_depth_texture_cube_map GL_OES_packed_depth_stencil GL_OES_rgb8_rgba8 GL_EXT_read_format_bgra GL_OES_compressed_paletted_texture GL_OES_compressed_ETC1_RGB8_texture GL_OES_standard_derivatives GL_OES_EGL_image GL_OES_EGL_image_external GL_OES_EGL_image_external_essl3 GL_OES_EGL_sync GL_OES_texture_npot GL_OES_vertex_half_float GL_OES_required_internalformat GL_OES_vertex_array_object GL_OES_mapbuffer GL_EXT_texture_format_BGRA8888 GL_EXT_texture_rg GL_EXT_texture_type_2_10_10_10_REV GL_OES_fbo_render_mipmap GL_OES_element_index_uint GL_EXT_shadow_samplers GL_OES_texture_compression_astc GL_KHR_texture_compression_astc_ldr GL_KHR_texture_compression_astc_hdr GL_KHR_texture_compression_astc_sliced_3d GL_KHR_debug GL_EXT_occlusion_query_boolean GL_EXT_disjoint_timer_query GL_EXT_blend_minmax GL_EXT_discard_framebuffer GL_OES_get_program_binary GL_OES_texture_3D GL_EXT_texture_storage GL_EXT_multisamp
01-01 00:03:21.179   212   212 I SurfaceFlinger: GL_MAX_TEXTURE_SIZE = 8192
01-01 00:03:21.179   212   212 I SurfaceFlinger: GL_MAX_VIEWPORT_DIMS = 8192
01-01 00:03:21.180   212   212 D mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, egl_color_buffer_format *, EGLBoolean) returns 0x3000
01-01 00:03:21.185   259   259 E drone_id_read: Error open file
01-01 00:03:21.193   210   210 E connect_manager: read modem_status with value 1
01-01 00:03:21.193   210   210 E connect_manager: modem not ready, retrying...
01-01 00:03:21.218   264   264 I OpenCV  : calling android_getCpuFeatures() ...
01-01 00:03:21.222   264   264 I OpenCV  : calling android_getCpuFeatures() ... Done (1f7ff)
01-01 00:03:21.241   211   211 E SELinux : avc:  denied  { add } for service=service.uavmaincamera pid=264 uid=0 scontext=u:r:uavmaincamera_daemon:s0 tcontext=u:object_r:default_android_service:s0 tclass=service_manager permissive=1
01-01 00:03:21.286   259   259 E drone_id_read: Error open file
01-01 00:03:21.386   259   259 E drone_id_read: Error open file
01-01 00:03:21.407   246   246 I mediaserver: ServiceManager: 0xec399620
01-01 00:03:21.420   246   246 W BatteryNotifier: batterystats service unavailable!
01-01 00:03:21.487   259   259 E drone_id_read: Error open file
01-01 00:03:21.489   212   212 D SurfaceFlinger: shader cache generated - 24 shaders in 309.099884 ms
01-01 00:03:21.493   212   212 D SurfaceFlinger: Set power mode=2, type=0 flinger=0x72aaa48000
01-01 00:03:21.493   212   212 I hwcomposer: Display set to ON state!
01-01 00:03:21.508   212   212 E gralloc : Try first /vendor/lib64/egl/libGLES_1_mali.so !
01-01 00:03:21.508   212   212 W gralloc : Failed to find GPU block configuration in libGLES_1_mali.so. Using static build configuration.
01-01 00:03:21.508   212   212 I gralloc : alloc start: size = 8486912, usage = 0x1a00, 0x1a00,                        int_format = 0x100000001, w = 1920, h = 1080
01-01 00:03:21.579   325   325 D song-mla-manager:
01-01 00:03:21.579   325   325 D song-mla-manager:     song-mla-manager, version 1.0.0
01-01 00:03:21.579   325   325 D song-mla-manager:     COPYRIGHT (C) 2015 Beijing Pinecone Electronics Co., Ltd
01-01 00:03:21.579   325   325 D song-mla-manager: PID of song-mla-manager: 325
01-01 00:03:21.579   325   325 D song-mla-manager: Current usb state: [1]
01-01 00:03:21.579   325   325 D song-mla-manager: Current usb configuration: [mass_storage,adb]
01-01 00:03:21.579   325   325 D song-mla-manager: Current modem debug flag: [0]
01-01 00:03:21.579   325   325 D song-mla-manager: usb_config_now not serial or modem debug not enabled
01-01 00:03:21.587   259   259 E drone_id_read: Error open file
01-01 00:03:21.608   326   326 I recovery: Recovery image already installed
01-01 00:03:21.688   235   261 I rc_service: sbus:0 no data received in last second, frame stop is set!
01-01 00:03:21.688   235   261 I rc_service: sbus:0 total frame number(1s):0, loss frame number(1s):0
01-01 00:03:21.688   235   261 I rc_service: sbus:1 no data received in last second, frame stop is set!
01-01 00:03:21.688   235   261 I rc_service: sbus:1 total frame number(1s):0, loss frame number(1s):0
01-01 00:03:21.688   259   259 E drone_id_read: Error open file
01-01 00:03:21.693   210   210 E connect_manager: read modem_status with value 3
01-01 00:03:21.789   259   259 E drone_id_read: Error open file
01-01 00:03:21.886   333   333 I vendorservice.s: type=1400 audit(0.0:151): avc: denied { getattr } for path="/system/bin/toybox" dev="mmcblk1p17" ino=270 scontext=u:r:vendorservice:s0 tcontext=u:object_r:toolbox_exec:s0 tclass=file permissive=1
01-01 00:03:21.886   333   333 I vendorservice.s: type=1400 audit(0.0:152): avc: denied { execute } for name="toybox" dev="mmcblk1p17" ino=270 scontext=u:r:vendorservice:s0 tcontext=u:object_r:toolbox_exec:s0 tclass=file permissive=1
01-01 00:03:21.886   333   333 I vendorservice.s: type=1400 audit(0.0:153): avc: denied { read open } for path="/system/bin/toybox" dev="mmcblk1p17" ino=270 scontext=u:r:vendorservice:s0 tcontext=u:object_r:toolbox_exec:s0 tclass=file permissive=1
01-01 00:03:21.886   333   333 I vendorservice.s: type=1400 audit(0.0:154): avc: denied { execute_no_trans } for path="/system/bin/toybox" dev="mmcblk1p17" ino=270 scontext=u:r:vendorservice:s0 tcontext=u:object_r:toolbox_exec:s0 tclass=file permissive=1
01-01 00:03:21.889   259   259 E drone_id_read: Error open file
01-01 00:03:21.906   333   333 I ifconfig: type=1400 audit(0.0:155): avc: denied { create } for scontext=u:r:vendorservice:s0 tcontext=u:r:vendorservice:s0 tclass=udp_socket permissive=1
01-01 00:03:21.906   333   333 I ifconfig: type=1400 audit(0.0:156): avc: denied { net_raw } for capability=13 scontext=u:r:vendorservice:s0 tcontext=u:r:vendorservice:s0 tclass=capability permissive=1
01-01 00:03:21.906   333   333 I ifconfig: type=1400 audit(0.0:157): avc: denied { read } for name="dev" dev="proc" ino=4026532026 scontext=u:r:vendorservice:s0 tcontext=u:object_r:proc_net:s0 tclass=file permissive=1
01-01 00:03:21.906   333   333 I ifconfig: type=1400 audit(0.0:158): avc: denied { open } for path="/proc/333/net/dev" dev="proc" ino=4026532026 scontext=u:r:vendorservice:s0 tcontext=u:object_r:proc_net:s0 tclass=file permissive=1
01-01 00:03:21.906   333   333 I ifconfig: type=1400 audit(0.0:159): avc: denied { getattr } for path="/proc/333/net/dev" dev="proc" ino=4026532026 scontext=u:r:vendorservice:s0 tcontext=u:object_r:proc_net:s0 tclass=file permissive=1
01-01 00:03:21.906   333   333 I ifconfig: type=1400 audit(0.0:160): avc: denied { ioctl } for path="socket:[9693]" dev="sockfs" ino=9693 ioctlcmd=0x8913 scontext=u:r:vendorservice:s0 tcontext=u:r:vendorservice:s0 tclass=udp_socket permissive=1
01-01 00:03:21.990   259   259 E drone_id_read: Error open file
01-01 00:03:22.086   265   265 I d2d_config: type=1400 audit(0.0:161): avc: denied { call } for scontext=u:r:d2d_config:s0 tcontext=u:r:lampsignal:s0 tclass=binder permissive=1
01-01 00:03:22.090   259   259 E drone_id_read: Error open file
01-01 00:03:22.163   256   256 I webtools: type=1400 audit(0.0:162): avc: denied { call } for scontext=u:r:webtools:s0 tcontext=u:r:servicemanager:s0 tclass=binder permissive=1
01-01 00:03:22.163   211   211 I servicemanager: type=1400 audit(0.0:163): avc: denied { search } for name="256" dev="proc" ino=9147 scontext=u:r:servicemanager:s0 tcontext=u:r:webtools:s0 tclass=dir permissive=1
01-01 00:03:22.163   211   211 I servicemanager: type=1400 audit(0.0:164): avc: denied { read } for name="current" dev="proc" ino=11397 scontext=u:r:servicemanager:s0 tcontext=u:r:webtools:s0 tclass=file permissive=1
01-01 00:03:22.163   211   211 I servicemanager: type=1400 audit(0.0:165): avc: denied { open } for path="/proc/256/attr/current" dev="proc" ino=11397 scontext=u:r:servicemanager:s0 tcontext=u:r:webtools:s0 tclass=file permissive=1
01-01 00:03:22.163   211   211 I servicemanager: type=1400 audit(0.0:166): avc: denied { getattr } for scontext=u:r:servicemanager:s0 tcontext=u:r:webtools:s0 tclass=process permissive=1
01-01 00:03:22.166   256   256 I webtools: type=1400 audit(0.0:167): avc: denied { call } for scontext=u:r:webtools:s0 tcontext=u:r:webservd_daemon:s0 tclass=binder permissive=1
01-01 00:03:22.166   263   263 I webservd: type=1400 audit(0.0:168): avc: denied { dac_override } for capability=1 scontext=u:r:webservd_daemon:s0 tcontext=u:r:webservd_daemon:s0 tclass=capability permissive=1
01-01 00:03:22.166   263   263 I webservd: type=1400 audit(0.0:169): avc: denied { transfer } for scontext=u:r:webservd_daemon:s0 tcontext=u:r:webtools:s0 tclass=binder permissive=1
01-01 00:03:22.166   256   256 I webtools: type=1400 audit(0.0:170): avc: denied { transfer } for scontext=u:r:webtools:s0 tcontext=u:r:webservd_daemon:s0 tclass=binder permissive=1
01-01 00:03:22.167   211   211 E SELinux : avc:  denied  { find } for service=android.webservd.Server pid=256 uid=0 scontext=u:r:webtools:s0 tcontext=u:object_r:default_android_service:s0 tclass=service_manager permissive=1
01-01 00:03:22.171   256   256 I         : [0101/000322:INFO:webtools.cc(1867)] Webserver is online
01-01 00:03:22.191   259   259 E drone_id_read: Error open file
01-01 00:03:22.291   259   259 E drone_id_read: Error open file
01-01 00:03:22.392   259   259 E drone_id_read: Error open file
01-01 00:03:22.431   212   212 I gralloc : alloc start: size = 8486912, usage = 0x1a00, 0x1a00,                        int_format = 0x100000001, w = 1920, h = 1080
01-01 00:03:22.493   259   259 E drone_id_read: Error open file
01-01 00:03:22.593   259   259 E drone_id_read: Error open file
01-01 00:03:22.614   233   233 I usbethx : change@/devices/platform/regulatory.0
01-01 00:03:22.614   233   233 I usbethx : ACTION=change
01-01 00:03:22.614   233   233 I usbethx : DEVPATH=/devices/platform/regulatory.0
01-01 00:03:22.614   233   233 I usbethx : SUBSYSTEM=platform
01-01 00:03:22.614   233   233 I usbethx : COUNTRY=00
01-01 00:03:22.614   233   233 I usbethx : MODALIAS=platform:regulatory
01-01 00:03:22.614   233   233 I usbethx : SEQNUM=1723
01-01 00:03:22.688   235   261 I rc_service: sbus:0 no data received in last second, frame stop is set!
01-01 00:03:22.688   235   261 I rc_service: sbus:0 total frame number(1s):0, loss frame number(1s):0
01-01 00:03:22.688   235   261 I rc_service: sbus:1 no data received in last second, frame stop is set!
01-01 00:03:22.688   235   261 I rc_service: sbus:1 total frame number(1s):0, loss frame number(1s):0
01-01 00:03:22.694   259   259 E drone_id_read: Error open file
01-01 00:03:22.794   259   259 E drone_id_read: Error open file
01-01 00:03:22.895   259   259 E drone_id_read: Error open file
01-01 00:03:22.946   381   381 I ifconfig: type=1400 audit(0.0:172): avc: denied { net_admin } for capability=12 scontext=u:r:vendorservice:s0 tcontext=u:r:vendorservice:s0 tclass=capability permissive=1
01-01 00:03:22.966   382   382 I ebtables: type=1400 audit(0.0:173): avc: denied { create } for scontext=u:r:vendorservice:s0 tcontext=u:r:vendorservice:s0 tclass=rawip_socket permissive=1
01-01 00:03:22.966   382   382 I ebtables: type=1400 audit(0.0:174): avc: denied { getopt } for lport=2 scontext=u:r:vendorservice:s0 tcontext=u:r:vendorservice:s0 tclass=rawip_socket permissive=1
01-01 00:03:22.966   382   382 I ebtables: type=1400 audit(0.0:175): avc: denied { setopt } for lport=2 scontext=u:r:vendorservice:s0 tcontext=u:r:vendorservice:s0 tclass=rawip_socket permissive=1
01-01 00:03:22.996   259   259 E drone_id_read: Error open file
01-01 00:03:23.010   385   385 I ip      : type=1400 audit(0.0:176): avc: denied { create } for scontext=u:r:vendorservice:s0 tcontext=u:r:vendorservice:s0 tclass=netlink_route_socket permissive=1
01-01 00:03:23.010   385   385 I ip      : type=1400 audit(0.0:177): avc: denied { setopt } for scontext=u:r:vendorservice:s0 tcontext=u:r:vendorservice:s0 tclass=netlink_route_socket permissive=1
01-01 00:03:23.010   385   385 I ip      : type=1400 audit(0.0:178): avc: denied { bind } for scontext=u:r:vendorservice:s0 tcontext=u:r:vendorservice:s0 tclass=netlink_route_socket permissive=1
01-01 00:03:23.010   385   385 I ip      : type=1400 audit(0.0:179): avc: denied { getattr } for scontext=u:r:vendorservice:s0 tcontext=u:r:vendorservice:s0 tclass=netlink_route_socket permissive=1
01-01 00:03:23.010   385   385 I ip      : type=1400 audit(0.0:180): avc: denied { write } for scontext=u:r:vendorservice:s0 tcontext=u:r:vendorservice:s0 tclass=netlink_route_socket permissive=1
01-01 00:03:23.010   385   385 I ip      : type=1400 audit(0.0:181): avc: denied { nlmsg_read } for scontext=u:r:vendorservice:s0 tcontext=u:r:vendorservice:s0 tclass=netlink_route_socket permissive=1
01-01 00:03:23.010   385   385 I ip      : type=1400 audit(0.0:182): avc: denied { read } for scontext=u:r:vendorservice:s0 tcontext=u:r:vendorservice:s0 tclass=netlink_route_socket permissive=1
01-01 00:03:23.013   255   255 I vendorservice.s: type=1400 audit(0.0:183): avc: denied { getattr } for path="/system/bin/sh" dev="mmcblk1p17" ino=229 scontext=u:r:vendorservice:s0 tcontext=u:object_r:shell_exec:s0 tclass=file permissive=1
01-01 00:03:23.013   255   255 I vendorservice.s: type=1400 audit(0.0:184): avc: denied { execute } for name="sh" dev="mmcblk1p17" ino=229 scontext=u:r:vendorservice:s0 tcontext=u:object_r:shell_exec:s0 tclass=file permissive=1
01-01 00:03:23.013   386   386 I vendorservice.s: type=1400 audit(0.0:185): avc: denied { read open } for path="/system/bin/sh" dev="mmcblk1p17" ino=229 scontext=u:r:vendorservice:s0 tcontext=u:object_r:shell_exec:s0 tclass=file permissive=1
01-01 00:03:23.013   386   386 I vendorservice.s: type=1400 audit(0.0:186): avc: denied { execute_no_trans } for path="/system/bin/sh" dev="mmcblk1p17" ino=229 scontext=u:r:vendorservice:s0 tcontext=u:object_r:shell_exec:s0 tclass=file permissive=1
01-01 00:03:23.096   259   259 E drone_id_read: Error open file
01-01 00:03:23.197   259   259 E drone_id_read: Error open file
01-01 00:03:23.297   259   259 E drone_id_read: Error open file
01-01 00:03:23.313   265   265 I d2d_config: type=1400 audit(0.0:187): avc: denied { read } for name="devices" dev="proc" ino=4026531942 scontext=u:r:d2d_config:s0 tcontext=u:object_r:proc:s0 tclass=file permissive=1
01-01 00:03:23.313   265   265 I d2d_config: type=1400 audit(0.0:188): avc: denied { open } for path="/proc/bus/input/devices" dev="proc" ino=4026531942 scontext=u:r:d2d_config:s0 tcontext=u:object_r:proc:s0 tclass=file permissive=1
01-01 00:03:23.313   265   265 I d2d_config: type=1400 audit(0.0:189): avc: denied { getattr } for path="/proc/bus/input/devices" dev="proc" ino=4026531942 scontext=u:r:d2d_config:s0 tcontext=u:object_r:proc:s0 tclass=file permissive=1
01-01 00:03:23.313   265   265 I d2d_config: type=1400 audit(0.0:190): avc: denied { read } for name="event2" dev="tmpfs" ino=10324 scontext=u:r:d2d_config:s0 tcontext=u:object_r:input_device:s0 tclass=chr_file permissive=1
01-01 00:03:23.313   265   265 I d2d_config: type=1400 audit(0.0:191): avc: denied { open } for path="/dev/input/event2" dev="tmpfs" ino=10324 scontext=u:r:d2d_config:s0 tcontext=u:object_r:input_device:s0 tclass=chr_file permissive=1
01-01 00:03:23.398   259   259 E drone_id_read: Error open file
01-01 00:03:23.498   259   259 E drone_id_read: Error open file
01-01 00:03:23.599   259   259 E drone_id_read: Error open file
01-01 00:03:23.689   235   261 I rc_service: sbus:0 no data received in last second, frame stop is set!
01-01 00:03:23.689   235   261 I rc_service: sbus:0 total frame number(1s):0, loss frame number(1s):0
01-01 00:03:23.689   235   261 I rc_service: sbus:1 no data received in last second, frame stop is set!
01-01 00:03:23.689   235   261 I rc_service: sbus:1 total frame number(1s):0, loss frame number(1s):0
01-01 00:03:23.693   210   210 E connect_manager: ps_open_lmi
01-01 00:03:23.699   259   259 E drone_id_read: Error open file
01-01 00:03:23.799   259   259 E drone_id_read: Error open file
01-01 00:03:23.866   210   210 E connect_manager: d2d_enable_vlan: entry, dev_name = lmi40, prop_value = 192.168.144.10, g_vxlan_mode = 1, net_mask = 24
01-01 00:03:23.900   259   259 E drone_id_read: Error open file
01-01 00:03:24.000   259   259 E drone_id_read: Error open file
01-01 00:03:24.020   407   407 I sh      : type=1400 audit(0.0:198): avc: denied { getattr } for path="/bin/busybox" dev="rootfs" ino=5139 scontext=u:r:connect_daemon:s0 tcontext=u:object_r:rootfs:s0 tclass=file permissive=1
01-01 00:03:24.020   407   407 I sh      : type=1400 audit(0.0:199): avc: denied { execute } for name="busybox" dev="rootfs" ino=5139 scontext=u:r:connect_daemon:s0 tcontext=u:object_r:rootfs:s0 tclass=file permissive=1
01-01 00:03:24.020   407   407 I sh      : type=1400 audit(0.0:200): avc: denied { read open } for path="/bin/busybox" dev="rootfs" ino=5139 scontext=u:r:connect_daemon:s0 tcontext=u:object_r:rootfs:s0 tclass=file permissive=1
01-01 00:03:24.020   407   407 I sh      : type=1400 audit(0.0:201): avc: denied { execute_no_trans } for path="/bin/busybox" dev="rootfs" ino=5139 scontext=u:r:connect_daemon:s0 tcontext=u:object_r:rootfs:s0 tclass=file permissive=1
01-01 00:03:24.023   407   407 I busybox : type=1400 audit(0.0:202): avc: denied { execmem } for scontext=u:r:connect_daemon:s0 tcontext=u:r:connect_daemon:s0 tclass=process permissive=1
01-01 00:03:24.023   407   407 I busybox : type=1400 audit(0.0:203): avc: denied { create } for scontext=u:r:connect_daemon:s0 tcontext=u:r:connect_daemon:s0 tclass=tcp_socket permissive=1
01-01 00:03:24.023   407   407 I busybox : type=1400 audit(0.0:204): avc: denied { read } for name="unix" dev="proc" ino=4026532063 scontext=u:r:connect_daemon:s0 tcontext=u:object_r:proc_net:s0 tclass=file permissive=1
01-01 00:03:24.023   407   407 I busybox : type=1400 audit(0.0:205): avc: denied { ioctl } for path="socket:[12385]" dev="sockfs" ino=12385 ioctlcmd=0x8933 scontext=u:r:connect_daemon:s0 tcontext=u:r:connect_daemon:s0 tclass=unix_dgram_socket permissive=1
01-01 00:03:24.023   407   407 I busybox : type=1400 audit(0.0:206): avc: denied { ioctl } for path="socket:[12383]" dev="sockfs" ino=12383 ioctlcmd=0x89a2 scontext=u:r:connect_daemon:s0 tcontext=u:r:connect_daemon:s0 tclass=tcp_socket permissive=1
01-01 00:03:24.101   259   259 E drone_id_read: Error open file
01-01 00:03:24.116   411   411 I rtsp_server: type=1400 audit(0.0:207): avc: denied { getattr } for path="/vendor" dev="rootfs" ino=5203 scontext=u:r:rtsp_daemon:s0 tcontext=u:object_r:rootfs:s0 tclass=lnk_file permissive=1
01-01 00:03:24.120   412   412 I mavlink-router: type=1400 audit(0.0:208): avc: denied { getattr } for path="/vendor" dev="rootfs" ino=5203 scontext=u:r:mavlinkrouter_daemon:s0 tcontext=u:object_r:rootfs:s0 tclass=lnk_file permissive=1
01-01 00:03:24.123   413   413 I system-control: type=1400 audit(0.0:209): avc: denied { getattr } for path="/vendor" dev="rootfs" ino=5203 scontext=u:r:systemcontrol_daemon:s0 tcontext=u:object_r:rootfs:s0 tclass=lnk_file permissive=1
01-01 00:03:24.143   412   412 I mavlink-router: type=1400 audit(0.0:210): avc: denied { read } for name="mavlink-router.conf" dev="tmpfs" ino=10555 scontext=u:r:mavlinkrouter_daemon:s0 tcontext=u:object_r:tmpfs:s0 tclass=lnk_file permissive=1
01-01 00:03:24.146   412   412 I mavlink-router: Condition [persist.uart.1.mavlink] is [1].
01-01 00:03:24.146   412   412 I mavlink-router: Condition [persist.uart.1.disable] is [0].
01-01 00:03:24.143   412   412 I mavlink-router: type=1400 audit(0.0:211): avc: denied { create } for scontext=u:r:mavlinkrouter_daemon:s0 tcontext=u:r:mavlinkrouter_daemon:s0 tclass=udp_socket permissive=1
01-01 00:03:24.143   412   412 I mavlink-router: type=1400 audit(0.0:212): avc: denied { net_raw } for capability=13 scontext=u:r:mavlinkrouter_daemon:s0 tcontext=u:r:mavlinkrouter_daemon:s0 tclass=capability permissive=1
01-01 00:03:24.143   412   412 I mavlink-router: type=1400 audit(0.0:213): avc: denied { bind } for scontext=u:r:mavlinkrouter_daemon:s0 tcontext=u:r:mavlinkrouter_daemon:s0 tclass=udp_socket permissive=1
01-01 00:03:24.143   412   412 I mavlink-router: type=1400 audit(0.0:214): avc: denied { name_bind } for src=14550 scontext=u:r:mavlinkrouter_daemon:s0 tcontext=u:object_r:port:s0 tclass=udp_socket permissive=1
01-01 00:03:24.143   412   412 I mavlink-router: type=1400 audit(0.0:215): avc: denied { node_bind } for src=14550 scontext=u:r:mavlinkrouter_daemon:s0 tcontext=u:object_r:node:s0 tclass=udp_socket permissive=1
01-01 00:03:24.143   412   412 I mavlink-router: type=1400 audit(0.0:216): avc: denied { setopt } for lport=14550 scontext=u:r:mavlinkrouter_daemon:s0 tcontext=u:r:mavlinkrouter_daemon:s0 tclass=udp_socket permissive=1
01-01 00:03:24.146   412   412 I mavlink-router: Open LOCAL [6] [boardendpoint]-[(null)]
01-01 00:03:24.147   412   412 I mavlink-router: Local endpoint added: [local_board_mavlink]
01-01 00:03:24.147   412   412 I mavlink-router: Open LOCAL [7] [cameraendpoint]-[(null)]
01-01 00:03:24.147   412   412 I mavlink-router: Local endpoint added: [local_camera_mavlink]
01-01 00:03:24.147   412   412 I mavlink-router: Open UDP [8] 192.168.0.11:14550 * 14550
01-01 00:03:24.147   412   412 I mavlink-router: Udp endpoint added: [udp_data_mavlink]
01-01 00:03:24.147   412   412 I mavlink-router: Open UDP [9] 0.0.0.0:18446744073709551615 * 14552
01-01 00:03:24.147   412   412 I mavlink-router: Udp endpoint added: [spare1]
01-01 00:03:24.147   412   412 I mavlink-router: Open UDP [10] 0.0.0.0:18446744073709551615 * 14553
01-01 00:03:24.147   412   412 I mavlink-router: Udp endpoint added: [spare2]
01-01 00:03:24.147   412   412 I mavlink-router: Open UDP [11] 0.0.0.0:18446744073709551615 * 14554
01-01 00:03:24.147   412   412 I mavlink-router: Udp endpoint added: [spare3]
01-01 00:03:24.147   412   412 I mavlink-router: Open UDP [12] 192.168.0.11:15550 * 15550
01-01 00:03:24.147   412   412 I mavlink-router: Udp endpoint added: [udp_control_mavlink]
01-01 00:03:24.148   412   412 I mavlink-router: _retrieve_baudrate_property: persist.uart.1.baud=57600
01-01 00:03:24.148   412   412 I mavlink-router: set uart baudrate to: [57600]
01-01 00:03:24.148   412   412 I mavlink-router: Uart endpoint added: [uart_mavlink]
01-01 00:03:24.148   412   412 I mavlink-router: msg filter for [local_camera_mavlink], type [2]: [270]
01-01 00:03:24.148   412   412 I mavlink-router: msg filter for [local_board_mavlink], type [2]: [111]
01-01 00:03:24.146   412   412 I mavlink-router: type=1400 audit(0.0:217): avc: denied { dac_override } for capability=1 scontext=u:r:mavlinkrouter_daemon:s0 tcontext=u:r:mavlinkrouter_daemon:s0 tclass=capability permissive=1
01-01 00:03:24.178   411   411 I RTSPServer-m: Play this stream using the URL:rtsp://0.0.0.0:8554/H264Video
01-01 00:03:24.178   411   411 I RTSPServer-m: Play this stream using the URL:rtsp://0.0.0.0:8554/H264VideoSub
01-01 00:03:24.178   411   411 I RTSPServer-m: RTSP SERVER do EventLoop
01-01 00:03:24.182   413   413 D SystemControl: start
01-01 00:03:24.183   413   413 D SystemControl: start board control module
01-01 00:03:24.185   211   211 E SELinux : avc:  denied  { find } for service=LampSignalService pid=413 uid=0 scontext=u:r:systemcontrol_daemon:s0 tcontext=u:object_r:default_android_service:s0 tclass=service_manager permissive=1
01-01 00:03:24.186   413   413 D ModuleThread: get domain socket [8] [boardcontrol] in BoardControl
01-01 00:03:24.186   413   413 D SystemControl: start d2d tracker module
01-01 00:03:24.186   413   413 D ModuleThread: get domain socket [11] [ ] in D2DTracker
01-01 00:03:24.186   413   413 D ModuleThread: get domain socket [12] [ ] in D2DTracker
01-01 00:03:24.186   413   413 D ModuleThread: get domain socket [13] [d2dcontrol] in D2DTracker
01-01 00:03:24.187   413   413 D SystemControl: start camera control module
01-01 00:03:24.187   413   413 E UAVCamera: [UAVCamera:60]constructor
01-01 00:03:24.187   413   413 E UAVCamera: [getService:41]interface_cast<IUAVMainCamService>(binder); start
01-01 00:03:24.188   413   413 E UAVCamera: [getService:44]new DeathNotifier
01-01 00:03:24.188   413   413 E UAVCamera: [getService:48]getService
01-01 00:03:24.188   413   413 D UAVCamera: UAVCamera::pineGetFPVCameraID
01-01 00:03:24.188   413   413 D UAVCamera: BpUAVMainCamService::pineGetFPVCameraID
01-01 00:03:24.188   264   320 D UAVCamera: UavCameraService::pineGetFPVCameraID
01-01 00:03:24.201   259   259 E drone_id_read: Error open file
01-01 00:03:24.236   264   320 D PineCameraHal: HAL_getNumberOfCameras
01-01 00:03:24.236   264   320 D pinecamera: Opening camera media device /dev/media0
01-01 00:03:24.237   264   320 D pinecamera: media device fd = 17, name = /dev/media0
01-01 00:03:24.239   264   320 I pinecamera: pine_get_num_of_cameras: find a camera sensor[0] song.tele.lt6911c0
01-01 00:03:24.239   264   320 I pinecamera: pine_get_num_of_cameras: find a camera sensor[1] song.tele.lt6911c1
01-01 00:03:24.241   264   320 D pinecamera: pine_get_num_of_cameras:129, ret is 0
01-01 00:03:24.241   264   320 I pinecamera: pine_get_num_of_cameras: find uvc camera
01-01 00:03:24.241   264   320 D pinecamera: pine_get_num_of_cameras:140, camera_num is 2
01-01 00:03:24.241   264   320 D [UavCam]CameraManager: num of cameras is 2
01-01 00:03:24.242   413   413 D CameraControl: uid is 33554845, cam count is 2
01-01 00:03:24.242   413   413 D ModuleThread: get domain socket [21] [cameracontrol] in CameraControl
01-01 00:03:24.301   259   259 E drone_id_read: Error open file
01-01 00:03:24.402   259   259 E drone_id_read: Error open file
01-01 00:03:24.502   259   259 E drone_id_read: Error open file
01-01 00:03:24.603   259   259 E drone_id_read: Error open file
01-01 00:03:24.686   413   414 I DroneIDGen: Starting Drone ID Generation
01-01 00:03:24.687   413   414 E DroneIDGen: m2o_collectMessagePack: m2o.messagePackEnc.MsgPackSize 1 msgs 0 0 1 0 0 0 FAIL/ERROR
01-01 00:03:24.687   413   414 D DroneIDGen: dsInformation: FA0BBC0D00F21901220000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000
01-01 00:03:24.689   235   261 I rc_service: sbus:0 no data received in last second, frame stop is set!
01-01 00:03:24.689   235   261 I rc_service: sbus:0 total frame number(1s):0, loss frame number(1s):0
01-01 00:03:24.689   235   261 I rc_service: sbus:1 no data received in last second, frame stop is set!
01-01 00:03:24.689   235   261 I rc_service: sbus:1 total frame number(1s):0, loss frame number(1s):0
01-01 00:03:24.704   259   259 E drone_id_read: Error open file
01-01 00:03:24.732   413   414 D DroneIDGen: Generate drone id data seq no: 0, crc32: 6CCFA82F
01-01 00:03:24.733   413   414 D DroneIDGen: Lock success
01-01 00:03:24.735   211   211 E SELinux : avc:  denied  { find } for service=LampSignalService pid=412 uid=0 scontext=u:r:mavlinkrouter_daemon:s0 tcontext=u:object_r:default_android_service:s0 tclass=service_manager permissive=1
01-01 00:03:24.738   413   414 D BoardControl: thermal sensor temperature max 41┬░C, report 38┬░C
01-01 00:03:24.738   413   414 D BoardControl: cpu mask 0x00
01-01 00:03:24.738   413   414 D BoardControl: cpu temperature changed to 38┬░C
01-01 00:03:24.738   413   414 D BoardControl: D2d Shram Info 0x056CC000 32768
01-01 00:03:25.243   413   419 D UAVCamera: UAVCamera::openCamera
01-01 00:03:25.243   413   419 D UAVCamera: BpUAVMainCamService::openCamera
01-01 00:03:25.245   264   320 D UAVCamera: UavCameraService::openCamera(0)
01-01 00:03:25.245   264   320 D PineCameraHal: HAL_camera_device_open
01-01 00:03:25.249   264   320 I PineCameraWatermark: [Watermark:30]mFontLoaded  is 1
01-01 00:03:25.249   264   320 D PineCameraHardware: CAMPERF camera id 0 hal version 1.0.2
01-01 00:03:25.249   264   320 D pinecamera: Opening camera media device /dev/media0
01-01 00:03:25.249   264   320 D pinecamera: media device fd = 17, name = /dev/media0
01-01 00:03:25.254   264   320 D pinecamera: get entity i = 0, dev name /dev/v4l-subdev0, entity info id = 1, name song.tele.lt6911c0, me_nr = 1
01-01 00:03:25.254   264   320 D pinecamera: get entity i = 1, dev name /dev/v4l-subdev1, entity info id = 3, name song.tele.lt6911c1, me_nr = 2
01-01 00:03:25.255   264   320 D pinecamera: get entity i = 2, dev name /dev/v4l-subdev2, entity info id = 5, name v5122isd-IDI1, me_nr = 3
01-01 00:03:25.255   264   320 D pinecamera: get entity i = 3, dev name /dev/v4l-subdev3, entity info id = 12, name v5122isd-IDI2, me_nr = 4
01-01 00:03:25.255   264   320 D pinecamera: get entity i = 4, dev name /dev/v4l-subdev4, entity info id = 19, name v5122isd-Pipeline#1, me_nr = 5
01-01 00:03:25.255   264   320 D pinecamera: get entity i = 5, dev name /dev/v4l-subdev5, entity info id = 22, name v5122isd-DataDump#1, me_nr = 6
01-01 00:03:25.255   264   320 D pinecamera: get entity i = 6, dev name /dev/v4l-subdev6, entity info id = 25, name v5122isd-MemorySensor#1, me_nr = 7
01-01 00:03:25.255   264   320 D pinecamera: get entity i = 7, dev name /dev/v4l-subdev7, entity info id = 28, name v5122isd-Pipeline#2, me_nr = 8
01-01 00:03:25.255   264   320 D pinecamera: get entity i = 8, dev name /dev/v4l-subdev8, entity info id = 31, name v5122isd-DataDump#2, me_nr = 9
01-01 00:03:25.255   264   320 D pinecamera: get entity i = 9, dev name /dev/v4l-subdev9, entity info id = 34, name v5122isd-MemorySensor#2, me_nr = 10
01-01 00:03:25.256   264   320 D pinecamera: get entity i = 10, dev name /dev/v4l-subdev10, entity info id = 37, name v5122isd-HighSpeed, me_nr = 11
01-01 00:03:25.256   264   320 D pinecamera: get entity i = 11, dev name /dev/v4l-subdev11, entity info id = 40, name v5122isd-HDRProcess, me_nr = 12
01-01 00:03:25.256   264   320 D pinecamera: get entity i = 12, dev name /dev/v4l-subdev12, entity info id = 43, name v5122isd-3DStereo, me_nr = 13
01-01 00:03:25.256   264   320 D pinecamera: get entity i = 13, dev name /dev/v4l-subdev13, entity info id = 46, name v5122isd-Output-A, me_nr = 14
01-01 00:03:25.256   264   320 D pinecamera: get entity i = 14, dev name /dev/video0, entity info id = 49, name vout<v5122isd-Output-A>, me_nr = 15
01-01 00:03:25.256   264   320 D pinecamera: get entity i = 15, dev name /dev/v4l-subdev14, entity info id = 55, name v5122isd-Output-B, me_nr = 16
01-01 00:03:25.256   264   320 D pinecamera: get entity i = 16, dev name /dev/video1, entity info id = 58, name vout<v5122isd-Output-B>, me_nr = 17
01-01 00:03:25.256   264   320 D pinecamera: get entity i = 17, dev name /dev/v4l-subdev15, entity info id = 64, name v5122isd-Output-C, me_nr = 18
01-01 00:03:25.256   264   320 D pinecamera: get entity i = 18, dev name /dev/video2, entity info id = 67, name vout<v5122isd-Output-C>, me_nr = 19
01-01 00:03:25.257   264   320 D pinecamera: get entity i = 19, dev name /dev/v4l-subdev16, entity info id = 73, name v5122isd-Output-D, me_nr = 20
01-01 00:03:25.257   264   320 D pinecamera: get entity i = 20, dev name /dev/video3, entity info id = 76, name vout<v5122isd-Output-D>, me_nr = 21
01-01 00:03:25.257   264   320 D pinecamera: get entity i = 21, dev name /dev/v4l-subdev17, entity info id = 82, name v5122isd-Output-E, me_nr = 22
01-01 00:03:25.257   264   320 D pinecamera: get entity i = 22, dev name /dev/video4, entity info id = 85, name vout<v5122isd-Output-E>, me_nr = 23
01-01 00:03:25.257   264   320 D pinecamera: get entity i = 23, dev name /dev/v4l-subdev18, entity info id = 91, name v5122isd-Output-F, me_nr = 24
01-01 00:03:25.259   264   320 D pinecamera: get entity i = 24, dev name /dev/video5, entity info id = 94, name vout<v5122isd-Output-F>, me_nr = 25
01-01 00:03:25.259   264   320 D pinecamera: get entity i = 25, dev name /dev/v4l-subdev19, entity info id = 100, name v5122isd-Input-A, me_nr = 26
01-01 00:03:25.259   264   320 D pinecamera: get entity i = 26, dev name /dev/video6, entity info id = 103, name vin<v5122isd-Input-A>, me_nr = 27
01-01 00:03:25.259   264   320 D pinecamera: get entity i = 27, dev name /dev/v4l-subdev20, entity info id = 109, name v5122isd-Input-B, me_nr = 28
01-01 00:03:25.260   264   320 D pinecamera: get entity i = 28, dev name /dev/video7, entity info id = 112, name vin<v5122isd-Input-B>, me_nr = 29
01-01 00:03:25.260   264   320 D pinecamera: get entity i = 29, dev name /dev/v4l-subdev21, entity info id = 118, name v5122isd-Input-C, me_nr = 30
01-01 00:03:25.260   264   320 D pinecamera: get entity i = 30, dev name /dev/video8, entity info id = 121, name vin<v5122isd-Input-C>, me_nr = 31
01-01 00:03:25.260   264   320 D pinecamera: get entity i = 31, dev name /dev/v4l-subdev22, entity info id = 127, name v5122isd-Input-D, me_nr = 32
01-01 00:03:25.260   264   320 D pinecamera: get entity i = 32, dev name /dev/video9, entity info id = 130, name vin<v5122isd-Input-D>, me_nr = 33
01-01 00:03:25.260   264   320 D pinecamera: get entity i = 33, dev name /dev/v4l-subdev23, entity info id = 136, name mipi-csi #0, me_nr = 34
01-01 00:03:25.260   264   320 D pinecamera: get entity i = 34, dev name /dev/v4l-subdev24, entity info id = 139, name mipi-csi #1, me_nr = 35
01-01 00:03:25.261   264   320 I pinecamera: Find input 0 <sensor>: song.tele.lt6911c0
01-01 00:03:25.262   264   320 I pinecamera: Find input 1 <sensor>: song.tele.lt6911c1
01-01 00:03:25.262   264   320 I pinecamera: Find input 2 <v4l-dev>: vin<v5122isd-Input-A>
01-01 00:03:25.262   264   320 I pinecamera: Find input 3 <v4l-dev>: vin<v5122isd-Input-B>
01-01 00:03:25.262   264   320 I pinecamera: Find input 4 <v4l-dev>: vin<v5122isd-Input-C>
01-01 00:03:25.262   264   320 I pinecamera: Find input 5 <v4l-dev>: vin<v5122isd-Input-D>
01-01 00:03:25.262   264   320 I pinecamera: Find path 0: v5122isd-Pipeline#1
01-01 00:03:25.262   264   320 I pinecamera: Find path 1: v5122isd-DataDump#1
01-01 00:03:25.262   264   320 I pinecamera: Find path 2: v5122isd-MemorySensor#1
01-01 00:03:25.262   264   320 I pinecamera: Find path 3: v5122isd-Pipeline#2
01-01 00:03:25.262   264   320 I pinecamera: Find path 4: v5122isd-DataDump#2
01-01 00:03:25.262   264   320 I pinecamera: Find path 5: v5122isd-MemorySensor#2
01-01 00:03:25.262   264   320 I pinecamera: Find path 6: v5122isd-HighSpeed
01-01 00:03:25.263   264   320 I pinecamera: Find output 0: vout<v5122isd-Output-A>
01-01 00:03:25.263   264   320 I pinecamera: Find output 1: vout<v5122isd-Output-B>
01-01 00:03:25.263   264   320 I pinecamera: Find output 2: vout<v5122isd-Output-C>
01-01 00:03:25.263   264   320 I pinecamera: Find output 3: vout<v5122isd-Output-D>
01-01 00:03:25.263   264   320 I pinecamera: Find output 4: vout<v5122isd-Output-E>
01-01 00:03:25.263   264   320 I pinecamera: Find output 5: vout<v5122isd-Output-F>
01-01 00:03:25.274   264   320 D PineCameraHardware: module_info: back_camera=tele.lt6911c0,front_camera=tele.lt6911c1
01-01 00:03:25.275   264   320 D pinecamera: found camera info name song.tele.lt6911c0, width 1920, height 1080
01-01 00:03:25.275   264   320 I PineCameraInfo: @@@@@@@@@@@ mSnapshotMaxWidth = 1920, mSnapshotMaxHeight = 1080 @@@@@@@@@@@@
01-01 00:03:25.275   264   320 I PineCameraInfo: @@@@@@@@@@@ mPreviewMaxWidth = 1920, mPreviewMaxHeight = 1080 @@@@@@@@@@@@
01-01 00:03:25.275   264   320 D PineCameraParameters: initDefault: preview max size:1920x1080
01-01 00:03:25.275   264   320 D PineCameraParameters: initDefault: supported preview sizes: 1920x1080,1440x1080,1280x960,1280x720,720x480,640x480,352x288,320x240,176x144
01-01 00:03:25.275   264   320 D PineCameraParameters: initDefault: snapshot max size: 1920x1080
01-01 00:03:25.275   264   320 D PineCameraParameters: initDefault: video max size: 3840x2160
01-01 00:03:25.276   264   320 D PineCameraParameters: initDefault: supported video sizes: 3840x2160,1920x1080,1280x960,1280x720,720x480,640x480,640x352,352x288,320x240,176x144
01-01 00:03:25.276   264   320 D PineCameraHardware: setParameters
01-01 00:03:25.276   264   320 D PineCameraHardware: setParameters: preview size set to be 1920 x 1080
01-01 00:03:25.276   264   320 D PineCameraHardware: setParameters: picture size set to be 1920 x 1080
01-01 00:03:25.276   264   320 I PineCameraHardware: HFR: 0
01-01 00:03:25.276   264   320 D PineCameraHardware: previewEnabled: 0
01-01 00:03:25.276   264   320 D PineCameraParameters: context not exist, some parameters will be set after preview start
01-01 00:03:25.276   264   320 D PineCameraParameters: setRecordingHint: recording hint set to be false
01-01 00:03:25.276   264   320 D PineCameraParameters: setVideoSizeParam: video size set to be 3840 x 2160
01-01 00:03:25.276   264   320 D PineCameraParameters: setPictureFmt: set picture format jpeg
01-01 00:03:25.276   264   320 D PineCameraParameters: setVideoFormat: video format str is yuv420sp
01-01 00:03:25.276   264   320 D PineCameraParameters: setVideoStab: video stab set to be false
01-01 00:03:25.276   264   320 D PineCameraParameters: setZsl: ZSL set to be true
01-01 00:03:25.276   264   320 D PineCameraParameters: setEffect: effect set to be none
01-01 00:03:25.277   264   320 D PineCameraParameters: set new preview rotation values: -1
01-01 00:03:25.277   264   320 D PineCameraHal: opened camera 0 (0xed403000)
01-01 00:03:25.277   264   320 D PineCameraHal: HAL_camera_device_set_callbacks
01-01 00:03:25.277   264   320 D PineCameraHal: HAL_camera_device_get_parameters
01-01 00:03:25.277   264   320 D PineCameraHardware: getParameters
01-01 00:03:25.278   264   422 D PineCameraNotifier: notifyRoutine
01-01 00:03:25.279   264   320 D PineCameraHal: HAL_camera_device_put_parameters
01-01 00:03:25.279   264   320 D [UavCam]CameraDevice: [Cam0]open: current camera type = 1
01-01 00:03:25.279   264   320 D UAVCamera: UavCameraService::openCamera(0) return(0)
01-01 00:03:25.280   413   419 E UAVCamera: [setNotifyCallback:302]UAVCamera::setNotifyCallback
01-01 00:03:25.280   413   419 D UAVCamera: BpUAVMainCamService::setCallback
01-01 00:03:25.276   413   413 I /system/bin/system-control: type=1400 audit(0.0:278): avc: denied { transfer } for comm=504F5349582074696D65722030 scontext=u:r:systemcontrol_daemon:s0 tcontext=u:r:uavmaincamera_daemon:s0 tclass=binder permissive=1
01-01 00:03:25.281   264   264 D UAVCamera: UavCameraService::setNotifyCallback(0)
01-01 00:03:25.281   413   419 D UAVCamera: UAVCamera::startPreview
01-01 00:03:25.282   413   419 D UAVCamera: BpUAVMainCamService::startPreview
01-01 00:03:25.282   264   320 D UAVCamera: UavCameraService::startPreview(0)
01-01 00:03:25.282   264   421 D PineCameraEncoder: encodeRoutine: start process routine
01-01 00:03:25.282   264   320 D PineCameraHal: HAL_camera_device_start_preview
01-01 00:03:25.282   264   320 D PineCameraHardware: CAMPERF startPreview: 0
01-01 00:03:25.283   264   320 D PineCameraHardware: startPreview deferred
01-01 00:03:25.283   264   320 I pinecamera: pine_camera_add_context: add context, camID=0, src=0, path=1
01-01 00:03:25.283   264   320 I pinecamera: route find between 'song.tele.lt6911c0' and 'v5122isd-DataDump#1'
01-01 00:03:25.686   413   414 I DroneIDGen: Starting Drone ID Generation
01-01 00:03:25.686   413   414 E DroneIDGen: m2o_collectMessagePack: m2o.messagePackEnc.MsgPackSize 1 msgs 0 0 1 0 0 0 FAIL/ERROR
01-01 00:03:25.686   413   414 D DroneIDGen: dsInformation: FA0BBC0D01F21901220000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000
01-01 00:03:25.688   235   261 I rc_service: sbus:0 no data received in last second, frame stop is set!
01-01 00:03:25.688   235   261 I rc_service: sbus:0 total frame number(1s):0, loss frame number(1s):0
01-01 00:03:25.688   235   261 I rc_service: sbus:1 no data received in last second, frame stop is set!
01-01 00:03:25.688   235   261 I rc_service: sbus:1 total frame number(1s):0, loss frame number(1s):0
01-01 00:03:25.725   413   414 D DroneIDGen: Generate drone id data seq no: 1, crc32: FE341937
01-01 00:03:25.725   413   414 D DroneIDGen: Lock success
01-01 00:03:25.813   259   259 D drone_id_read: New drone id seq no: 1, len: 38340, gen time: 9987, crc32: FE341937 FE341937 PASS
01-01 00:03:25.810   259   259 I drone_id_read: type=1400 audit(0.0:279): avc: denied { read write } for name="modem" dev="tmpfs" ino=9258 scontext=u:r:drone_id_read:s0 tcontext=u:object_r:radio_device:s0 tclass=chr_file permissive=1
01-01 00:03:25.810   259   259 I drone_id_read: type=1400 audit(0.0:280): avc: denied { open } for path="/dev/modem" dev="tmpfs" ino=9258 scontext=u:r:drone_id_read:s0 tcontext=u:object_r:radio_device:s0 tclass=chr_file permissive=1
01-01 00:03:25.815   233   233 I usbethx : change@/devices/platform/regulatory.0
01-01 00:03:25.815   233   233 I usbethx : ACTION=change
01-01 00:03:25.815   233   233 I usbethx : DEVPATH=/devices/platform/regulatory.0
01-01 00:03:25.815   233   233 I usbethx : SUBSYSTEM=platform
01-01 00:03:25.816   233   233 I usbethx : COUNTRY=00
01-01 00:03:25.816   233   233 I usbethx : MODALIAS=platform:regulatory
01-01 00:03:25.816   233   233 I usbethx : SEQNUM=1727
01-01 00:03:26.298   264   320 I pinecamera: context0 [source'song.tele.lt6911c0' => crop'v5122isd-IDI1' => path'v5122isd-DataDump#1' => 0x8 outputs] created
01-01 00:03:26.686   413   414 I DroneIDGen: Starting Drone ID Generation
01-01 00:03:26.686   413   414 E DroneIDGen: m2o_collectMessagePack: m2o.messagePackEnc.MsgPackSize 1 msgs 0 0 1 0 0 0 FAIL/ERROR
01-01 00:03:26.687   413   414 D DroneIDGen: dsInformation: FA0BBC0D02F21901220000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000
01-01 00:03:26.688   235   261 I rc_service: sbus:0 no data received in last second, frame stop is set!
01-01 00:03:26.688   235   261 I rc_service: sbus:0 total frame number(1s):0, loss frame number(1s):0
01-01 00:03:26.688   235   261 I rc_service: sbus:1 no data received in last second, frame stop is set!
01-01 00:03:26.688   235   261 I rc_service: sbus:1 total frame number(1s):0, loss frame number(1s):0
01-01 00:03:26.730   413   414 D DroneIDGen: Generate drone id data seq no: 2, crc32: 1EA9406B
01-01 00:03:26.730   413   414 D DroneIDGen: Lock success
01-01 00:03:26.823   259   259 D drone_id_read: New drone id seq no: 2, len: 38340, gen time: 10992, crc32: 1EA9406B 1EA9406B PASS
01-01 00:03:27.686   413   414 I DroneIDGen: Starting Drone ID Generation
01-01 00:03:27.686   413   414 E DroneIDGen: m2o_collectMessagePack: m2o.messagePackEnc.MsgPackSize 1 msgs 0 0 1 0 0 0 FAIL/ERROR
01-01 00:03:27.687   413   414 D DroneIDGen: dsInformation: FA0BBC0D03F21901220000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000
01-01 00:03:27.688   235   261 I rc_service: sbus:0 no data received in last second, frame stop is set!
01-01 00:03:27.688   235   261 I rc_service: sbus:0 total frame number(1s):0, loss frame number(1s):0
01-01 00:03:27.688   235   261 I rc_service: sbus:1 no data received in last second, frame stop is set!
01-01 00:03:27.688   235   261 I rc_service: sbus:1 total frame number(1s):0, loss frame number(1s):0
01-01 00:03:27.730   413   414 D DroneIDGen: Generate drone id data seq no: 3, crc32: F4CE2DEC
01-01 00:03:27.731   413   414 D DroneIDGen: Lock success
01-01 00:03:27.831   259   259 D drone_id_read: New drone id seq no: 3, len: 38340, gen time: 11992, crc32: F4CE2DEC F4CE2DEC PASS
01-01 00:03:28.686   413   414 I DroneIDGen: Starting Drone ID Generation
01-01 00:03:28.686   413   414 E DroneIDGen: m2o_collectMessagePack: m2o.messagePackEnc.MsgPackSize 1 msgs 0 0 1 0 0 0 FAIL/ERROR
01-01 00:03:28.687   413   414 D DroneIDGen: dsInformation: FA0BBC0D04F21901220000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000
01-01 00:03:28.688   235   261 I rc_service: sbus:0 no data received in last second, frame stop is set!
01-01 00:03:28.688   235   261 I rc_service: sbus:0 total frame number(1s):0, loss frame number(1s):0
01-01 00:03:28.688   235   261 I rc_service: sbus:1 no data received in last second, frame stop is set!
01-01 00:03:28.688   235   261 I rc_service: sbus:1 total frame number(1s):0, loss frame number(1s):0
01-01 00:03:28.730   413   414 D DroneIDGen: Generate drone id data seq no: 4, crc32: 89626782
01-01 00:03:28.730   413   414 D DroneIDGen: Lock success
01-01 00:03:28.736   259   259 D drone_id_read: New drone id seq no: 4, len: 38340, gen time: 12992, crc32: 89626782 89626782 PASS
01-01 00:03:29.014   233   233 I usbethx : change@/devices/platform/regulatory.0
01-01 00:03:29.015   233   233 I usbethx : ACTION=change
01-01 00:03:29.015   233   233 I usbethx : DEVPATH=/devices/platform/regulatory.0
01-01 00:03:29.015   233   233 I usbethx : SUBSYSTEM=platform
01-01 00:03:29.015   233   233 I usbethx : COUNTRY=00
01-01 00:03:29.015   233   233 I usbethx : MODALIAS=platform:regulatory
01-01 00:03:29.015   233   233 I usbethx : SEQNUM=1728
01-01 00:03:29.686   413   414 I DroneIDGen: Starting Drone ID Generation
01-01 00:03:29.686   413   414 E DroneIDGen: m2o_collectMessagePack: m2o.messagePackEnc.MsgPackSize 1 msgs 0 0 1 0 0 0 FAIL/ERROR
01-01 00:03:29.687   413   414 D DroneIDGen: dsInformation: FA0BBC0D05F21901220000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000
01-01 00:03:29.688   235   261 I rc_service: sbus:0 no data received in last second, frame stop is set!

01-01 00:03:29.688   235   261 I rc_service: sbus:0 total frame number(1s):0, loss frame number(1s):0
01-01 00:03:29.688   235   261 I rc_service: sbus:1 no data received in last second, frame stop is set!
01-01 00:03:29.688   235   261 I rc_service: sbus:1 total frame number(1s):0, loss frame number(1s):0
01-01 00:03:29.731   413   414 D DroneIDGen: Generate drone id data seq no: 5, crc32: DE4D4608
01-01 00:03:29.731   413   414 D DroneIDGen: Lock success
01-01 00:03:29.732   413   414 D BoardControl: thermal sensor temperature max 41┬░C, report 37┬░C
01-01 00:03:29.744   259   259 D drone_id_read: New drone id seq no: 5, len: 38340, gen time: 13993, crc32: DE4D4608 DE4D4608 PASS

nothing you have posted shows anything im concerned with. how are you coming to your conclusion?

Please pair it, and confirm firmware versions. on both sides.

It worked after a few reset and pairing cycles