SIP Registration doesn't get triggered through Ethernet connection (AUD-4550)

Logs in detail.

I (27) boot: ESP-IDF v4.4.4-dirty 2nd stage bootloader I (27) boot: compile time 10:03:06 I (27) boot: chip revision: v3.0 I (28) boot_comm: chip revision: 3, min. bootloader chip revision: 0 I (29) qio_mode: Enabling default flash chip QIO I (29) boot.esp32: SPI Speed : 80MHz I (30) boot.esp32: SPI Mode : QIO I (30) boot.esp32: SPI Flash Size : 8MB I (31) boot: Enabling RNG early entropy source... I (32) boot: Partition Table: I (32) boot: ## Label Usage Type ST Offset Length I (33) boot: 0 phy_init RF data 01 01 0000f000 00001000 I (34) boot: 1 otadata OTA data 01 00 00010000 00002000 I (35) boot: 2 nvs WiFi data 01 02 00012000 0000e000 I (36) boot: 3 ota_0 OTA app 00 10 00020000 00220000 I (37) boot: 4 ota_1 OTA app 00 11 00240000 00220000 I (38) boot: 5 at_customize unknown 40 00 00460000 00250000 I (39) boot: 6 flash_tone Unknown data 01 ff 006b0000 0007d000 I (40) boot: End of partition table I (40) boot: No factory image, trying OTA 0 I (41) boot_comm: chip revision: 3, min. application chip revision: 0 I (42) esp_image: segment 0: paddr=00020020 vaddr=3f400020 size=645cch (411084) map I (156) esp_image: segment 1: paddr=000845f4 vaddr=3ff80067 size=00008h ( 8) load I (156) esp_image: segment 2: paddr=00084604 vaddr=3ffbdb60 size=05ed0h ( 24272) load I (164) esp_image: segment 3: paddr=0008a4dc vaddr=40080000 size=05b3ch ( 23356) load I (172) esp_image: segment 4: paddr=00090020 vaddr=400d0020 size=16998ch (1481100) map I (580) esp_image: segment 5: paddr=001f99b4 vaddr=40085b3c size=143c4h ( 82884) load I (607) esp_image: segment 6: paddr=0020dd80 vaddr=400c0000 size=00068h ( 104) load I (621) boot: Loaded app from partition at offset 0x20000 I (649) boot: Set actual ota_seq=1 in otadata[0] I (649) boot: Disabling RNG early entropy source... D (651) efuse: In EFUSE_BLK0DATA3_REG is used 3 bits starting with 9 bit D (651) efuse: In EFUSE_BLK0DATA3_REG is used 1 bits starting with 2 bit I (651) psram: This chip is ESP32-D0WD I (652) spiram: Found 64MBit SPI RAM device I (653) spiram: SPI RAM mode: flash 80m sram 80m I (653) spiram: PSRAM initialized, cache is in low/high (2-core) mode. I (654) cpu_start: Pro cpu up. D (654) efuse: In EFUSE_BLK0DATA3_REG is used 3 bits starting with 9 bit D (655) efuse: In EFUSE_BLK0DATA3_REG is used 1 bits starting with 2 bit I (656) cpu_start: Starting app cpu, entry point is 0x400818b4 I (0) cpu_start: App cpu up. I (1153) spiram: SPI SRAM memory test OK D (1161) clk: RTC_SLOW_CLK calibration value: 3228173 I (1162) cpu_start: Pro cpu start user code I (1162) cpu_start: cpu freq: 240000000 I (1162) cpu_start: Application information: I (1162) cpu_start: Project name: VOIP_AT I (1163) cpu_start: App version: 1 I (1163) cpu_start: Compile time: Apr 24 2023 10:01:57 I (1164) cpu_start: ELF file SHA256: 5201ecace8e3f4f8... I (1165) cpu_start: ESP-IDF: v4.4.4-dirty V (1165) memory_layout: reserved range is 0x3f46458c - 0x3f4645ec D (1166) memory_layout: Checking 12 reserved memory ranges: D (1167) memory_layout: Reserved memory range 0x3f800000 - 0x3fc00000 D (1168) memory_layout: Reserved memory range 0x3ffae000 - 0x3ffae6e0 D (1168) memory_layout: Reserved memory range 0x3ffae6e0 - 0x3ffaff10 D (1169) memory_layout: Reserved memory range 0x3ffb0000 - 0x3ffb6388 D (1170) memory_layout: Reserved memory range 0x3ffb8000 - 0x3ffb9a20 D (1171) memory_layout: Reserved memory range 0x3ffbdb28 - 0x3ffbdb5c D (1172) memory_layout: Reserved memory range 0x3ffbdb60 - 0x3ffc9700 D (1172) memory_layout: Reserved memory range 0x3ffe0000 - 0x3ffe0440 D (1173) memory_layout: Reserved memory range 0x3ffe3f20 - 0x3ffe4350 D (1174) memory_layout: Reserved memory range 0x40070000 - 0x40078000 D (1175) memory_layout: Reserved memory range 0x40078000 - 0x40080000 D (1176) memory_layout: Reserved memory range 0x40080000 - 0x40099f00 D (1177) memory_layout: Building list of available memory regions: V (1177) memory_layout: Examining memory region 0x3f800000 - 0x3fc00000 V (1178) memory_layout: Region 0x3f800000 - 0x3fc00000 inside of reserved 0x3f800000 - 0x3fc00000 V (1179) memory_layout: Examining memory region 0x3ffae000 - 0x3ffb0000 V (1180) memory_layout: Start of region 0x3ffae000 - 0x3ffb0000 overlaps reserved 0x3ffae000 - 0x3ffae6e0 V (1181) memory_layout: Start of region 0x3ffae6e0 - 0x3ffb0000 overlaps reserved 0x3ffae6e0 - 0x3ffaff10 D (1183) memory_layout: Available memory region 0x3ffaff10 - 0x3ffb0000 V (1183) memory_layout: Examining memory region 0x3ffb0000 - 0x3ffb8000 V (1184) memory_layout: Start of region 0x3ffb0000 - 0x3ffb8000 overlaps reserved 0x3ffb0000 - 0x3ffb6388 D (1185) memory_layout: Available memory region 0x3ffb6388 - 0x3ffb8000 V (1186) memory_layout: Examining memory region 0x3ffb8000 - 0x3ffc0000 V (1187) memory_layout: Start of region 0x3ffb8000 - 0x3ffc0000 overlaps reserved 0x3ffb8000 - 0x3ffb9a20 V (1188) memory_layout: Region 0x3ffb9a20 - 0x3ffc0000 contains reserved 0x3ffbdb28 - 0x3ffbdb5c D (1189) memory_layout: Available memory region 0x3ffb9a20 - 0x3ffbdb28 V (1190) memory_layout: Examining memory region 0x3ffbdb5c - 0x3ffc0000 V (1191) memory_layout: End of region 0x3ffbdb5c - 0x3ffc0000 overlaps reserved 0x3ffbdb60 - 0x3ffc9700 V (1192) memory_layout: Examining memory region 0x3ffc0000 - 0x3ffc2000 V (1193) memory_layout: Region 0x3ffc0000 - 0x3ffc2000 inside of reserved 0x3ffbdb60 - 0x3ffc9700 V (1194) memory_layout: Examining memory region 0x3ffc2000 - 0x3ffc4000 V (1195) memory_layout: Region 0x3ffc2000 - 0x3ffc4000 inside of reserved 0x3ffbdb60 - 0x3ffc9700 V (1196) memory_layout: Examining memory region 0x3ffc4000 - 0x3ffc6000 V (1197) memory_layout: Region 0x3ffc4000 - 0x3ffc6000 inside of reserved 0x3ffbdb60 - 0x3ffc9700 V (1198) memory_layout: Examining memory region 0x3ffc6000 - 0x3ffc8000 V (1199) memory_layout: Region 0x3ffc6000 - 0x3ffc8000 inside of reserved 0x3ffbdb60 - 0x3ffc9700 V (1200) memory_layout: Examining memory region 0x3ffc8000 - 0x3ffca000 V (1201) memory_layout: Start of region 0x3ffc8000 - 0x3ffca000 overlaps reserved 0x3ffbdb60 - 0x3ffc9700 D (1202) memory_layout: Available memory region 0x3ffc9700 - 0x3ffca000 V (1203) memory_layout: Examining memory region 0x3ffca000 - 0x3ffcc000 D (1204) memory_layout: Available memory region 0x3ffca000 - 0x3ffcc000 V (1205) memory_layout: Examining memory region 0x3ffcc000 - 0x3ffce000 D (1205) memory_layout: Available memory region 0x3ffcc000 - 0x3ffce000 V (1206) memory_layout: Examining memory region 0x3ffce000 - 0x3ffd0000 D (1207) memory_layout: Available memory region 0x3ffce000 - 0x3ffd0000 V (1208) memory_layout: Examining memory region 0x3ffd0000 - 0x3ffd2000 D (1209) memory_layout: Available memory region 0x3ffd0000 - 0x3ffd2000 V (1210) memory_layout: Examining memory region 0x3ffd2000 - 0x3ffd4000 D (1210) memory_layout: Available memory region 0x3ffd2000 - 0x3ffd4000 V (1211) memory_layout: Examining memory region 0x3ffd4000 - 0x3ffd6000 D (1212) memory_layout: Available memory region 0x3ffd4000 - 0x3ffd6000 V (1213) memory_layout: Examining memory region 0x3ffd6000 - 0x3ffd8000 D (1214) memory_layout: Available memory region 0x3ffd6000 - 0x3ffd8000 V (1215) memory_layout: Examining memory region 0x3ffd8000 - 0x3ffda000 D (1215) memory_layout: Available memory region 0x3ffd8000 - 0x3ffda000 V (1216) memory_layout: Examining memory region 0x3ffda000 - 0x3ffdc000 D (1217) memory_layout: Available memory region 0x3ffda000 - 0x3ffdc000 V (1218) memory_layout: Examining memory region 0x3ffdc000 - 0x3ffde000 D (1219) memory_layout: Available memory region 0x3ffdc000 - 0x3ffde000 V (1220) memory_layout: Examining memory region 0x3ffde000 - 0x3ffe0000 D (1220) memory_layout: Available memory region 0x3ffde000 - 0x3ffe0000 V (1221) memory_layout: Examining memory region 0x3ffe0000 - 0x3ffe4000 V (1222) memory_layout: Start of region 0x3ffe0000 - 0x3ffe4000 overlaps reserved 0x3ffe0000 - 0x3ffe0440 V (1223) memory_layout: End of region 0x3ffe0440 - 0x3ffe4000 overlaps reserved 0x3ffe3f20 - 0x3ffe4350 D (1224) memory_layout: Available memory region 0x3ffe0440 - 0x3ffe3f20 V (1225) memory_layout: Examining memory region 0x3ffe4000 - 0x3ffe8000 V (1226) memory_layout: Start of region 0x3ffe4000 - 0x3ffe8000 overlaps reserved 0x3ffe3f20 - 0x3ffe4350 D (1227) memory_layout: Available memory region 0x3ffe4350 - 0x3ffe8000 V (1228) memory_layout: Examining memory region 0x3ffe8000 - 0x3fff0000 D (1229) memory_layout: Available memory region 0x3ffe8000 - 0x3fff0000 V (1230) memory_layout: Examining memory region 0x3fff0000 - 0x3fff8000 D (1231) memory_layout: Available memory region 0x3fff0000 - 0x3fff8000 V (1232) memory_layout: Examining memory region 0x3fff8000 - 0x3fffc000 D (1232) memory_layout: Available memory region 0x3fff8000 - 0x3fffc000 V (1233) memory_layout: Examining memory region 0x3fffc000 - 0x40000000 D (1234) memory_layout: Available memory region 0x3fffc000 - 0x40000000 V (1235) memory_layout: Examining memory region 0x40070000 - 0x40078000 V (1236) memory_layout: Region 0x40070000 - 0x40078000 inside of reserved 0x40070000 - 0x40078000 V (1237) memory_layout: Examining memory region 0x40078000 - 0x40080000 V (1238) memory_layout: Region 0x40078000 - 0x40080000 inside of reserved 0x40078000 - 0x40080000 V (1239) memory_layout: Examining memory region 0x40080000 - 0x40082000 V (1240) memory_layout: Region 0x40080000 - 0x40082000 inside of reserved 0x40080000 - 0x40099f00 V (1241) memory_layout: Examining memory region 0x40082000 - 0x40084000 V (1242) memory_layout: Region 0x40082000 - 0x40084000 inside of reserved 0x40080000 - 0x40099f00 V (1243) memory_layout: Examining memory region 0x40084000 - 0x40086000 V (1244) memory_layout: Region 0x40084000 - 0x40086000 inside of reserved 0x40080000 - 0x40099f00 V (1245) memory_layout: Examining memory region 0x40086000 - 0x40088000 V (1245) memory_layout: Region 0x40086000 - 0x40088000 inside of reserved 0x40080000 - 0x40099f00 V (1247) memory_layout: Examining memory region 0x40088000 - 0x4008a000 V (1247) memory_layout: Region 0x40088000 - 0x4008a000 inside of reserved 0x40080000 - 0x40099f00 V (1249) memory_layout: Examining memory region 0x4008a000 - 0x4008c000 V (1249) memory_layout: Region 0x4008a000 - 0x4008c000 inside of reserved 0x40080000 - 0x40099f00 V (1250) memory_layout: Examining memory region 0x4008c000 - 0x4008e000 V (1251) memory_layout: Region 0x4008c000 - 0x4008e000 inside of reserved 0x40080000 - 0x40099f00 V (1252) memory_layout: Examining memory region 0x4008e000 - 0x40090000 V (1253) memory_layout: Region 0x4008e000 - 0x40090000 inside of reserved 0x40080000 - 0x40099f00 V (1254) memory_layout: Examining memory region 0x40090000 - 0x40092000 V (1255) memory_layout: Region 0x40090000 - 0x40092000 inside of reserved 0x40080000 - 0x40099f00 V (1256) memory_layout: Examining memory region 0x40092000 - 0x40094000 V (1257) memory_layout: Region 0x40092000 - 0x40094000 inside of reserved 0x40080000 - 0x40099f00 V (1258) memory_layout: Examining memory region 0x40094000 - 0x40096000 V (1259) memory_layout: Region 0x40094000 - 0x40096000 inside of reserved 0x40080000 - 0x40099f00 V (1260) memory_layout: Examining memory region 0x40096000 - 0x40098000 V (1261) memory_layout: Region 0x40096000 - 0x40098000 inside of reserved 0x40080000 - 0x40099f00 V (1262) memory_layout: Examining memory region 0x40098000 - 0x4009a000 V (1263) memory_layout: Start of region 0x40098000 - 0x4009a000 overlaps reserved 0x40080000 - 0x40099f00 D (1264) memory_layout: Available memory region 0x40099f00 - 0x4009a000 V (1265) memory_layout: Examining memory region 0x4009a000 - 0x4009c000 D (1266) memory_layout: Available memory region 0x4009a000 - 0x4009c000 V (1267) memory_layout: Examining memory region 0x4009c000 - 0x4009e000 D (1268) memory_layout: Available memory region 0x4009c000 - 0x4009e000 V (1268) memory_layout: Examining memory region 0x4009e000 - 0x400a0000 D (1269) memory_layout: Available memory region 0x4009e000 - 0x400a0000 I (1270) heap_init: Initializing. RAM available for dynamic allocation: D (1271) heap_init: New heap initialised at 0x3ffaff10 I (1272) heap_init: At 3FFAFF10 len 000000F0 (0 KiB): DRAM D (1272) heap_init: New heap initialised at 0x3ffb6388 I (1273) heap_init: At 3FFB6388 len 00001C78 (7 KiB): DRAM D (1274) heap_init: New heap initialised at 0x3ffb9a20 I (1274) heap_init: At 3FFB9A20 len 00004108 (16 KiB): DRAM D (1275) heap_init: New heap initialised at 0x3ffc9700 I (1276) heap_init: At 3FFC9700 len 00016900 (90 KiB): DRAM I (1277) heap_init: At 3FFE0440 len 00003AE0 (14 KiB): D/IRAM I (1278) heap_init: At 3FFE4350 len 0001BCB0 (111 KiB): D/IRAM D (1278) heap_init: New heap initialised at 0x40099f00 I (1279) heap_init: At 40099F00 len 00006100 (24 KiB): IRAM I (1280) spiram: Adding pool of 4084K of external SPI memory to heap allocator V (1281) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): checking args V (1282) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): Args okay. Resulting flags 0xE D (1283) intr_alloc: Connected src 46 to int 2 (cpu 0) D (1284) FLASH_HAL: extra_dummy: 2 V (1284) memspi: raw_chip_id: 1740C8

V (1284) memspi: chip_id: C84017

V (1285) memspi: raw_chip_id: 1740C8

V (1285) memspi: chip_id: C84017

D (1285) spi_flash: trying chip: issi D (1286) spi_flash: trying chip: gd I (1286) spi_flash: detected chip: gd I (1287) spi_flash: flash io: qio D (1287) chip_generic: set_io_mode: status before 0x2 V (1288) chip_generic: set_io_mode: status update 0x2 D (1289) cpu_start: calling init function: 0x40204324 D (1289) cpu_start: calling init function: 0x40204234 D (1290) cpu_start: calling init function: 0x4020113c D (1291) cpu_start: calling init function: 0x401faf0c D (1291) cpu_start: calling init function: 0x401f7f24 D (1292) cpu_start: calling init function: 0x401f1288 D (1293) cpu_start: calling init function: 0x4016700c D (1293) cpu_start: calling init function: 0x40141f48 D (1294) cpu_start: calling init function: 0x400d4090 D (1294) cpu_start: calling init function: 0x400d3170 V (1295) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): checking args V (1296) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): Args okay. Resulting flags 0xC02 D (1297) intr_alloc: Connected src 17 to int 3 (cpu 0) V (1298) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): checking args V (1298) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): Args okay. Resulting flags 0x40E D (1299) intr_alloc: Connected src 24 to int 9 (cpu 0) I (1300) cpu_start: Starting scheduler on PRO CPU. V (0) intr_alloc: esp_intr_alloc_intrstatus (cpu 1): checking args V (0) intr_alloc: esp_intr_alloc_intrstatus (cpu 1): Args okay. Resulting flags 0x40E D (1) intr_alloc: Connected src 25 to int 2 (cpu 1) I (2) cpu_start: Starting scheduler on APP CPU. D (1306) heap_init: New heap initialised at 0x3ffe0440 D (1307) heap_init: New heap initialised at 0x3ffe4350 I (1308) spiram: Reserving pool of 18K of internal memory for DMA/internal allocations D (1309) spiram: Allocating block of size 18432 bytes V (1309) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): checking args V (1309) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): Args okay. Resulting flags 0xE D (1309) intr_alloc: Connected src 16 to int 12 (cpu 0) D (1312) partition: Loading the partition table V (1318) calculated md5: 0x3ffbbbe8 10 4f fc 87 5f 56 92 f0 65 63 0d a4 6f e3 86 8d |.O.._V..ec..o...| V (1319) stored md5: 0x3f4780f0 10 4f fc 87 5f 56 92 f0 65 63 0d a4 6f e3 86 8d |.O.._V..ec..o...| D (1319) partition: Partition table MD5 verified D (1338) event: running task for loop 0x3ffbdb04 D (1338) event: created task for loop 0x3ffbdb04 D (1338) event: created event loop 0x3ffbdb04 D (1339) esp_netif_lwip: LwIP stack has been initialized D (1339) esp_netif_lwip: esp-netif has been successfully initialized D (1340) esp_netif_objects: esp_netif_add_to_list 0x3ffd0d30 D (1341) esp_netif_objects: esp_netif_add_to_list netif added successfully (total netifs: 1) D (1342) esp_netif_objects: esp_netif_add_to_list 0x3ffd1104 D (1342) esp_netif_objects: esp_netif_add_to_list netif added successfully (total netifs: 2) D (1344) esp_netif_objects: esp_netif_add_to_list 0x3ffd12ec D (1344) esp_netif_objects: esp_netif_add_to_list netif added successfully (total netifs: 3) D (1346) nvs: nvs_open_from_partition misc 1 I (1348) wifi:wifi driver task: 3ffd3840, prio:23, stack:6656, core=0 V (1348) esp_adapter: thread sem create: sem=0x3ffd39a8 V (1348) esp_adapter: thread sem get: sem=0x3ffd39a8 I (1349) system_api: Base MAC address is not set I (1349) system_api: read default base MAC address from EFUSE D (1350) efuse: In EFUSE_BLK0DATA2_REG is used 8 bits starting with 8 bit D (1351) efuse: In EFUSE_BLK0DATA2_REG is used 8 bits starting with 0 bit D (1352) efuse: In EFUSE_BLK0DATA1_REG is used 8 bits starting with 24 bit D (1352) efuse: In EFUSE_BLK0DATA1_REG is used 8 bits starting with 16 bit D (1353) efuse: In EFUSE_BLK0DATA1_REG is used 8 bits starting with 8 bit D (1354) efuse: In EFUSE_BLK0DATA1_REG is used 8 bits starting with 0 bit D (1355) efuse: In EFUSE_BLK0DATA2_REG is used 8 bits starting with 16 bit D (1356) nvs: nvs_open_from_partition nvs.net80211 1 D (1357) nvs: nvs_get opmode 1 D (1358) nvs: nvs_get_str_or_blob sta.ssid D (1358) nvs: nvs_get sta.authmode 1 D (1358) nvs: nvs_get_str_or_blob sta.pswd D (1359) nvs: nvs_get_str_or_blob sta.pmk D (1359) nvs: nvs_get sta.chan 1 D (1360) nvs: nvs_get auto.conn 1 D (1360) nvs: nvs_get bssid.set 1 D (1360) nvs: nvs_get_str_or_blob sta.bssid D (1361) nvs: nvs_get sta.lis_intval 2 D (1361) nvs: nvs_get sta.phym 1 D (1362) nvs: nvs_get sta.phybw 1 D (1362) nvs: nvs_get_str_or_blob sta.apsw D (1363) nvs: nvs_get_str_or_blob sta.apinfo D (1363) nvs: nvs_get sta.scan_method 1 D (1364) nvs: nvs_get sta.sort_method 1 D (1364) nvs: nvs_get sta.minrssi 1 D (1365) nvs: nvs_get sta.minauth 1 D (1365) nvs: nvs_get sta.pmf_e 1 D (1366) nvs: nvs_get sta.pmf_r 1 D (1366) nvs: nvs_get sta.btm_e 1 D (1366) nvs: nvs_get sta.rrm_e 1 D (1367) nvs: nvs_get sta.mbo_e 1 D (1367) nvs: nvs_get_str_or_blob ap.ssid D (1368) nvs: nvs_get_str_or_blob ap.passwd D (1368) nvs: nvs_get_str_or_blob ap.pmk D (1369) nvs: nvs_get ap.chan 1 D (1369) nvs: nvs_get ap.authmode 1 D (1370) nvs: nvs_get ap.hidden 1 D (1370) nvs: nvs_get ap.max.conn 1 D (1370) nvs: nvs_get bcn.interval 2 D (1371) nvs: nvs_get ap.phym 1 D (1371) nvs: nvs_get ap.phybw 1 D (1372) nvs: nvs_get ap.sndchan 1 D (1372) nvs: nvs_get ap.pmf_e 1 D (1373) nvs: nvs_get ap.pmf_r 1 D (1373) nvs: nvs_get ap.p_cipher 1 D (1373) nvs: nvs_get lorate 1 D (1374) nvs: nvs_get_str_or_blob country D (1374) nvs: nvs_get ap.ftm_r 1 D (1375) nvs: nvs_set ap.sndchan 1 1 I (1376) wifi:wifi firmware version: 6567a16 I (1376) wifi:wifi certification version: v7.0 I (1376) wifi:config NVS flash: enabled I (1377) wifi:config nano formating: disabled I (1377) wifi:Init data frame dynamic rx buffer num: 128 I (1378) wifi:Init management frame dynamic rx buffer num: 128 I (1379) wifi:Init management short buffer num: 32 I (1379) wifi:Init static tx buffer num: 9 I (1380) wifi:Init tx cache buffer num: 32 I (1380) wifi:Init static rx buffer size: 1600 I (1381) wifi:Init static rx buffer num: 9 I (1381) wifi:Init dynamic rx buffer num: 128 V (1382) wifi:hint=255, act_dur=<0,120>, pas_dur=360, nchans=14 history_num=0 I (1383) wifi_init: rx ba win: 16 I (1383) wifi_init: tcpip mbox: 64 I (1383) wifi_init: udp mbox: 64 I (1384) wifi_init: tcp mbox: 64 I (1384) wifi_init: tcp tx win: 65535 I (1385) wifi_init: tcp rx win: 65535 I (1385) wifi_init: tcp mss: 1440 I (1386) wifi_init: WiFi/LWIP prefer SPIRAM V (1387) esp_adapter: thread sem get: sem=0x3ffd39a8 D (1387) ADC: Wi-Fi takes adc2 lock. I (1388) phy_init: phy_version 4670,719f9f6,Feb 18 2021,17:07:07 D (1389) phy_init: loading PHY init data from application binary D (1389) nvs: nvs_open_from_partition phy 0 D (1390) phy_init: esp_phy_load_cal_data_from_nvs: failed to open NVS namespace (0x1102) W (1391) phy_init: failed to load RF calibration data (0x1102), falling back to full calibration D (1392) efuse: In EFUSE_BLK0DATA2_REG is used 8 bits starting with 8 bit D (1393) efuse: In EFUSE_BLK0DATA2_REG is used 8 bits starting with 0 bit D (1394) efuse: In EFUSE_BLK0DATA1_REG is used 8 bits starting with 24 bit D (1395) efuse: In EFUSE_BLK0DATA1_REG is used 8 bits starting with 16 bit D (1395) efuse: In EFUSE_BLK0DATA1_REG is used 8 bits starting with 8 bit D (1396) efuse: In EFUSE_BLK0DATA1_REG is used 8 bits starting with 0 bit D (1397) efuse: In EFUSE_BLK0DATA2_REG is used 8 bits starting with 16 bit D (1554) nvs: nvs_open_from_partition phy 1 D (1555) nvs: nvs_set_blob cal_data 1904 D (1563) efuse: In EFUSE_BLK0DATA2_REG is used 8 bits starting with 8 bit D (1563) efuse: In EFUSE_BLK0DATA2_REG is used 8 bits starting with 0 bit D (1563) efuse: In EFUSE_BLK0DATA1_REG is used 8 bits starting with 24 bit D (1564) efuse: In EFUSE_BLK0DATA1_REG is used 8 bits starting with 16 bit D (1565) efuse: In EFUSE_BLK0DATA1_REG is used 8 bits starting with 8 bit D (1566) efuse: In EFUSE_BLK0DATA1_REG is used 8 bits starting with 0 bit D (1567) efuse: In EFUSE_BLK0__DATA2_REG is used 8 bits starting with 16 bit D (1568) nvs: nvs_set_blob cal_mac 6 V (1570) phy_init: phy_get_rf_cal_version: 4670

D (1570) nvs: nvs_set cal_version 4 4670 D (1571) nvs: nvs_close 3 V (1571) wifi:ht40u freq=2422, chan=1 D (1572) wifi:filter: set rx policy=0 I (1572) wifi:mode : softAP (44:17:93:e6:40:ed) D (1572) wifi:filter: set rx policy=9 V (1572) wifi:ht40u freq=2422, chan=1 I (1573) wifi:Total power save buffer number: 4 I (1573) wifi:Init max length of beacon: 752/752 I (1574) wifi:Init max length of beacon: 752/752 D (1574) event: running post WIFI_EVENT:12 with handler 0x401672fc and context 0x3ffd1070 on loop 0x3ffbdb04 D (1575) wifi_init_default: wifi_start esp-netif:0x3ffd1104 event-id12 D (1576) wifi_init_default: WIFI mac address: 44 17 93 e6 40 ed V (1577) esp_adapter: thread sem create: sem=0x3ffdb8fc V (1577) esp_adapter: thread sem get: sem=0x3ffdb8fc V (1578) esp_adapter: thread sem get: sem=0x3ffdb8fc D (1579) esp_netif_handlers: esp_netif action has started with netif0x3ffd1104 from event_id=12 D (1580) esp_netif_lwip: check: remote, if=0x3ffd1104 fn=0x4015a3cc

[ED] at_wifi_init D (1581) esp_netif_lwip: esp_netif_start_api 0x3ffd1104 D (1582) esp_netif_lwip: esp_netif_get_hostname esp_netif:0x3ffd1104 D (1582) esp_netif_lwip: esp_netif_start_api Setting the lwip netif0x3ffd1184 UP D (1584) esp_netif_lwip: DHCP server started successfully D (1584) esp_netif_lwip: check: local, if=0x3ffd1104 fn=0x4015b088

D (1585) esp_netif_lwip: esp_netif_update_default_netif_lwip 0x3ffd1104 V (1586) esp_netif_lwip: esp_netif_is_netif_up esp_netif:0x3ffd1104 D (1586) esp_netif_lwip: call api in lwip: ret=0x0, give sem V (1587) spi_flash: allocate temp buffer: 0x3ffdb9dc (4096) V (1589) spi_flash: allocate temp buffer: 0x3ffdbcac (4096) D (1590) nvs: nvs_open_from_partition UART 0 D (1590) nvs: nvs_open_from_partition UART 1 D (1591) nvs: nvs_set rate 4 115200 D (1592) nvs: nvs_set databits 1 3 D (1592) nvs: nvs_set stopbits 1 1 D (1593) nvs: nvs_set parity 1 0 D (1594) nvs: nvs_set flow_ctrl 1 1 D (1594) nvs: nvs_close 4 I (1595) uart: queue free spaces: 30 V (1595) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): checking args V (1595) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): Args okay. Resulting flags 0xE D (1596) intr_alloc: Connected src 35 to int 13 (cpu 0) [ED] at_interface_init V (1597) spi_flash: allocate temp buffer: 0x3ffdd010 (4096) module_name:WROVER-32 V (1599) esp_adapter: thread sem get: sem=0x3ffd39a8 max tx power=78,ret=0 V (1599) esp_adapter: thread sem get: sem=0x3ffd39a8 I (1600) wifi:set country: cc=CN schan=1 nchan=13 policy=1

[ED] esp_at_board_init D (1601) nvs: nvs_open_from_partition NVM_020 0 D (1601) nvs: nvs_open_from_partition NVM_020 0 D (1602) nvs: nvs_open_from_partition NVM_020 0 D (1602) nvs: nvs_open_from_partition NVM_020 0 D (1603) nvs: nvs_open_from_partition NVM_020 0 D (1603) nvs: nvs_open_from_partition NVM_020 0 D (1604) nvs: nvs_open_from_partition NVM_020 0 D (1605) nvs: nvs_open_from_partition NVM_020 0 D (1605) nvs: nvs_open_from_partition NVM_020 0 D (1606) nvs: nvs_open_from_partition NVM_020 0 [ED] esp_at_module_init D (1607) nvs: nvs_open_from_partition NVM_012 0 [ED] esp_at_base_cmd_regist [ED] esp_at_user_cmd_regist V (1608) esp_adapter: thread sem get: sem=0x3ffd39a8 I (1609) wifi:mode : sta (44:17:93:e6:40:ec) + softAP (44:17:93:e6:40:ed) I (1609) wifi:enable tsf D (1609) wifi:filter: set rx policy=1 D (1610) wifi:connect status 0 -> 0 D (1610) event: running post WIFI_EVENT:2 with handler 0x40167314 and context 0x3ffd0fb0 on loop 0x3ffbdb04 D (1612) wifi_init_default: wifi_start esp-netif:0x3ffd0d30 event-id2 D (1612) wifi_init_default: WIFI mac address: 44 17 93 e6 40 ec V (1613) esp_adapter: thread sem get: sem=0x3ffdb8fc D (1614) esp_netif_handlers: esp_netif action has started with netif0x3ffd0d30 from event_id=2 D (1615) esp_netif_lwip: check: remote, if=0x3ffd0d30 fn=0x4015a3cc

D (1616) esp_netif_lwip: esp_netif_start_api 0x3ffd0d30 D (1616) nvs: nvs_open_from_partition NVM_004 0 D (1616) esp_netif_lwip: esp_netif_get_hostname esp_netif:0x3ffd0d30 D (1618) esp_netif_lwip: check: local, if=0x3ffd0d30 fn=0x4015b088

D (1618) esp_netif_lwip: esp_netif_update_default_netif_lwip 0x3ffd0d30 V (1619) esp_netif_lwip: esp_netif_is_netif_up esp_netif:0x3ffd1104 V (1620) esp_netif_lwip: esp_netif_is_netif_up esp_netif:0x3ffd0d30 D (1621) esp_netif_lwip: call api in lwip: ret=0x0, give sem D (1622) nvs: nvs_open_from_partition NVM_003 0 D (1622) nvs: nvs_open_from_partition NVM_017 0 D (1623) nvs: nvs_open_from_partition NVM_022 1 D (1624) nvs: nvs_get wac 1 D (1624) nvs: nvs_open_from_partition nvs.net80211 0 D (1624) nvs: nvs_get auto.conn 1 D (1625) nvs: nvs_close 6 D (1625) nvs: nvs_set wac 1 1 D (1626) nvs: nvs_close 5 D (1626) nvs: nvs_open_from_partition NVM_013 0 D (1626) esp_netif_lwip: check: remote, if=0x3ffd0d30 fn=0x40159d04

D (1627) esp_netif_lwip: esp_netif_dhcpc_stop_api esp_netif:0x3ffd0d30 D (1628) esp_netif_lwip: dhcp client stop successfully D (1629) esp_netif_lwip: call api in lwip: ret=0x0, give sem D (1629) esp_netif_lwip: check: remote, if=0x3ffd1104 fn=0x40159b9c

D (1630) esp_netif_lwip: esp_netif_dhcps_stop_api esp_netif:0x3ffd1104 D (1631) esp_netif_lwip: dhcp server stop successfully D (1632) esp_netif_lwip: call api in lwip: ret=0x0, give sem D (1632) nvs: nvs_open_from_partition NVM_002 0 D (1633) nvs: nvs_open_from_partition NVM_021 0 D (1634) nvs: nvs_open_from_partition NVM_001 0 D (1634) nvs: nvs_open_from_partition NVM_007 0 D (1635) nvs: nvs_open_from_partition NVM_006 0 D (1635) esp_netif_lwip: check: remote, if=0x3ffd0d30 fn=0x40159dd0

D (1636) esp_netif_lwip: esp_netif_dhcpc_start_api esp_netif:0x3ffd0d30 D (1637) esp_netif_lwip: dhcp client re init D (1637) esp_netif_lwip: call api in lwip: ret=0x0, give sem D (1638) esp_netif_lwip: check: remote, if=0x3ffd1104 fn=0x401596d0

D (1639) esp_netif_lwip: esp_netif_dhcps_start_api esp_netif:0x3ffd1104 D (1640) esp_netif_lwip: DHCP server started successfully D (1640) esp_netif_lwip: call api in lwip: ret=0x0, give sem V (1641) esp_adapter: thread sem get: sem=0x3ffd39a8 D (1642) wifi:connect status 0 -> 0 D (1642) wifi:Start wifi disconnect D (1643) wifi:connect status 0 -> 0 D (1643) wifi:filter: set rx policy=8 D (1643) wifi:filter: set rx policy=2 D (1644) wifi:clear scan ap list D (1644) wifi:clear blacklist D (1645) wifi:clear rc list I (1645) wifi:mode : softAP (44:17:93:e6:40:ed) D (1646) event: running post WIFI_EVENT:3 with handler 0x401671d4 and context 0x3ffd0fe0 on loop 0x3ffbdb04 D (1647) esp_netif_handlers: esp_netif action stopped with netif0x3ffd0d30 from event_id=3 D (1648) esp_netif_lwip: check: remote, if=0x3ffd0d30 fn=0x4015a584

D (1649) esp_netif_lwip: call api in lwip: ret=0x5002, give sem [ED] esp_at_wifi_cmd_regist D (1650) nvs: nvs_open_from_partition NVM_008 1 D (1651) nvs: nvs_get dns_ser0 4 D (1651) nvs: nvs_get dns_ser1 4 D (1651) nvs: nvs_get dns_ser2 4 D (1651) nvs: nvs_get_str_or_blob dns_svr0 D (1652) nvs: nvs_close 7 D (1652) esp_netif_lwip: check: remote, if=0x3ffd0d30 fn=0x4015a14c

D (1653) esp_netif_lwip: esp_netif_set_dns_info_api esp_netif:0x3ffd0d30 D (1654) esp_netif_lwip: set dns if=0x3ffd0d30 type=0 dns=dede43d0 D (1655) esp_netif_lwip: call api in lwip: ret=0x0, give sem D (1655) esp_netif_lwip: check: remote, if=0x3ffd0d30 fn=0x4015a14c

D (1656) esp_netif_lwip: esp_netif_set_dns_info_api esp_netif:0x3ffd0d30 D (1657) esp_netif_lwip: set dns if=0x3ffd0d30 type=2 dns=8080808 D (1658) esp_netif_lwip: call api in lwip: ret=0x0, give sem D (1659) nvs: nvs_open_from_partition NVM_009 1 D (1660) nvs: nvs_get maxlink 1 D (1660) nvs: nvs_open_from_partition NVM_009 0 D (1660) nvs: nvs_get auth0 1 D (1660) nvs: nvs_open_from_partition NVM_009 0 D (1661) nvs: nvs_get auth1 1 D (1661) nvs: nvs_open_from_partition NVM_009 0 D (1662) nvs: nvs_get auth2 1 D (1662) nvs: nvs_open_from_partition NVM_009 0 D (1663) nvs: nvs_get auth3 1 D (1663) nvs: nvs_open_from_partition NVM_009 0 D (1664) nvs: nvs_get auth4 1 D (1664) nvs: nvs_open_from_partition NVM_009 0 D (1665) nvs: nvs_get auth5 1 D (1665) nvs: nvs_open_from_partition NVM_009 0 D (1666) nvs: nvs_get auth6 1 D (1666) nvs: nvs_open_from_partition NVM_009 0 D (1667) nvs: nvs_get auth7 1 D (1667) nvs: nvs_open_from_partition NVM_009 0 D (1668) nvs: nvs_get auth8 1 D (1668) nvs: nvs_open_from_partition NVM_009 0 D (1669) nvs: nvs_get auth9 1 D (1669) nvs: nvs_open_from_partition NVM_018 0 D (1670) nvs: nvs_open_from_partition NVM_005 1 D (1671) nvs: nvs_get enable 1 D (1671) nvs: nvs_get type 1 D (1671) nvs: nvs_get_str_or_blob r_ip D (1671) nvs: nvs_get r_port 4 D (1672) nvs: nvs_get l_port 4 D (1672) nvs: nvs_get change_mode 1 D (1673) nvs: nvs_get keep_alive 2 D (1673) nvs: nvs_close 19 [ED] esp_at_net_cmd_regist [ED] esp_at_mqtt_cmd_regist [ED] esp_at_http_cmd_regist D (1674) BTDM_INIT: Release DRAM [0x3ffae6e0] - [0x3ffaff10] D (1675) BTDM_INIT: Release DRAM [0x3ffb0000] - [0x3ffb6388] D (1676) BTDM_INIT: Release DRAM [0x3ffb8000] - [0x3ffb9a20] D (1677) BTDM_INIT: Release DRAM [0x3ffbdb28] - [0x3ffbdb5c] [ED] esp_at_mdns_cmd_regist [ED] esp_at_wps_cmd_regist [ED] esp_at_smartconfig_cmd_regist [ED] esp_at_ping_cmd_regist D (1679) nvs: nvs_open_from_partition NVM_011 0 D (1679) esp_netif_lwip: check: remote, if=0x3ffd12ec fn=0x40159d04

D (1680) esp_netif_lwip: esp_netif_dhcpc_stop_api esp_netif:0x3ffd12ec D (1681) esp_netif_lwip: dhcp client stop successfully D (1681) esp_netif_lwip: call api in lwip: ret=0x0, give sem D (1682) nvs: nvs_open_from_partition NVM_010 0 D (1683) nvs: nvs_open_from_partition NVM_006 0 D (1683) esp_netif_lwip: check: remote, if=0x3ffd12ec fn=0x40159dd0

D (1684) esp_netif_lwip: esp_netif_dhcpc_start_api esp_netif:0x3ffd12ec D (1685) esp_netif_lwip: dhcp client re init D (1686) esp_netif_lwip: call api in lwip: ret=0x0, give sem V (1687) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): checking args V (1687) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): Args okay. Resulting flags 0xE D (1688) intr_alloc: Connected src 38 to int 17 (cpu 0) D (1719) esp_eth.phy: Found PHY address: 0 E (1749) rtl8201: [SUNGSU]Traditional LED Function Selection before (3) E (1749) rtl8201: [SUNGSU]Traditional LED Function Selection after (1) D (1750) esp_eth: new ethernet driver @0x3ffb2124 I (1750) esp_eth.netif.netif_glue: 44:17:93:e6:40:ef I (1751) esp_eth.netif.netif_glue: ethernet attached to netif D (5752) event: running post ETH_EVENT:0 with handler 0x400e58d4 and context 0x3ffb2104 on loop 0x3ffbdb04 D (5752) event: running post ETH_EVENT:0 with handler 0x40156e30 and context 0x3ffb21cc on loop 0x3ffbdb04 D (5753) esp_eth.netif.netif_glue: eth_action_start: 0x3ffb2198, 0x3f432130, 0, 0x3ffb229c, 0x3ffb2124 D (5754) esp_netif_handlers: esp_netif action has started with netif0x3ffd12ec from event_id=0 D (5755) esp_netif_lwip: check: remote, if=0x3ffd12ec fn=0x4015a3cc

D (5756) esp_netif_lwip: esp_netif_start_api 0x3ffd12ec [ED] esp_at_eth_cmd_regist D (5757) esp_netif_lwip: esp_netif_get_hostname esp_netif:0x3ffd12ec D (5758) esp_netif_lwip: check: local, if=0x3ffd12ec fn=0x4015b088

D (5759) esp_netif_lwip: esp_netif_update_default_netif_lwip 0x3ffd12ec V (5759) esp_netif_lwip: esp_netif_is_netif_up esp_netif:0x3ffd1104 V (5760) esp_netif_lwip: esp_netif_is_netif_up esp_netif:0x3ffd12ec D (5761) esp_netif_lwip: call api in lwip: ret=0x0, give sem V (5762) wl_flash: config start_addr=0x00000000, full_mem_size=0x00200000, page_size=0x00001000, sector_size=0x00001000, updaterate=0x00000010, wr_size=0x00000010, version=0x00000002, temp_buff_size=0x00000020 D (5764) wl_flash: config - config result: state_size=0x00003000, cfg_size=0x00001000, addr_cfg=0x001ff000, addr_state1=0x001f9000, addr_state2=0x001fc000, flash_size=0x001f8000 V (5766) wl_ext_safe: init D (5767) wl_flash: init - config ID=2, stored ID=2, access_count=0, block_size=4096, max_count=16, pos=0, move_count=0x00000000 D (5768) wl_flash: init starts: crc1= 0x5010a84c, crc2 = 0x5010a84c, this->state.crc= 0x5010a84c, state_copy->crc= 0x5010a84c, version=2, read_version=2 D (5770) wl_flash: init: crc1=0x5010a84c, crc2 = 0x5010a84c, result= 0x00000000 V (5770) wl_flash: recoverPos start V (5771) wl_flash: recoverPos - check pos: result=0x00000000, position= 0, pos_bits= 0x00000000 D (5772) wl_flash: recoverPos - this->state.pos= 0x00000000, position= 0x00000000, result= 0x00000000, max_pos= 0x000001f9 V (5773) wl_flash: recoverPos done D (5774) wl_flash: init - move_count= 0x00000000 D (5774) wl_flash: read - src_addr= 0x001f6000, size= 0x00000010 V (5775) wl_flash: calcAddr - addr= 0x001f6000 -> result= 0x001f7000, dummy_addr= 0x00000000 V (5776) wl_ext_safe: recover recover, start_addr = 0xffffffff, local_addr_base = 0xffffffff, local_addr_shift = -1, count=-1 V (5778) ff_diskio_spiflash: ff_wl_read - pdrv=0, sector=0, count=1

D (5779) wl_flash: read - src_addr= 0x00000000, size= 0x00000200 V (5779) wl_flash: calcAddr - addr= 0x00000000 -> result= 0x00001000, dummy_addr= 0x00000000 V (5780) spi_flash: allocate temp buffer: 0x3ffb269c (512) [ED] esp_at_fs_cmd_regist [ED] esp_at_ota_cmd_regist [ED] esp_at_fact_cmd_regist [ED] esp_at_web_server_cmd_regist [ED] esp_at_awsota_cmd_regist [ED] esp_at_voip_cmd_regist [ED] esp_at_audio_ota_cmd_regist [ED] at_custom_init [ED] heap_caps_register_failed_alloc_callback V (21304) ff_diskio_spiflash: ff_wl_read - pdrv=0, sector=13, count=1

D (21305) wl_flash: read - src_addr= 0x00001a00, size= 0x00000200 V (21305) wl_flash: calcAddr - addr= 0x00001a00 -> result= 0x00002a00, dummy_addr= 0x00000000 V (21306) spi_flash: allocate temp buffer: 0x3ffb2f50 (512) V (21307) ff_diskio_spiflash: ff_wl_read - pdrv=0, sector=14, count=1

D (21307) wl_flash: read - src_addr= 0x00001c00, size= 0x00000200 V (21308) wl_flash: calcAddr - addr= 0x00001c00 -> result= 0x00002c00, dummy_addr= 0x00000000 V (21309) spi_flash: allocate temp buffer: 0x3ffb2f50 (512) V (66921) esp_adapter: thread sem create: sem=0x3ffb2f50 V (66921) esp_adapter: thread sem get: sem=0x3ffb2f50 V (66921) esp_adapter: thread sem get: sem=0x3ffb2f50 D (66922) wifi:filter: set rx policy=10 I (66922) wifi:mode : null D (66922) nvs: nvs_set opmode 1 0 V (66923) esp_adapter: thread sem get: sem=0x3ffb2f50 D (66923) event: running post WIFI_EVENT:13 with handler 0x401671bc and context 0x3ffd10a0 on loop 0x3ffbdb04 V (66924) esp_adapter: thread sem get: sem=0x3ffb2f50 D (66924) esp_netif_handlers: esp_netif action stopped with netif0x3ffd1104 from event_id=13 V (66925) esp_adapter: thread sem get: sem=0x3ffb2f50 D (66926) esp_netif_lwip: check: remote, if=0x3ffd1104 fn=0x4015a584

I (66927) wifi:flush txq I (66928) wifi:stop sw txq D (66928) wifi:filter: set rx policy=0 D (66929) esp_netif_lwip: check: local, if=0x3ffd1104 fn=0x4015b088

I (66929) wifi:D (66929) esp_netif_lwip: esp_netif_update_default_netif_lwip 0x3ffd1104 lmac stop hw txqV (66930) esp_netif_objects: esp_netif_next_unsafe 0x0

V (66931) esp_netif_lwip: esp_netif_is_netif_up esp_netif:0x3ffd12ec V (66932) esp_netif_objects: esp_netif_next_unsafe 0x3ffd12ec V (66933) esp_netif_lwip: esp_netif_is_netif_up esp_netif:0x3ffd1104 V (66934) esp_netif_objects: esp_netif_next_unsafe 0x3ffd1104 V (66934) esp_netif_lwip: esp_netif_is_netif_up esp_netif:0x3ffd0d30 V (66935) esp_netif_objects: esp_netif_next_unsafe 0x3ffd0d30 D (66932) ADC: Wi-Fi returns adc2 lock. D (66936) esp_netif_lwip: call api in lwip: ret=0x0, give sem D (66937) event: running post WIFI_EVENT:13 with handler 0x400f4e40 and context 0x3ffb81a4 on loop 0x3ffbdb04 D (99757) esp.emac: working in 100Mbps D (99757) esp.emac: working in full duplex D (99757) esp.emac: Flow control not enabled for the link D (99757) event: running post ETH_EVENT:2 with handler 0x400e58d4 and context 0x3ffb2104 on loop 0x3ffbdb04 D (99759) event: running post ETH_EVENT:2 with handler 0x40156eb0 and context 0x3ffb222c on loop 0x3ffbdb04 D (99760) esp_eth.netif.netif_glue: eth_action_connected: 0x3ffb2198, 0x3f432130, 2, 0x3ffb2fc0, 0x3ffb2124 D (99761) esp_netif_handlers: esp_netif action connected with netif0x3ffd12ec from event_id=2 D (99762) esp_netif_lwip: check: remote, if=0x3ffd12ec fn=0x4015a604

D (99763) esp_netif_lwip: esp_netif_up_api esp_netif:0x3ffd12ec D (99764) esp_netif_lwip: check: local, if=0x3ffd12ec fn=0x4015b088

D (99764) esp_netif_lwip: esp_netif_update_default_netif_lwip 0x3ffd12ec V (99765) esp_netif_lwip: esp_netif_is_netif_up esp_netif:0x3ffd12ec D (99766) esp_netif_lwip: call api in lwip: ret=0x0, give sem D (99767) esp_netif_lwip: check: remote, if=0x3ffd12ec fn=0x40159dd0

D (99768) esp_netif_lwip: esp_netif_dhcpc_start_api esp_netif:0x3ffd12ec D (99768) esp_netif_lwip: esp_netif_start_ip_lost_timer esp_netif:0x3ffd12ec D (99769) esp_netif_lwip: if0x3ffd12ec start ip lost tmr: no need start because netif=0x3ffd136c interval=120 ip=0 D (99771) esp_netif_lwip: starting dhcp client D (99772) esp_netif_lwip: call api in lwip: ret=0x0, give sem D (99772) esp.emac: receive len= 342 D (99773) esp.emac: receive len= 66 D (99773) esp.emac: receive len= 66 D (99774) esp.emac: receive len= 66 D (99774) esp.emac: receive len= 342 D (99775) esp.emac: receive len= 0 D (99776) esp.emac: receive len= 342 D (100521) esp.emac: receive len= 60 D (100772) esp_netif_lwip: esp_netif_dhcpc_cb lwip-netif:0x3ffd136c D (100772) esp_netif_lwip: if0x3ffd12ec ip changed=1 D (100772) event: running post IP_EVENT:4 with handler 0x400e58d4 and context 0x3ffb99fc on loop 0x3ffbdb04 D (100773) event: running post IP_EVENT:4 with handler 0x40156f30 and context 0x3ffb227c on loop 0x3ffbdb04 D (100774) esp.emac: receive len= 342 D (100774) esp_eth.netif.netif_glue: eth_action_got_ip: 0x3ffb2198, 0x3f43393c, 4, 0x3ffb2fc0, 0xffffffff D (100776) esp_netif_handlers: esp_netif action got_ip with netif0x3ffd12ec from event_id=4 I (100777) esp_netif_handlers: eth ip: 10.0.28.130, mask: 255.255.255.0, gw: 10.0.28.1 D (101100) esp.emac: receive len= 718 D (101126) esp.emac: receive len= 217 D (101179) esp.emac: receive len= 66 D (101258) esp.emac: receive len= 150 D (101261) esp.emac: receive len= 170 D (101624) esp.emac: receive len= 698 D (101695) esp.emac: receive len= 60 D (101911) esp.emac: receive len= 316 D (102135) esp.emac: receive len= 217 D (102399) esp.emac: receive len= 60 D (102504) esp.emac: receive len= 60 D (102965) esp.emac: receive len= 81 D (102966) esp.emac: receive len= 101 D (102967) esp.emac: receive len= 95 D (102968) esp.emac: receive len= 75 D (102969) esp.emac: receive len= 81 D (102970) esp.emac: receive len= 101 D (102971) esp.emac: receive len= 95 D (102971) esp.emac: receive len= 75 D (103080) esp.emac: receive len= 139 D (103080) esp.emac: receive len= 159 D (103158) esp.emac: receive len= 217 D (103397) esp.emac: receive len= 60 D (104164) esp.emac: receive len= 217 D (106463) esp.emac: receive len= 150 D (106467) esp.emac: receive len= 170 D (106910) esp.emac: receive len= 316 D (107684) esp.emac: receive len= 204 D (107687) esp.emac: receive len= 224 D (107975) esp.emac: receive len= 217 D (108090) esp.emac: receive len= 206 D (108092) esp.emac: receive len= 226 D (108409) esp.emac: receive len= 60 D (108932) esp.emac: receive len= 60 D (108990) esp.emac: receive len= 217 D (109973) esp.emac: receive len= 60 D (109992) esp.emac: receive len= 217 D (110007) esp.emac: receive len= 217 D (110993) esp.emac: receive len= 217 D (111008) esp.emac: receive len= 217 D (111605) esp.emac: receive len= 150 D (111608) esp.emac: receive len= 170 D (111910) esp.emac: receive len= 316 D (112008) esp.emac: receive len= 217 D (112272) esp.emac: receive len= 217 D (112713) esp.emac: receive len= 60 D (112771) esp.emac: receive len= 99 D (113019) esp.emac: receive len= 217 D (113286) esp.emac: receive len= 217 D (113355) esp.emac: receive len= 81 D (113356) esp.emac: receive len= 101 D (113356) esp.emac: receive len= 81 D (113356) esp.emac: receive len= 101 D (113357) esp.emac: receive len= 95 D (113357) esp.emac: receive len= 75 D (113398) esp.emac: receive len= 60 D (113419) esp.emac: receive len= 139 D (113419) esp.emac: receive len= 159 D (114181) esp.emac: receive len= 66 D (114289) esp.emac: receive len= 217 D (114399) esp.emac: receive len= 60 D (114485) esp.emac: receive len= 60 D (114597) esp.emac: receive len= 82 D (115292) esp.emac: receive len= 217 D (115632) esp.emac: receive len= 60 D (115744) esp.emac: receive len= 60 D (116399) esp.emac: receive len= 60 D (116629) esp.emac: receive len= 206 D (116871) esp.emac: receive len= 150 D (116874) esp.emac: receive len= 170 D (116910) esp.emac: receive len= 316 D (117403) esp.emac: receive len= 60 D (117693) esp.emac: receive len= 204 D (117695) esp.emac: receive len= 224 D (118095) esp.emac: receive len= 206 D (118097) esp.emac: receive len= 226 D (118620) esp.emac: receive len= 116 D (119620) esp.emac: receive len= 207 D (119774) esp.emac: receive len= 60 D (120406) esp.emac: receive len= 60 D (120827) esp.emac: receive len= 82 D (120835) esp.emac: receive len= 60 D (121391) esp.emac: receive len= 60 D (121592) esp.emac: receive len= 60 D (121920) esp.emac: receive len= 316 D (122037) esp.emac: receive len= 150 D (122040) esp.emac: receive len= 170 D (122510) esp.emac: receive len= 410 D (122511) esp.emac: receive len= 456 D (122588) esp.emac: receive len= 60 D (122762) esp.emac: receive len= 456 D (122762) esp.emac: receive len= 410 D (123338) esp.emac: receive len= 217 D (124351) esp.emac: receive len= 217 D (125353) esp.emac: receive len= 217 D (125930) esp.emac: receive len= 60 D (125930) esp.emac: receive len= 60 D (126038) esp.emac: receive len= 169 D (126354) esp.emac: receive len= 217 D (126920) esp.emac: receive len= 316 D (127332) esp.emac: receive len= 150 D (127335) esp.emac: receive len= 170 D (127700) esp.emac: receive len= 204 D (127704) esp.emac: receive len= 224 D (127788) esp.emac: receive len= 60 D (128100) esp.emac: receive len= 206 D (128102) esp.emac: receive len= 226 D (128404) esp.emac: receive len= 60 D (128543) esp.emac: receive len= 60 D (128543) esp.emac: receive len= 60 D (128709) esp.emac: receive len= 154 D (128709) esp.emac: receive len= 174 D (129406) esp.emac: receive len= 60 D (129547) esp.emac: receive len= 90 D (129718) esp.emac: receive len= 154 D (129719) esp.emac: receive len= 174 D (130182) esp.emac: receive len= 66 D (130315) esp.emac: receive len= 60 D (130839) esp.emac: receive len= 60 D (131919) esp.emac: receive len= 316 D (132509) esp.emac: receive len= 150 D (132512) esp.emac: receive len= 170 D (132562) esp.emac: receive len= 90 D (132717) esp.emac: receive len= 154 D (132718) esp.emac: receive len= 174 D (133003) esp.emac: receive len= 81 D (133004) esp.emac: receive len= 101 D (133005) esp.emac: receive len= 95 D (133005) esp.emac: receive len= 75 D (133007) esp.emac: receive len= 81 D (133007) esp.emac: receive len= 101 D (133008) esp.emac: receive len= 95 D (133008) esp.emac: receive len= 75 D (133141) esp.emac: receive len= 139 D (133142) esp.emac: receive len= 159 D (133382) esp.emac: receive len= 217 D (133557) esp.emac: receive len= 217 D (134183) esp.emac: receive len= 66 D (134183) esp.emac: receive len= 66 D (134183) esp.emac: receive len= 66 D (134183) esp.emac: receive len= 0 D (134390) esp.emac: receive len= 217 D (134563) esp.emac: receive len= 217 D (134702) esp.emac: receive len= 217 D (135367) esp.emac: receive len= 217 D (135404) esp.emac: receive len= 217 D (135577) esp.emac: receive len= 217 D (135717) esp.emac: receive len= 217 D (136376) esp.emac: receive len= 217 D (136420) esp.emac: receive len= 217 D (136595) esp.emac: receive len= 217 D (136719) esp.emac: receive len= 217 D (136919) esp.emac: receive len= 316 D (137383) esp.emac: receive len= 217 D (137647) esp.emac: receive len= 150 D (137650) esp.emac: receive len= 170 D (137708) esp.emac: receive len= 204 D (137710) esp.emac: receive len= 224 D (137721) esp.emac: receive len= 217 D (137852) esp.emac: receive len= 60 D (137886) esp.emac: receive len= 217 D (138105) esp.emac: receive len= 206 D (138107) esp.emac: receive len= 226 D (138183) esp.emac: receive len= 66 D (138183) esp.emac: receive len= 66 D (138184) esp.emac: receive len= 66 D (138184) esp.emac: receive len= 0 D (138393) esp.emac: receive len= 217 D (138900) esp.emac: receive len= 217 D (139029) esp.emac: receive len= 92 D (139789) esp.emac: receive len= 92 D (139900) esp.emac: receive len= 217 D (140184) esp.emac: receive len= 66 D (140539) esp.emac: receive len= 92 D (140907) esp.emac: receive len= 217 D (141735) esp.emac: receive len= 154 D (141736) esp.emac: receive len= 174 D (141919) esp.emac: receive len= 316 D (141941) esp.emac: receive len= 139 D (141949) esp.emac: receive len= 90 D (143273) esp.emac: receive len= 217 D (143375) esp.emac: receive len= 81 D (143375) esp.emac: receive len= 101 D (143376) esp.emac: receive len= 95 D (143376) esp.emac: receive len= 75 D (143376) esp.emac: receive len= 81 D (143377) esp.emac: receive len= 101 D (143377) esp.emac: receive len= 95 D (143377) esp.emac: receive len= 75 D (143483) esp.emac: receive len= 139 D (143483) esp.emac: receive len= 159 D (143771) esp.emac: receive len= 99 D (143812) esp.emac: receive len= 60 D (144296) esp.emac: receive len= 217 D (144414) esp.emac: receive len= 60 D (145051) esp.emac: receive len= 217 D (145254) esp.emac: receive len= 217 D (145295) esp.emac: receive len= 217 D (145412) esp.emac: receive len= 60 D (146063) esp.emac: receive len= 217 D (146265) esp.emac: receive len= 217 D (146290) esp.emac: receive len= 217 D (146815) esp.emac: receive len= 60 D (146918) esp.emac: receive len= 316 D (147070) esp.emac: receive len= 217 D (147269) esp.emac: receive len= 217 D (147416) esp.emac: receive len= 60 D (147719) esp.emac: receive len= 204 D (147722) esp.emac: receive len= 224 D (148076) esp.emac: receive len= 217 D (148110) esp.emac: receive len= 206 D (148112) esp.emac: receive len= 226 D (148272) esp.emac: receive len= 217 D (148395) esp.emac: receive len= 60 D (148916) esp.emac: receive len= 82 D (150829) esp.emac: receive len= 60 D (151398) esp.emac: receive len= 60 D (151918) esp.emac: receive len= 316 D (152185) esp.emac: receive len= 66 D (152398) esp.emac: receive len= 60 D (153024) esp.emac: receive len= 112 D (155293) esp.emac: receive len= 82 D (156918) esp.emac: receive len= 316 D (157728) esp.emac: receive len= 204 D (157740) esp.emac: receive len= 224 D (158115) esp.emac: receive len= 206 D (158117) esp.emac: receive len= 226 D (158835) esp.emac: receive len= 60 D (159398) esp.emac: receive len= 60 D (160155) esp.emac: receive len= 130 D (160156) esp.emac: receive len= 60 D (160159) esp.emac: receive len= 78 D (160161) esp.emac: receive len= 60 D (160250) esp.emac: receive len= 90 D (160250) esp.emac: receive len= 86 D (160252) esp.emac: receive len= 342 D (160253) esp.emac: receive len= 352 D (160255) esp.emac: receive len= 62 D (160372) esp.emac: receive len= 130 D (160393) esp.emac: receive len= 60 D (160398) esp.emac: receive len= 60 D (160433) esp.emac: receive len= 217 D (160842) esp.emac: receive len= 342 D (160843) esp.emac: receive len= 352 D (161259) esp.emac: receive len= 90 D (161443) esp.emac: receive len= 217 I (161611) VOIP_CMD: VOIP CONFIG[SUNGSU]1 I (161612) VOIP_CMD: VOIP CONFIG[SUNGSU]2 I (161612) VOIP_CMD: [1.0] Initialize peripherals management V (161612) intr_alloc: esp_intr_alloc_intrstatus (cpu 1): checking args V (161613) intr_alloc: esp_intr_alloc_intrstatus (cpu 1): Args okay. Resulting flags 0x2 D (161614) intr_alloc: Connected src 22 to int 3 (cpu 1) I (161615) VOIP_CMD: [1.1] Initialize and start peripherals I (161615) VOIP_CMD: [ 2 ] Start codec chip I (161616) VOIP_CMD: [ 2.1 ] Start codec chip V (161617) intr_alloc: esp_intr_alloc_intrstatus (cpu 1): checking args V (161618) intr_alloc: esp_intr_alloc_intrstatus (cpu 1): Args okay. Resulting flags 0xE D (161619) intr_alloc: Connected src 49 to int 4 (cpu 1) E (161631) gpio: GPIO can only be used as input mode E (161631) gpio: gpio_set_level(226): GPIO output gpio_num error I (161632) ES8388_DRIVER: init,out:02, in:00 D (161637) ES8388_DRIVER: Set volume:70 reg_value:0x2a dB:-21.0 I (161637) AUDIO_HAL: Codec mode is 3, Ctrl:1 D (161641) ES8388_DRIVER: es8388_start default is mode:3 D (161641) ES8388_DRIVER: start default is decode mode:3 D (161642) ES8388_DRIVER: Set volume:55 reg_value:0x39 dB:-28.5 I (161642) VOIP_CMD: [ 2.2 ] Initialize av stream V (161642) intr_alloc: esp_intr_alloc_intrstatus (cpu 1): checking args V (161643) intr_alloc: esp_intr_alloc_intrstatus (cpu 1): Args okay. Resulting flags 0xE D (161644) intr_alloc: Connected src 32 to int 9 (cpu 1) D (161645) I2S: Addr[0] = 1073429296 D (161645) I2S: Addr[1] = 1073429444 D (161646) I2S: Addr[2] = 1073429592 D (161646) I2S: Addr[3] = 1073429740 D (161647) I2S: Addr[4] = 1073429888 D (161647) I2S: Addr[5] = 1073430036 D (161647) I2S: Addr[6] = 1073430184 D (161648) I2S: Addr[7] = 1073430332 I (161648) I2S: DMA Malloc info, datalen=blocksize=128, dma_buf_count=8 D (161649) I2S: Addr[0] = 1073430480 D (161650) I2S: Addr[1] = 1073430628 D (161650) I2S: Addr[2] = 1073430776 D (161651) I2S: Addr[3] = 1073430924 D (161651) I2S: Addr[4] = 1073431072 D (161652) I2S: Addr[5] = 1073431220 D (161652) I2S: Addr[6] = 1073431368 D (161652) I2S: Addr[7] = 1073431516 I (161653) I2S: DMA Malloc info, datalen=blocksize=128, dma_buf_count=8 I (161654) I2S: I2S0, MCLK output by GPIO3 I (161655) LYRAT_V4_3: I2S0, MCLK output by GPIO0 W (161655) AUDIO_BOARD: The board has already been initialized! I (161656) AUDIO_HAL: Codec mode is 3, Ctrl:1 D (161660) ES8388_DRIVER: es8388_start default is mode:3 D (161660) ES8388_DRIVER: start default is decode mode:3 D (161661) ES8388_DRIVER: Set volume:75 reg_value:0x25 dB:-18.5 I (161661) VOIP_CMD: [ 3 ] Initialize tone player I (161661) VOIP_CMD: [ 4 ] Create VOIP service instance I (161662) AUDIO_THREAD: The voip_serv task allocate stack on external memory I (161663) VOIP_CMD: [ 5 ] DEBUG 100, SIPpassword100, epicsafetysiptest.sip.twilio.com I (161664) VOIP_CMD: [ 6 ] DEBUG 100, SIPpassword100, epicsafetysiptest.sip.twilio.com I (161665) VOIP_CMD: [ 7 ] DEBUG UDP://100:SIPpassword100@epicsafetysiptest.sip.twilio.com I (161666) VOIP_CMD: VOIP CONFIG[SUNGSU]3 W (170137) VOIP_SERV: STATE type:2, pdata:0x0, len:0 D (170137) VOIP_CMD: event type:2,source:0x3f811ad0, data:0x0,len:0,ctx:0x0 I (170137) VOIP_CMD: PERIPH_VOIP_CONNECTED [399] I (170138) VOIP_CMD: [ 5 ] Create SIP Service D (170139) esp_netif_lwip: esp_netif_get_ip_info esp_netif:0x3ffd12ec D (170140) VOIP_CMD: IP: 2182873098 D (170140) VOIP_CMD: IP: 10.0.28.130 I (170140) ESP_RTC_CORE: esp_rtc ver: 1.0.0 compile date: Feb 7 2023-01:59:15 I (170142) SIP: Conecting... I (170143) ESP_RTC_CORE: esp_rtc_init done E (183930) SIP: Connection failed, error: Success W (193930) SIP: CHANGE STATE FROM 0, TO 0, :func: sip_reconnect:370 I (195130) SIP: Conecting... E (208930) SIP: Connection failed, error: Success W (218930) SIP: CHANGE STATE FROM 0, TO 0, :func: sip_reconnect:370 I (219145) VOIP_CMD: SUNGSU RTMP VER I (220130) SIP: Conecting... E (233930) SIP: Connection failed, error: Success W (243930) SIP: CHANGE STATE FROM 0, TO 0, :func: sip_reconnect:370 I (245130) SIP: Conecting... E (258930) SIP: Connection failed, error: Success W (268930) SIP: CHANGE STATE FROM 0, TO 0, :func: sip_reconnect:370 I (270130) SIP: Conecting... E (283930) SIP: Connection failed, error: Success W (293930) SIP: CHANGE STATE FROM 0, TO 0, :func: sip_reconnect:370 I (295130) SIP: Conecting... E (309130) SIP: Connection failed, error: Success W (319130) SIP: CHANGE STATE FROM 0, TO 0, :func: sip_reconnect:370 I (320330) SIP: Conecting... E (334330) SIP: Connection failed, error: Success W (344330) SIP: CHANGE STATE FROM 0, TO 0, :func: sip_reconnect:370 I (345530) SIP: Conecting... E (359530) SIP: Connection failed, error: Success W (369530) SIP: CHANGE STATE FROM 0, TO 0, :func: sip_reconnect:370 I (370730) SIP: Conecting... E (384730) SIP: Connection failed, error: Success W (394730) SIP: CHANGE STATE FROM 0, TO 0, :func: sip_reconnect:370 I (395930) SIP: Conecting... E (409930) SIP: Connection failed, error: Success W (419930) SIP: CHANGE STATE FROM 0, TO 0, :func: sip_reconnect:370 I (421130) SIP: Conecting... E (435130) SIP: Connection failed, error: Success W (445130) SIP: CHANGE STATE FROM 0, TO 0, :func: sip_reconnect:370 I (446330) SIP: Conecting... E (460330) SIP: Connection failed, error: Success W (470330) SIP: CHANGE STATE FROM 0, TO 0, :func: sip_reconnect:370 I (471530) SIP: Conecting... E (485530) SIP: Connection failed, error: Success W (495530) SIP: CHANGE STATE FROM 0, TO 0, :func: sip_reconnect:370 I (496730) SIP: Conecting... E (510730) SIP: Connection failed, error: Success W (520730) SIP: CHANGE STATE FROM 0, TO 0, :func: sip_reconnect:370 I (521930) SIP: Conecting... E (535930) SIP: Connection failed, error: Success W (545930) SIP: CHANGE STATE FROM 0, TO 0, :func: sip_reconnect:370 I (547130) SIP: Conecting... E (561130) SIP: Connection failed, error: Success W (571130) SIP: CHANGE STATE FROM 0, TO 0, :func: sip_reconnect:370 I (572330) SIP: Conecting... E (586330) SIP: Connection failed, error: Success W (596330) SIP: CHANGE STATE FROM 0, TO 0, :func: sip_reconnect:370 I (597530) SIP: Conecting... E (611530) SIP: Connection failed, error: Success W (621530) SIP: CHANGE STATE FROM 0, TO 0, :func: sip_reconnect:370 I (622730) SIP: Conecting... E (636730) SIP: Connection failed, error: Success W (646730) SIP: CHANGE STATE FROM 0, TO 0, :func: sip_reconnect:370 I (647930) SIP: Conecting... E (661930) SIP: Connection failed, error: Success W (671930) SIP: CHANGE STATE FROM 0, TO 0, :func: sip_reconnect:370 I (673130) SIP: Conecting... E (687130) SIP: Connection failed, error: Success W (697130) SIP: CHANGE STATE FROM 0, TO 0, :func: sip_reconnect:370 I (698330) SIP: Conecting... E (712330) SIP: Connection failed, error: Success W (722330) SIP: CHANGE STATE FROM 0, TO 0, :func: sip_reconnect:370 I (723530) SIP: Conecting... E (737530) SIP: Connection failed, error: Success W (747530) SIP: CHANGE STATE FROM 0, TO 0, :func: sip_reconnect:370 I (748730) SIP: Conecting... E (762730) SIP: Connection failed, error: Success W (772730) SIP: CHANGE STATE FROM 0, TO 0, :func: sip_reconnect:370 I (773930) SIP: Conecting... E (787930) SIP: Connection failed, error: Success W (797930) SIP: CHANGE STATE FROM 0, TO 0, :func: sip_reconnect:370 I (799130) SIP: Conecting... E (813130) SIP: Connection failed, error: Success

espressif / esp-adf

SIP Registration doesn't get triggered through Ethernet connection (AUD-4550) #990

Problem Description

Environment

Test Procedure & Analysis

Logs

Logs in detail.