
rst:0x1 (POWERON_RESET),boot:0x13 (SPI_FAST_FLASH_BOOT)
configsip: 0, SPIWP:0xee
clk_drv:0x00,q_drv:0x00,d_drv:0x00,cs0_drv:0x00,hd_drv:0x00,wp_drv:0x00
mode:DIO, clock div:2
load:0x3fff0030,len:6984
load:0x40078000,len:16144
load:0x40080400,len:3620
entry 0x40080618
I (27) boot: ESP-IDF v5.0.6-dirty 2nd stage bootloader
I (28) boot: compile time 08:19:23
W (28) boot: Unicore bootloader
I (31) boot: chip revision: v3.1
I (34) boot.esp32: SPI Speed      : 40MHz
I (39) boot.esp32: SPI Mode       : DIO
I (44) boot.esp32: SPI Flash Size : 4MB
I (48) boot: Enabling RNG early entropy source...
I (54) boot: Partition Table:
I (57) boot: ## Label            Usage          Type ST Offset   Length
I (65) boot:  0 phy_init         RF data          01 01 0000f000 00001000
I (72) boot:  1 otadata          OTA data         01 00 00010000 00002000
I (79) boot:  2 nvs              WiFi data        01 02 00012000 0000e000
I (87) boot:  3 at_customize     unknown          40 00 00020000 000e0000
I (94) boot:  4 ota_0            OTA app          00 10 00100000 00180000
I (102) boot:  5 ota_1            OTA app          00 11 00280000 00180000
I (109) boot: End of partition table
I (114) esp_image: segment 0: paddr=00100020 vaddr=3f400020 size=34560h (214368) map
I (200) esp_image: segment 1: paddr=00134588 vaddr=3ff80063 size=00008h (     8) load
I (200) esp_image: segment 2: paddr=00134598 vaddr=3ffb0000 size=032a4h ( 12964) load
I (211) esp_image: segment 3: paddr=00137844 vaddr=40080000 size=087d4h ( 34772) load
I (228) esp_image: segment 4: paddr=00140020 vaddr=400d0020 size=d9884h (891012) map
I (550) esp_image: segment 5: paddr=002198ac vaddr=400887d4 size=0ec2ch ( 60460) load
I (575) esp_image: segment 6: paddr=002284e0 vaddr=400c0000 size=00064h (   100) load
I (587) boot: Loaded app from partition at offset 0x100000
I (587) boot: Disabling RNG early entropy source...
I (599) cpu_start: Unicore app
I (599) cpu_start: Pro cpu up.
I (599) cpu_start: Single core mode
D (600) clk: waiting for 32k oscillator to start up
D (685) clk: waiting for 32k oscillator to start up
W (765) clk: 32 kHz XTAL not found, switching to internal 150 kHz oscillator
D (773) clk: RTC_SLOW_CLK calibration value: 2980582
I (779) cpu_start: Pro cpu start user code
I (779) cpu_start: cpu freq: 80000000 Hz
I (779) cpu_start: Application information:
I (783) cpu_start: Project name:     esp-at
I (788) cpu_start: App version:      v3.4.0.0-78-ga599a7e6
I (794) cpu_start: Compile time:     Nov  5 2024 08:19:01
I (801) cpu_start: ELF file SHA256:  74e4b2d9c3222218...
I (807) cpu_start: ESP-IDF:          v5.0.6-dirty
I (812) cpu_start: Min chip rev:     v0.0
I (817) cpu_start: Max chip rev:     v3.99
I (821) cpu_start: Chip rev:         v3.1
D (826) memory_layout: Checking 8 reserved memory ranges:
D (832) memory_layout: Reserved memory range 0x3ff80000 - 0x3ff80068
D (838) memory_layout: Reserved memory range 0x3ff82000 - 0x3ff82000
D (844) memory_layout: Reserved memory range 0x3ffae000 - 0x3ffae6e0
D (851) memory_layout: Reserved memory range 0x3ffb0000 - 0x3ffba8b0
D (857) memory_layout: Reserved memory range 0x3ffe0000 - 0x3ffe0440
D (864) memory_layout: Reserved memory range 0x40070000 - 0x40078000
D (870) memory_layout: Reserved memory range 0x40080000 - 0x40097400
D (877) memory_layout: Reserved memory range 0x50001fe8 - 0x50002000
D (883) memory_layout: Building list of available memory regions:
D (889) memory_layout: Available memory region 0x3ffae6e0 - 0x3ffb0000
D (896) memory_layout: Available memory region 0x3ffba8b0 - 0x3ffc0000
D (902) memory_layout: Available memory region 0x3ffc0000 - 0x3ffc2000
D (909) memory_layout: Available memory region 0x3ffc2000 - 0x3ffc4000
D (916) memory_layout: Available memory region 0x3ffc4000 - 0x3ffc6000
D (922) memory_layout: Available memory region 0x3ffc6000 - 0x3ffc8000
D (929) memory_layout: Available memory region 0x3ffc8000 - 0x3ffca000
D (935) memory_layout: Available memory region 0x3ffca000 - 0x3ffcc000
D (942) memory_layout: Available memory region 0x3ffcc000 - 0x3ffce000
D (949) memory_layout: Available memory region 0x3ffce000 - 0x3ffd0000
D (955) memory_layout: Available memory region 0x3ffd0000 - 0x3ffd2000
D (962) memory_layout: Available memory region 0x3ffd2000 - 0x3ffd4000
D (968) memory_layout: Available memory region 0x3ffd4000 - 0x3ffd6000
D (975) memory_layout: Available memory region 0x3ffd6000 - 0x3ffd8000
D (982) memory_layout: Available memory region 0x3ffd8000 - 0x3ffda000
D (988) memory_layout: Available memory region 0x3ffda000 - 0x3ffdc000
D (995) memory_layout: Available memory region 0x3ffdc000 - 0x3ffde000
D (1001) memory_layout: Available memory region 0x3ffde000 - 0x3ffe0000
D (1008) memory_layout: Available memory region 0x3ffe0440 - 0x3ffe4000
D (1015) memory_layout: Available memory region 0x3ffe4000 - 0x3ffe8000
D (1021) memory_layout: Available memory region 0x3ffe8000 - 0x3fff0000
D (1028) memory_layout: Available memory region 0x3fff0000 - 0x3fff8000
D (1035) memory_layout: Available memory region 0x3fff8000 - 0x3fffc000
D (1041) memory_layout: Available memory region 0x3fffc000 - 0x40000000
D (1048) memory_layout: Available memory region 0x40078000 - 0x40080000
D (1055) memory_layout: Available memory region 0x40097400 - 0x40098000
D (1061) memory_layout: Available memory region 0x40098000 - 0x4009a000
D (1068) memory_layout: Available memory region 0x4009a000 - 0x4009c000
D (1075) memory_layout: Available memory region 0x4009c000 - 0x4009e000
D (1082) memory_layout: Available memory region 0x4009e000 - 0x400a0000
D (1088) memory_layout: Available memory region 0x3ff80068 - 0x3ff82000
I (1095) heap_init: Initializing. RAM available for dynamic allocation:
D (1102) heap_init: New heap initialised at 0x3ffae6e0
I (1107) heap_init: At 3FFAE6E0 len 00001920 (6 KiB): DRAM
D (1114) heap_init: New heap initialised at 0x3ffba8b0
I (1119) heap_init: At 3FFBA8B0 len 00025750 (149 KiB): DRAM
I (1125) heap_init: At 3FFE0440 len 0001FBC0 (126 KiB): D/IRAM
D (1132) heap_init: New heap initialised at 0x40078000
I (1137) heap_init: At 40078000 len 00008000 (32 KiB): IRAM
D (1143) heap_init: New heap initialised at 0x40097400
I (1148) heap_init: At 40097400 len 00008C00 (35 KiB): IRAM
D (1155) heap_init: New heap initialised at 0x3ff80068
I (1160) heap_init: At 3FF80068 len 00001F98 (7 KiB): RTCRAM
D (1167) intr_alloc: Connected src 46 to int 2 (cpu 0)
D (1172) spi_flash: trying chip: issi
D (1175) spi_flash: trying chip: gd
D (1179) spi_flash: trying chip: mxic
D (1182) spi_flash: trying chip: winbond
D (1186) spi_flash: trying chip: generic
I (1190) spi_flash: detected chip: generic
I (1195) spi_flash: flash io: dio
D (1199) cpu_start: calling init function: 0x4018b770
D (1204) cpu_start: calling init function: 0x4018b29c
D (1209) cpu_start: calling init function: 0x401a61a8
D (1215) cpu_start: calling init function: 0x400fc1ac
W (1220) ADC: legacy driver is deprecated, please migrate to `esp_adc/adc_oneshot.h`
D (1228) cpu_start: calling init function: 0x400fc164
W (1233) i2s(legacy): legacy i2s driver is deprecated, please migrate to use driver/i2s_std.h, driver/i2s_pdm.h or driver/i2s_tdm.h
D (1246) cpu_start: calling init function: 0x400d3994
D (1251) cpu_start: calling init function: 0x400d2df4
D (1256) cpu_start: calling init function: 0x401a5c34 on core: 0
D (1262) intr_alloc: Connected src 17 to int 3 (cpu 0)
D (1267) cpu_start: calling init function: 0x400feecc on core: 0
I (1273) sleep: Configure to isolate all GPIO pins in sleep state
I (1280) sleep: Enable automatic switching of GPIO sleep configuration
D (1287) cpu_start: calling init function: 0x400d371c on core: 0
D (1305) intr_alloc: Connected src 24 to int 9 (cpu 0)
I (1305) app_start: Starting scheduler on CPU0
I (1306) main_task: Started on CPU0
D (1310) heap_init: New heap initialised at 0x3ffe0440
D (1315) intr_alloc: Connected src 16 to int 12 (cpu 0)
I (1320) main_task: Calling app_main()
no external 32k oscillator, disable it now.
D (1329) at-workaround: at main pre-process done
D (1364) esp_netif_lwip: LwIP stack has been initialized
D (1365) esp_netif_lwip: esp-netif has been successfully initialized
D (1366) event: running task for loop 0x3ffbe7e8
D (1370) event: created task for loop 0x3ffbe7e8
D (1375) event: created event loop 0x3ffbe7e8
at param mode: 1
D (1397) esp_netif_lwip: check: remote, if=0 fn=0x4011e02c

D (1398) esp_netif_lwip: call api in lwip: ret=0x0, give sem
D (1399) esp_netif_objects: esp_netif_add_to_list 0x3ffc02a0
D (1405) esp_netif_objects: esp_netif_add_to_list netif added successfully (total netifs: 1)
D (1414) esp_netif_objects: esp_netif_add_to_list 0x3ffc0664
D (1419) esp_netif_objects: esp_netif_add_to_list netif added successfully (total netifs: 2)
D (1428) nvs: nvs_open_from_partition misc 1
I (1433) wifi:wifi driver task: 3ffc2924, prio:23, stack:6144, core=0
I (1438) system_api: Base MAC address is not set
I (1443) system_api: read default base MAC address from EFUSE
D (1450) efuse: In EFUSE_BLK0__DATA2_REG is used 8 bits starting with 8 bit
D (1456) efuse: In EFUSE_BLK0__DATA2_REG is used 8 bits starting with 0 bit
D (1463) efuse: In EFUSE_BLK0__DATA1_REG is used 8 bits starting with 24 bit
D (1470) efuse: In EFUSE_BLK0__DATA1_REG is used 8 bits starting with 16 bit
D (1477) efuse: In EFUSE_BLK0__DATA1_REG is used 8 bits starting with 8 bit
D (1484) efuse: In EFUSE_BLK0__DATA1_REG is used 8 bits starting with 0 bit
D (1491) efuse: In EFUSE_BLK0__DATA2_REG is used 8 bits starting with 16 bit
D (1499) nvs: nvs_open_from_partition nvs.net80211 1
D (1504) nvs: nvs_get opmode 1
D (1507) nvs: nvs_get_str_or_blob sta.ssid
D (1511) nvs: nvs_get sta.authmode 1
D (1515) nvs: nvs_get_str_or_blob sta.pswd
D (1519) nvs: nvs_get_str_or_blob sta.pmk
D (1523) nvs: nvs_get sta.chan 1
D (1526) nvs: nvs_get auto.conn 1
D (1529) nvs: nvs_get bssid.set 1
D (1533) nvs: nvs_get_str_or_blob sta.bssid
D (1537) nvs: nvs_get sta.lis_intval 2
D (1541) nvs: nvs_get sta.phym 1
D (1544) nvs: nvs_get sta.phybw 1
D (1547) nvs: nvs_get_str_or_blob sta.apsw
D (1552) nvs: nvs_get_str_or_blob sta.apinfo
D (1557) nvs: nvs_get sta.scan_method 1
D (1560) nvs: nvs_get sta.sort_method 1
D (1564) nvs: nvs_get sta.minrssi 1
D (1567) nvs: nvs_get sta.minauth 1
D (1571) nvs: nvs_get sta.pmf_e 1
D (1574) nvs: nvs_get sta.pmf_r 1
D (1578) nvs: nvs_get sta.btm_e 1
D (1581) nvs: nvs_get sta.rrm_e 1
D (1584) nvs: nvs_get sta.mbo_e 1
D (1588) nvs: nvs_get_str_or_blob ap.ssid
D (1592) nvs: nvs_get_str_or_blob ap.passwd
D (1596) nvs: nvs_get_str_or_blob ap.pmk
D (1600) nvs: nvs_get ap.chan 1
D (1603) nvs: nvs_get ap.authmode 1
D (1606) nvs: nvs_get ap.hidden 1
D (1610) nvs: nvs_get ap.max.conn 1
D (1613) nvs: nvs_get bcn.interval 2
D (1617) nvs: nvs_get ap.phym 1
D (1620) nvs: nvs_get ap.phybw 1
D (1623) nvs: nvs_get ap.sndchan 1
D (1627) nvs: nvs_get ap.pmf_e 1
D (1630) nvs: nvs_get ap.pmf_r 1
D (1633) nvs: nvs_get ap.p_cipher 1
D (1637) nvs: nvs_get lorate 1
D (1640) nvs: nvs_get_str_or_blob country
D (1644) nvs: nvs_get ap.ftm_r 1
D (1647) nvs: nvs_get sta.ft 1
D (1651) nvs: nvs_get sta.owe 1
D (1654) nvs: nvs_get sta.trans_d 1
D (1657) nvs: nvs_get sta.sae_h2e 1
D (1661) nvs: nvs_get sta.bss_retry 1
D (1665) nvs: nvs_get_str_or_blob sta.owe_data
D (1669) nvs: nvs_get_str_or_blob ap.pmk_info
D (1674) nvs: nvs_set ap.sndchan 1 1
I (1677) wifi:wifi firmware version: dbb7b72
I (1681) wifi:wifi certification version: v7.0
I (1685) wifi:config NVS flash: enabled
I (1689) wifi:config nano formating: enabled
I (1693) wifi:Init data frame dynamic rx buffer num: 32
I (1698) wifi:Init static rx mgmt buffer num: 5
I (1702) wifi:Init management short buffer num: 32
I (1706) wifi:Init dynamic tx buffer num: 32
I (1710) wifi:Init static rx buffer size: 1600
I (1715) wifi:Init static rx buffer num: 10
I (1718) wifi:Init dynamic rx buffer num: 32
I (1724) wifi_init: rx ba win: 6
I (1726) wifi_init: tcpip mbox: 32
I (1730) wifi_init: udp mbox: 6
I (1734) wifi_init: tcp mbox: 6
I (1738) wifi_init: tcp tx win: 5760
I (1742) wifi_init: tcp rx win: 5760
I (1746) wifi_init: tcp mss: 1440
I (1750) wifi_init: WiFi IRAM OP enabled
I (1755) wifi_init: WiFi RX IRAM OP enabled
I (1759) wifi_init: WiFi SLP IRAM OP enabled
D (1765) adc_share_hw_ctrl: Wi-Fi takes adc2 lock.
I (1769) phy_init: phy_version 4791,2c4672b,Dec 20 2023,16:06:06
D (1776) phy_init: loading PHY init data from application binary
D (1782) nvs: nvs_open_from_partition phy 0
D (1786) nvs: nvs_get cal_version 4
D (1790) nvs: nvs_get_str_or_blob cal_mac
D (1794) efuse: In EFUSE_BLK0__DATA2_REG is used 8 bits starting with 8 bit
D (1801) efuse: In EFUSE_BLK0__DATA2_REG is used 8 bits starting with 0 bit
D (1808) efuse: In EFUSE_BLK0__DATA1_REG is used 8 bits starting with 24 bit
D (1815) efuse: In EFUSE_BLK0__DATA1_REG is used 8 bits starting with 16 bit
D (1822) efuse: In EFUSE_BLK0__DATA1_REG is used 8 bits starting with 8 bit
D (1829) efuse: In EFUSE_BLK0__DATA1_REG is used 8 bits starting with 0 bit
D (1836) efuse: In EFUSE_BLK0__DATA2_REG is used 8 bits starting with 16 bit
D (1843) nvs: nvs_get_str_or_blob cal_data
D (1850) nvs: nvs_close 3
D (1851) efuse: In EFUSE_BLK0__DATA2_REG is used 8 bits starting with 8 bit
D (1857) efuse: In EFUSE_BLK0__DATA2_REG is used 8 bits starting with 0 bit
D (1864) efuse: In EFUSE_BLK0__DATA1_REG is used 8 bits starting with 24 bit
D (1871) efuse: In EFUSE_BLK0__DATA1_REG is used 8 bits starting with 16 bit
D (1878) efuse: In EFUSE_BLK0__DATA1_REG is used 8 bits starting with 8 bit
D (1885) efuse: In EFUSE_BLK0__DATA1_REG is used 8 bits starting with 0 bit
D (1892) efuse: In EFUSE_BLK0__DATA2_REG is used 8 bits starting with 16 bit
D (1982) wifi:filter: set rx policy=0
I (1984) wifi:mode : sta (e8:6b:ea:c4:72:54)
I (1985) wifi:enable tsf
D (1985) wifi:filter: set rx policy=1
D (1985) wifi:connect status 0 -> 0
D (1989) event: running post WIFI_EVENT:2 with handler 0x40132278 and context 0x3ffc049c on loop 0x3ffbe7e8
D (1998) wifi_init_default: wifi_start esp-netif:0x3ffc02a0 event-id2
D (2004) wifi_init_default: WIFI mac address: e8 6b ea c4 72 54
D (2011) esp_netif_lwip: check: remote, if=0x3ffc02a0 fn=0x4011e03c

D (2017) esp_netif_lwip: call api in lwip: ret=0x0, give sem
D (2022) esp_netif_handlers: esp_netif action has started with netif0x3ffc02a0 from event_id=2
D (2031) esp_netif_lwip: check: remote, if=0x3ffc02a0 fn=0x4011eef0

D (2038) esp_netif_lwip: esp_netif_start_api 0x3ffc02a0
D (2043) esp_netif_lwip: esp_netif_get_hostname esp_netif:0x3ffc02a0
D (2049) esp_netif_lwip: check: local, if=0x3ffc02a0 fn=0x4011fcec

D (2055) esp_netif_lwip: esp_netif_update_default_netif_lwip 0x3ffc02a0
D (2062) esp_netif_lwip: call api in lwip: ret=0x0, give sem
D (2068) nvs: nvs_open_from_partition factory_param 0
D (2073) nvs: nvs_get uart_port 1
D (2077) nvs: nvs_get uart_tx_pin 4
D (2080) nvs: nvs_get uart_rx_pin 4
D (2083) nvs: nvs_get uart_cts_pin 4
D (2087) nvs: nvs_get uart_rts_pin 4
I (2091) uart: queue free spaces: 30
D (2095) intr_alloc: Connected src 35 to int 13 (cpu 0)
D (2100) nvs: nvs_open_from_partition factory_param 0
D (2105) nvs: nvs_get uart_baudrate 4
D (2109) nvs: nvs_open_from_partition UART 0
D (2113) nvs: nvs_get rate 4
D (2116) nvs: nvs_get databits 1
D (2120) nvs: nvs_get stopbits 1
D (2123) nvs: nvs_get parity 1
D (2126) nvs: nvs_get flow_ctrl 1
D (2129) nvs: nvs_close 6
AT cmd port:uart1 tx:17 rx:16 cts:15 rts:14 baudrate:115200
D (2137) nvs: nvs_open_from_partition factory_param 0
D (2142) nvs: nvs_get_str_or_blob module_name
D (2147) nvs: nvs_close 7
module_name: WROOM-32
D (2151) nvs: nvs_open_from_partition factory_param 0
D (2157) nvs: nvs_get max_tx_power 1
max tx power=78, ret=0
D (2162) nvs: nvs_get start_channel 1
D (2166) nvs: nvs_get channel_num 1
D (2170) nvs: nvs_get_str_or_blob country_code
I (2175) wifi:set country: cc=CN schan=1 nchan=13 policy=1

D (2180) nvs: nvs_close 8
D (2182) at-init: at wifi init done
v3.4.0.0
AT version:3.5.0.0-dev(ba52610 - ESP32 - Oct 31 2024 08:01:30)
SDK version:v5.0.6-dirty
compile time(a599a7e6):Nov  5 2024 08:19:31
Bin version:v3.4.0.0(WROOM-32)

D (2202) at-init: at module init done
D (2205) nvs: nvs_open_from_partition NVM_012 0
D (2210) at-cmd-register: esp_at_base_cmd_regist success
I (2217) wifi:mode : sta (e8:6b:ea:c4:72:54) + softAP (e8:6b:ea:c4:72:55)
D (2222) wifi:filter: set rx policy=9
I (2226) wifi:Total power save buffer number: 16
I (2229) wifi:Init max length of beacon: 752/752
I (2234) wifi:Init max length of beacon: 752/752
D (2239) event: running post WIFI_EVENT:12 with handler 0x40132260 and context 0x3ffc05d0 on loop 0x3ffbe7e8
D (2248) wifi_init_default: wifi_start esp-netif:0x3ffc0664 event-id12
D (2255) wifi_init_default: WIFI mac address: e8 6b ea c4 72 55
D (2261) esp_netif_lwip: check: remote, if=0x3ffc0664 fn=0x4011e03c

D (2267) esp_netif_lwip: call api in lwip: ret=0x0, give sem
D (2272) esp_netif_handlers: esp_netif action has started with netif0x3ffc0664 from event_id=12
D (2281) esp_netif_lwip: check: remote, if=0x3ffc0664 fn=0x4011eef0

D (2288) esp_netif_lwip: esp_netif_start_api 0x3ffc0664
D (2293) esp_netif_lwip: esp_netif_internal_dhcpc_cb lwip-netif:0x3ffc06e8
D (2300) esp_netif_lwip: if0x3ffc0664 ip unchanged
D (2305) esp_netif_lwip: esp_netif_get_hostname esp_netif:0x3ffc0664
D (2311) esp_netif_lwip: esp_netif_start_api Setting the lwip netif0x3ffc06e8 UP
D (2320) esp_netif_lwip: DHCP server started successfully
D (2324) esp_netif_lwip: check: local, if=0x3ffc0664 fn=0x4011fcec

D (2330) esp_netif_lwip: esp_netif_update_default_netif_lwip 0x3ffc0664
D (2337) esp_netif_lwip: call api in lwip: ret=0x0, give sem
D (2343) nvs: nvs_open_from_partition NVM_004 0
D (2347) nvs: nvs_open_from_partition NVM_003 0
D (2352) nvs: nvs_open_from_partition NVM_017 0
D (2356) nvs: nvs_get flag 1
D (2359) nvs: nvs_get wris 4
D (2363) nvs: nvs_get wrrc 4
D (2365) nvs: nvs_close 9
D (2368) nvs: nvs_open_from_partition NVM_022 1
D (2372) nvs: nvs_get wac 1
D (2375) nvs: nvs_close 10
D (2378) nvs: nvs_open_from_partition NVM_024 0
D (2383) nvs: nvs_open_from_partition NVM_013 0
D (2387) nvs: nvs_get apmode 4
D (2390) nvs: nvs_close 11
D (2393) esp_netif_lwip: check: remote, if=0x3ffc02a0 fn=0x4011e878

D (2399) esp_netif_lwip: esp_netif_dhcpc_stop_api esp_netif:0x3ffc02a0
D (2406) esp_netif_lwip: dhcp client stop successfully
D (2411) esp_netif_lwip: call api in lwip: ret=0x0, give sem
D (2417) esp_netif_lwip: check: remote, if=0x3ffc0664 fn=0x4011e7d4

D (2423) esp_netif_lwip: esp_netif_dhcps_stop_api esp_netif:0x3ffc0664
D (2430) esp_netif_lwip: dhcp server stop successfully
D (2435) esp_netif_lwip: call api in lwip: ret=0x0, give sem
D (2441) nvs: nvs_open_from_partition NVM_002 0
D (2445) nvs: nvs_open_from_partition NVM_021 0
D (2450) nvs: nvs_open_from_partition NVM_001 0
D (2454) nvs: nvs_open_from_partition NVM_007 0
D (2459) nvs: nvs_open_from_partition NVM_006 0
D (2464) esp_netif_lwip: check: remote, if=0x3ffc02a0 fn=0x4011e96c

D (2470) esp_netif_lwip: esp_netif_dhcpc_start_api esp_netif:0x3ffc02a0
D (2477) esp_netif_lwip: dhcp client re init
D (2481) esp_netif_lwip: call api in lwip: ret=0x0, give sem
D (2487) esp_netif_lwip: check: remote, if=0x3ffc0664 fn=0x4011e638

D (2493) esp_netif_lwip: esp_netif_dhcps_start_api esp_netif:0x3ffc0664
D (2500) esp_netif_lwip: DHCP server started successfully
D (2505) esp_netif_lwip: call api in lwip: ret=0x0, give sem
D (2512) wifi:filter: set rx policy=10
I (2515) wifi:mode : sta (e8:6b:ea:c4:72:54)
D (2519) event: running post WIFI_EVENT:13 with handler 0x4013212c and context 0x3ffc0600 on loop 0x3ffbe7e8
D (2528) esp_netif_handlers: esp_netif action stopped with netif0x3ffc0664 from event_id=13
D (2537) esp_netif_lwip: check: remote, if=0x3ffc0664 fn=0x4011f0cc

D (2543) esp_netif_lwip: check: local, if=0x3ffc0664 fn=0x4011fcec

D (2549) esp_netif_lwip: esp_netif_update_default_netif_lwip 0x3ffc0664
D (2556) esp_netif_lwip: call api in lwip: ret=0x0, give sem
D (2564) wifi:Start wifi connect
D (2565) wifi:connect status 0 -> 0
D (2568) wifi:connect chan=0
D (2571) wifi:first chan=11
D (2573) wifi:connect status 0 -> 1
D (2576) wifi:filter: set rx policy=3
D (2580) wifi:clear scan ap list
D (2582) wifi:start scan: type=0x50f, priority=2, cb=0x401750cc, arg=0, ss_state=0x1, time=601857, index=0
D (2592) wifi:perform scan: ss_state=0x9, chan<11,0>, dur<0,120>
D (2600) at-cmd-register: esp_at_wifi_cmd_regist success
D (2603) at-cmd-register: esp_at_smartconfig_cmd_regist success
D (2605) wifi:rsn valid: gcipher=3 ucipher=3 akm=5

D (2614) wifi:profile match: ss_state=0x7
D (2617) wifi:scan end: arg=0, status=0, ss_state=0x7
D (2622) wifi:find first mathched ssid, scan done
D (2627) wifi:filter: set rx policy=4
D (2630) wifi:first chan=1
D (2632) wifi:handoff_cb: status=0
D (2635) wifi:ap found, mac=8c:6a:8d:d9:aa:e0
D (2639) wifi:new_bss=0x3ffb93e0, cur_bss=0, new_chan=<11,0>, cur_chan=1
D (2646) wifi:filter: set rx policy=5
I (2649) wifi:new:<11,0>, old:<1,1>, ap:<255,255>, sta:<11,0>, prof:1
D (2656) wifi:connect_op: status=0, auth=5, cipher=3
D (2661) wifi:auth mode is not none
D (2663) wifi:connect_bss: auth=1, reconnect=0
I (2667) wifi:state: init -> auth (b0)
D (2671) wifi:start 1s AUTH timer
D (2674) wifi:clear scan ap list
D (2677) at-cmd-register: esp_at_wps_cmd_regist success
D (2679) wifi:recv auth: seq=2, status=0
I (2685) wifi:state: auth -> assoc (0)
D (2689) wifi:restart connect 1s timer for assoc
D (2694) at-cmd-register: esp_at_mdns_cmd_regist success
D (2699) nvs: nvs_open_from_partition NVM_020 0
D (2703) nvs: nvs_open_from_partition NVM_020 0
D (2704) wifi:recv assoc: type=0x10
D (2711) wifi:filter: set rx policy=6
I (2714) wifi:state: assoc -> run (10)
D (2718) wifi:start 10s connect timer for 4 way handshake
D (2724) nvs: nvs_open_from_partition NVM_020 0
D (2727) nvs: nvs_open_from_partition NVM_020 0
D (2732) nvs: nvs_open_from_partition NVM_020 0
D (2740) nvs: nvs_open_from_partition NVM_008 1
D (2741) nvs: nvs_get dns_ser0 4
D (2745) nvs: nvs_get dns_ser1 4
I (2750) wifi:<ba-add>idx:0 (ifx:0, 8c:6a:8d:d9:aa:e0), tid:0, ssn:0, winSize:64
D (2756) nvs: nvs_get dns_ser2 4
D (2758) nvs: nvs_get_str_or_blob dns_svr0
D (2764) nvs: nvs_close 12
D (2765) esp_netif_lwip: check: remote, if=0x3ffc02a0 fn=0x4011ecb8

I (2770) wifi:connected with Tendulkar2GHz, aid = 18, channel 11, BW20, bssid = 8c:6a:8d:d9:aa:e0
I (2780) wifi:security: WPA2-PSK, phy: bgn, rssi: -62
D (2785) wifi:remove all except 8c:6a:8d:d9:aa:e0 from rc list
D (2790) wifi:clear blacklist
D (2793) nvs: nvs_set sta.chan 1 11
D (2797) nvs: nvs_set_blob sta.apinfo 700
D (2802) wifi:filter: set rx policy=7
I (2804) wifi:pm start, type: 1

I (2807) wifi:dp: 1, bi: 102400, li: 3, scale listen interval from 307200 us to 307200 us
D (2815) wifi:Send sta connected event
D (2818) wifi:connect status 1 -> 5
D (2821) wifi:obss scan is disabled
D (2824) wifi:start obss scan: obss scan is stopped
D (2830) event: running post WIFI_EVENT:4 with handler 0x401322a8 and context 0x3ffc04fc on loop 0x3ffbe7e8
I (2838) wifi:AP's beacon interval = 102400 us, DTIM period = 1
D (2845) wifi:set max rate: from <rate=130, phy=3, sig=0> to <rate=144, phy=3 sig=0>
D (2852) wifi:sig_b=0, sig_g=0, sig_n=0, max_b=22, max_g=108, max_n=144
D (2858) wifi:update trc
D (2861) esp_netif_handlers: esp_netif action connected with netif0x3ffc02a0 from event_id=4
D (2869) esp_netif_lwip: check: remote, if=0x3ffc02a0 fn=0x4011f14c

D (2875) esp_netif_lwip: esp_netif_up_api esp_netif:0x3ffc02a0
D (2881) esp_netif_lwip: check: local, if=0x3ffc02a0 fn=0x4011fcec

D (2887) esp_netif_lwip: esp_netif_update_default_netif_lwip 0x3ffc02a0
D (2894) esp_netif_lwip: call api in lwip: ret=0x0, give sem
D (2900) esp_netif_lwip: check: remote, if=0x3ffc02a0 fn=0x4011e96c

D (2906) esp_netif_lwip: esp_netif_dhcpc_start_api esp_netif:0x3ffc02a0
D (2913) esp_netif_lwip: esp_netif_start_ip_lost_timer esp_netif:0x3ffc02a0
D (2920) esp_netif_lwip: if0x3ffc02a0 start ip lost tmr: no need start because netif=0x3ffc0324 interval=120 ip=0
D (2930) esp_netif_lwip: starting dhcp client
I (2935) udp-tx: IPL:336, SP:68, DP:67, UDL:308
D (2941) esp_netif_lwip: call api in lwip: ret=0x0, give sem
D (2946) event: running post WIFI_EVENT:4 with handler 0x400ec9bc and context 0x3ffcc0a0 on loop 0x3ffbe7e8
I (2957) intf-tx: 0x3f407f5c   57 49 46 49 20 43 4f 4e  4e 45 43 54 45 44 0d 0a  |WIFI CONNECTED..|
D (2966) event: running post WIFI_EVENT:4 with handler 0x400ed6c8 and context 0x3ffcf23c on loop 0x3ffbe7e8
D (2975) esp_netif_lwip: esp_netif_set_dns_info_api esp_netif:0x3ffc02a0
D (2981) esp_netif_lwip: set dns if=0x3ffc02a0 type=0 dns=dede43d0
D (2988) esp_netif_lwip: call api in lwip: ret=0x0, give sem
I (2994) wifi:<ba-add>idx:1 (ifx:0, 8c:6a:8d:d9:aa:e0), tid:6, ssn:0, winSize:64
D (3001) esp_netif_lwip: check: remote, if=0x3ffc02a0 fn=0x4011ecb8

D (3007) esp_netif_lwip: esp_netif_set_dns_info_api esp_netif:0x3ffc02a0
I (3013) udp-rx: IPL:328, SP:67, DP:68, UDL:300
D (3019) esp_netif_lwip: set dns if=0x3ffc02a0 type=2 dns=8080808
D (3025) esp_netif_lwip: call api in lwip: ret=0x0, give sem
I (3032) udp-tx: IPL:336, SP:68, DP:67, UDL:308
D (3038) nvs: nvs_open_from_partition NVM_009 1
D (3040) nvs: nvs_get maxlink 1
D (3044) nvs: nvs_open_from_partition NVM_009 0
D (3048) nvs: nvs_get auth0 1
D (3051) nvs: nvs_open_from_partition NVM_009 0
I (3053) udp-rx: IPL:328, SP:67, DP:68, UDL:300
D (3063) nvs: nvs_get auth1 1
D (3064) nvs: nvs_open_from_partition NVM_009 0
D (3069) nvs: nvs_get auth2 1
D (3071) nvs: nvs_open_from_partition NVM_009 0
D (3076) nvs: nvs_get auth3 1
D (3079) nvs: nvs_open_from_partition NVM_009 0
D (3084) nvs: nvs_get auth4 1
D (3087) nvs: nvs_open_from_partition NVM_018 0
D (3091) nvs: nvs_open_from_partition NVM_005 1
D (3096) nvs: nvs_get enable 1
D (3099) nvs: nvs_close 19
D (3102) at-cmd-register: esp_at_net_cmd_regist success
D (3107) at-cmd-register: esp_at_ping_cmd_regist success
D (3112) at-cmd-register: esp_at_mqtt_cmd_regist success
D (3118) at-cmd-register: esp_at_http_cmd_regist success
D (3123) at-cmd-register: esp_at_fact_cmd_regist success
D (3128) at-cmd-register: esp_at_ota_cmd_regist success
D (3133) at-cmd-register: esp_at_uart_cmd_regist success
D (3139) at-cmd-register: esp_at_user_cmd_regist success
I (3145) intf-tx: 0x3f4043ec   0d 0a 72 65 61 64 79 0d  0a                       |..ready..|
D (3154) at-init: esp_at_init done
I (3157) main_task: Returned from app_main()
D (3944) esp_netif_lwip: esp_netif_internal_dhcpc_cb lwip-netif:0x3ffc0324
D (3945) esp_netif_lwip: if0x3ffc02a0 ip changed=1
D (3945) event: running post IP_EVENT:0 with handler 0x401320d4 and context 0x3ffc0644 on loop 0x3ffbe7e8
D (3955) wifi_init_default: Got IP wifi default handler entered
D (3961) esp_netif_handlers: esp_netif action got_ip with netif0x3ffc02a0 from event_id=0
I (3969) esp_netif_handlers: sta ip: 192.168.0.171, mask: 255.255.255.0, gw: 192.168.0.1
D (3977) event: running post IP_EVENT:0 with handler 0x400ed478 and context 0x3ffcc0e0 on loop 0x3ffbe7e8
I (3988) intf-tx: 0x3f408004   57 49 46 49 20 47 4f 54  20 49 50 0d 0a           |WIFI GOT IP..|
negotiated phy mode: 3
D (3999) event: running post IP_EVENT:0 with handler 0x400e17f4 and context 0x3ffd1ac8 on loop 0x3ffbe7e8
I (31584) intf-rx: 0x3ffb3c1c   41 54 2b 52 53 54 0d 0a                           |AT+RST..|
I (31585) intf-tx: 0x3ffb3c1c   41 54 2b 52 53 54 0d 0a                           |AT+RST..|
I (31593) intf-tx: 0x3f407a9c   0d 0a 4f 4b 0d 0a                                 |..OK..|
D (31621) wifi:connect status 5 -> 0
D (31622) wifi:Start wifi disconnect
I (31622) wifi:state: run -> init (0)
D (31623) wifi:connect status 0 -> 6
D (31624) wifi:stop beacon/connect timer, send diassoc(8)
D (31630) wifi:sta leave
I (31631) wifi:pm stop, total sleep time: lu us / lu us

D (31636) wifi:stop CSA timer
I (31639) wifi:<ba-del>idx
I (31641) wifi:<ba-del>idx
D (31644) wifi:remove 8c:6a:8d:d9:aa:e0 from rc list
I (31649) wifi:new:<11,0>, old:<11,0>, ap:<255,255>, sta:<11,0>, prof:1
D (31655) wifi:filter: set rx policy=8
D (31658) wifi:Send disconnect event, reason=8, AP number=0
D (31664) wifi:connect status 6 -> 0
D (31667) wifi:filter: set rx policy=8
D (31670) wifi:filter: set rx policy=2
D (31674) wifi:clear scan ap list
D (31677) wifi:clear blacklist
D (31679) wifi:clear rc list
D (31683) event: running post WIFI_EVENT:5 with handler 0x40132290 and context 0x3ffc05a0 on loop 0x3ffbe7e8
D (31692) esp_netif_handlers: esp_netif action disconnected with netif0x3ffc02a0 from event_id=5
D (31701) esp_netif_lwip: check: remote, if=0x3ffc02a0 fn=0x4011f19c

D (31707) esp_netif_lwip: esp_netif_down_api esp_netif:0x3ffc02a0
I (31714) udp-tx: IPL:336, SP:68, DP:67, UDL:308
E (31719) @@if-tx: netif tx error, tot_len:350 len:350 ret: 12290
D (31726) esp_netif_lwip: esp_netif_internal_dhcpc_cb lwip-netif:0x3ffc0324
D (31732) esp_netif_lwip: esp_netif_start_ip_lost_timer esp_netif:0x3ffc02a0
D (31740) esp_netif_lwip: if0x3ffc02a0 start ip lost tmr: interval=120
D (31746) esp_netif_lwip: esp_netif_start_ip_lost_timer esp_netif:0x3ffc02a0
D (31753) esp_netif_lwip: if0x3ffc02a0 start ip lost tmr: already started
D (31760) esp_netif_lwip: check: local, if=0x3ffc02a0 fn=0x4011fcec

D (31766) esp_netif_lwip: esp_netif_update_default_netif_lwip 0x3ffc02a0
D (31773) esp_netif_lwip: call api in lwip: ret=0x0, give sem
D (31779) event: running post WIFI_EVENT:5 with handler 0x400ed07c and context 0x3ffcc0c0 on loop 0x3ffbe7e8
wifi disconnected, rc:8
I (31792) intf-tx: 0x3f407f8c   57 49 46 49 20 44 49 53  43 4f 4e 4e 45 43 54 0d  |WIFI DISCONNECT.|
I (31801) intf-tx: 0x3f407f9c   0a                                                |.|
D (31810) event: running post WIFI_EVENT:5 with handler 0x400ed6c8 and context 0x3ffcf23c on loop 0x3ffbe7e8
D (31819) event: running post WIFI_EVENT:5 with handler 0x400e522c and context 0x3ffd1aa8 on loop 0x3ffbe7e8
D (31829) event: running post WIFI_EVENT:3 with handler 0x40132144 and context 0x3ffc04cc on loop 0x3ffbe7e8
D (31839) esp_netif_handlers: esp_netif action stopped with netif0x3ffc02a0 from event_id=3
D (31847) esp_netif_lwip: check: remote, if=0x3ffc02a0 fn=0x4011f0cc

D (31854) esp_netif_lwip: call api in lwip: ret=0x5002, give sem
D (31860) event: running post WIFI_EVENT:3 with handler 0x400ed6c8 and context 0x3ffcf23c on loop 0x3ffbe7e8
I (31891) wifi:flush txq
I (31891) wifi:stop sw txq
D (31891) wifi:filter: set rx policy=0
I (31892) wifi:lmac stop hw txq
ets Jul 29 2019 12:21:46

rst:0xc (SW_CPU_RESET),boot:0x13 (SPI_FAST_FLASH_BOOT)
configsip: 0, SPIWP:0xee
clk_drv:0x00,q_drv:0x00,d_drv:0x00,cs0_drv:0x00,hd_drv:0x00,wp_drv:0x00
mode:DIO, clock div:2
load:0x3fff0030,len:6984
load:0x40078000,len:16144
load:0x40080400,len:3620
entry 0x40080618
I (27) boot: ESP-IDF v5.0.6-dirty 2nd stage bootloader
I (27) boot: compile time 08:19:23
W (27) boot: Unicore bootloader
I (31) boot: chip revision: v3.1
I (34) boot.esp32: SPI Speed      : 40MHz
I (39) boot.esp32: SPI Mode       : DIO
I (44) boot.esp32: SPI Flash Size : 4MB
I (48) boot: Enabling RNG early entropy source...
I (54) boot: Partition Table:
I (57) boot: ## Label            Usage          Type ST Offset   Length
I (64) boot:  0 phy_init         RF data          01 01 0000f000 00001000
I (72) boot:  1 otadata          OTA data         01 00 00010000 00002000
I (79) boot:  2 nvs              WiFi data        01 02 00012000 0000e000
I (87) boot:  3 at_customize     unknown          40 00 00020000 000e0000
I (94) boot:  4 ota_0            OTA app          00 10 00100000 00180000
I (102) boot:  5 ota_1            OTA app          00 11 00280000 00180000
I (109) boot: End of partition table
I (114) esp_image: segment 0: paddr=00100020 vaddr=3f400020 size=34560h (214368) map
I (200) esp_image: segment 1: paddr=00134588 vaddr=3ff80063 size=00008h (     8) load
I (200) esp_image: segment 2: paddr=00134598 vaddr=3ffb0000 size=032a4h ( 12964) load
I (211) esp_image: segment 3: paddr=00137844 vaddr=40080000 size=087d4h ( 34772) load
I (228) esp_image: segment 4: paddr=00140020 vaddr=400d0020 size=d9884h (891012) map
I (550) esp_image: segment 5: paddr=002198ac vaddr=400887d4 size=0ec2ch ( 60460) load
I (575) esp_image: segment 6: paddr=002284e0 vaddr=400c0000 size=00064h (   100) load
I (587) boot: Loaded app from partition at offset 0x100000
I (587) boot: Disabling RNG early entropy source...
I (599) cpu_start: Unicore app
I (599) cpu_start: Pro cpu up.
I (599) cpu_start: Single core mode
D (600) clk: waiting for 32k oscillator to start up
D (685) clk: waiting for 32k oscillator to start up
W (765) clk: 32 kHz XTAL not found, switching to internal 150 kHz oscillator
D (773) clk: RTC_SLOW_CLK calibration value: 2983155
I (779) cpu_start: Pro cpu start user code
I (779) cpu_start: cpu freq: 80000000 Hz
I (779) cpu_start: Application information:
I (783) cpu_start: Project name:     esp-at
I (788) cpu_start: App version:      v3.4.0.0-78-ga599a7e6
I (794) cpu_start: Compile time:     Nov  5 2024 08:19:01
I (800) cpu_start: ELF file SHA256:  74e4b2d9c3222218...
I (806) cpu_start: ESP-IDF:          v5.0.6-dirty
I (812) cpu_start: Min chip rev:     v0.0
I (817) cpu_start: Max chip rev:     v3.99
I (821) cpu_start: Chip rev:         v3.1
D (826) memory_layout: Checking 8 reserved memory ranges:
D (832) memory_layout: Reserved memory range 0x3ff80000 - 0x3ff80068
D (838) memory_layout: Reserved memory range 0x3ff82000 - 0x3ff82000
D (844) memory_layout: Reserved memory range 0x3ffae000 - 0x3ffae6e0
D (851) memory_layout: Reserved memory range 0x3ffb0000 - 0x3ffba8b0
D (857) memory_layout: Reserved memory range 0x3ffe0000 - 0x3ffe0440
D (864) memory_layout: Reserved memory range 0x40070000 - 0x40078000
D (870) memory_layout: Reserved memory range 0x40080000 - 0x40097400
D (876) memory_layout: Reserved memory range 0x50001fe8 - 0x50002000
D (883) memory_layout: Building list of available memory regions:
D (889) memory_layout: Available memory region 0x3ffae6e0 - 0x3ffb0000
D (896) memory_layout: Available memory region 0x3ffba8b0 - 0x3ffc0000
D (902) memory_layout: Available memory region 0x3ffc0000 - 0x3ffc2000
D (909) memory_layout: Available memory region 0x3ffc2000 - 0x3ffc4000
D (915) memory_layout: Available memory region 0x3ffc4000 - 0x3ffc6000
D (922) memory_layout: Available memory region 0x3ffc6000 - 0x3ffc8000
D (929) memory_layout: Available memory region 0x3ffc8000 - 0x3ffca000
D (935) memory_layout: Available memory region 0x3ffca000 - 0x3ffcc000
D (942) memory_layout: Available memory region 0x3ffcc000 - 0x3ffce000
D (948) memory_layout: Available memory region 0x3ffce000 - 0x3ffd0000
D (955) memory_layout: Available memory region 0x3ffd0000 - 0x3ffd2000
D (962) memory_layout: Available memory region 0x3ffd2000 - 0x3ffd4000
D (968) memory_layout: Available memory region 0x3ffd4000 - 0x3ffd6000
D (975) memory_layout: Available memory region 0x3ffd6000 - 0x3ffd8000
D (981) memory_layout: Available memory region 0x3ffd8000 - 0x3ffda000
D (988) memory_layout: Available memory region 0x3ffda000 - 0x3ffdc000
D (995) memory_layout: Available memory region 0x3ffdc000 - 0x3ffde000
D (1001) memory_layout: Available memory region 0x3ffde000 - 0x3ffe0000
D (1008) memory_layout: Available memory region 0x3ffe0440 - 0x3ffe4000
D (1015) memory_layout: Available memory region 0x3ffe4000 - 0x3ffe8000
D (1021) memory_layout: Available memory region 0x3ffe8000 - 0x3fff0000
D (1028) memory_layout: Available memory region 0x3fff0000 - 0x3fff8000
D (1035) memory_layout: Available memory region 0x3fff8000 - 0x3fffc000
D (1041) memory_layout: Available memory region 0x3fffc000 - 0x40000000
D (1048) memory_layout: Available memory region 0x40078000 - 0x40080000
D (1055) memory_layout: Available memory region 0x40097400 - 0x40098000
D (1061) memory_layout: Available memory region 0x40098000 - 0x4009a000
D (1068) memory_layout: Available memory region 0x4009a000 - 0x4009c000
D (1075) memory_layout: Available memory region 0x4009c000 - 0x4009e000
D (1081) memory_layout: Available memory region 0x4009e000 - 0x400a0000
D (1088) memory_layout: Available memory region 0x3ff80068 - 0x3ff82000
I (1095) heap_init: Initializing. RAM available for dynamic allocation:
D (1102) heap_init: New heap initialised at 0x3ffae6e0
I (1107) heap_init: At 3FFAE6E0 len 00001920 (6 KiB): DRAM
D (1114) heap_init: New heap initialised at 0x3ffba8b0
I (1119) heap_init: At 3FFBA8B0 len 00025750 (149 KiB): DRAM
I (1125) heap_init: At 3FFE0440 len 0001FBC0 (126 KiB): D/IRAM
D (1132) heap_init: New heap initialised at 0x40078000
I (1137) heap_init: At 40078000 len 00008000 (32 KiB): IRAM
D (1143) heap_init: New heap initialised at 0x40097400
I (1148) heap_init: At 40097400 len 00008C00 (35 KiB): IRAM
D (1154) heap_init: New heap initialised at 0x3ff80068
I (1160) heap_init: At 3FF80068 len 00001F98 (7 KiB): RTCRAM
D (1167) intr_alloc: Connected src 46 to int 2 (cpu 0)
D (1172) spi_flash: trying chip: issi
D (1175) spi_flash: trying chip: gd
D (1179) spi_flash: trying chip: mxic
D (1182) spi_flash: trying chip: winbond
D (1186) spi_flash: trying chip: generic
I (1190) spi_flash: detected chip: generic
I (1195) spi_flash: flash io: dio
D (1199) cpu_start: calling init function: 0x4018b770
D (1204) cpu_start: calling init function: 0x4018b29c
D (1209) cpu_start: calling init function: 0x401a61a8
D (1215) cpu_start: calling init function: 0x400fc1ac
W (1220) ADC: legacy driver is deprecated, please migrate to `esp_adc/adc_oneshot.h`
D (1228) cpu_start: calling init function: 0x400fc164
W (1233) i2s(legacy): legacy i2s driver is deprecated, please migrate to use driver/i2s_std.h, driver/i2s_pdm.h or driver/i2s_tdm.h
D (1246) cpu_start: calling init function: 0x400d3994
D (1251) cpu_start: calling init function: 0x400d2df4
D (1256) cpu_start: calling init function: 0x401a5c34 on core: 0
D (1262) intr_alloc: Connected src 17 to int 3 (cpu 0)
D (1267) cpu_start: calling init function: 0x400feecc on core: 0
I (1273) sleep: Configure to isolate all GPIO pins in sleep state
I (1280) sleep: Enable automatic switching of GPIO sleep configuration
D (1287) cpu_start: calling init function: 0x400d371c on core: 0
D (1305) intr_alloc: Connected src 24 to int 9 (cpu 0)
I (1305) app_start: Starting scheduler on CPU0
I (1306) main_task: Started on CPU0
D (1310) heap_init: New heap initialised at 0x3ffe0440
D (1315) intr_alloc: Connected src 16 to int 12 (cpu 0)
I (1320) main_task: Calling app_main()
no external 32k oscillator, disable it now.
D (1329) at-workaround: at main pre-process done
D (1364) esp_netif_lwip: LwIP stack has been initialized
D (1365) esp_netif_lwip: esp-netif has been successfully initialized
D (1366) event: running task for loop 0x3ffbe7e8
D (1370) event: created task for loop 0x3ffbe7e8
D (1375) event: created event loop 0x3ffbe7e8
at param mode: 1
D (1397) esp_netif_lwip: check: remote, if=0 fn=0x4011e02c

D (1398) esp_netif_lwip: call api in lwip: ret=0x0, give sem
D (1399) esp_netif_objects: esp_netif_add_to_list 0x3ffc02a0
D (1405) esp_netif_objects: esp_netif_add_to_list netif added successfully (total netifs: 1)
D (1414) esp_netif_objects: esp_netif_add_to_list 0x3ffc0664
D (1419) esp_netif_objects: esp_netif_add_to_list netif added successfully (total netifs: 2)
D (1428) nvs: nvs_open_from_partition misc 1
I (1433) wifi:wifi driver task: 3ffc2924, prio:23, stack:6144, core=0
I (1438) system_api: Base MAC address is not set
I (1443) system_api: read default base MAC address from EFUSE
D (1450) efuse: In EFUSE_BLK0__DATA2_REG is used 8 bits starting with 8 bit
D (1456) efuse: In EFUSE_BLK0__DATA2_REG is used 8 bits starting with 0 bit
D (1463) efuse: In EFUSE_BLK0__DATA1_REG is used 8 bits starting with 24 bit
D (1470) efuse: In EFUSE_BLK0__DATA1_REG is used 8 bits starting with 16 bit
D (1477) efuse: In EFUSE_BLK0__DATA1_REG is used 8 bits starting with 8 bit
D (1484) efuse: In EFUSE_BLK0__DATA1_REG is used 8 bits starting with 0 bit
D (1491) efuse: In EFUSE_BLK0__DATA2_REG is used 8 bits starting with 16 bit
D (1499) nvs: nvs_open_from_partition nvs.net80211 1
D (1504) nvs: nvs_get opmode 1
D (1507) nvs: nvs_get_str_or_blob sta.ssid
D (1511) nvs: nvs_get sta.authmode 1
D (1515) nvs: nvs_get_str_or_blob sta.pswd
D (1519) nvs: nvs_get_str_or_blob sta.pmk
D (1523) nvs: nvs_get sta.chan 1
D (1526) nvs: nvs_get auto.conn 1
D (1529) nvs: nvs_get bssid.set 1
D (1533) nvs: nvs_get_str_or_blob sta.bssid
D (1537) nvs: nvs_get sta.lis_intval 2
D (1541) nvs: nvs_get sta.phym 1
D (1544) nvs: nvs_get sta.phybw 1
D (1547) nvs: nvs_get_str_or_blob sta.apsw
D (1552) nvs: nvs_get_str_or_blob sta.apinfo
D (1557) nvs: nvs_get sta.scan_method 1
D (1560) nvs: nvs_get sta.sort_method 1
D (1564) nvs: nvs_get sta.minrssi 1
D (1567) nvs: nvs_get sta.minauth 1
D (1571) nvs: nvs_get sta.pmf_e 1
D (1574) nvs: nvs_get sta.pmf_r 1
D (1578) nvs: nvs_get sta.btm_e 1
D (1581) nvs: nvs_get sta.rrm_e 1
D (1584) nvs: nvs_get sta.mbo_e 1
D (1588) nvs: nvs_get_str_or_blob ap.ssid
D (1592) nvs: nvs_get_str_or_blob ap.passwd
D (1596) nvs: nvs_get_str_or_blob ap.pmk
D (1600) nvs: nvs_get ap.chan 1
D (1603) nvs: nvs_get ap.authmode 1
D (1606) nvs: nvs_get ap.hidden 1
D (1610) nvs: nvs_get ap.max.conn 1
D (1613) nvs: nvs_get bcn.interval 2
D (1617) nvs: nvs_get ap.phym 1
D (1620) nvs: nvs_get ap.phybw 1
D (1623) nvs: nvs_get ap.sndchan 1
D (1627) nvs: nvs_get ap.pmf_e 1
D (1630) nvs: nvs_get ap.pmf_r 1
D (1633) nvs: nvs_get ap.p_cipher 1
D (1637) nvs: nvs_get lorate 1
D (1640) nvs: nvs_get_str_or_blob country
D (1644) nvs: nvs_get ap.ftm_r 1
D (1647) nvs: nvs_get sta.ft 1
D (1651) nvs: nvs_get sta.owe 1
D (1654) nvs: nvs_get sta.trans_d 1
D (1657) nvs: nvs_get sta.sae_h2e 1
D (1661) nvs: nvs_get sta.bss_retry 1
D (1665) nvs: nvs_get_str_or_blob sta.owe_data
D (1669) nvs: nvs_get_str_or_blob ap.pmk_info
D (1674) nvs: nvs_set ap.sndchan 1 1
I (1677) wifi:wifi firmware version: dbb7b72
I (1681) wifi:wifi certification version: v7.0
I (1685) wifi:config NVS flash: enabled
I (1689) wifi:config nano formating: enabled
I (1693) wifi:Init data frame dynamic rx buffer num: 32
I (1698) wifi:Init static rx mgmt buffer num: 5
I (1702) wifi:Init management short buffer num: 32
I (1706) wifi:Init dynamic tx buffer num: 32
I (1710) wifi:Init static rx buffer size: 1600
I (1715) wifi:Init static rx buffer num: 10
I (1718) wifi:Init dynamic rx buffer num: 32
I (1724) wifi_init: rx ba win: 6
I (1726) wifi_init: tcpip mbox: 32
I (1730) wifi_init: udp mbox: 6
I (1734) wifi_init: tcp mbox: 6
I (1738) wifi_init: tcp tx win: 5760
I (1742) wifi_init: tcp rx win: 5760
I (1746) wifi_init: tcp mss: 1440
I (1750) wifi_init: WiFi IRAM OP enabled
I (1755) wifi_init: WiFi RX IRAM OP enabled
I (1759) wifi_init: WiFi SLP IRAM OP enabled
D (1765) adc_share_hw_ctrl: Wi-Fi takes adc2 lock.
I (1769) phy_init: phy_version 4791,2c4672b,Dec 20 2023,16:06:06
D (1776) phy_init: loading PHY init data from application binary
D (1782) nvs: nvs_open_from_partition phy 0
D (1786) nvs: nvs_get cal_version 4
D (1790) nvs: nvs_get_str_or_blob cal_mac
D (1794) efuse: In EFUSE_BLK0__DATA2_REG is used 8 bits starting with 8 bit
D (1801) efuse: In EFUSE_BLK0__DATA2_REG is used 8 bits starting with 0 bit
D (1808) efuse: In EFUSE_BLK0__DATA1_REG is used 8 bits starting with 24 bit
D (1815) efuse: In EFUSE_BLK0__DATA1_REG is used 8 bits starting with 16 bit
D (1822) efuse: In EFUSE_BLK0__DATA1_REG is used 8 bits starting with 8 bit
D (1829) efuse: In EFUSE_BLK0__DATA1_REG is used 8 bits starting with 0 bit
D (1836) efuse: In EFUSE_BLK0__DATA2_REG is used 8 bits starting with 16 bit
D (1843) nvs: nvs_get_str_or_blob cal_data
D (1850) nvs: nvs_close 3
D (1851) efuse: In EFUSE_BLK0__DATA2_REG is used 8 bits starting with 8 bit
D (1857) efuse: In EFUSE_BLK0__DATA2_REG is used 8 bits starting with 0 bit
D (1864) efuse: In EFUSE_BLK0__DATA1_REG is used 8 bits starting with 24 bit
D (1871) efuse: In EFUSE_BLK0__DATA1_REG is used 8 bits starting with 16 bit
D (1878) efuse: In EFUSE_BLK0__DATA1_REG is used 8 bits starting with 8 bit
D (1885) efuse: In EFUSE_BLK0__DATA1_REG is used 8 bits starting with 0 bit
D (1892) efuse: In EFUSE_BLK0__DATA2_REG is used 8 bits starting with 16 bit
D (1983) wifi:filter: set rx policy=0
I (1985) wifi:mode : sta (e8:6b:ea:c4:72:54)
I (1985) wifi:enable tsf
D (1986) wifi:filter: set rx policy=1
D (1986) wifi:connect status 0 -> 0
D (1990) event: running post WIFI_EVENT:2 with handler 0x40132278 and context 0x3ffc049c on loop 0x3ffbe7e8
D (1999) wifi_init_default: wifi_start esp-netif:0x3ffc02a0 event-id2
D (2005) wifi_init_default: WIFI mac address: e8 6b ea c4 72 54
D (2012) esp_netif_lwip: check: remote, if=0x3ffc02a0 fn=0x4011e03c

D (2018) esp_netif_lwip: call api in lwip: ret=0x0, give sem
D (2023) esp_netif_handlers: esp_netif action has started with netif0x3ffc02a0 from event_id=2
D (2032) esp_netif_lwip: check: remote, if=0x3ffc02a0 fn=0x4011eef0

D (2038) esp_netif_lwip: esp_netif_start_api 0x3ffc02a0
D (2044) esp_netif_lwip: esp_netif_get_hostname esp_netif:0x3ffc02a0
D (2050) esp_netif_lwip: check: local, if=0x3ffc02a0 fn=0x4011fcec

D (2056) esp_netif_lwip: esp_netif_update_default_netif_lwip 0x3ffc02a0
D (2063) esp_netif_lwip: call api in lwip: ret=0x0, give sem
D (2069) nvs: nvs_open_from_partition factory_param 0
D (2074) nvs: nvs_get uart_port 1
D (2078) nvs: nvs_get uart_tx_pin 4
D (2081) nvs: nvs_get uart_rx_pin 4
D (2084) nvs: nvs_get uart_cts_pin 4
D (2088) nvs: nvs_get uart_rts_pin 4
I (2092) uart: queue free spaces: 30
D (2096) intr_alloc: Connected src 35 to int 13 (cpu 0)
D (2101) nvs: nvs_open_from_partition factory_param 0
D (2106) nvs: nvs_get uart_baudrate 4
D (2110) nvs: nvs_open_from_partition UART 0
D (2114) nvs: nvs_get rate 4
D (2117) nvs: nvs_get databits 1
D (2120) nvs: nvs_get stopbits 1
D (2124) nvs: nvs_get parity 1
D (2127) nvs: nvs_get flow_ctrl 1
D (2130) nvs: nvs_close 6
AT cmd port:uart1 tx:17 rx:16 cts:15 rts:14 baudrate:115200
D (2138) nvs: nvs_open_from_partition factory_param 0
D (2143) nvs: nvs_get_str_or_blob module_name
D (2148) nvs: nvs_close 7
module_name: WROOM-32
D (2152) nvs: nvs_open_from_partition factory_param 0
D (2157) nvs: nvs_get max_tx_power 1
max tx power=78, ret=0
D (2163) nvs: nvs_get start_channel 1
D (2167) nvs: nvs_get channel_num 1
D (2171) nvs: nvs_get_str_or_blob country_code
I (2176) wifi:set country: cc=CN schan=1 nchan=13 policy=1

D (2181) nvs: nvs_close 8
D (2183) at-init: at wifi init done
v3.4.0.0
AT version:3.5.0.0-dev(ba52610 - ESP32 - Oct 31 2024 08:01:30)
SDK version:v5.0.6-dirty
compile time(a599a7e6):Nov  5 2024 08:19:31
Bin version:v3.4.0.0(WROOM-32)

D (2203) at-init: at module init done
D (2206) nvs: nvs_open_from_partition NVM_012 0
D (2211) at-cmd-register: esp_at_base_cmd_regist success
I (2217) wifi:mode : sta (e8:6b:ea:c4:72:54) + softAP (e8:6b:ea:c4:72:55)
D (2223) wifi:filter: set rx policy=9
I (2227) wifi:Total power save buffer number: 16
I (2230) wifi:Init max length of beacon: 752/752
I (2235) wifi:Init max length of beacon: 752/752
D (2240) event: running post WIFI_EVENT:12 with handler 0x40132260 and context 0x3ffc05d0 on loop 0x3ffbe7e8
D (2249) wifi_init_default: wifi_start esp-netif:0x3ffc0664 event-id12
D (2255) wifi_init_default: WIFI mac address: e8 6b ea c4 72 55
D (2262) esp_netif_lwip: check: remote, if=0x3ffc0664 fn=0x4011e03c

D (2268) esp_netif_lwip: call api in lwip: ret=0x0, give sem
D (2273) esp_netif_handlers: esp_netif action has started with netif0x3ffc0664 from event_id=12
D (2282) esp_netif_lwip: check: remote, if=0x3ffc0664 fn=0x4011eef0

D (2289) esp_netif_lwip: esp_netif_start_api 0x3ffc0664
D (2294) esp_netif_lwip: esp_netif_internal_dhcpc_cb lwip-netif:0x3ffc06e8
D (2301) esp_netif_lwip: if0x3ffc0664 ip unchanged
D (2306) esp_netif_lwip: esp_netif_get_hostname esp_netif:0x3ffc0664
D (2312) esp_netif_lwip: esp_netif_start_api Setting the lwip netif0x3ffc06e8 UP
D (2321) esp_netif_lwip: DHCP server started successfully
D (2325) esp_netif_lwip: check: local, if=0x3ffc0664 fn=0x4011fcec

D (2331) esp_netif_lwip: esp_netif_update_default_netif_lwip 0x3ffc0664
D (2338) esp_netif_lwip: call api in lwip: ret=0x0, give sem
D (2344) nvs: nvs_open_from_partition NVM_004 0
D (2348) nvs: nvs_open_from_partition NVM_003 0
D (2353) nvs: nvs_open_from_partition NVM_017 0
D (2357) nvs: nvs_get flag 1
D (2360) nvs: nvs_get wris 4
D (2363) nvs: nvs_get wrrc 4
D (2366) nvs: nvs_close 9
D (2369) nvs: nvs_open_from_partition NVM_022 1
D (2373) nvs: nvs_get wac 1
D (2376) nvs: nvs_close 10
D (2379) nvs: nvs_open_from_partition NVM_024 0
D (2383) nvs: nvs_open_from_partition NVM_013 0
D (2388) nvs: nvs_get apmode 4
D (2391) nvs: nvs_close 11
D (2394) esp_netif_lwip: check: remote, if=0x3ffc02a0 fn=0x4011e878

D (2400) esp_netif_lwip: esp_netif_dhcpc_stop_api esp_netif:0x3ffc02a0
D (2407) esp_netif_lwip: dhcp client stop successfully
D (2412) esp_netif_lwip: call api in lwip: ret=0x0, give sem
D (2418) esp_netif_lwip: check: remote, if=0x3ffc0664 fn=0x4011e7d4

D (2424) esp_netif_lwip: esp_netif_dhcps_stop_api esp_netif:0x3ffc0664
D (2431) esp_netif_lwip: dhcp server stop successfully
D (2436) esp_netif_lwip: call api in lwip: ret=0x0, give sem
D (2442) nvs: nvs_open_from_partition NVM_002 0
D (2446) nvs: nvs_open_from_partition NVM_021 0
D (2451) nvs: nvs_open_from_partition NVM_001 0
D (2455) nvs: nvs_open_from_partition NVM_007 0
D (2460) nvs: nvs_open_from_partition NVM_006 0
D (2465) esp_netif_lwip: check: remote, if=0x3ffc02a0 fn=0x4011e96c

D (2471) esp_netif_lwip: esp_netif_dhcpc_start_api esp_netif:0x3ffc02a0
D (2478) esp_netif_lwip: dhcp client re init
D (2482) esp_netif_lwip: call api in lwip: ret=0x0, give sem
D (2488) esp_netif_lwip: check: remote, if=0x3ffc0664 fn=0x4011e638

D (2494) esp_netif_lwip: esp_netif_dhcps_start_api esp_netif:0x3ffc0664
D (2501) esp_netif_lwip: DHCP server started successfully
D (2506) esp_netif_lwip: call api in lwip: ret=0x0, give sem
D (2512) wifi:filter: set rx policy=10
I (2516) wifi:mode : sta (e8:6b:ea:c4:72:54)
D (2520) event: running post WIFI_EVENT:13 with handler 0x4013212c and context 0x3ffc0600 on loop 0x3ffbe7e8
D (2529) esp_netif_handlers: esp_netif action stopped with netif0x3ffc0664 from event_id=13
D (2537) esp_netif_lwip: check: remote, if=0x3ffc0664 fn=0x4011f0cc

D (2544) esp_netif_lwip: check: local, if=0x3ffc0664 fn=0x4011fcec

D (2550) esp_netif_lwip: esp_netif_update_default_netif_lwip 0x3ffc0664
D (2557) esp_netif_lwip: call api in lwip: ret=0x0, give sem
D (2565) wifi:Start wifi connect
D (2566) wifi:connect status 0 -> 0
D (2569) wifi:connect chan=0
D (2571) wifi:first chan=11
D (2574) wifi:connect status 0 -> 1
D (2577) wifi:filter: set rx policy=3
D (2580) wifi:clear scan ap list
D (2583) wifi:start scan: type=0x50f, priority=2, cb=0x401750cc, arg=0, ss_state=0x1, time=601844, index=0
D (2593) wifi:perform scan: ss_state=0x9, chan<11,0>, dur<0,120>
D (2600) at-cmd-register: esp_at_wifi_cmd_regist success
D (2604) at-cmd-register: esp_at_smartconfig_cmd_regist success
D (2606) wifi:rsn valid: gcipher=3 ucipher=3 akm=5

D (2615) wifi:profile match: ss_state=0x7
D (2618) wifi:scan end: arg=0, status=0, ss_state=0x7
D (2623) wifi:find first mathched ssid, scan done
D (2628) wifi:filter: set rx policy=4
D (2631) wifi:first chan=1
D (2633) wifi:handoff_cb: status=0
D (2636) wifi:ap found, mac=8c:6a:8d:d9:aa:e0
D (2640) wifi:new_bss=0x3ffb93e0, cur_bss=0, new_chan=<11,0>, cur_chan=1
D (2646) wifi:filter: set rx policy=5
I (2650) wifi:new:<11,0>, old:<1,1>, ap:<255,255>, sta:<11,0>, prof:1
D (2657) wifi:connect_op: status=0, auth=5, cipher=3
D (2662) wifi:auth mode is not none
D (2664) wifi:connect_bss: auth=1, reconnect=0
I (2668) wifi:state: init -> auth (b0)
D (2672) wifi:start 1s AUTH timer
D (2675) wifi:clear scan ap list
D (2678) at-cmd-register: esp_at_wps_cmd_regist success
D (2683) at-cmd-register: esp_at_mdns_cmd_regist success
D (2688) nvs: nvs_open_from_partition NVM_020 0
D (2690) wifi:recv auth: seq=2, status=0
I (2696) wifi:state: auth -> assoc (0)
D (2700) wifi:restart connect 1s timer for assoc
D (2705) wifi:recv auth: seq=2, status=0
D (2708) wifi:not auth state, ignore
D (2711) wifi:recv assoc: type=0x10
D (2715) wifi:filter: set rx policy=6
I (2718) wifi:state: assoc -> run (10)
D (2721) wifi:start 10s connect timer for 4 way handshake
I (2731) wifi:<ba-add>idx:0 (ifx:0, 8c:6a:8d:d9:aa:e0), tid:0, ssn:0, winSize:64
D (2734) nvs: nvs_open_from_partition NVM_020 0
D (2738) nvs: nvs_open_from_partition NVM_020 0
D (2744) nvs: nvs_open_from_partition NVM_020 0
D (2747) nvs: nvs_open_from_partition NVM_020 0
I (2751) wifi:connected with Tendulkar2GHz, aid = 21, channel 11, BW20, bssid = 8c:6a:8d:d9:aa:e0
I (2760) wifi:security: WPA2-PSK, phy: bgn, rssi: -60
D (2765) wifi:remove all except 8c:6a:8d:d9:aa:e0 from rc list
D (2770) wifi:clear blacklist
D (2773) nvs: nvs_set sta.chan 1 11
D (2777) nvs: nvs_set_blob sta.apinfo 700
D (2782) wifi:filter: set rx policy=7
I (2784) wifi:pm start, type: 1

I (2787) wifi:dp: 1, bi: 102400, li: 3, scale listen interval from 307200 us to 307200 us
D (2795) wifi:Send sta connected event
D (2798) wifi:connect status 1 -> 5
D (2801) wifi:obss scan is disabled
D (2804) wifi:start obss scan: obss scan is stopped
I (2809) wifi:AP's beacon interval = 102400 us, DTIM period = 1
D (2816) wifi:set max rate: from <rate=130, phy=3, sig=0> to <rate=144, phy=3 sig=0>
D (2822) wifi:sig_b=0, sig_g=0, sig_n=0, max_b=22, max_g=108, max_n=144
D (2828) wifi:update trc
D (2831) event: running post WIFI_EVENT:4 with handler 0x401322a8 and context 0x3ffc04fc on loop 0x3ffbe7e8
D (2841) esp_netif_handlers: esp_netif action connected with netif0x3ffc02a0 from event_id=4
D (2849) esp_netif_lwip: check: remote, if=0x3ffc02a0 fn=0x4011f14c

D (2855) esp_netif_lwip: esp_netif_up_api esp_netif:0x3ffc02a0
D (2861) esp_netif_lwip: check: local, if=0x3ffc02a0 fn=0x4011fcec

D (2868) esp_netif_lwip: esp_netif_update_default_netif_lwip 0x3ffc02a0
D (2874) esp_netif_lwip: call api in lwip: ret=0x0, give sem
D (2880) esp_netif_lwip: check: remote, if=0x3ffc02a0 fn=0x4011e96c

D (2887) esp_netif_lwip: esp_netif_dhcpc_start_api esp_netif:0x3ffc02a0
D (2893) esp_netif_lwip: esp_netif_start_ip_lost_timer esp_netif:0x3ffc02a0
D (2900) esp_netif_lwip: if0x3ffc02a0 start ip lost tmr: no need start because netif=0x3ffc0324 interval=120 ip=0
D (2910) esp_netif_lwip: starting dhcp client
I (2916) udp-tx: IPL:336, SP:68, DP:67, UDL:308
D (2922) esp_netif_lwip: call api in lwip: ret=0x0, give sem
D (2926) event: running post WIFI_EVENT:4 with handler 0x400ec9bc and context 0x3ffcc0a0 on loop 0x3ffbe7e8
I (2936) intf-tx: 0x3f407f5c   57 49 46 49 20 43 4f 4e  4e 45 43 54 45 44 0d 0a  |WIFI CONNECTED..|
I (2937) wifi:<ba-add>idx:1 (ifx:0, 8c:6a:8d:d9:aa:e0), tid:6, ssn:0, winSize:64
D (2946) event: running post WIFI_EVENT:4 with handler 0x400ed6c8 and context 0x3ffcf23c on loop 0x3ffbe7e8
I (2965) udp-rx: IPL:328, SP:67, DP:68, UDL:300
I (2968) udp-tx: IPL:336, SP:68, DP:67, UDL:308
D (2976) nvs: nvs_open_from_partition NVM_008 1
D (2977) nvs: nvs_get dns_ser0 4
D (2980) nvs: nvs_get dns_ser1 4
D (2983) nvs: nvs_get dns_ser2 4
D (2987) nvs: nvs_get_str_or_blob dns_svr0
D (2991) nvs: nvs_close 12
D (2994) esp_netif_lwip: check: remote, if=0x3ffc02a0 fn=0x4011ecb8

D (3000) esp_netif_lwip: esp_netif_set_dns_info_api esp_netif:0x3ffc02a0
D (3007) esp_netif_lwip: set dns if=0x3ffc02a0 type=0 dns=dede43d0
D (3013) esp_netif_lwip: call api in lwip: ret=0x0, give sem
I (3016) udp-rx: IPL:328, SP:67, DP:68, UDL:300
D (3027) esp_netif_lwip: check: remote, if=0x3ffc02a0 fn=0x4011ecb8

D (3030) esp_netif_lwip: esp_netif_set_dns_info_api esp_netif:0x3ffc02a0
D (3037) esp_netif_lwip: set dns if=0x3ffc02a0 type=2 dns=8080808
D (3043) esp_netif_lwip: call api in lwip: ret=0x0, give sem
D (3049) nvs: nvs_open_from_partition NVM_009 1
D (3053) nvs: nvs_get maxlink 1
D (3057) nvs: nvs_open_from_partition NVM_009 0
D (3061) nvs: nvs_get auth0 1
D (3064) nvs: nvs_open_from_partition NVM_009 0
D (3069) nvs: nvs_get auth1 1
D (3072) nvs: nvs_open_from_partition NVM_009 0
D (3076) nvs: nvs_get auth2 1
D (3079) nvs: nvs_open_from_partition NVM_009 0
D (3084) nvs: nvs_get auth3 1
D (3087) nvs: nvs_open_from_partition NVM_009 0
D (3091) nvs: nvs_get auth4 1
D (3094) nvs: nvs_open_from_partition NVM_018 0
D (3099) nvs: nvs_open_from_partition NVM_005 1
D (3104) nvs: nvs_get enable 1
D (3107) nvs: nvs_close 19
D (3109) at-cmd-register: esp_at_net_cmd_regist success
D (3115) at-cmd-register: esp_at_ping_cmd_regist success
D (3120) at-cmd-register: esp_at_mqtt_cmd_regist success
D (3125) at-cmd-register: esp_at_http_cmd_regist success
D (3131) at-cmd-register: esp_at_fact_cmd_regist success
D (3136) at-cmd-register: esp_at_ota_cmd_regist success
D (3141) at-cmd-register: esp_at_uart_cmd_regist success
D (3147) at-cmd-register: esp_at_user_cmd_regist success
I (3152) intf-tx: 0x3f4043ec   0d 0a 72 65 61 64 79 0d  0a                       |..ready..|
D (3161) at-init: esp_at_init done
I (3164) main_task: Returned from app_main()
D (3925) esp_netif_lwip: esp_netif_internal_dhcpc_cb lwip-netif:0x3ffc0324
D (3926) esp_netif_lwip: if0x3ffc02a0 ip changed=1
D (3927) event: running post IP_EVENT:0 with handler 0x401320d4 and context 0x3ffc0644 on loop 0x3ffbe7e8
D (3936) wifi_init_default: Got IP wifi default handler entered
D (3942) esp_netif_handlers: esp_netif action got_ip with netif0x3ffc02a0 from event_id=0
I (3950) esp_netif_handlers: sta ip: 192.168.0.171, mask: 255.255.255.0, gw: 192.168.0.1
D (3959) event: running post IP_EVENT:0 with handler 0x400ed478 and context 0x3ffcc0e0 on loop 0x3ffbe7e8
I (3969) intf-tx: 0x3f408004   57 49 46 49 20 47 4f 54  20 49 50 0d 0a           |WIFI GOT IP..|
negotiated phy mode: 3
D (3980) event: running post IP_EVENT:0 with handler 0x400e17f4 and context 0x3ffd04e4 on loop 0x3ffbe7e8
I (4682) intf-rx: 0x3ffb3c1c   41 54 45 30 0d 0a                                 |ATE0..|
I (4683) intf-tx: 0x3ffb3c1c   41 54 45 30 0d 0a                                 |ATE0..|
I (4691) intf-tx: 0x3f407a9c   0d 0a 4f 4b 0d 0a                                 |..OK..|
I (4715) intf-rx: 0x3ffb3c1c   41 54 2b 43 57 4d 4f 44  45 3d 31 0d 0a           |AT+CWMODE=1..|
I (4716) intf-tx: 0x3f407a9c   0d 0a 4f 4b 0d 0a                                 |..OK..|
I (4739) intf-rx: 0x3ffb3c1c   41 54 2b 43 49 50 4d 55  58 3d 31 0d 0a           |AT+CIPMUX=1..|
I (4741) intf-tx: 0x3f407a9c   0d 0a 4f 4b 0d 0a                                 |..OK..|
I (4764) intf-rx: 0x3ffb3c1c   41 54 2b 43 49 50 52 45  43 56 4d 4f 44 45 3d 31  |AT+CIPRECVMODE=1|
I (4764) intf-rx: 0x3ffb3c2c   0d 0a                                             |..|
I (4777) intf-tx: 0x3f407a9c   0d 0a 4f 4b 0d 0a                                 |..OK..|
I (4797) intf-rx: 0x3ffb3c1c   41 54 2b 43 57 53 54 41  54 45 3f 0d 0a           |AT+CWSTATE?..|
I (4799) intf-tx: 0x3ffcd9cc   2b 43 57 53 54 41 54 45  3a 32 2c 22 54 65 6e 64  |+CWSTATE:2,"Tend|
I (4805) intf-tx: 0x3ffcd9dc   75 6c 6b 61 72 32 47 48  7a 22 0d 0a              |ulkar2GHz"..|
I (4815) intf-tx: 0x3f407a9c   0d 0a 4f 4b 0d 0a                                 |..OK..|
I (4840) intf-rx: 0x3ffb3c1c   41 54 2b 43 49 50 53 54  41 54 45 3f 0d 0a        |AT+CIPSTATE?..|
I (4842) intf-tx: 0x3f407a9c   0d 0a 4f 4b 0d 0a                                 |..OK..|
I (4863) intf-rx: 0x3ffb3c1c   41 54 2b 43 57 4c 41 50  0d 0a                    |AT+CWLAP..|
D (4865) wifi:Start wifi scan
D (4866) wifi:ssid=, channel=0, hidden=1, type=active, active=<0,0>, passive=0
D (4871) wifi:home_channel_dwell_time=30
D (4875) wifi:first chan=11
D (4878) wifi:filter: set rx policy=3
D (4881) wifi:clear scan ap list
D (4884) wifi:start scan: type=0x50f, priority=3, cb=0, arg=0x3ffb8ab8, ss_state=0x1, time=2911382, index=0
D (4893) wifi:perform scan: ss_state=0x9, chan<11,0>, dur<0,120>
D (5020) wifi:scan end: arg=0, status=0, ss_state=0x3
D (5051) wifi:perform scan: ss_state=0x9, chan<1,0>, dur<0,120>
D (5172) wifi:scan end: arg=0, status=0, ss_state=0x3
D (5204) wifi:perform scan: ss_state=0x9, chan<2,0>, dur<0,120>
D (5325) wifi:scan end: arg=0, status=0, ss_state=0x3
D (5357) wifi:perform scan: ss_state=0x9, chan<3,0>, dur<0,120>
D (5479) wifi:scan end: arg=0, status=0, ss_state=0x3
D (5510) wifi:perform scan: ss_state=0x9, chan<4,0>, dur<0,120>
D (5632) wifi:scan end: arg=0, status=0, ss_state=0x3
D (5663) wifi:perform scan: ss_state=0x9, chan<5,0>, dur<0,120>
D (5785) wifi:scan end: arg=0, status=0, ss_state=0x3
D (5816) wifi:perform scan: ss_state=0x9, chan<6,0>, dur<0,120>
D (5938) wifi:scan end: arg=0, status=0, ss_state=0x3
D (5969) wifi:perform scan: ss_state=0x9, chan<7,0>, dur<0,120>
D (6091) wifi:scan end: arg=0, status=0, ss_state=0x3
D (6122) wifi:perform scan: ss_state=0x9, chan<8,0>, dur<0,120>
D (6243) wifi:scan end: arg=0, status=0, ss_state=0x3
D (6274) wifi:perform scan: ss_state=0x9, chan<9,0>, dur<0,120>
D (6396) wifi:scan end: arg=0, status=0, ss_state=0x3
D (6428) wifi:perform scan: ss_state=0x9, chan<10,0>, dur<0,120>
D (6549) wifi:scan end: arg=0, status=0, ss_state=0x3
D (6581) wifi:perform scan: ss_state=0x9, chan<12,0>, dur<0,120>
D (6702) wifi:scan end: arg=0, status=0, ss_state=0x3
D (6733) wifi:perform scan: ss_state=0x9, chan<13,0>, dur<0,120>
D (6855) wifi:scan end: arg=0, status=0, ss_state=0x3
D (6886) wifi:filter: set rx policy=4
D (6887) wifi:first chan=1
D (6887) wifi:Send scan done event: status=0, apnum=15
D (6889) event: running post WIFI_EVENT:1 with handler 0x400ea934 and context 0x3ffcc178 on loop 0x3ffbe7e8
D (6896) event: running post WIFI_EVENT:1 with handler 0x400ed6c8 and context 0x3ffcf23c on loop 0x3ffbe7e8
I (6908) intf-tx: 0x3ffd07f0   2b 43 57 4c 41 50 3a 28  33 2c 22 54 65 6e 64 75  |+CWLAP:(3,"Tendu|
I (6916) intf-tx: 0x3ffd0800   6c 6b 61 72 32 47 48 7a  22 2c 2d 36 30 2c 22 38  |lkar2GHz",-60,"8|
I (6925) intf-tx: 0x3ffd0810   63 3a 36 61 3a 38 64 3a  64 39 3a 61 61 3a 65 30  |c:6a:8d:d9:aa:e0|
I (6935) intf-tx: 0x3ffd0820   22 2c 31 31 2c 2d 31 2c  2d 31 2c 34 2c 34 2c 37  |",11,-1,-1,4,4,7|
I (6945) intf-tx: 0x3ffd0830   2c 31 29 0d 0a                                    |,1)..|
I (6954) intf-tx: 0x3ffd07f0   2b 43 57 4c 41 50 3a 28  30 2c 22 56 6f 64 61 66  |+CWLAP:(0,"Vodaf|
I (6963) intf-tx: 0x3ffd0800   6f 6e 65 20 48 6f 6d 65  73 70 6f 74 22 2c 2d 36  |one Homespot",-6|
I (6973) intf-tx: 0x3ffd0810   31 2c 22 38 65 3a 36 61  3a 38 64 3a 64 39 3a 61  |1,"8e:6a:8d:d9:a|
I (6983) intf-tx: 0x3ffd0820   61 3a 65 32 22 2c 31 31  2c 2d 31 2c 2d 31 2c 30  |a:e2",11,-1,-1,0|
I (6992) intf-tx: 0x3ffd0830   2c 30 2c 37 2c 30 29 0d  0a                       |,0,7,0)..|
I (7002) intf-tx: 0x3ffd07f0   2b 43 57 4c 41 50 3a 28  30 2c 22 56 6f 64 61 66  |+CWLAP:(0,"Vodaf|
I (7011) intf-tx: 0x3ffd0800   6f 6e 65 20 48 6f 74 73  70 6f 74 22 2c 2d 36 31  |one Hotspot",-61|
I (7020) intf-tx: 0x3ffd0810   2c 22 38 65 3a 36 61 3a  38 64 3a 64 39 3a 61 61  |,"8e:6a:8d:d9:aa|
I (7030) intf-tx: 0x3ffd0820   3a 65 34 22 2c 31 31 2c  2d 31 2c 2d 31 2c 30 2c  |:e4",11,-1,-1,0,|
I (7039) intf-tx: 0x3ffd0830   30 2c 37 2c 30 29 0d 0a                           |0,7,0)..|
I (7049) intf-tx: 0x3ffd07f0   2b 43 57 4c 41 50 3a 28  33 2c 22 56 6f 64 61 66  |+CWLAP:(3,"Vodaf|
I (7058) intf-tx: 0x3ffd0800   6f 6e 65 2d 44 41 44 45  22 2c 2d 37 32 2c 22 36  |one-DADE",-72,"6|
I (7068) intf-tx: 0x3ffd0810   63 3a 36 33 3a 39 63 3a  35 30 3a 61 38 3a 64 61  |c:63:9c:50:a8:da|
I (7078) intf-tx: 0x3ffd0820   22 2c 31 2c 2d 31 2c 2d  31 2c 34 2c 34 2c 36 2c  |",1,-1,-1,4,4,6,|
I (7087) intf-tx: 0x3ffd0830   31 29 0d 0a                                       |1)..|
I (7096) intf-tx: 0x3ffd07f0   2b 43 57 4c 41 50 3a 28  30 2c 22 56 6f 64 61 66  |+CWLAP:(0,"Vodaf|
I (7106) intf-tx: 0x3ffd0800   6f 6e 65 20 48 6f 6d 65  73 70 6f 74 22 2c 2d 37  |one Homespot",-7|
I (7115) intf-tx: 0x3ffd0810   32 2c 22 36 65 3a 36 33  3a 39 63 3a 35 30 3a 61  |2,"6e:63:9c:50:a|
I (7125) intf-tx: 0x3ffd0820   38 3a 64 65 22 2c 31 2c  2d 31 2c 2d 31 2c 30 2c  |8:de",1,-1,-1,0,|
I (7134) intf-tx: 0x3ffd0830   30 2c 36 2c 30 29 0d 0a                           |0,6,0)..|
I (7144) intf-tx: 0x3ffd07f0   2b 43 57 4c 41 50 3a 28  30 2c 22 56 6f 64 61 66  |+CWLAP:(0,"Vodaf|
I (7153) intf-tx: 0x3ffd0800   6f 6e 65 20 48 6f 74 73  70 6f 74 22 2c 2d 37 32  |one Hotspot",-72|
I (7163) intf-tx: 0x3ffd0810   2c 22 36 65 3a 36 33 3a  39 63 3a 35 30 3a 61 38  |,"6e:63:9c:50:a8|
I (7172) intf-tx: 0x3ffd0820   3a 64 63 22 2c 31 2c 2d  31 2c 2d 31 2c 30 2c 30  |:dc",1,-1,-1,0,0|
I (7183) intf-tx: 0x3ffd0830   2c 36 2c 30 29 0d 0a                              |,6,0)..|
I (7192) intf-tx: 0x3ffd07f0   2b 43 57 4c 41 50 3a 28  33 2c 22 4b 61 62 65 6c  |+CWLAP:(3,"Kabel|
I (7201) intf-tx: 0x3ffd0800   42 6f 78 2d 35 33 38 43  22 2c 2d 38 30 2c 22 39  |Box-538C",-80,"9|
I (7210) intf-tx: 0x3ffd0810   30 3a 35 63 3a 34 34 3a  34 37 3a 66 30 3a 38 33  |0:5c:44:47:f0:83|
I (7220) intf-tx: 0x3ffd0820   22 2c 31 31 2c 2d 31 2c  2d 31 2c 35 2c 33 2c 37  |",11,-1,-1,5,3,7|
I (7229) intf-tx: 0x3ffd0830   2c 31 29 0d 0a                                    |,1)..|
I (7239) intf-tx: 0x3ffd07f0   2b 43 57 4c 41 50 3a 28  30 2c 22 56 6f 64 61 66  |+CWLAP:(0,"Vodaf|
I (7248) intf-tx: 0x3ffd0800   6f 6e 65 20 48 6f 74 73  70 6f 74 22 2c 2d 38 30  |one Hotspot",-80|
I (7258) intf-tx: 0x3ffd0810   2c 22 38 36 3a 35 63 3a  34 34 3a 34 37 3a 66 30  |,"86:5c:44:47:f0|
I (7267) intf-tx: 0x3ffd0820   3a 38 33 22 2c 31 31 2c  2d 31 2c 2d 31 2c 30 2c  |:83",11,-1,-1,0,|
I (7277) intf-tx: 0x3ffd0830   30 2c 37 2c 30 29 0d 0a                           |0,7,0)..|
I (7286) intf-tx: 0x3ffd07f0   2b 43 57 4c 41 50 3a 28  30 2c 22 56 6f 64 61 66  |+CWLAP:(0,"Vodaf|
I (7296) intf-tx: 0x3ffd0800   6f 6e 65 20 48 6f 6d 65  73 70 6f 74 22 2c 2d 38  |one Homespot",-8|
I (7305) intf-tx: 0x3ffd0810   30 2c 22 38 61 3a 35 63  3a 34 34 3a 34 37 3a 66  |0,"8a:5c:44:47:f|
I (7315) intf-tx: 0x3ffd0820   30 3a 38 33 22 2c 31 31  2c 2d 31 2c 2d 31 2c 30  |0:83",11,-1,-1,0|
I (7324) intf-tx: 0x3ffd0830   2c 30 2c 37 2c 30 29 0d  0a                       |,0,7,0)..|
I (7334) intf-tx: 0x3ffd07f0   2b 43 57 4c 41 50 3a 28  37 2c 22 31 59 22 2c 2d  |+CWLAP:(7,"1Y",-|
I (7343) intf-tx: 0x3ffd0800   38 34 2c 22 34 38 3a 35  64 3a 33 35 3a 30 31 3a  |84,"48:5d:35:01:|
I (7353) intf-tx: 0x3ffd0810   65 66 3a 33 30 22 2c 36  2c 2d 31 2c 2d 31 2c 34  |ef:30",6,-1,-1,4|
I (7362) intf-tx: 0x3ffd0820   2c 34 2c 37 2c 30 29 0d  0a                       |,4,7,0)..|
I (7372) intf-tx: 0x3ffd07f0   2b 43 57 4c 41 50 3a 28  33 2c 22 57 4c 41 4e 2d  |+CWLAP:(3,"WLAN-|
I (7381) intf-tx: 0x3ffd0800   51 33 5a 53 58 51 22 2c  2d 39 30 2c 22 63 63 3a  |Q3ZSXQ",-90,"cc:|
I (7392) intf-tx: 0x3ffd0810   61 32 3a 32 33 3a 62 34  3a 37 30 3a 36 66 22 2c  |a2:23:b4:70:6f",|
I (7401) intf-tx: 0x3ffd0820   31 31 2c 2d 31 2c 2d 31  2c 34 2c 34 2c 37 2c 31  |11,-1,-1,4,4,7,1|
I (7410) intf-tx: 0x3ffd0830   29 0d 0a                                          |)..|
I (7420) intf-tx: 0x3ffd07f0   2b 43 57 4c 41 50 3a 28  33 2c 22 57 4c 41 4e 2d  |+CWLAP:(3,"WLAN-|
I (7429) intf-tx: 0x3ffd0800   4d 32 48 5a 34 52 22 2c  2d 39 30 2c 22 33 30 3a  |M2HZ4R",-90,"30:|
I (7438) intf-tx: 0x3ffd0810   37 34 3a 39 36 3a 30 39  3a 33 33 3a 35 34 22 2c  |74:96:09:33:54",|
I (7448) intf-tx: 0x3ffd0820   31 2c 2d 31 2c 2d 31 2c  34 2c 34 2c 37 2c 31 29  |1,-1,-1,4,4,7,1)|
I (7457) intf-tx: 0x3ffd0830   0d 0a                                             |..|
I (7466) intf-tx: 0x3ffd07f0   2b 43 57 4c 41 50 3a 28  33 2c 22 46 52 49 54 5a  |+CWLAP:(3,"FRITZ|
I (7476) intf-tx: 0x3ffd0800   21 42 6f 78 20 37 35 36  30 20 57 59 22 2c 2d 39  |!Box 7560 WY",-9|
I (7485) intf-tx: 0x3ffd0810   32 2c 22 63 63 3a 63 65  3a 31 65 3a 36 63 3a 30  |2,"cc:ce:1e:6c:0|
I (7495) intf-tx: 0x3ffd0820   32 3a 37 35 22 2c 31 2c  2d 31 2c 2d 31 2c 34 2c  |2:75",1,-1,-1,4,|
I (7504) intf-tx: 0x3ffd0830   34 2c 37 2c 31 29 0d 0a                           |4,7,1)..|
I (7514) intf-tx: 0x3ffd07f0   2b 43 57 4c 41 50 3a 28  34 2c 22 46 52 49 54 5a  |+CWLAP:(4,"FRITZ|
I (7523) intf-tx: 0x3ffd0800   21 42 6f 78 20 36 33 36  30 20 43 61 62 6c 65 22  |!Box 6360 Cable"|
I (7533) intf-tx: 0x3ffd0810   2c 2d 39 33 2c 22 63 30  3a 32 35 3a 30 36 3a 66  |,-93,"c0:25:06:f|
I (7543) intf-tx: 0x3ffd0820   31 3a 35 31 3a 33 39 22  2c 31 2c 2d 31 2c 2d 31  |1:51:39",1,-1,-1|
I (7552) intf-tx: 0x3ffd0830   2c 34 2c 33 2c 37 2c 31  29 0d 0a                 |,4,3,7,1)..|
I (7562) intf-tx: 0x3ffd07f0   2b 43 57 4c 41 50 3a 28  33 2c 22 6f 32 2d 57 4c  |+CWLAP:(3,"o2-WL|
I (7571) intf-tx: 0x3ffd0800   41 4e 35 31 22 2c 2d 39  33 2c 22 66 38 3a 35 62  |AN51",-93,"f8:5b|
I (7581) intf-tx: 0x3ffd0810   3a 33 62 3a 61 39 3a 38  65 3a 66 31 22 2c 33 2c  |:3b:a9:8e:f1",3,|
I (7590) intf-tx: 0x3ffd0820   2d 31 2c 2d 31 2c 34 2c  34 2c 37 2c 31 29 0d 0a  |-1,-1,4,4,7,1)..|
I (7600) intf-tx: 0x3f407a9c   0d 0a 4f 4b 0d 0a                                 |..OK..|
I (7637) intf-rx: 0x3ffb3c1c   41 54 2b 43 57 4a 41 50  3d 22 54 65 6e 64 75 6c  |AT+CWJAP="Tendul|
I (7637) intf-rx: 0x3ffb3c2c   6b 61 72 32 47 48 7a 22  2c 22 30 37 30 38 41 72  |kar2GHz","0708Ar|
I (7645) intf-rx: 0x3ffb3c3c   61 76 54 65 6e 5b 5d 40  22 0d 0a                 |avTen[]@"..|
D (7656) wifi:Start wifi disconnect
I (7658) wifi:state: run -> init (0)
D (7661) wifi:connect status 5 -> 6
D (7664) wifi:stop beacon/connect timer, send diassoc(8)
D (7670) wifi:sta leave
I (7671) wifi:pm stop, total sleep time: lu us / lu us

D (7676) wifi:stop CSA timer
I (7679) wifi:<ba-del>idx
I (7681) wifi:<ba-del>idx
D (7684) wifi:remove 8c:6a:8d:d9:aa:e0 from rc list
I (7688) wifi:new:<11,0>, old:<11,0>, ap:<255,255>, sta:<11,0>, prof:1
D (7694) wifi:filter: set rx policy=8
D (7698) wifi:Send disconnect event, reason=8, AP number=0
D (7703) wifi:connect status 6 -> 0
D (7706) wifi:filter: set rx policy=8
D (7710) event: running post WIFI_EVENT:5 with handler 0x40132290 and context 0x3ffc05a0 on loop 0x3ffbe7e8
D (7719) esp_netif_handlers: esp_netif action disconnected with netif0x3ffc02a0 from event_id=5
D (7728) esp_netif_lwip: check: remote, if=0x3ffc02a0 fn=0x4011f19c

D (7734) esp_netif_lwip: esp_netif_down_api esp_netif:0x3ffc02a0
E (7741) @@if-tx: netif tx error, tot_len:42 len:42 ret: 12294
D (7747) esp_netif_lwip: esp_netif_internal_dhcpc_cb lwip-netif:0x3ffc0324
D (7754) esp_netif_lwip: esp_netif_start_ip_lost_timer esp_netif:0x3ffc02a0
D (7761) esp_netif_lwip: if0x3ffc02a0 start ip lost tmr: interval=120
D (7767) esp_netif_lwip: esp_netif_start_ip_lost_timer esp_netif:0x3ffc02a0
D (7774) esp_netif_lwip: if0x3ffc02a0 start ip lost tmr: already started
D (7781) esp_netif_lwip: check: local, if=0x3ffc02a0 fn=0x4011fcec

D (7787) esp_netif_lwip: esp_netif_update_default_netif_lwip 0x3ffc02a0
D (7794) esp_netif_lwip: call api in lwip: ret=0x0, give sem
D (7800) event: running post WIFI_EVENT:5 with handler 0x400ed07c and context 0x3ffcc0c0 on loop 0x3ffbe7e8
wifi disconnected, rc:8
I (7812) intf-tx: 0x3f407f8c   57 49 46 49 20 44 49 53  43 4f 4e 4e 45 43 54 0d  |WIFI DISCONNECT.|
I (7821) intf-tx: 0x3f407f9c   0a                                                |.|
D (7830) event: running post WIFI_EVENT:5 with handler 0x400ed6c8 and context 0x3ffcf23c on loop 0x3ffbe7e8
D (7839) event: running post WIFI_EVENT:5 with handler 0x400e522c and context 0x3ffcf63c on loop 0x3ffbe7e8
D (7850) wifi:clear blacklist
D (7852) nvs: nvs_get_str_or_blob sta.ssid
D (7857) nvs: nvs_get sta.pmf_e 1
D (7860) nvs: nvs_open_from_partition NVM_017 0
D (7864) nvs: nvs_get flag 1
D (7867) nvs: nvs_get wris 4
D (7870) nvs: nvs_get wrrc 4
D (7873) nvs: nvs_close 20
D (7875) nvs: nvs_open_from_partition NVM_017 1
D (7880) nvs: nvs_set wris 4 1
D (7883) nvs: nvs_set wrrc 4 0
D (7886) nvs: nvs_close 21
D (7890) wifi:Start wifi connect
D (7892) wifi:connect status 0 -> 0
D (7895) wifi:connect chan=0
D (7898) wifi:first chan=11
D (7900) wifi:connect status 0 -> 1
D (7903) wifi:filter: set rx policy=3
D (7907) wifi:clear scan ap list
D (7910) wifi:start scan: type=0x50f, priority=2, cb=0x401750cc, arg=0, ss_state=0x1, time=5941086, index=0
D (7919) wifi:perform scan: ss_state=0x9, chan<11,0>, dur<0,120>
D (7927) nvs: nvs_open_from_partition NVM_013 1
D (7929) nvs: nvs_set apmode 4 0
D (7931) wifi:rsn valid: gcipher=3 ucipher=3 akm=5

D (7938) wifi:profile match: ss_state=0x7
D (7941) wifi:scan end: arg=0, status=0, ss_state=0x7
D (7946) wifi:find first mathched ssid, scan done
D (7950) wifi:filter: set rx policy=4
D (7953) wifi:first chan=1
D (7956) wifi:handoff_cb: status=0
D (7959) wifi:ap found, mac=8c:6a:8d:d9:aa:e0
D (7963) wifi:new_bss=0x3ffb93e0, cur_bss=0, new_chan=<11,0>, cur_chan=11
D (7969) wifi:filter: set rx policy=5
I (7973) wifi:new:<11,0>, old:<11,0>, ap:<255,255>, sta:<11,0>, prof:1
D (7979) wifi:connect_op: status=0, auth=5, cipher=3
D (7985) wifi:auth mode is not none
D (7987) wifi:connect_bss: auth=1, reconnect=0
I (7991) wifi:state: init -> auth (b0)
D (7995) wifi:start 1s AUTH timer
D (7998) wifi:clear scan ap list
D (8001) nvs: nvs_close 22
D (8002) wifi:recv auth: seq=2, status=0
I (8007) wifi:state: auth -> assoc (0)
D (8011) wifi:restart connect 1s timer for assoc
D (8021) wifi:recv assoc: type=0x10
D (8022) wifi:filter: set rx policy=6
I (8022) wifi:state: assoc -> run (10)
D (8025) wifi:start 10s connect timer for 4 way handshake
I (8036) wifi:<ba-add>idx:0 (ifx:0, 8c:6a:8d:d9:aa:e0), tid:0, ssn:0, winSize:64
I (8047) wifi:connected with Tendulkar2GHz, aid = 22, channel 11, BW20, bssid = 8c:6a:8d:d9:aa:e0
I (8048) wifi:security: WPA2-PSK, phy: bgn, rssi: -61
D (8050) wifi:remove all except 8c:6a:8d:d9:aa:e0 from rc list
D (8056) wifi:clear blacklist
D (8058) nvs: nvs_set sta.chan 1 11
D (8062) nvs: nvs_set_blob sta.apinfo 700
D (8068) wifi:filter: set rx policy=7
I (8069) wifi:pm start, type: 1

D (8072) wifi:Send sta connected event
D (8076) wifi:connect status 1 -> 5
D (8079) wifi:obss scan is disabled
D (8082) wifi:start obss scan: obss scan is stopped
D (8087) event: running post WIFI_EVENT:4 with handler 0x401322a8 and context 0x3ffc04fc on loop 0x3ffbe7e8
D (8097) esp_netif_handlers: esp_netif action connected with netif0x3ffc02a0 from event_id=4
D (8105) esp_netif_lwip: check: remote, if=0x3ffc02a0 fn=0x4011f14c

I (8108) wifi:AP's beacon interval = 102400 us, DTIM period = 1
D (8118) wifi:set max rate: from <rate=130, phy=3, sig=0> to <rate=144, phy=3 sig=0>
D (8124) wifi:sig_b=0, sig_g=0, sig_n=0, max_b=22, max_g=108, max_n=144
D (8131) wifi:update trc
D (8134) esp_netif_lwip: esp_netif_up_api esp_netif:0x3ffc02a0
D (8139) esp_netif_lwip: check: local, if=0x3ffc02a0 fn=0x4011fcec

D (8145) esp_netif_lwip: esp_netif_update_default_netif_lwip 0x3ffc02a0
D (8152) esp_netif_lwip: call api in lwip: ret=0x0, give sem
D (8158) esp_netif_lwip: check: remote, if=0x3ffc02a0 fn=0x4011e96c

D (8164) esp_netif_lwip: esp_netif_dhcpc_start_api esp_netif:0x3ffc02a0
D (8171) esp_netif_lwip: esp_netif_start_ip_lost_timer esp_netif:0x3ffc02a0
D (8178) esp_netif_lwip: if0x3ffc02a0 start ip lost tmr: already started
D (8184) esp_netif_lwip: starting dhcp client
I (8190) udp-tx: IPL:336, SP:68, DP:67, UDL:308
D (8196) esp_netif_lwip: call api in lwip: ret=0x0, give sem
D (8200) event: running post WIFI_EVENT:4 with handler 0x400ec9bc and context 0x3ffcc0a0 on loop 0x3ffbe7e8
I (8208) udp-rx: IPL:328, SP:67, DP:68, UDL:300
I (8210) intf-tx: 0x3f407f5c   57 49 46 49 20 43 4f 4e  4e 45 43 54 45 44 0d 0a  |WIFI CONNECTED..|
I (8215) wifi:<ba-add>idx:1 (ifx:0, 8c:6a:8d:d9:aa:e0), tid:6, ssn:0, winSize:64
D (8225) event: running post WIFI_EVENT:4 with handler 0x400ed6c8 and context 0x3ffcf23c on loop 0x3ffbe7e8
I (8242) udp-tx: IPL:336, SP:68, DP:67, UDL:308
I (8255) udp-rx: IPL:328, SP:67, DP:68, UDL:300
D (9198) esp_netif_lwip: esp_netif_internal_dhcpc_cb lwip-netif:0x3ffc0324
D (9199) esp_netif_lwip: if0x3ffc02a0 ip changed=0
D (9200) event: running post IP_EVENT:0 with handler 0x401320d4 and context 0x3ffc0644 on loop 0x3ffbe7e8
D (9209) wifi_init_default: Got IP wifi default handler entered
D (9215) esp_netif_handlers: esp_netif action got_ip with netif0x3ffc02a0 from event_id=0
I (9223) esp_netif_handlers: sta ip: 192.168.0.171, mask: 255.255.255.0, gw: 192.168.0.1
D (9232) event: running post IP_EVENT:0 with handler 0x400ed478 and context 0x3ffcc0e0 on loop 0x3ffbe7e8
I (9242) intf-tx: 0x3f408004   57 49 46 49 20 47 4f 54  20 49 50 0d 0a           |WIFI GOT IP..|
negotiated phy mode: 3
D (9254) event: running post IP_EVENT:0 with handler 0x400e17f4 and context 0x3ffd04e4 on loop 0x3ffbe7e8
I (9263) intf-tx: 0x3f407a9c   0d 0a 4f 4b 0d 0a                                 |..OK..|
I (9288) intf-rx: 0x3ffb3c1c   41 54 2b 43 57 53 54 41  54 45 3f 0d 0a           |AT+CWSTATE?..|
I (9290) intf-tx: 0x3ffcd9cc   2b 43 57 53 54 41 54 45  3a 32 2c 22 54 65 6e 64  |+CWSTATE:2,"Tend|
I (9297) intf-tx: 0x3ffcd9dc   75 6c 6b 61 72 32 47 48  7a 22 0d 0a              |ulkar2GHz"..|
I (9306) intf-tx: 0x3f407a9c   0d 0a 4f 4b 0d 0a                                 |..OK..|
I (9331) intf-rx: 0x3ffb3c1c   41 54 2b 43 49 50 4d 55  58 3d 31 0d 0a           |AT+CIPMUX=1..|
I (9333) intf-tx: 0x3f407a9c   0d 0a 4f 4b 0d 0a                                 |..OK..|
I (9361) intf-rx: 0x3ffb3c1c   41 54 2b 43 49 50 53 54  41 52 54 3d 33 2c 22 53  |AT+CIPSTART=3,"S|
I (9362) intf-rx: 0x3ffb3c2c   53 4c 22 2c 22 31 39 32  2e 31 36 38 2e 30 2e 31  |SL","192.168.0.1|
I (9370) intf-rx: 0x3ffb3c3c   31 35 22 2c 32 35 32 35  2c 30 0d 0a              |15",2525,0..|
D (9384) esp-tls: host:192.168.0.115: strlen 13
D (9386) esp-tls: [sock=55] Resolved IPv4 address: 192.168.0.115
D (9390) esp-tls: [sock=55] Connecting to server. HOST: 192.168.0.115, Port: 2525
I (9448) @@tcp-tx: IPL:44, S:2503821538, A:0, SP:52705, DP:2525, F:0x2, TDL:0
I (9468) @@tcp-rx: IPL:44, S:708090138, A:2503821539, SP:2525, DP:52705, F:0x12, TDL:0
I (9471) @@tcp-tx: IPL:40, S:2503821539, A:708090139, SP:52705, DP:2525, F:0x10, TDL:0
D (9484) esp-tls: handshake in progress...
I (9490) @@tcp-tx: IPL:292, S:2503821539, A:708090139, SP:52705, DP:2525, F:0x18, TDL:252
I (9525) @@tcp-rx: IPL:1274, S:708090139, A:2503821791, SP:2525, DP:52705, F:0x18, TDL:1234
I (9647) @@tcp-tx: IPL:40, S:2503821791, A:708091373, SP:52705, DP:2525, F:0x10, TDL:0
I (10293) @@tcp-tx: IPL:82, S:2503821791, A:708091373, SP:52705, DP:2525, F:0x18, TDL:42
I (10369) @@tcp-rx: IPL:40, S:708091373, A:2503821833, SP:2525, DP:52705, F:0x10, TDL:0
I (10372) @@tcp-tx: IPL:91, S:2503821833, A:708091373, SP:52705, DP:2525, F:0x18, TDL:51
I (10391) @@tcp-rx: IPL:266, S:708091373, A:2503821884, SP:2525, DP:52705, F:0x18, TDL:226
I (10401) @@tcp-tx: IPL:40, S:2503821884, A:708091599, SP:52705, DP:2525, F:0x10, TDL:0
I (10410) intf-tx: 0x3ffd28a8   33 2c 43 4f 4e 4e 45 43  54 0d 0a                 |3,CONNECT..|
I (10413) intf-tx: 0x3f407a9c   0d 0a 4f 4b 0d 0a                                 |..OK..|
I (10441) intf-rx: 0x3ffb3c1c   41 54 2b 43 49 50 53 45  4e 44 4c 3d 33 2c 31 30  |AT+CIPSENDL=3,10|
I (10442) intf-rx: 0x3ffb3c2c   30 0d 0a                                          |0..|
I (10451) intf-tx: 0x3f407ab0   0d 0a 4f 4b 0d 0a 0d 0a  3e                       |..OK....>|
I (10490) intf-rx: 0x3ffb3c1c   41 42 43 44 45 46 47 48  49 4a 4b 4c 4d 4e 4f 50  |ABCDEFGHIJKLMNOP|
I (10491) intf-rx: 0x3ffb3c2c   51 52 53 54 55 56 57 58  59 5a 41 42 43 44 45 46  |QRSTUVWXYZABCDEF|
I (10499) intf-rx: 0x3ffb3c3c   47 48 49 4a 4b 4c 4d 4e  4f 50 51 52 53 54 55 56  |GHIJKLMNOPQRSTUV|
I (10509) intf-rx: 0x3ffb3c4c   57 58 59 5a 41 42 43 44  45 46 47 48 49 4a 4b 4c  |WXYZABCDEFGHIJKL|
I (10519) intf-rx: 0x3ffb3c5c   4d 4e 4f 50 51 52 53 54  55 56 57 58 59 5a 41 42  |MNOPQRSTUVWXYZAB|
I (10529) intf-rx: 0x3ffb3c6c   43 44 45 46 47 48 49 4a  4b 4c 4d 4e 4f 50 51 52  |CDEFGHIJKLMNOPQR|
I (10538) intf-rx: 0x3ffb3c7c   53 54 55 56                                       |STUV|
I (10550) @@tcp-tx: IPL:169, S:2503821884, A:708091599, SP:52705, DP:2525, F:0x18, TDL:129
I (10560) intf-tx: 0x3ffcd9a0   2b 43 49 50 53 45 4e 44  4c 3a 31 30 30 2c 31 30  |+CIPSENDL:100,10|
I (10566) intf-tx: 0x3ffcd9b0   30 0d 0a                                          |0..|
I (10575) intf-tx: 0x3f406444   0d 0a 53 45 4e 44 20 4f  4b 0d 0a                 |..SEND OK..|
I (10608) @@tcp-rx: IPL:40, S:708091599, A:2503822013, SP:2525, DP:52705, F:0x10, TDL:0
