U-Boot 2013.07-H20241023a (Mar 28 2025 - 18:27:22) apll_freq = 1200000000 mpll_freq = 1200000000 vpll_freq = 1188000000 sdram init start DDR clk rate 600000000 80000e4c 00000000 00000000 DDR soft training ... sdram init Finished image entry point: 0x80100000 Board: PRJ007 (Ingenic XBurst PRJ007 SoC) DRAM: 64 MiB Top of RAM usable for U-Boot at: 84000000 Reserving 452k for U-Boot at: 83f8c000 Reserving 32784k for malloc() at: 81f88000 Reserving 32 Bytes for Board Info at: 81f87fe0 Reserving 124 Bytes for Global Data at: 81f87f64 Reserving 128k for boot params() at: 81f67f64 Stack Pointer at: 81f67f48 Now running in RAM - U-Boot at: 83f8c000 serial_initialize done mem_malloc_init done MMC PWR EN MMC: MSC: 0 SF: Detected GD25Q128C, flash size: 16MB, manufacturer id: c8 In: serial Out: serial Err: serial Net: Jz4775-9161 Interface: MMC Device 0: Vendor: Man 00006f Snr 00013601 Rev: 10.10 Prod: IST3T Type: Removable Hard Disk Capacity: 119305.0 MB = 116.5 GB (244336640 x 512) Filesystem: FAT32 "" SF: Detected GD25Q128C, flash size: 16MB, manufacturer id: c8 reading t32_cfgupdate t32_cfgupdate not found Hit any key to stop autoboot: 0 SF: Detected GD25Q128C, flash size: 16MB, manufacturer id: c8 --->probe spend 6 ms SF: 2621440 bytes @ 0x40000 Read: OK --->read spend 842 ms ## Booting kernel from Legacy Image at 80600000 ... Image Name: Linux-3.10.14__isvp_goat_1.0__ Image Type: MIPS Linux Kernel Image (lzma compressed) Data Size: 1645201 Bytes = 1.6 MiB Load Address: 80010000 Entry Point: 80385bf0 Verifying Checksum ... OK Uncompressing lzma Kernel Image ... OK Starting kernel ... [ 0.000000] Initializing cgroup subsys cpu [ 0.000000] Initializing cgroup subsys cpuacct [ 0.000000] Linux version 3.10.14__isvp_goat_1.0__ (cxl@cxl-virtual-machine) (gcc version 5.4.0 (Ingenic r3.3.7-gcc540 Fix: forbid mxu2 division into delay slot . 2024.10-18) ) #3 PREEMPT Fri Mar 28 18:30:44 CST 2025 [ 0.000000] Ingenic Kernel-3.10 version H20240927a [ 0.000000] bootconsole [early0] enabled [ 0.000000] CPU0 RESET ERROR PC:801C2760 [ 0.000000] [<801c2760>] __delay+0x0/0x10 [ 0.000000] CPU0 revision is: 00d00100 (Ingenic Xburst) [ 0.000000] FPU revision is: 00b70000 [ 0.000000] CCLK:1200MHz L2CLK:600Mhz H0CLK:200MHz H2CLK:200Mhz PCLK:100Mhz [ 0.000000] Determined physical RAM map: [ 0.000000] memory: 00497000 @ 00010000 (usable) [ 0.000000] memory: 00039000 @ 004a7000 (usable after init) [ 0.000000] User-defined physical RAM map: [ 0.000000] memory: 02e00000 @ 00000000 (usable) [ 0.000000] Zone ranges: [ 0.000000] Normal [mem 0x00000000-0x02dfffff] [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x00000000-0x02dfffff] [ 0.000000] cma: CMA: reserved 8 MiB at 02400000 [ 0.000000] Primary instruction cache 32kB, 8-way, VIPT, linesize 32 bytes. [ 0.000000] Primary data cache 32kB, 8-way, VIPT, no aliases, linesize 32 bytes [ 0.000000] pls check processor_id[0x00d00100],sc_jz not support! [ 0.000000] MIPS secondary cache 128kB, 8-way, linesize 32 bytes. [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 11684 [ 0.000000] Kernel command line: console=ttyS1,115200n8 mem=46M@0x0 rmem=18M@0x2E00000 init=/linuxrc rootfstype=squashfs root=/dev/mtdblock2 rw mtdparts=sfc0_nor:256k(boot),2048k(kernel),2048k(root),512k(cfg),-(appfs) [ 0.000000] PID hash table entries: 256 (order: -2, 1024 bytes) [ 0.000000] Dentry cache hash table entries: 8192 (order: 3, 32768 bytes) [ 0.000000] Inode-cache hash table entries: 4096 (order: 2, 16384 bytes) [ 0.000000] Memory: 33048k/47104k available (3574k kernel code, 14056k reserved, 1124k data, 228k init, 0k highmem, 8192K cma-reserved) [ 0.000000] SLUB: HWalign=32, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 [ 0.000000] Preemptible hierarchical RCU implementation. [ 0.000000] NR_IRQS:358 [ 0.000000] clockevents_config_and_register success. [ 12.267397] Calibrating delay loop... 1196.85 BogoMIPS (lpj=5984256) [ 12.355185] pid_max: default: 32768 minimum: 301 [ 12.360084] Mount-cache hash table entries: 512 [ 12.365126] Initializing cgroup subsys debug [ 12.369390] Initializing cgroup subsys freezer [ 12.375980] regulator-dummy: no parameters [ 12.380413] NET: Registered protocol family 16 [ 12.395970] bio: create slab at 0 [ 12.401758] jz-dma jz-dma: JZ SoC DMA initialized [ 12.406832] usbcore: registered new interface driver usbfs [ 12.412354] usbcore: registered new interface driver hub [ 12.417858] usbcore: registered new device driver usb [ 12.423078] (null): set:249 hold:250 dev=100000000 h=500 l=500 [ 12.429174] i2c i2c-0: i2c0 register ok. [ 12.434807] Switching to clocksource jz_clocksource [ 12.440267] NET: Registered protocol family 2 [ 12.444734] cfg80211: Calling CRDA to update world regulatory domain [ 12.451664] TCP established hash table entries: 512 (order: 0, 4096 bytes) [ 12.458581] TCP bind hash table entries: 512 (order: -1, 2048 bytes) [ 12.465074] TCP: Hash tables configured (established 512 bind 512) [ 12.471362] TCP: reno registered [ 12.474557] UDP hash table entries: 256 (order: 0, 4096 bytes) [ 12.480506] UDP-Lite hash table entries: 256 (order: 0, 4096 bytes) [ 12.487057] NET: Registered protocol family 1 [ 12.491774] RPC: Registered named UNIX socket transport module. [ 12.497708] RPC: Registered udp transport module. [ 12.502544] RPC: Registered tcp transport module. [ 12.507243] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 12.514101] cpu_clk rate is 1200000000 [ 12.522523] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ 12.529210] jffs2: version 2.2. © 2001-2006 Red Hat, Inc. [ 12.535159] msgmni has been set to 80 [ 12.540148] io scheduler noop registered [ 12.544085] io scheduler cfq registered (default) [ 12.549181] vpu_node_num: 1radix0 probe success [ 12.553900] vpu_node_num: 2helix0 success [ 12.559021] jz-uart.1: ttyS1 at MMIO 0x10031000 (irq = 58) is a gate_uart1 [ 12.567269] console [ttyS1] enabled, bootconsole disabled [ 12.567269] console [ttyS1] enabled, bootconsole disabled [ 12.578529] jz-uart.2: ttyS2 at MMIO 0x10032000 (irq = 57) is a gate_uart2 [ 12.588924] brd: module loaded [ 12.593822] loop: module loaded [ 12.597576] zram: Created 2 device(s) ... [ 12.601899] logger: created 256K log 'log_main' [ 12.607198] jz TCU driver register completed [ 12.612029] JZ-SFC,Use SFC Standard Mode [ 12.616092] JZ-SFC,Use SFC PIO Mode [ 12.620604] jz-sfc jz-sfc.0: Found Supported nor device, BE = 32K, id = c84018, name = GD25Q127C [ 12.629780] jz-sfc jz-sfc.0: nor flash now use standard mode! [ 12.635728] jz-sfc jz-sfc.0: nor flash now use 3bytes mode! [ 12.641528] 5 cmdlinepart partitions found on MTD device sfc0_nor [ 12.647835] Creating 5 MTD partitions on "sfc0_nor": [ 12.652988] 0x000000000000-0x000000040000 : "boot" [ 12.658513] 0x000000040000-0x000000240000 : "kernel" [ 12.664184] 0x000000240000-0x000000440000 : "root" [ 12.669572] 0x000000440000-0x0000004c0000 : "cfg" [ 12.674958] 0x0000004c0000-0x000001000000 : "appfs" [ 12.680630] jz-sfc jz-sfc.0: SPI NOR MTD LOAD OK [ 12.685476] tun: Universal TUN/TAP device driver, 1.6 [ 12.690755] tun: (C) 1999-2004 Max Krasnyansky [ 12.697262] usbcore: registered new interface driver zd1201 [ 12.703140] jz-dwc2 jz-dwc2: div clk gate get error [ 12.708208] DWC IN OTG MODE [ 12.711784] dwc2 dwc2: Keep PHY ON [ 12.715306] dwc2 dwc2: Using Buffer DMA mode [ 12.719750] dwc2 dwc2: Core Release: 3.00a [ 12.724025] dwc2 dwc2: DesignWare USB2.0 High-Speed Host Controller [ 12.730544] dwc2 dwc2: new USB bus registered, assigned bus number 1 [ 12.738266] hub 1-0:1.0: USB hub found [ 12.742230] hub 1-0:1.0: 1 port detected [ 12.746419] dwc2 dwc2: DWC2 Host Initialized [ 12.752413] mmc0: Unknown controller version (5). You may experience problems. [ 12.760112] mmc0: no vqmmc regulator found [ 12.764358] mmc0: no vmmc regulator found [ 12.819807] mmc0: SDHCI controller on ingenic-msc [jz-sdhci.0] using ADMA [ 12.826856] dwc2 dwc2: ID PIN CHANGED! [ 12.831060] sdhci: Secure Digital Host Controller Interface driver [ 12.839516] sdhci: Copyright(c) Pierre Ossman [ 12.849496] TCP: cubic registered [ 12.853100] NET: Registered protocol family 17 [ 12.862195] soc_vpu probe success,version:1.0.0-03203fd46d [ 12.872296] input: gpio-keys as /devices/platform/gpio-keys/input/input0 [ 12.888050] VFS: Mounted root (squashfs filesystem) readonly on device 31:2. [ 12.895878] Freeing unused kernel memory: 228K (804a7000 - 804e0000) [ 12.929212] mmc0: new high speed SDXC card at address b369 [ 12.935436] mmcblk0: mmc0:b369 IST3T 116 GiB [ 12.947627] mmcblk0: p1 MDEV:mmcblk0p1 ACTION:add [ 13.690402] FAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. MDEV:mmcblk0 ACTION:add mdev ignore mmcblk0 mdev is ok...... net.core.wmem_max = 26214400 net.core.wmem_default = 26214400 Ingenic-uc1_1 login: [ 14.330819] [atbm_log]:atbm_usb_module_init 0 [ 14.338418] [atbm_log]:platform_init(253) [ 14.345139] [atbm_log]:SVN_VER=34074,DPLL_CLOCK=2,BUILD_TIME=2025-04-01_20:18:44 [ 14.353284] usbcore: registered new interface driver atbm_wlan [ 14.799732] usb 1-1: new high-speed USB device number 2 using dwc2 [ 15.013787] [atbm_log]:atbm_usb_probe : idVendor[7a] idProduct[8890] [ 15.023000] [atbm_log]:reset wifi_chip_probe! [ 15.027518] [atbm_log]:Probe called -1 v1 [ 15.031774] [atbm_log]:not CONFIG_USE_DMA_ADDR_BUFFER [ 15.037152] [atbm_log]:CONFIG_TX_NO_CONFIRM [ 15.041595] [atbm_log]:ble_spin_lock init [ 15.045842] [atbm_log]:Allocated hw_priv @ 82094ee0 [ 15.051310] [atbm_log]: wait_event_interruptible from send_prbresp_wq [ 15.058134] [atbm_log]:atbmwifi USB_USE_TASTLET_TXRX enable (82094ee0) [ 15.064988] [atbm_log]:atbmwifi USB_USE_TASTLET_TXRX enable (82094ee0) [ 15.071876] [atbm_log]:atbm_get_chiptype, chipver=0xa3, g_wifi_chip_type[14] [ 15.079172] [atbm_log]:atbm_before_load_firmware++ [ 15.084210] [atbm_log]:+++++++++++++++++1.1v++++++++++++++++++ [ 15.090263] [atbm_log]:===================~_~==================== [ 15.096976] [atbm_log]:atbm_start_load_firmware++ [ 15.101861] fwhdr->flags 34353678 sram_addr 9012000 [ 15.106910] [atbm_log]: [ 15.106910] ======>>> load WIFI BLE COMB firmware <<<====== [ 15.106910] [ 15.116740] [atbm_log]:START DOWNLOAD ICCM========= [ 15.121798] [atbm_log]:atbm_load_firmware_generic: addr 10000: len 28000 [ 15.252026] [atbm_log]:START DOWNLOAD DCCM========= [ 15.257087] [atbm_log]:atbm_load_firmware_generic: addr 800000: len a000 [ 15.295139] [atbm_log]:START DOWNLOAD SRAM========= [ 15.300214] [atbm_log]:atbm_load_firmware_generic: addr 9012000: len 4000 [ 15.319546] [atbm_log]:atbm_after_load_firmware++ [ 15.324443] [atbm_log]:usb:try to flush rx.... [ 15.419759] [atbm_log]:flush rx[-145][0] [ 15.423826] [atbm_log]:ARES_A:after_load_firmware [ 15.428888] [atbm_log]:0x1610102c=0x40a0e [ 15.433411] [atbm_log]:0x1610102c=0x10a0f [ 15.437612] [atbm_log]:0x16101000=0x8000e08 [ 15.442318] [atbm_log]:set_block_size=256 [ 15.446492] [atbm_log]:firmwareCap f1a9 [ 15.450481] [atbm_log]:firmwareCap2 1185 [ 15.454540] [atbm_log]:wsm_caps.firmwareCap 1185f1a9 0 [ 15.459687] [atbm_log]:apollo wifi WSM init done. [ 15.459687] Input buffers: 25 x 1648 bytes [ 15.459687] Hardware: 7.0 [ 15.459687] WSM firmware [=MODEM=RF=Ares_AX Apr 22 2024 14:36:14], ver: 19963, build: 4221, api: 1060, cap: 0x1185F1A9 Config[30008] expection 9001fdc, ep0 cmd addr 0 NumOfStations[8] NumOfInterfaces[3] [ 15.491207] [atbm_log]:EFUSE(8) [0] [ 15.495082] [atbm_log]:EFUSE(I) [0] [ 15.499061] [atbm_log]:EFUSE(B) [0] [ 15.502860] [atbm_log]:CAPABILITIES_ATBM_PRIVATE_IE [0] [ 15.508354] [atbm_log]:CAPABILITIES_NVR_IPC [0] [ 15.513140] [atbm_log]:CAPABILITIES_NO_CONFIRM [1] [ 15.518186] [atbm_log]:CAPABILITIES_SDIO_PATCH [0] [ 15.523240] [atbm_log]:CAPABILITIES_NO_BACKOFF [1] [ 15.528284] [atbm_log]:CAPABILITIES_CFO [0] [ 15.532707] [atbm_log]:CAPABILITIES_AGC [1] [ 15.537123] [atbm_log]:CAPABILITIES_TXCAL [1] [ 15.541727] [atbm_log]:CAPABILITIES_MONITOR [0] [ 15.546503] [atbm_log]:CAPABILITIES_CUSTOM [0] [ 15.551195] [atbm_log]:CAPABILITIES_SMARTCONFIG [0] [ 15.556330] [atbm_log]:CAPABILITIES_ETF [1] [ 15.560754] [atbm_log]:CAPABILITIES_LMAC_RATECTL [1] [ 15.565981] [atbm_log]:CAPABILITIES_LMAC_TPC [1] [ 15.570854] [atbm_log]:CAPABILITIES_LMAC_TEMPC [1] [ 15.575900] [atbm_log]:CAPABILITIES_CTS_BUG [1] [ 15.580682] [atbm_log]:CAPABILITIES_USE_IPC [0] [ 15.585457] [atbm_log]:CAPABILITIES_OUTER_PA [0] [ 15.590331] [atbm_log]:CAPABILITIES_POWER_CONSUMPTION [0] [ 15.596006] [atbm_log]:CAPABILITIES_RSSI_DECIDE_TXPOWER [0] [ 15.601869] [atbm_log]:CAPABILITIES_RTS_LONG_DURATION [1] [ 15.607546] [atbm_log]:CAPABILITIES_TX_CFO_PPM_CORRECTION [1] [ 15.613588] [atbm_log]:CAPABILITIES_NOISE_SET_DCXO [0] [ 15.618996] [atbm_log]:CAPABILITIES_CFO_DCXO_CORRECTION [1] [ 15.624858] [atbm_log]:CAPABILITIES_HW_CHECKSUM [0] [ 15.630002] [atbm_log]:CAPABILITIES_SINGLE_CHANNEL_MULTI_RX [0] [ 15.636218] [atbm_log]:EX_CAPABILITIES_TWO_CHIP_ONE_SOC [0] [ 15.642082] [atbm_log]:EX_CAPABILITIES_MANUAL_SET_AC [0] [ 15.647668] [atbm_log]:EX_CAPABILITIES_LMAC_BW_CONTROL [1] [ 15.653442] [atbm_log]:EX_CAPABILITIES_SUPPORT_TWO_ANTENNA [0] [ 15.659567] [atbm_log]:EX_CAPABILITIES_ENABLE_STA_REMAIN_ON_CHANNEL [1] [ 15.666510] [atbm_log]:EX_CAPABILITIES_ENABLE_PS [1] [ 15.671743] [atbm_log]:EX_CAPABILITIES_TX_REQUEST_FIFO_LINK [0] [ 15.677958] [atbm_log]:EX_CAPABILITIES_DRIVER_PHY_REG_INIT [0] [ 15.684092] [atbm_log]:EX_CAPABILITIES_DRIVER_PROCESS_BA [0] [ 15.690044] [atbm_log]:EX_CAPABILITIES_DRIVER_PHY_REG_INIT [0] [ 15.696169] [atbm_log]:EX_CAPABILITIES_DRIVER_PROCESS_BA[1] [ 15.701943] [atbm_log]:CONFIG_PRODUCT_TEST_USE_FEATURE_ID [1] [ 15.707887] [atbm_log]:CONFIG_PRODUCT_TEST_USE_GOLDEN_LED [1] [ 15.713949] [atbm_log]:mdelay wait wsm_startup_done !! [ 15.719739] [atbm_log]:wsm_generic_confirm:status(2) [ 15.724920] [atbm_log]: wsm_write_mib fail !!! mibId=4132 [ 15.731631] [atbm_log]:efuse data is [0x11,0x55,0x2,0x3e,0x3b,0x10,0x0,0x0,0x60:0x56:0xee:0x16:0x81:0x2] [ 15.741629] [atbm_log]:apollo wifi : can't open /data/.mac.info [ 15.748264] [atbm_log]:enable sg [ 15.754233] [atbm_log]:[wlan0] has been disabled [ 15.773723] [atbm_log]:ble start [ 15.779675] [atbm_log]:[phy0-ble_recv] start [ 15.784310] [atbm_log]:ble subscribe [ 15.788187] [atbm_log]:[phy0-ble_xmit] start [ 15.792981] [atbm_log]:ble_platform_probe(81b19700) [ 15.800759] [atbm_log]:is registered as 'phy0' [ 15.805401] [atbm_log]:apollo wifi : can't open /tmp/atbm_txpwer_dcxo_cfg.txt [ 15.812916] [atbm_log]:apollo wifi : can't open /tmp/set_rate_power.txt [ 15.820027] [atbm_log]:apollo wifi : can't open /tmp/set_rate_power_5g.txt [ 15.827331] [atbm_log]:open_auto_cfo:ppm_buf:cfo 1 0 , buf_len:8 [ 15.833864] [atbm_log]:get chip id [34][0][0] [ 15.838465] [atbm_log]:current chiptype 6132-BU [ 15.843278] [atbm_log]:[atbm_wtd]:set wtd_probe = 1 [ 18.383392] [atbm_log]:atbm_setup_mac:addr(6056ee168102) [ 18.389125] [atbm_log]:3 !!! atbm_vif_setup_params: enabling priv [ 18.419730] [atbm_log]:[STA] Interface ID:0 of type:2 added [ 18.425680] [atbm_log]:atbm_set_uapsd_param:uapsdFlags(0) [ 18.432028] [atbm_log]:atbm_set_uapsd_param:uapsdFlags(0) [ 18.438024] [atbm_log]:atbm_set_uapsd_param:uapsdFlags(0) [ 18.444053] [atbm_log]:atbm_set_uapsd_param:uapsdFlags(0) [ 18.450035] [atbm_log]:atbm_set_uapsd_param:uapsdFlags(0) start_param -------------------- clk_name=mpll isp_clk=200000000 --nrvbs 2 --sboot=0 --fps=30 [ 18.717273] @@@@ tx-isp-probe ok (version H20241022a), compiler date: Oct 22 2024 17:27:33 @@@@@ [ 18.922629] dma dma0chan24: Channel 24 have been requested.(phy id 7,type 0x06 desc a2403000) [ 18.934488] dma dma0chan25: Channel 25 have been requested.(phy id 6,type 0x06 desc a2404000) [ 18.944078] dma dma0chan26: Channel 26 have been requested.(phy id 5,type 0x04 desc a2405000) [ 18.959155] the codec_type = 0 !!!!! [ 18.979774] @@@@@ inner codec power up@@@@@@ [ 19.259766] @@@@ audio driver ok(version H20240815a) @@@@@ [ 19.296616] tnna_clk=1200MHz, v0_clk=600MHz, default=600MHz [ 19.308972] Successful insmod, version=0x10200. [1970-01-01 00:00:10:203] tag[INFO] module[PRODUCT_CONFIG] func[product_config_init] line[480] product config default file create success,cost:35 ms [1970-01-01 00:00:10:204] tag[INFO] module[PRODUCT_NET_INFO] func[product_net_info_get_first] line[58] work_mode_->valueint:1 [1970-01-01 00:00:10:204] tag[INFO] module[PRODUCT_NET_INFO] func[product_net_info_get_first] line[71] essid_:sonsii [1970-01-01 00:00:10:204] tag[INFO] module[PRODUCT_NET_INFO] func[product_net_info_get_first] line[138] mac_:0C:F0:B4:B8:DC:DA [1970-01-01 00:00:10:205] tag[INFO] module[PRODUCT_NET_INFO] func[product_net_info_get_first] line[151] strlen(str):5 nic_name_:wlan0 [1970-01-01 00:00:10:205] tag[INFO] module[PRODUCT_NET_INFO] func[product_net_info_get_first] line[177] bind_:0 [1970-01-01 00:00:10:205] tag[INFO] module[PRODUCT_NET_INFO] func[product_net_info_get_first] line[187] token_: [1970-01-01 00:00:10:206] tag[INFO] module[PRODUCT_NET_INFO] func[product_net_info_get_first] line[58] work_mode_->valueint:1 [1970-01-01 00:00:10:207] tag[INFO] module[PRODUCT_NET_INFO] func[product_net_info_get_first] line[71] essid_:sonsii [1970-01-01 00:00:10:207] tag[INFO] module[PRODUCT_NET_INFO] func[product_net_info_get_first] line[138] mac_:0C:F0:B4:7C:34:D5 [1970-01-01 00:00:10:207] tag[INFO] module[PRODUCT_NET_INFO] func[product_net_info_get_first] line[151] strlen(str):5 nic_name_:wlan0 [1970-01-01 00:00:10:207] tag[INFO] module[PRODUCT_NET_INFO] func[product_net_info_get_first] line[177] bind_:0 [1970-01-01 00:00:10:207] tag[INFO] module[PRODUCT_NET_INFO] func[product_net_info_get_first] line[187] token_: [1970-01-01 00:00:10:207] tag[INFO] module[PRODUCT_CONFIG] func[product_config_init] line[500] product config user file load success,cost:2 ms [1970-01-01 00:00:10:216] tag[INFO] module[PRODUCT_CONFIG] func[product_config_init] line[535] PRODUCT_CONFIG init success [1970-01-01 00:00:10:216] tag[INFO] module[MAIN] func[product_config_set] line[287] firmware_version:V1.0.13 mcu uart init.... [1970-01-01 00:00:10:226] tag[INFO] module[MCU_UART] func[uart_init] line[1173] ===================uart init =================== [1970-01-01 00:00:10:243] tag[DEBG] module[COMPORT_INIT] func[comport_open] line[55] Open /dev/ttyS2 successfully. [1970-01-01 00:00:10:444] tag[DEBG] module[COMPORT_INIT] func[comport_init] line[217] Comport Init Successfully...... [1970-01-01 00:00:10:444] tag[INFO] module[MCU_UART] func[uart_init] line[1224] uart init ===================success! [1970-01-01 00:00:10:444] tag[INFO] module[MCU_UART] func[mcu_uart_init] line[1293] create uart receive thread...ok [1970-01-01 00:00:10:445] tag[INFO] module[MCU_UART] func[mcu_uart_init] line[1302] create heart beat thread...ok [1970-01-01 00:00:10:445] tag[INFO] module[MCU_UART] func[mcu_uart_init] line[1311] create upgrade thread...ok [1970-01-01 00:00:10:445] tag[INFO] module[TIMEZONE] func[timezone_init] line[135] timezone_str_:GMT+8 [1969-12-31 16:00:10:446] tag[DEBG] module[COMPORT_SWAP] func[comport_send] line[21] send command length(8), max length(196) ............ [1969-12-31 16:00:10:447] tag[DEBG] module[COMPORT_SWAP] func[comport_send] line[68] serial message is send success [1969-12-31 16:00:10:447] tag[INFO] module[SYSTEM_TIME] func[_system_time_init_from_file] line[235] time_str:20210807 23:15:22 [1969-12-31 16:00:10:448] tag[INFO] module[SYSTEM_TIME] func[_system_time_init_from_file] line[264] year:2021,month:08,day:07,hour:23,minute:15,second:22 [2021-08-07 23:15:22:000] tag[DEBG] module[UTIL_TIME] func[util_local_time_set] line[23] set local time:2021-08-07 23:15:22 [2021-08-07 23:15:22:000] tag[INFO] module[SYSTEM_TIME] func[system_time_init] line[366] SYSTEM_TIME init success [2021-08-07 23:15:22:000] tag[INFO] module[ALARM_MNG] func[alarm_mng_init] line[233] ALARM_MNG init success [2021-08-07 23:15:22:000] tag[INFO] module[UTIL_MEDIA_BUFF] func[util_media_buff_create] line[199] chn:0,block_num:4,block_size:524288 [2021-08-07 23:15:22:004] tag[INFO] module[STREAM_BUFF_INIT] func[stream_buff_init] line[129] video_info->resolution_size_ :5; width:1920;height:1080 [2021-08-07 23:15:22:005] tag[INFO] module[UTIL_MEDIA_BUFF] func[util_media_buff_set_attr] line[176] height_:1080 width_:1920 channel_:0 framerate_:15 stream_format_:5 codec_type_:0 audio_bit_:0 audio_sample_:0 [2021-08-07 23:15:22:005] tag[INFO] module[UTIL_MEDIA_BUFF] func[util_media_buff_create] line[199] chn:1,block_num:2,block_size:262144 [2021-08-07 23:15:22:006] tag[INFO] module[STREAM_BUFF_INIT] func[stream_buff_init] line[129] video_info->resolution_size_ :1; width:640;height:360 [2021-08-07 23:15:22:006] tag[INFO] module[UTIL_MEDIA_BUFF] func[util_media_buff_set_attr] line[176] height_:360 width_:640 channel_:1 framerate_:15 stream_format_:1 codec_type_:0 audio_bit_:0 audio_sample_:0 [2021-08-07 23:15:22:006] tag[INFO] module[STREAM_BUFF_INIT] func[stream_buff_init] line[154] STREAM_BUFF_INIT init success [2021-08-07 23:15:22:006] tag[DEBG] module[VIDEO_INIT] func[video_init] line[4516] video [0] stream info: enable_:1 video_encode_:0 resolution_size_:5 framerate_:15 bitrate_:1352000 gop_:20 bitrate_control_:2 osd_format_:0 osd_font_color_:0xffff osd_edge_color_:0x8000 [2021-08-07 23:15:22:007] tag[DEBG] module[VIDEO_INIT] func[video_init] line[4516] video [1] stream info: enable_:1 video_encode_:0 resolution_size_:1 framerate_:15 bitrate_:1 gop_:20 bitrate_control_:2 osd_format_:0 osd_font_color_:0xffff osd_edge_color_:0x8000 [2021-08-07 23:15:22:007] tag[DEBG] module[NET_MNG] func[net_notify_func_register] line[737] name:system_time 55aa030000010104 [2021-08-07 23:15:22:338] tag[INFO] module[COMPORT_SWAP] func[comport_recv] line[133] reading serial response length(128),receive len(8) success! [2021-08-07 23:15:22:338] tag[INFO] module[ 23.135397] set sensor mclk(0) gpio [MCU_UART] func[dispatch_message] line[915] dispatch message. [2021-08-07 23:15:22:338] tag[INFO] module[MCU_UART] func[process_message] line[821] msg cmd:0x00, len:1 [2021-08-07 23:15:22:338] tag[INFO] module[MCU_UART] func[process_message] line[839] Heart Beat Rsp... [2021-08-07 23:15:22:499] tag[DEBG] module[COMPORT_SWAP] func[comport_send] line[21] send command length(8), max length(196) ............ [2021-08-07 23:15:22:499] tag[DEBG] module[COMPORT_SWAP] func[comport_send] line[68] serial message is send success 55aa030000010104 [2021-08-07 23:15:22:538] tag[INFO] module[COMPORT_SWAP] func[comport_recv] line[133] reading serial response length(128),receive len(8) success! [2021-08-07 23:15:22:539] tag[INFO] module[MCU_UART] func[dispatch_message] line[915] dispatch message. [2021-08-07 23:15:22:539] tag[INFO] module[MCU_UART] func[process_message] line[821] msg cmd:0x00, len:1 [2021-08-07 23:15:22:539] tag[INFO] module[MCU_UART] func[process_message] line[839] Heart Beat Rsp... [ 23.360238] -----cv2003_detect: 1057 ret = 0, v = 0x20 [ 23.366079] -----cv2003_detect: 1065 ret = 0, v = 0x03 [ 23.371417] =================================================== [ 23.377544] Template version is V20241105a [ 23.381794] Sensor driver version is CVSENS.CV2003MP.songsii.V01.20250110 [ 23.388818] Sensor name is cv2003 [ 23.392254] Sensor chip found @ 0x36 (gate_i2c0) [ 23.397030] Sensor video interface is 0 [ 23.401006] Sensor default boot is [0-->1920x1080@(30/1)fps] [ 23.406860] =================================================== [ 23.413401] Create framechan0 OK! [ 23.422508] Create framechan1 OK! [ 23.428296] Create framechan2 OK! [ 23.449786] ************************************************* [ 23.455836] ********* ISP Compiler: Oct 22 2024, 17:27:26 *********** [ 23.463056] ************************************************* [ 23.473722] [ISP][tisp_all_reset, 234]: isp all reset !!! [ 23.488505] [ISP][lib_tisp_get_isp_memory_space, 950]: width is 1920 [ 23.550642] [ISP][lib_tisp_set_isp_memory_space, 970]: vinum is 0 [2021-08-07 23:15:22:889] tag[INFO] module[MCU_UART] func[mcu_uart_night_vision_status] line[557] mcu_uart_night_vision_status. [2021-08-07 23:15:22:889] tag[DEBG] module[COMPORT_SWAP] func[comport_send] line[21] send command length(12), max length(196) ............ [2021-08-07 23:15:22:889] tag[DEBG] module[COMPORT_SWAP] func[comport_send] line[68] serial message is send success [2021-08-07 23:15:22:889] tag[INFO] module[MCU_UART] func[mcu_uart_night_vision_status] line[567] UART_MSG_DPID_CONTROL DPID:0x90, status:0x0 [2021-08-07 23:15:22:890] tag[INFO] module[MCU_UART] func[mcu_uart_ring_lamp_ctrl] line[515] mcu_uart_ring_lamp_ctrl. [2021-08-07 23:15:22:890] tag[DEBG] module[COMPORT_SWAP] func[comport_send] line[21] send command length(12), max length(196) ............ [2021-08-07 23:15:22:890] tag[DEBG] module[COMPORT_SWAP] func[comport_send] line[68] serial message is send success [2021-08-07 23:15:22:890] tag[INFO] module[MCU_UART] func[mcu_uart_ring_lamp_ctrl] line[525] UART_MSG_DPID_CONTROL DPID:0x8d, emoji:0x1 [2021-08-07 23:15:22:899] tag[DEBG] module[GPIO_CMD] func[gpio_cmd_write] line[181] gpioB8 write 1 [2021-08-07 23:15:22:900] tag[DEBG] module[GPIO_CMD] func[gpio_cmd_write] line[181] gpioB13 write 0 [2021-08-07 23:15:22:903] tag[DEBG] module[GPIO_CMD] func[gpio_cmd_write] line[181] gpioB14 write 1 55aa030700059004000100a3 [2021-08-07 23:15:22:938] tag[INFO] module[COMPORT_SWAP] func[comport_recv] line[133] reading serial response length(128),receive len(12) success! [2021-08-07 23:15:22:938] tag[INFO] module[MCU_UART] func[dispatch_message] line[915] dispatch message. [2021-08-07 23:15:22:938] tag[INFO] module[MCU_UART] func[process_message] line[821] msg cmd:0x07, len:5 [2021-08-07 23:15:22:938] tag[INFO] module[MCU_UART] func[process_message] line[842] UART_MSG_STATUS_REPORT. [2021-08-07 23:15:22:938] tag[ERRR] module[MCU_UART] func[dispatch_dpid_msg] line[805] invalid dpid:90 [2021-08-07 23:15:23:104] tag[DEBG] module[GPIO_CMD] func[gpio_cmd_write] line[181] gpioB13 write 0 [2021-08-07 23:15:2[ 23.854854] Allocated 2 buffers! 3:104] tag[DEBG] module[GPIO_CMD] func[gpio_cmd_write] line[181] gpioB14 write 0 [2021-08-07 23:15:23:10[ 23.873309] Allocated 2 buffers! 4] tag[ERRR] module[VIDEO_INIT] func[isp_mode_set] line[4305] IMP_ISP_Tuning_SetHVFLIP fail,hvflip:0 [2021-08-07 23:15:23:108] tag[DEBG] module[VIDEO_INIT] func[_isp_init] line[3980] video init result:0 [2021-08-07 23:15:23:108] tag[DEBG] module[VIDEO_INIT] func[_isp_init] line[3989] imp system init success [2021-08-07 23:15:23:109] tag[DEBG] module[VIDEO_INIT] func[_framesource_init] line[3715] _framesource_init success [2021-08-07 23:15:23:109] tag[DEBG] module[VIDEO_INIT] func[_group_init] line[3589] group init start [2021-08-07 23:15:23:110] tag[DEBG] module[VIDEO_INIT] func[_group_init] line[3613] group init success i265e[info]: Main profile, Level-4 (Main tier) i265e[info]: Main profile, Level-2.1 (Main tier) [2021-08-07 23:15:23:134] tag[DEBG] module[VIDEO_INIT] func[_osd_init] line[2543] stream_index:0,time_rgn_handle:0 [2021-08-07 23:15:23:134] tag[DEBG] module[VIDEO_INIT] func[_osd_init] line[2543] stream_index:1,time_rgn_handle:1 [2021-08-07 23:15:23:135] tag[DEBG] module[VIDEO_INIT] func[_osd_init] line[2804] _osd_init success 55aa030700058d04000101a1 [2021-08-07 23:15:23:147] tag[INFO] module[COMPORT_SWAP] func[comport_recv] line[133] reading serial response length(128),receive len(12) success! [2021-08-07 23:15:23:147] tag[INFO] module[MCU_UART] func[dispatch_message] line[915] dispatch message. [2021-08-07 23:15:23:147] tag[INFO] module[MCU_UART] func[process_message] line[821] msg cmd:0x07, len:5 [2021-08-07 23:15:23:147] tag[INFO] module[MCU_UART] func[process_message] line[842] UART_MSG_STATUS_REPORT. [2021-08-07 23:15:23:147] tag[INFO] module[MCU_UART] func[dispatch_dpid_msg] line[801] MSG_DPID_TYPE_RING_LAMP:0x1 [2021-08-07 23:15:23:164] tag[DEBG] module[VIDEO_INIT] func[_framesource_on] line[1534] _framesource_on success [2021-08-07 23:15:23:164] tag[DEBG] module[VIDEO_INIT] func[video_init] line[4644] VIDEO_INIT init success [2021-08-07 23:15:23:166] tag[DEBG] module[SNAP_INIT] func[snap_init] line[510] SNAP_INIT init success [2021-08-07 23:15:23:166] tag[DEBG] module[AUDIO_INIT] func[_ai_init] line[1202] ai attr: samplerate:16000 bitwidth:16 soundmode:1 frmNum:20 numPerFrm:320 chnCnt:1 [2021-08-07 23:15:23:241] tag[DEBG] module[AUDIO_INIT] func[_ai_init] line[1237] ai chn param: usrFrmDepth:20 aecChn:0 warn: shm_init,53shm init already [2021-08-07 23:15:23:242] tag[DEBG] module[AUDIO_INIT] func[_ai_init] line[1264] ai_vol:80 i265e[info]: Main profile, Level-4 (Main tier) i265e[info]: Main profile, Level-2.1 (Main tier) [2021-08-07 23:15:23:301] tag[DEBG] module[AUDIO_INIT] func[_ai_init] line[1283] ai_gain:28 aec version: v2.1.201201 in webrtc_profile.ini and v2.1.231101 in aec lib. PATH:AEC_PATH is empty,normal audio library [2021-08-07 23:15:23:592] tag[DEBG] module[AUDIO_INIT] func[_ai_init] line[1335] _ai_init success [2021-08-07 23:15:23:599] tag[DEBG] module[AUDIO_INIT] func[_aenc_init] line[1116] _aenc_init success [2021-08-07 23:15:23:599] tag[DEBG] module[AUDIO_INIT] func[_adec_init] line[1055] _adec_init success [2021-08-07 23:15:23:601] tag[INFO] module[AUDIO_INIT] func[turn_on_spk] line[94] spk_power_pin level : 0 [2021-08-07 23:15:23:601] tag[DEBG] module[GPIO_CMD] func[gpio_cmd_write] line[181] gpioB31 write 1 [2021-08-07 23:15:23:601] tag[DEBG] module[AUDIO_INIT] func[_ao_init] line[820] ao attr: samplerate:8000 bitwidth:16 soundmode:1 frmNum:20 numPerFrm:320 chnCnt:1 warn: shm_init,53shm init already [2021-08-07 23:15:23:682] tag[DEBG] module[AUDIO_INIT] func[_ao_init] line[870] ao_gain:23 [2021-08-07 23:15:23:682] tag[DEBG] module[AUDIO_INIT] func[_ao_init] line[928] _ao_init success [2021-08-07 23:15:23:682] tag[INFO] module[AUDIO_INIT] func[audio_init] line[1897] AUDIO_INIT init success [2021-08-07 23:15:23:682] tag[INFO] module[IR_CUT] func[ircut_init] line[433] IR_CUT init success [2021-08-07 23:15:23:683] tag[INFO] module[MISC] func[misc_key_init] line[318] start init key [2021-08-07 23:15:23:683] tag[INFO] module[MISC] func[misc_key_init] line[332] init key success [2021-08-07 23:15:23:683] tag[INFO] module[MCU_UART] func[mcu_uart_ring_lamp_ctrl] line[515] mcu_uart_ring_lamp_ctrl. [2021-08-07 23:15:23:683] tag[DEBG] module[COMPORT_SWAP] func[comport_send] line[21] send command length(12), max length(196) ............ [2021-08-07 23:15:23:683] tag[DEBG] module[COMPORT_SWAP] func[comport_send] line[68] serial message is send success [2021-08-07 23:15:23:683] tag[INFO] module[MCU_UART] func[mcu_uart_ring_lamp_ctrl] line[525] UART_MSG_DPID_CONTROL DPID:0x8d, emoji:0x1 [2021-08-07 23:15:23:683] tag[INFO] module[MCU_UART] func[mcu_uart_set_laser_pointer] line[494] mcu_uart_set_laser_pointer. [2021-08-07 23:15:23:684] tag[DEBG] module[COMPORT_SWAP] func[comport_send] line[21] send command length(12), max length(196) ............ [2021-08-07 23:15:23:684] tag[DEBG] module[COMPORT_SWAP] func[comport_send] line[68] serial message is send success [2021-08-07 23:15:23:684] tag[INFO] module[MCU_UART] func[mcu_uart_set_laser_pointer] line[504] UART_MSG_DPID_CONTROL DPID:0x86, speed:0x0 [2021-08-07 23:15:23:684] tag[INFO] module[MCU_UART] func[mcu_uart_set_move_speed] line[473] mcu_uart_set_move_speed. [2021-08-07 23:15:23:684] tag[DEBG] module[COMPORT_SWAP] func[comport_send] line[21] send command length(12), max length(196) ............ [2021-08-07 23:15:23:684] tag[DEBG] module[COMPORT_SWAP] func[comport_send] line[68] serial message is send success [2021-08-07 23:15:23:684] tag[INFO] module[MCU_UART] func[mcu_uart_set_move_speed] line[483] UART_MSG_DPID_CONTROL DPID:0x8c, speed:0x32 [2021-08-07 23:15:23:684] tag[DEBG] module[MISC] func[misc_init] line[499] MISC init success [2021-08-07 23:15:23:685] tag[DEBG] module[QRCODE] func[qrcode_init] line[628] QRCODE init start [2021-08-07 23:15:23:696] tag[INFO] module[MISC] func[key_event_listener] line[192] Start read key event [2021-08-07 23:15:23:719] tag[INFO] module[PROMPT_TONE] func[prompt_tone_init] line[491] PROMPT_TONE init success [2021-08-07 23:15:23:719] tag[INFO] module[QRCODE] func[qrcode_init] line[682] QRCODE init success [2021-08-07 23:15:23:720] tag[INFO] module[PLATFORM_TY] func[platform_init] line[1762] sdk init start>>>>>>>>>>>> [2021-08-07 23:15:23:720] tag[DEBG] module[ALARM_MNG] func[alarm_mng_func_register] line[169] cb:0x45c6e0 [2021-08-07 23:15:23:727] tag[DEBG] module[VIDEO_INIT] func[framesource_depth_set] line[4076] cur_depth:0,depth:1 [2021-08-07 23:15:23:727] tag[DEBG] module[PROMPT_TONE] func[_prompt_tone_thread] line[183] adec_format:2,play_item_type:41 55aa030700058d04000101a1 [2021-08-07 23:15:23:738] tag[INFO] module[COMPORT_SWAP] func[comport_recv] line[133] reading serial response length(128),receive len(12) success! [2021-08-07 23:15:23:738] tag[INFO] module[MCU_UART] func[dispatch_message] line[915] dispatch message. [2021-08-07 23:15:24:070] tag[INFO] module[MCU_UART] func[process_message] line[821] msg cmd:0x07, len:5 [2021-08-07 23:15:24:070] tag[INFO] module[MCU_UART] func[process_message] line[842] UART_MSG_STATUS_REPORT. [2021-08-07 23:15:24:070] tag[INFO] module[MCU_UART] func[dispatch_dpid_msg] line[801] MSG_DPID_TYPE_RING_LAMP:0x1 [2021-08-07 23:15:23:766] tag[DEBG] module[QRCODE] func[_qrcode_thread] line[454] yuv data buff malloc success!!! [2021-08-07 23:15:23:788] tag[WARN] module[PLATFORM_TY] func[platform_init] line[1826] udid:uuida4c86e451c399c33,key:AmER9q1SPBjfkErpGgyqLjNHTsuRrCQp [2021-08-07 23:15:24:073] tag[INFO] module[PLATFORM_TY] func[platform_init] line[1847] firmware version str:V1.0.13 [2021-08-07 23:15:24:073] tag[INFO] module[PLATFORM_TY] func[platform_init] line[1849] firmware version :1.0.13 SDK Version:< TuyaOS V:6.2.6 BS:40.00_PT:2.3_LAN:3.5_CAD:1.0.5_CD:1.0.0 > < BUILD AT:2025_04_03_11_22_47 BY dandi.guo FOR tuyaos-ipc AT T32_uclibc_r3.3.7 > IOT DEFS < WIFI_GW:1 DEBUG:0 KV_FILE:0 LITTLE_END:1 SL:1 OPERATING_SYSTEM:100 RELIABLE_TRANSFER:0 > MODE:1 LINK_TYPE:5 IP_MODE_TYPE:0 [01-01 00:00:00 ty I][1e80][tal_thread.c:185] thread_create name:sys_timer,stackDepth:4096,totalstackDepth:4096,priority:5 [01-01 00:00:00 ty I][1e80][tal_thread.c:185] thread_create name:wq_system,stackDepth:6144,totalstackDepth:10240,priority:3 [01-01 00:00:00 ty I][1e80][tal_thread.c:185] thread_create name:wq_highpri,stackDepth:5120,totalstackDepth:15360,priority:4 tkl_wifi_init-173 called [01-01 00:00:00 ty I][1e80][tal_thread.c:185] thread_create name:health_monitor,stackDepth:1536,totalstackDepth:16896,priority:5 [01-01 00:00:00 ty I][1e80][mqc_app.c:490] mqc app init ... [01-01 00:00:00 ty E][1e80][log_seq.c:861] open err [01-01 00:00:00 ty I][1e80][kv_storge.c:45] Init Kvs With File:/mnt/config/ 55aa0307000586040001009955aa030700058c04000132d1 [2021-08-07 23:15:24:271] tag[INFO] module[COMPORT_SWAP] func[comport_recv] line[133] reading serial response length(128),receive len(24) success! [2021-08-07 23:15:24:740] tag[INFO] module[MCU_UART] func[dispatch_message] line[915] dispatch message. [2021-08-07 23:15:24:740] tag[INFO] module[MCU_UART] func[process_message] line[821] msg cmd:0x07, len:5 [2021-08-07 23:15:24:741] tag[INFO] module[MCU_UART] func[process_message] line[842] UART_MSG_STATUS_REPORT. [2021-08-07 23:15:24:741] tag[INFO] module[MCU_UART] func[dispatch_dpid_msg] line[797] MSG_DPID_TYPE_LASER_POINTER:0x0 [2021-08-07 23:15:24:741] tag[INFO] module[MCU_UART] func[process_message] line[821] msg cmd:0x07, len:5 [2021-08-07 23:15:24:741] tag[INFO] module[MCU_UART] func[process_message] line[842] UART_MSG_STATUS_REPORT. [2021-08-07 23:15:24:741] tag[ERRR] module[MCU_UART] func[dispatch_dpid_msg] line[805] invalid dpid:8C WIFI mode[0] Get IP failed wifi_status_event_cb-155 set wf event[2] [01-01 00:00:00 ty N][1e80][tuya_tls.c:876] uni_random_init... [01-01 00:00:00 ty N][1e80][tuya_tls.c:303] tuya_tls_rand_init ok! [01-01 00:00:00 ty N][1e80][tuya_svc_devos.c:338] gw_cntl->gw_wsm.stat:0 [01-01 00:00:00 ty D][1e80][tuya_ipc_media_adapter.c:101] media adapter init success. avaliable_res_size:5000 [01-01 00:00:00 ty D][1e80][tuya_ipc_media_adapter.c:511] insert media info node success! device:[0] channel:[0] [01-01 00:00:00 ty D][1e80][ty_sdk_media_callback.c:699] init ring buffer Channel:0 Stream:0 Enable:1 [01-01 00:00:00 ty D][1e80][ty_sdk_media_callback.c:717] video_bitrate 768, video_fps 15 [01-01 00:00:00 ty D][1e80][tuya_ring_buffer.c:649] Init Ring Buffer. ch0st0tr0 bitrate:768 fps:15 [01-01 00:00:00 ty D][1e80][tuya_ring_buffer.c:672] Ring buffer malloc 589824 bytes for ch0st0tr0, max frame size 147456 [01-01 00:00:00 ty I][1e80][tuya_ring_buffer.c:694] Init Ring Buffer success: ch0st0tr0 size:589824 nodes:90 [01-01 00:00:00 ty T][1e80][tuya_ring_buffer.c:148] ch0st0tr0 release ref count: 0 [01-01 00:00:00 ty D][1e80][ty_sdk_media_callback.c:725] init ring buffer success. channel:0 [01-01 00:00:00 ty D][1e80][ty_sdk_media_callback.c:699] init ring buffer Channel:0 Stream:1 Enable:1 [01-01 00:00:00 ty D][1e80][ty_sdk_media_callback.c:717] video_bitrate 256, video_fps 15 [01-01 00:00:00 ty D][1e80][tuya_ring_buffer.c:649] Init Ring Buffer. ch0st0tr1 bitrate:256 fps:15 [01-01 00:00:00 ty D][1e80][tuya_ring_buffer.c:672] Ring buffer malloc 196608 bytes for ch0st0tr1, max frame size 49152 [01-01 00:00:00 ty I][1e80][tuya_ring_buffer.c:694] Init Ring Buffer success: ch0st0tr1 size:196608 nodes:90 [01-01 00:00:00 ty T][1e80][tuya_ring_buffer.c:148] ch0st0tr1 release ref count: 0 [01-01 00:00:00 ty D][1e80][ty_sdk_media_callback.c:725] init ring buffer success. channel:1 [01-01 00:00:00 ty D][1e80][ty_sdk_media_callback.c:699] init ring buffer Channel:0 Stream:2 Enable:0 [01-01 00:00:00 ty D][1e80][ty_sdk_media_callback.c:699] init ring buffer Channel:0 Stream:3 Enable:0 [01-01 00:00:00 ty D][1e80][ty_sdk_media_callback.c:699] init ring buffer Channel:0 Stream:4 Enable:0 [01-01 00:00:00 ty D][1e80][ty_sdk_media_callback.c:699] init ring buffer Channel:0 Stream:5 Enable:0 [01-01 00:00:00 ty D][1e80][ty_sdk_media_callback.c:699] init ring buffer Channel:0 Stream:6 Enable:0 [01-01 00:00:00 ty D][1e80][ty_sdk_media_callback.c:699] init ring buffer Channel:0 Stream:7 Enable:0 [01-01 00:00:00 ty D][1e80][ty_sdk_media_callback.c:699] init ring buffer Channel:0 Stream:8 Enable:0 [01-01 00:00:00 ty D][1e80][ty_sdk_media_callback.c:699] init ring buffer Channel:0 Stream:9 Enable:1 [01-01 00:00:00 ty D][1e80][ty_sdk_media_callback.c:708] audio_sample 16000, audio_databits 16, audio_fps 25 [01-01 00:00:00 ty D][1e80][tuya_ring_buffer.c:649] Init Ring Buffer. ch0st0tr9 bitrate:250 fps:25 [01-01 00:00:00 ty D][1e80][tuya_ring_buffer.c:672] Ring buffer malloc 192000 bytes for ch0st0tr9, max frame size 48000 [01-01 00:00:00 ty I][1e80][tuya_ring_buffer.c:694] Init Ring Buffer success: ch0st0tr9 size:192000 nodes:150 [01-01 00:00:00 ty T][1e80][tuya_ring_buffer.c:148] ch0st0tr9 release ref count: 0 [01-01 00:00:00 ty D][1e80][ty_sdk_media_callback.c:725] init ring buffer success. channel:9 [01-01 00:00:00 ty D][1e80][ty_sdk_media_callback.c:699] init ring buffer Channel:0 Stream:10 Enable:0 [01-01 00:00:00 ty D][1e80][ty_sdk_media_callback.c:699] init ring buffer Channel:0 Stream:11 Enable:0 [01-01 00:00:00 ty D][1e80][ty_sdk_media_callback.c:699] init ring buffer Channel:0 Stream:12 Enable:0 [01-01 00:00:00 ty D][1e80][ty_sdk_media_callback.c:699] init ring buffer Channel:0 Stream:13 Enable:0 [01-01 00:00:00 ty D][1e80][ty_sdk_media_callback.c:699] init ring buffer Channel:0 Stream:14 Enable:0 [01-01 00:00:00 ty D][1e80][ty_sdk_media_callback.c:699] init ring buffer Channel:0 Stream:15 Enable:0 [01-01 00:00:00 ty D][1e80][simplekv.c:1133] read key:gw_bi isFuzzy:0 skipCnt:0 [01-01 00:00:00 ty D][1e80][simplekv.c:1164] find key:1 gw_bi [01-01 00:00:00 ty D][1e80][simplekv.c:1190] key:gw_bi find value.Len:224 [01-01 00:00:00 ty D][1e80][tuya_ws_db.c:667] sync to protected len[223] [01-01 00:00:00 ty D][1e80][ws_db_gw.c:148] gw_bi read ret:0 [01-01 00:00:00 ty D][1e80][tuya_wifi_link.c:901] tuya wifi link init mthd:0,wifi start mode:0, enable_station_ap:0 [01-01 00:00:01 ty D][1e80][simplekv.c:1133] read key:gw_wsm isFuzzy:0 skipCnt:0 [01-01 00:00:01 ty D][1e80][simplekv.c:1164] find key:2 gw_wsm [01-01 00:00:01 ty D][1e80][simplekv.c:1190] key:gw_wsm find value.Len:192 [01-01 00:00:01 ty D][1e80][tuya_ws_db.c:667] sync to protected len[188] [01-01 00:00:01 ty D][1e80][ws_db_gw.c:259] gw_wsm read ret:0 [01-01 00:00:01 ty N][1e80][tuya_wifi_link.c:85] start wifi link params validate, nc_tp:2 md:0 [01-01 00:00:01 ty N][1e80][tuya_wifi_link.c:107] gw_wsm.nc_tp:2 [01-01 00:00:01 ty N][1e80][tuya_wifi_link.c:108] gw_wsm.md:0 [01-01 00:00:01 ty D][1e80][tuya_bt_link.c:294] bt init... [01-01 00:00:01 ty D][1e80][tuya_svc_netmgr_linkage.c:86] link[3] is registered [2] [01-01 00:00:01 ty D][1e80][tuya_ble_svc.c:2325] get_wifi_list eanbled [01-01 00:00:01 ty D][1e80][tuya_ble_svc.c:2331] get_netcfg_stat eanbled [01-01 00:00:01 ty D][1e80][tuya_ble_svc.c:2335] get_dev_log eanbled [01-01 00:00:01 ty D][1e80][tuya_ble_svc.c:2341] get_ap_name eanbled [01-01 00:00:01 ty D][1e80][simplekv.c:1133] read key:gw_wsm isFuzzy:0 skipCnt:0 [01-01 00:00:01 ty D][1e80][simplekv.c:1164] find key:2 gw_wsm [01-01 00:00:01 ty D][1e80][simplekv.c:1190] key:gw_wsm find value.Len:192 [01-01 00:00:01 ty D][1e80][tuya_ws_db.c:667] sync to protected len[188] [01-01 00:00:01 ty D][1e80][ws_db_gw.c:259] gw_wsm read ret:0 [01-01 00:00:01 ty D][1e80][simplekv.c:1133] read key:wf_start_md isFuzzy:0 skipCnt:0 [01-01 00:00:01 ty D][1e80][simplekv.c:1161] no key find [01-01 00:00:01 ty D][1e80][simplekv.c:1203] __read_kv_raw fail. -3 [01-01 00:00:01 ty D][1e80][simplekv.c:1242] __read_kv_with_decode fail. -3 [01-01 00:00:01 ty E][1e80][tuya_wifi_reset.c:675] read wf start mode err:-6 [01-01 00:00:01 ty D][1e80][tuya_wifi_reset.c:712] <__gw_upd_nc_type> wf start mode change:-6, 0->0 [01-01 00:00:01 ty N][1e80][tuya_svc_devos.c:563] Last reset reason: 7 [01-01 00:00:01 ty D][1e80][simplekv.c:1133] read key:gw_di isFuzzy:0 skipCnt:0 [01-01 00:00:01 ty D][1e80][simplekv.c:1164] find key:3 gw_di [01-01 00:00:01 ty D][1e80][simplekv.c:1190] key:gw_di find value.Len:672 [01-01 00:00:01 ty D][1e80][ws_db_gw.c:376] gw_di read ret:0 [01-01 00:00:01 ty D][1e80][simplekv.c:1133] read key:is_stride isFuzzy:0 skipCnt:0 [01-01 00:00:01 ty D][1e80][simplekv.c:1161] no key find [01-01 00:00:01 ty D][1e80][simplekv.c:1203] __read_kv_raw fail. -3 [01-01 00:00:01 ty D][1e80][simplekv.c:1242] __read_kv_with_decode fail. -3 [01-01 00:00:01 ty D][1e80][tuya_devos_stride.c:55] stride from flash: 0. [01-01 00:00:01 ty D][1e80][tuya_devos_stride.c:62] no actived, no upgrade:0 [01-01 00:00:01 ty N][1e80][tuya_svc_devos.c:395] gw_cntl->gw_if.abi:0 input:0 [01-01 00:00:01 ty N][1e80][tuya_svc_devos.c:396] gw_cntl->gw_if.product_key:jtpzscc43s2fzaff, input:jtpzscc43s2fzaff [01-01 00:00:01 ty N][1e80][tuya_svc_devos.c:397] gw_cntl->gw_if.tp:0, input:0 [01-01 00:00:01 ty N][1e80][tuya_svc_devos.c:596] enter success_proc WIFI Get MAC 00-00-00-00-00-00 [01-01 00:00:01 ty N][1e80][tuya_svc_devos.c:599] serial_no:000000000000 [01-01 00:00:01 ty D][1e80][tuya_svc_upgrade.c:1369] tuya svc upgrade init success! [01-01 00:00:01 ty D][1e80][simplekv.c:1133] read key:kv.meta.report isFuzzy:0 skipCnt:0 [01-01 00:00:01 ty D][1e80][simplekv.c:1161] no key find [01-01 00:00:01 ty D][1e80][simplekv.c:1203] __read_kv_raw fail. -3 [01-01 00:00:01 ty D][1e80][simplekv.c:1242] __read_kv_with_decode fail. -3 [01-01 00:00:01 ty D][1e80][ty_meta_report.c:111] meta in kv {"metas":{}} [01-01 00:00:01 ty D][1e80][mqc_app.c:109] mq_pro:300 cnt:3 [01-01 00:00:01 ty D][1e80][mqc_app.c:109] mq_pro:302 cnt:4 [01-01 00:00:01 ty D][1e80][mqc_app.c:109] mq_pro:304 cnt:5 [01-01 00:00:01 ty D][1e80][mqc_app.c:109] mq_pro:307 cnt:6 [01-01 00:00:01 ty D][1e80][mqc_app.c:109] mq_pro:308 cnt:7 [01-01 00:00:01 ty D][1e80][mqc_app.c:109] mq_pro:312 cnt:8 [01-01 00:00:01 ty D][1e80][tuya_ipc_mqtt_subscribe.c:292] iot_register_extra_mqt_cb done [01-01 00:00:01 ty T][1e80][tuya_ring_buffer.c:127] ch0st0tr0 get ref count: 1 [01-01 00:00:01 ty T][1e80][tuya_ring_buffer.c:148] ch0st0tr0 release ref count: 0 [01-01 00:00:01 ty T][1e80][tuya_ring_buffer.c:127] ch0st0tr1 get ref count: 1 [01-01 00:00:01 ty T][1e80][tuya_ring_buffer.c:148] ch0st0tr1 release ref count: 0 [01-01 00:00:01 ty D][1e80][tuya_ipc_hardware_info.c:252] traversal over [01-01 00:00:01 ty E][1e80][tuya_ipc_hardware_info.c:173] NO sensor info. Please check if you need. [01-01 00:00:01 ty D][1e80][tuya_ipc_hardware_info.c:115] not found device wifi info [01-01 00:00:01 ty D][1e80][tuya_ipc_hardware_info.c:355] hard info ="skillParam":"{\"type\":4,\"skill\":{\"localStorage\":1,\"cloudStorage\":1,\"webrtc\":2,\"p2p\":611,\"security_ability\":30,\"video_num\":2,\"sdk_version\":\"6.2.6\"},\"hardware\":{\"toolchain\":\"T32_uclibc_r3.3.7\",\"cpu\":{\"model\":\"Goat\",\"bogomips\":\"1196.85\",\"name\":\"Ingenic Xburst V0.0 FPU V0.0\"}} [01-01 00:00:01 ty D][1e80][tuya_ipc_sdk_init.c:426] debug ability:2 [01-01 00:00:01 ty D][1e80][tuya_iot_wifi_api.c:452] register wifi network monitor. interval:1 [01-01 00:00:01 ty D][1e80][platform_ty.c:1549] tuya ipc sdk start is complete [01-01 00:00:01 ty D][ee84][tuya_svc_devos.c:854] state change from 0 to 1 [01-01 00:00:01 ty D][ee84][ty_sdk_status_callback.c:103] status chaged: group[1] status[9] [01-01 00:00:01 ty D][ee84][ty_sdk_status_callback.c:39] __on_netcfg_start, netcfg start. You can start your own netcfg task now. [01-01 00:00:01 ty D][ee84][simplekv.c:1133] read key:wf_start_md isFuzzy:0 skipCnt:0 [01-01 00:00:01 ty D][ee84][simplekv.c:1161] no key find [01-01 00:00:01 ty D][ee84][simplekv.c:1203] __read_kv_raw fail. -3 [01-01 00:00:01 ty D][ee84][simplekv.c:1242] __read_kv_with_decode fail. -3 [01-01 00:00:01 ty E][ee84][tuya_wifi_reset.c:675] read wf start mode err:-6 [01-01 00:00:01 ty D][ee84][tuya_wifi_reset.c:712] <__gw_upd_nc_type> wf start mode change:-6, 0->0 [01-01 00:00:01 ty D][ee84][simplekv.c:1133] read key:kv.ccode.avtive isFuzzy:0 skipCnt:0 [01-01 00:00:01 ty D][ee84][simplekv.c:[ 26.477778] [atbm_log]:ioctl:cmd[SIOCGIWNWID][0x8b03] not support 1161] no key find [01-01 00:00:01 ty D][ee84][simplekv.c:1203] __read_kv_raw fail. -3 [01-01 00:00:01 ty D][ee84][simplekv.c:1242] __read_kv_with_decode fail. -3 Set Country Code:0 Exec Cmd:ifconfig wlan0 up Exec Cmd:iwconfig wlan0 mode Managed WIFI Set Mode 2 [01-01 00:00:01 ty D][ee84][tuya_wifi_reset.c:596] reset init mthd:0, short timer:0 long timer:0 [ 26.542182] [atbm_log]:ioctl:cmd[SIOCGIWNICKN][0x8b1d] not support [ 26.579837] [atbm_log]:ioctl:cmd[SIOCGIWSENS][0x8b09] not support WIFI Get Mode [Managed] 2 [01-01 00:00:01 ty D][ee84][tuya_wifi_netcfg.c:437] do proxy actived work,mode:2,stat:0,nc_tp:2 [01-01 00:00:01 ty D][ee84][tuya_wifi_netcfg.c:734] nc_tp:2, md:0 Exec Cmd:ifconfig wlan0 up Exec Cmd:iwconfig wlan0 mode Managed WIFI Set Mode 2 [01-01 00:00:01 ty D][ee84][netcfg_module.c:133] type:0x10002,is_set:0 [01-01 00:00:01 ty D][ee84][netcfg_module.c:133] type:0x10100,is_set:0 [01-01 00:00:01 ty D][ee84][netcfg_module.c:133] type:0x10002,is_set:1 [ 26.762603] [atbm_log]:ioctl:cmd[SIOCGIWNWID][0x8b03] not support [ 26.817524] [atbm_log]:ioctl:cmd[SIOCGIWNICKN][0x8b1d] not support [ 26.854674] [atbm_log]:ioctl:cmd[SIOCGIWSENS][0x8b09] not support WIFI Get Mode [Managed] 2 [01-01 00:00:02 ty D][ee84][tuya_wifi_link.c:140] get work mode:2 [01-01 00:00:02 ty D][ee84][tuya_wifi_link.c:147] start ap netcfg, wk_md:3 Exec Cmd:ifconfig wlan0 up WIFI Set Mode 3 [01-01 00:00:02 ty E][ee84][tuya_wifi_link.c:151] wf_wk_mode_set error:-1 [01-01 00:00:02 ty E][ee84][netcfg_module.c:136] ret:-1 [01-01 00:00:02 ty D][ee84][netcfg_module.c:133] type:0x10002,is_set:0 [01-01 00:00:02 ty D][ee84][netcfg_module.c:133] type:0x10100,is_set:0 [01-01 00:00:02 ty D][ee84][netcfg_module.c:133] type:0x10002,is_set:0 [01-01 00:00:02 ty D][ee84][netcfg_module.c:133] type:0x10100,is_set:0 [ 26.992619] [atbm_log]:ioctl:cmd[SIOCGIWNWID][0x8b03] not support [ 27.047469] [atbm_log]:ioctl:cmd[SIOCGIWNICKN][0x8b1d] not support [ 27.086139] [atbm_log]:ioctl:cmd[SIOCGIWSENS][0x8b09] not support WIFI Get Mode [Managed] 2 [01-01 00:00:02 ty N][ee84][tuya_wifi_status.c:167] cur stat:2 0x4c3644 -->> [01-01 00:00:02 ty N][ee84][tuya_wifi_status.c:169] wifi netstat changed to:2 -->> [01-01 00:00:02 ty N][ee84][tuya_wifi_status.c:173] report wifi netstat[2] to callback -->> [01-01 00:00:02 ty E][ee84][tuya_ipc_sdk_init.c:345] wf nw status changed to [2], but not notify [01-01 00:00:02 ty D][ee84][netcfg_module.c:338] netcfg module start type:0x10100 [01-01 00:00:02 ty N][ee84][tuya_wifi_reset.c:438] timer stated, short timer:0x0, long timer:0x0 [01-01 00:00:02 ty D][ee84][tuya_wifi_netcfg.c:815] nc_tp:2, md:0 [01-01 00:00:02 ty N][ee84][tuya_bt_link.c:62] bt startup attr:ff [01-01 00:00:02 ty D][ee84][tuya_bt_link.c:77] bt link open [01-01 00:00:02 ty N][ee84][tuya_ble_svc.c:1199] upd product_id type:0 jtpzscc43s2fzaff [01-01 00:00:02 ty D][ee84][simplekv.c:1133] read key:bt_encrpt_v2 isFuzzy:0 skipCnt:0 [01-01 00:00:02 ty D][ee84][simplekv.c:1161] no key find [01-01 00:00:02 ty D][ee84][simplekv.c:1203] __read_kv_raw fail. -3 [01-01 00:00:02 ty D][ee84][simplekv.c:1242] __read_kv_with_decode fail. -3 [01-01 00:00:02 ty D][ee84][tuya_ble_cryption.c:491] read encrpt flag from flash: 0. ==================tkl_ble_gap_callback_register================= ==================tkl_ble_gatt_callback_register================= ==================tkl_ble_stack_init================= [01-01 00:00:02 ty D][ee84][tuya_ble_svc.c:1115] rev ble event 1 [01-01 00:00:02 ty D][ee84][tuya_ble_svc.c:1768] set ble serv stat:0, curr:0 [tkl_ble_stack_init:1537] role:3 ==================tkl_ble_gatts_service_add================= [tkl_ble_gatts_service_add:2041] p_service->svc_num:0x1 [tkl_ble_gatts_service_add:2042] p_service->p_service->handle:0xffff [tkl_ble_gatts_service_add:2043] p_service->p_service->svc_uuid:0 [tkl_ble_gatts_service_add:2044] p_service->p_service->type:0x2800 [tkl_ble_gatts_service_add:2045] p_service->p_service->char_num:0x3 register gatt service, num: 1 [tkl_ble_gatts_service_add:2055] i=0, p_service_param->svc_uuid.uuid_type:0 [tkl_ble_gatts_service_add:2056] i=0, p_service_param->handle:0xffff [tkl_ble_gatts_service_add:2057] i=0, p_service_param->type:0x2800 [tkl_ble_gatts_service_add:2058] i=0, p_service_param->svc_uuid.uuid.uuid16:0xfd50 [tkl_ble_gatts_service_add:2059] i=0, p_service_param->char_num:0x3 [tkl_ble_gatts_service_add:2061] i=0, p_service_param->p_char[0].char_uuid.uuid_type:0x2 [tkl_ble_gatts_service_add:2062] i=0, p_service_param->p_char[0].char_uuid.uuid128:0xb942d0 [tkl_ble_gatts_service_add:2063] i=0, p_service_param->p_char[0].handle:0xffff [tkl_ble_gatts_service_add:2064] i=0, p_service_param->p_char[0].permission:0x6 [tkl_ble_gatts_service_add:2065] i=0, p_service_param->p_char[0].property:0xc [tkl_ble_gatts_service_add:2066] i=0, p_service_param->p_char[0].value_len:0xf4 [tkl_ble_gatts_service_add:2061] i=0, p_service_param->p_char[1].char_uuid.uuid_type:0x2 [tkl_ble_gatts_service_add:2062] i=0, p_service_param->p_char[1].char_uuid.uuid128:0xb942ec [tkl_ble_gatts_service_add:2063] i=0, p_service_param->p_char[1].handle:0xffff [tkl_ble_gatts_service_add:2064] i=0, p_service_param->p_char[1].permission:0x6 [tkl_ble_gatts_service_add:2065] i=0, p_service_param->p_char[1].property:0x10 [tkl_ble_gatts_service_add:2066] i=0, p_service_param->p_char[1].value_len:0xf4 [tkl_ble_gatts_service_add:2061] i=0, p_service_param->p_char[2].char_uuid.uuid_type:0x2 [tkl_ble_gatts_service_add:2062] i=0, p_service_param->p_char[2].char_uuid.uuid128:0xb94308 [tkl_ble_gatts_service_add:2063] i=0, p_service_param->p_char[2].handle:0xffff [tkl_ble_gatts_service_add:2064] i=0, p_service_param->p_char[2].permission:0x2 [tkl_ble_gatts_service_add:2065] i=0, p_service_param->p_char[2].property:0x2 [tkl_ble_gatts_service_add:2066] i=0, p_service_param->p_char[2].value_len:0xf4 [tkl_ble_gatts_service_add:2085] i=0, p_service_param->type:0x2800 --- tuya_conn_handle :fd50 str_uuid_buf:00000001-0000-1001-8001-00805f9b07d0 p_service_param->p_char[0].handle:1 str_uuid_buf:00000002-0000-1001-8001-00805f9b07d0 p_service_param->p_char[1].handle:2 str_[ 27.486962] [atbm_log]:ioctl_open(80cbf100)(81b19700) uuid_buf:00000003-0000-1001-8001-00805f9b07d0 p_service_param->p_char[2].handle:3 [01-01 00:00:02 ty D][ee84][tuya_ble_svc.c:1626] start ble monitor [01-01 00:00:02 ty N][ee84][tuya_ble_svc.c:1294] ty bt sdk init success finish [01-01 00:00:02 ty D][ee84][tuya_ble_netcfg.c:153] net_cfg sub session created [01-01 00:00:02 ty D][ee84][tuya_ble_svc.c:2298] get_wifi_list sub [ 27.525566] [atbm_log]:atbm_ioctl_ble_start session created [01-01 00:00:02 ty D][ee84][tuya_ble_svc.c:2302] get_netcfg_stat sub session created [01-01 00:00:02 ty D][ee84][tuya_ble_svc.c:2306] get_dev_log sub session created [01-01 00:00:02 ty D][ee84][tuya_ble_svc.c:2310] get_ap_name sub session created ==================tkl_ble_gap_adv_start================= lib_ble_main_init ======>>atbm_ble_start>>> nimble_port_init++ os_mempool_module_init msys block_count:20 ble_npl_eventq_main acl block_count:40 nimble_host_task FD_CLOEXEC set ble_coexist_start-- ble_hs_sync:333 hif_ioctl_loop get_command_func ble_hs_hci_cmd_tx:352 ===========ble_hci_sync_ok ble_smart_cfg_startup!11 [ATBM lOG]set default tx power(0) [01-01 00:00:02 ty N][ee84][tuya_svc_devos.c:246] __devos_init_evt success [01-01 00:00:02 ty D][ee84][netcfg_module.c:116] start 0x10100 ret:0 [01-01 00:00:02 ty D][ee84][netcfg_module.c:338] netcfg module start type:0x10002 [01-01 00:00:02 ty D][ee84][tuya_ble_svc.c:244] upd adv para, send conn_req beacon. [01-01 00:00:02 ty D][ee84][tuya_ble_svc.c:115] adv_data 31 <0x12329e1> 02 01 06 03 02 50 fd 17 16 50 fd 43 04 00 10 6a 74 70 7a 73 63 63 34 33 73 32 66 7a 61 66 66 [01-01 00:00:02 ty D][ee84][tuya_ble_svc.c:115] rsp_data 31 <0x1232a01> 17 ff d0 07 00 00 04 21 e1 0f 16 2d 0b b3 ba 65 28 ce 77 19 9c 09 5f eb 06 09 54 55 59 41 5f [01-01 00:00:02 ty D][ee84][tuya_ble_svc.c:1665] ble get conn stat:4 ==================tkl_ble_gap_adv_stop================= ==================tkl_ble_gap_adv_rsp_data_set================= [tkl_ble_gap_adv_rsp_data_set:1773] 0x2 0x1 0x6 0x3 0x2 0x50 0xfd 0x17 0x16 0x50 0xfd 0x43 0x4 0 0x10 0x6a 0x74 0x70 0x7a 0x73 0x63 0x63 0x34 0x33 0x73 0x32 0x66 0x7a 0x61 0x66 0x66 ==================tkl_ble_gap_adv_start================= error lib_ble_main_init already! [01-01 00:00:02 ty N][ee84][tuya_ble_svc.c:1381] ble adv updated [01-01 00:00:02 ty D][ee84][ap_netcfg.c:1464] ap cfg start:65538 [01-01 00:00:02 ty E][ee84][ap_netcfg.c:1338] get ip fail:-1 [01-01 00:00:02 ty E][ee84][ap_netcfg.c:1469] ap_nw_cfg_start err:-6 [01-01 00:00:02 ty D][ee84][netcfg_module.c:116] start 0x10002 ret:-6 pub addr 60:56:ee:16:81:03 Ingenic-uc1_1 login: Ingenic-uc1_1 login: Ingenic-uc1_1 login: Ingenic-uc1_1 login: Ingenic-uc1_1 login: [2021-08-07 23:15:30:419] tag[INFO] module[PROMPT_TONE] func[_prompt_tone_thread] line[364] _prompt_tone_thread exit [2021-08-07 23:15:37:500] tag[DEBG] module[COMPORT_SWAP] func[comport_send] line[21] send command length(8), max length(196) ............ [2021-08-07 23:15:37:500] tag[DEBG] module[COMPORT_SWAP] func[comport_send] line[68] serial message is send success 55aa030000010104 [2021-08-07 23:15:37:538] tag[INFO] module[COMPORT_SWAP] func[comport_recv] line[133] reading serial response length(128),receive len(8) success! [2021-08-07 23:15:37:538] tag[INFO] module[MCU_UART] func[dispatch_message] line[915] dispatch message. [2021-08-07 23:15:37:539] tag[INFO] module[MCU_UART] func[process_message] line[821] msg cmd:0x00, len:1 [2021-08-07 23:15:37:539] tag[INFO] module[MCU_UART] func[process_message] line[839] Heart Beat Rsp... root Aug 7 23:15:40 login[71]: root login on 'console' [root@Ingenic-uc1_1:~]# [2021-08-07 23:15:52:500] tag[DEBG] module[COMPORT_SWAP] func[comport_send] line[21] send command length(8), max length(196) ............ [2021-08-07 23:15:52:500] tag[DEBG] module[COMPORT_SWAP] func[comport_send] line[68] serial message is send success 55aa030000010104 [2021-08-07 23:15:52:538] tag[INFO] module[COMPORT_SWAP] func[comport_recv] line[133] reading serial response length(128),receive len(8) success! [2021-08-07 23:15:52:538] tag[INFO] module[MCU_UART] func[dispatch_message] line[915] dispatch message. [2021-08-07 23:15:52:538] tag[INFO] module[MCU_UART] func[process_message] line[821] msg cmd:0x00, len:1 [2021-08-07 23:15:52:538] tag[INFO] module[MCU_UART] func[process_message] line[839] Heart Beat Rsp... [2021-08-07 23:16:07:501] tag[DEBG] module[COMPORT_SWAP] func[comport_send] line[21] send command length(8), max length(196) ............ [2021-08-07 23:16:07:501] tag[DEBG] module[COMPORT_SWAP] func[comport_send] line[68] serial message is send success 55aa030000010104 [2021-08-07 23:16:07:538] tag[INFO] module[COMPORT_SWAP] func[comport_recv] line[133] reading serial response length(128),receive len(8) success! [2021-08-07 23:16:07:538] tag[INFO] module[MCU_UART] func[dispatch_message] line[915] dispatch message. [2021-08-07 23:16:07:538] tag[INFO] module[MCU_UART] func[process_message] line[821] msg cmd:0x00, len:1 [2021-08-07 23:16:07:538] tag[INFO] module[MCU_UART] func[process_message] line[839] Heart Beat Rsp... ble_slave_gap_event->type=0 connection established; status=0 connection, handle=1 [ble_gap_event:107]send event type:4 (TKL_BLE_GAP_EVT_CONNECT) [ble_gap_event:108]gap_evt.conn_handle :64848 gf:TAL_BLE_EVT_PERIPHERAL_CONNECT, result :0 [01-01 00:00:47 ty D][e574][tuya_ble_svc.c:1115] rev ble event 4 [01-01 00:00:47 ty N][e574][tuya_ble_svc.c:746] Ble Connected [01-01 00:00:47 ty N][e574][tuya_ble_data_handler.c:69] ble reset sn [01-01 00:00:47 ty N][e574][tuya_ble_svc.c:1659] ble set conn stat:1 [01-01 00:00:47 ty D][e574][tuya_ble_svc.c:1152] conn monitor timer started ble_slave_gap_event->type=15 mtu update event; conn_handle=1 cid=4 mtu=247 ble_slave_gap_event->type=4 connection update request [ble_gap_event:147]send event type:8 (TKL_BLE_GAP_EVT_CONN_PARAM_REQ) [ble_gap_event:148]gap_evt.conn_handle :28420 ble_slave_gap_event->type=3 connection updated; status=0 conn_itvl=6 conn_latency=3 supervision_timeout=500 encrypted=0 authenticated=0 bonded=0 [ble_gap_event:131]send event type:9 (TKL_BLE_GAP_EVT_CONN_PARAM_UPDATE) [ble_gap_event:132]gap_evt.conn_handle :1 ble_slave_gap_event->type=4 connection update request [ble_gap_event:147]send event type:8 (TKL_BLE_GAP_EVT_CONN_PARAM_REQ) [ble_gap_event:148]gap_evt.conn_handle :28420 ble_slave_gap_event->type=3 connection updated; status=0 conn_itvl=24 conn_latency=3 supervision_timeout=500 encrypted=0 authenticated=0 bonded=0 [ble_gap_event:131]send event type:9 (TKL_BLE_GAP_EVT_CONN_PARAM_UPDATE) [ble_gap_event:132]gap_evt.conn_handle :1 [2021-08-07 23:16:22:501] tag[DEBG] module[COMPORT_SWAP] func[comport_send] line[21] send command length(8), max length(196) ............ [2021-08-07 23:16:22:502] tag[DEBG] module[COMPORT_SWAP] func[comport_send] line[68] serial message is send success 55aa030000010104 [2021-08-07 23:16:22:538] tag[INFO] module[COMPORT_SWAP] func[comport_recv] line[133] reading serial response length(128),receive len(8) success! [2021-08-07 23:16:22:538] tag[INFO] module[MCU_UART] func[dispatch_message] line[915] dispatch message. [2021-08-07 23:16:22:538] tag[INFO] module[MCU_UART] func[process_message] line[821] msg cmd:0x00, len:1 [2021-08-07 23:16:22:538] tag[INFO] module[MCU_UART] func[process_message] line[839] Heart Beat Rsp... WIFI mode[0] Get IP failed [ble_svc_gatt_access:224] ble_uuid_u16(ctxt->chr->uuid) >> uuid:0 [ble_svc_gatt_access:225] ctxt->chr->flags:0xc max_data_len=1024 Len=20 att=0x0 0x1 0x2 0x3 0x4 0x5 0x6 0x7 0x8 0x9 0x0 0x1 0x2 0x3 0x4 0x5 0x6 0x7 0x8 0x9 [ble_svc_gatt_access:259]send gatt event type:7 (TKL_BLE_GATT_EVT_WRITE_REQ) [ble_svc_gatt_access:260]event.gatt_event.write_report.char_handle :1 gf:p_event->ble_event.write_report.peer.char_handle[0] = 1 gf:ble_peripheral_info.char_handle[TAL_COMMON_WRITE_CHAR_INDEX] = 1 [01-01 00:00:59 ty D][e574][tuya_ble_svc.c:1115] rev ble event 14 [01-01 00:00:59 ty D][e574][tuya_ble_svc.c:1076] Dev Rev BT Package [01-01 00:00:59 ty D][e574][tuya_ble_svc.c:115] bt_rev_raw 20 <0x62e56868> 00 01 02 03 04 05 06 07 08 09 00 01 02 03 04 05 06 07 08 09 [01-01 00:00:59 ty D][e574][tuya_ble_data_handler.c:142] recive sub_pkg desc:3, no:1, pack_len:1, total_len:1 [01-01 00:00:59 ty E][e574][tuya_ble_data_handler.c:672] ty_ble_rx_proc version not compatibility! [2021-08-07 23:16:37:502] tag[DEBG] module[COMPORT_SWAP] func[comport_send] line[21] send command length(8), max length(196) ............ [2021-08-07 23:16:37:502] tag[DEBG] module[COMPORT_SWAP] func[comport_send] line[68] serial message is send success 55aa030000010104 [2021-08-07 23:16:37:538] tag[INFO] module[COMPORT_SWAP] func[comport_recv] line[133] reading serial response length(128),receive len(8) success! [2021-08-07 23:16:37:538] tag[INFO] module[MCU_UART] func[dispatch_message] line[915] dispatch message. [2021-08-07 23:16:37:538] tag[INFO] module[MCU_UART] func[process_message] line[821] msg cmd:0x00, len:1 [2021-08-07 23:16:37:538] tag[INFO] module[MCU_UART] func[process_message] line[839] Heart Beat Rsp... [01-01 00:01:17 ty D][ee84][tuya_ble_svc.c:1145] device no permit to connect, disconect!! ==================tkl_ble_gap_disconnect================= [2021-08-07 23:16:52:502] tag[DEBG] module[COMPORT_SWAP] func[comport_send] line[21] send command length(8), max length(196) ............ [2021-08-07 23:16:52:503] tag[DEBG] module[COMPORT_SWAP] func[comport_send] line[68] serial message is send success 55aa030000010104 [2021-08-07 23:16:52:540] tag[INFO] module[COMPORT_SWAP] func[comport_recv] line[133] reading serial response length(128),receive len(8) success! [2021-08-07 23:16:52:540] tag[INFO] module[MCU_UART] func[dispatch_message] line[915] dispatch message. [2021-08-07 23:16:52:540] tag[INFO] module[MCU_UART] func[process_message] line[821] msg cmd:0x00, len:1 [2021-08-07 23:16:52:540] tag[INFO] module[MCU_UART] func[process_message] line[839] Heart Beat Rsp... ble_slave_gap_event->type=1 disconnect; reason=0x213 [ble_gap_event:119]send event type:5 (TKL_BLE_GAP_EVT_DISCONNECT) [ble_gap_event:120]gap_evt.conn_handle :64848 [01-01 00:01:31 ty D][e574][tuya_ble_svc.c:1115] rev ble event 6 [01-01 00:01:31 ty N][e574][tuya_ble_svc.c:774] Ble Disonnected [01-01 00:01:31 ty N][e574][tuya_ble_data_handler.c:69] ble reset sn [01-01 00:01:31 ty N][e574][tuya_ble_data_handler.c:83] ble clear pair rand [01-01 00:01:31 ty N][e574][tuya_ble_svc.c:1659] ble set conn stat:0 [ble_gap_event:119]send event type:5 (TKL_BLE_GAP_EVT_DISCONNECT) [ble_gap_event:120]gap_evt.conn_handle :64848 [01-01 00:01:31 ty D][e574][tuya_ble_svc.c:1115] rev ble event 6 [01-01 00:01:31 ty N][e574][tuya_ble_svc.c:774] Ble Disonnected [01-01 00:01:31 ty N][e574][tuya_ble_data_handler.c:69] ble reset sn [01-01 00:01:31 ty N][e574][tuya_ble_data_handler.c:83] ble clear pair rand [01-01 00:01:31 ty N][e574][tuya_ble_svc.c:1659] ble set conn stat:0 [01-01 00:01:31 ty D][ee84][tuya_ble_svc.c:244] upd adv para, send conn_req beacon. [01-01 00:01:31 ty D][ee84][tuya_ble_svc.c:115] adv_data 31 <0x12329e1> 02 01 06 03 02 50 fd 17 16 50 fd 43 04 00 10 6a 74 70 7a 73 63 63 34 33 73 32 66 7a 61 66 66 [01-01 00:01:31 ty D][ee84][tuya_ble_svc.c:115] rsp_data 31 <0x1232a01> 17 ff d0 07 00 00 04 21 e1 0f 16 2d 0b b3 ba 65 28 ce 77 19 9c 09 5f eb 06 09 54 55 59 41 5f [01-01 00:01:31 ty D][ee84][tuya_ble_svc.c:1665] ble get conn stat:0 ==================tkl_ble_gap_adv_stop================= ==================tkl_ble_gap_adv_rsp_data_set================= [tkl_ble_gap_adv_rsp_data_set:1773] 0x2 0x1 0x6 0x3 0x2 0x50 0xfd 0x17 0x16 0x50 0xfd 0x43 0x4 0 0x10 0x6a 0x74 0x70 0x7a 0x73 0x63 0x63 0x34 0x33 0x73 0x32 0x66 0x7a 0x61 0x66 0x66 ==================tkl_ble_gap_adv_start================= error lib_ble_main_init already! [01-01 00:01:31 ty N][ee84][tuya_ble_svc.c:1381] ble adv updated [01-01 00:01:31 ty D][ee84][tuya_ble_svc.c:244] upd adv para, send conn_req beacon. [01-01 00:01:31 ty D][ee84][tuya_ble_svc.c:115] adv_data 31 <0x12329e1> 02 01 06 03 02 50 fd 17 16 50 fd 43 04 00 10 6a 74 70 7a 73 63 63 34 33 73 32 66 7a 61 66 66 [01-01 00:01:31 ty D][ee84][tuya_ble_svc.c:115] rsp_data 31 <0x1232a01> 17 ff d0 07 00 00 04 21 e1 0f 16 2d 0b b3 ba 65 28 ce 77 19 9c 09 5f eb 06 09 54 55 59 41 5f [01-01 00:01:31 ty D][ee84][tuya_ble_svc.c:1665] ble get conn stat:0 ==================tkl_ble_gap_adv_stop================= ==================tkl_ble_gap_adv_rsp_data_set================= [tkl_ble_gap_adv_rsp_data_set:1773] 0x2 0x1 0x6 0x3 0x2 0x50 0xfd 0x17 0x16 0x50 0xfd 0x43 0x4 0 0x10 0x6a 0x74 0x70 0x7a 0x73 0x63 0x63 0x34 0x33 0x73 0x32 0x66 0x7a 0x61 0x66 0x66 ==================tkl_ble_gap_adv_start================= error lib_ble_main_init already! [01-01 00:01:31 ty N][ee84][tuya_ble_svc.c:1381] ble adv updated ble_slave_gap_event->type=0 connection established; status=0 connection, handle=1 [ble_gap_event:107]send event type:4 (TKL_BLE_GAP_EVT_CONNECT) [ble_gap_event:108]gap_evt.conn_handle :64848 gf:TAL_BLE_EVT_PERIPHERAL_CONNECT, result :0 [01-01 00:01:36 ty D][e574][tuya_ble_svc.c:1115] rev ble event 4 [01-01 00:01:36 ty N][e574][tuya_ble_svc.c:746] Ble Connected [01-01 00:01:36 ty N][e574][tuya_ble_data_handler.c:69] ble reset sn [01-01 00:01:36 ty N][e574][tuya_ble_svc.c:1659] ble set conn stat:1 [01-01 00:01:36 ty D][e574][tuya_ble_svc.c:1152] conn monitor timer started ble_slave_gap_event->type=15 mtu update event; conn_handle=1 cid=4 mtu=247 ble_slave_gap_event->type=4 connection update request [ble_gap_event:147]send event type:8 (TKL_BLE_GAP_EVT_CONN_PARAM_REQ) [ble_gap_event:148]gap_evt.conn_handle :28420 ble_slave_gap_event->type=3 connection updated; status=0 conn_itvl=6 conn_latency=3 supervision_timeout=500 encrypted=0 authenticated=0 bonded=0 [ble_gap_event:131]send event type:9 (TKL_BLE_GAP_EVT_CONN_PARAM_UPDATE) [ble_gap_event:132]gap_evt.conn_handle :1 ble_slave_gap_event->type=4 connection update request [ble_gap_event:147]send event type:8 (TKL_BLE_GAP_EVT_CONN_PARAM_REQ) [ble_gap_event:148]gap_evt.conn_handle :28420 ble_slave_gap_event->type=3 connection updated; status=0 conn_itvl=24 conn_latency=3 supervision_timeout=500 encrypted=0 authenticated=0 bonded=0 [ble_gap_event:131]send event type:9 (TKL_BLE_GAP_EVT_CONN_PARAM_UPDATE) [ble_gap_event:132]gap_evt.conn_handle :1 [ble_svc_gatt_access:224] ble_uuid_u16(ctxt->chr->uuid) >> uuid:0 [ble_svc_gatt_access:225] ctxt->chr->flags:0xc max_data_len=1024 Len=20 att=0x0 0x1 0x2 0x3 0x4 0x5 0x6 0x7 0x8 0x9 0x0 0x1 0x2 0x3 0x4 0x5 0x6 0x7 0x8 0x9 [ble_svc_gatt_access:259]send gatt event type:7 (TKL_BLE_GATT_EVT_WRITE_REQ) [ble_svc_gatt_access:260]event.gatt_event.write_report.char_handle :1 gf:p_event->ble_event.write_report.peer.char_handle[0] = 1 gf:ble_peripheral_info.char_handle[TAL_COMMON_WRITE_CHAR_INDEX] = 1 [01-01 00:01:42 ty D][e574][tuya_ble_svc.c:1115] rev ble event 14 [01-01 00:01:42 ty D][e574][tuya_ble_svc.c:1076] Dev Rev BT Package [01-01 00:01:42 ty D][e574][tuya_ble_svc.c:115] bt_rev_raw 20 <0x62e56868> 00 01 02 03 04 05 06 07 08 09 00 01 02 03 04 05 06 07 08 09 [01-01 00:01:42 ty D][e574][tuya_ble_data_handler.c:142] recive sub_pkg desc:3, no:1, pack_len:1, total_len:1 [01-01 00:01:42 ty E][e574][tuya_ble_data_handler.c:672] ty_ble_rx_proc version not compatibility! [2021-08-07 23:17:07:503] tag[DEBG] module[COMPORT_SWAP] func[comport_send] line[21] send command length(8), max length(196) ............ [2021-08-07 23:17:07:503] tag[DEBG] module[COMPORT_SWAP] func[comport_send] line[68] serial message is send success 55aa030000010104 [2021-08-07 23:17:07:537] tag[INFO] module[COMPORT_SWAP] func[comport_recv] line[133] reading serial response length(128),receive len(8) success! [2021-08-07 23:17:07:538] tag[INFO] module[MCU_UART] func[dispatch_message] line[915] dispatch message. [2021-08-07 23:17:07:538] tag[INFO] module[MCU_UART] func[process_message] line[821] msg cmd:0x00, len:1 [2021-08-07 23:17:07:538] tag[INFO] module[MCU_UART] func[process_message] line[839] Heart Beat Rsp... [2021-08-07 23:17:22:503] tag[DEBG] module[COMPORT_SWAP] func[comport_send] line[21] send command length(8), max length(196) ............ [2021-08-07 23:17:22:503] tag[DEBG] module[COMPORT_SWAP] func[comport_send] line[68] serial message is send success 55aa030000010104 [2021-08-07 23:17:22:537] tag[INFO] module[COMPORT_SWAP] func[comport_recv] line[133] reading serial response length(128),receive len(8) success! [2021-08-07 23:17:22:538] tag[INFO] module[MCU_UART] func[dispatch_message] line[915] dispatch message. [2021-08-07 23:17:22:538] tag[INFO] module[MCU_UART] func[process_message] line[821] msg cmd:0x00, len:1 [2021-08-07 23:17:22:538] tag[INFO] module[MCU_UART] func[process_message] line[839] Heart Beat Rsp... WIFI mode[0] Get IP failed [01-01 00:02:00 ty D][6e84][simplekv.c:129] <__tmm_backup_work> backup file start...time: 133, MsTime: 206 [01-01 00:02:00 ty D][6e84][simplekv.c:241] backup normal file to bak success [01-01 00:02:00 ty D][6e84][simplekv.c:132] <__tmm_backup_work> backup file end...time: 133, MsTime: 255 [01-01 00:02:06 ty D][ee84][tuya_ble_svc.c:1145] device no permit to connect, disconect!! ==================tkl_ble_gap_disconnect================= [2021-08-07 23:17:37:504] tag[DEBG] module[COMPORT_SWAP] func[comport_send] line[21] send command length(8), max length(196) ............ [2021-08-07 23:17:37:504] tag[DEBG] module[COMPORT_SWAP] func[comport_send] line[68] serial message is send success 55aa030000010104 [2021-08-07 23:17:37:537] tag[INFO] module[COMPORT_SWAP] func[comport_recv] line[133] reading serial response length(128),receive len(8) success! [2021-08-07 23:17:37:538] tag[INFO] module[MCU_UART] func[dispatch_message] line[915] dispatch message. [2021-08-07 23:17:37:538] tag[INFO] module[MCU_UART] func[process_message] line[821] msg cmd:0x00, len:1 [2021-08-07 23:17:37:538] tag[INFO] module[MCU_UART] func[process_message] line[839] Heart Beat Rsp... [2021-08-07 23:17:52:504] tag[DEBG] module[COMPORT_SWAP] func[comport_send] line[21] send command length(8), max length(196) ............ [2021-08-07 23:17:52:505] tag[DEBG] module[COMPORT_SWAP] func[comport_send] line[68] serial message is send success 55aa030000010104 [2021-08-07 23:17:52:537] tag[INFO] module[COMPORT_SWAP] func[comport_recv] line[133] reading serial response length(128),receive len(8) success! [2021-08-07 23:17:52:537] tag[INFO] module[MCU_UART] func[dispatch_message] line[915] dispatch message. [2021-08-07 23:17:52:537] tag[INFO] module[MCU_UART] func[process_message] line[821] msg cmd:0x00, len:1 [2021-08-07 23:17:52:538] tag[INFO] module[MCU_UART] func[process_message] line[839] Heart Beat Rsp...