Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

Boot-loop when HSPI is used as AT interface #137

Closed
TinghuiWang opened this issue Oct 7, 2018 · 4 comments
Closed

Boot-loop when HSPI is used as AT interface #137

TinghuiWang opened this issue Oct 7, 2018 · 4 comments

Comments

@TinghuiWang
Copy link

TinghuiWang commented Oct 7, 2018 •
edited
Loading

I have successfully compiled and verified the esp32-at binaries for my ESP-WROOM-32 module with AT interface set to Uart0 and Uart1. However, when I try to test the AT commands using HSPI interface, fatal error occurs and brings ESP32 module into a boot loop.

From the Uart0 log, I am concerned about the following error messages:

E (653) HSPI-AT: Cannot get read data address.
...
ESP_ERROR_CHECK failed: esp_err_t 0xffffffff (ESP_FAIL) at 0x400f1e40
file: "/builds/rd/esp-at-core/components/at_core/at_port.c" line 711
func: initialise_wifi
expression: esp_event_loop_init(at_wifi_event_handler_cb, NULL)

Backtrace: 0x40093ae0:0x3ffba9a0 0x40093eb0:0x3ffba9c0 0x400f1e40:0x3ffba9e0 0x400f28e3:0x3ffbaaa0 0x400d4161:0x3ffbaae0 0x400d2408:0x3ffbab00 0x40090f29:0x3ffbab20

Rebooting...

I am wondering if anyone has experienced this error before or if anyone can advice on what I need to look into. Thanks indeed.

Here is the full log with output level set to verbose.

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:0x3fff0018,len:4
load:0x3fff001c,len:6256
ho 0 tail 12 room 4
load:0x40078000,len:9404
load:0x40080400,len:7128
entry 0x400807a0
I (30) boot: ESP-IDF v3.2-dev-1175-g11b444b8f 2nd stage bootloader
I (31) boot: compile time 16:58:37
I (31) boot: Enabling RNG early entropy source...
I (37) boot: SPI Speed      : 40MHz
I (41) boot: SPI Mode       : DIO
I (45) boot: SPI Flash Size : 4MB
I (49) boot: Partition Table:
I (53) boot: ## Label            Usage          Type ST Offset   Length
I (60) boot:  0 phy_init         RF data          01 01 0000f000 00001000
I (67) boot:  1 otadata          OTA data         01 00 00010000 00002000
I (75) boot:  2 nvs              WiFi data        01 02 00012000 0000e000
I (82) boot:  3 at_customize     unknown          40 00 00020000 000e0000
I (90) boot:  4 ota_0            OTA app          00 10 00100000 00180000
I (97) boot:  5 ota_1            OTA app          00 11 00280000 00180000
I (105) boot: End of partition table
I (109) boot: No factory image, trying OTA 0
I (114) esp_image: segment 0: paddr=0x00100020 vaddr=0x3f400020 size=0x2b7bc (178108) map
I (185) esp_image: segment 1: paddr=0x0012b7e4 vaddr=0x3ffbdb60 size=0x03508 ( 13576) load
I (191) esp_image: segment 2: paddr=0x0012ecf4 vaddr=0x3ffc1068 size=0x00000 (     0) load
I (192) esp_image: segment 3: paddr=0x0012ecfc vaddr=0x40080000 size=0x00400 (  1024) load
I (202) esp_image: segment 4: paddr=0x0012f104 vaddr=0x40080400 size=0x00f0c (  3852) load
I (212) esp_image: segment 5: paddr=0x00130018 vaddr=0x400d0018 size=0xf54b4 (1004724) map
I (571) esp_image: segment 6: paddr=0x002254d4 vaddr=0x4008130c size=0x15814 ( 88084) load
I (608) esp_image: segment 7: paddr=0x0023acf0 vaddr=0x400c0000 size=0x00064 (   100) load
I (608) esp_image: segment 8: paddr=0x0023ad5c vaddr=0x50000000 size=0x00000 (     0) load
I (627) boot: Loaded app from partition at offset 0x100000
I (628) boot: Disabling RNG early entropy source...
I (628) cpu_start: Pro cpu up.
I (632) cpu_start: Single core mode
V (636) memory_layout: reserved range is 0x3f42b794 - 0x3f42b7dc
D (642) memory_layout: Checking 11 reserved memory ranges:
D (648) memory_layout: Reserved memory range 0x3ffae000 - 0x3ffae6e0
D (654) memory_layout: Reserved memory range 0x3ffae6e0 - 0x3ffaff10
D (661) memory_layout: Reserved memory range 0x3ffb0000 - 0x3ffb6388
D (667) memory_layout: Reserved memory range 0x3ffb8000 - 0x3ffb9a20
D (673) memory_layout: Reserved memory range 0x3ffbdb28 - 0x3ffbdb5c
D (680) memory_layout: Reserved memory range 0x3ffbdb60 - 0x3ffcc3f0
D (686) memory_layout: Reserved memory range 0x3ffe0000 - 0x3ffe0440
D (693) memory_layout: Reserved memory range 0x3ffe4000 - 0x3ffe4350
D (699) memory_layout: Reserved memory range 0x40070000 - 0x40078000
D (706) memory_layout: Reserved memory range 0x40078000 - 0x40080000
D (712) memory_layout: Reserved memory range 0x40080000 - 0x40096b20
D (718) memory_layout: Building list of available memory regions:
V (725) memory_layout: Examining memory region 0x3ffae000 - 0x3ffb0000
V (731) memory_layout: Start of region 0x3ffae000 - 0x3ffb0000 overlaps reserved 0x3ffae000 - 0x3ffae6e0
V (741) memory_layout: Start of region 0x3ffae6e0 - 0x3ffb0000 overlaps reserved 0x3ffae6e0 - 0x3ffaff10
D (750) memory_layout: Available memory region 0x3ffaff10 - 0x3ffb0000
V (757) memory_layout: Examining memory region 0x3ffb0000 - 0x3ffb8000
V (763) memory_layout: Start of region 0x3ffb0000 - 0x3ffb8000 overlaps reserved 0x3ffb0000 - 0x3ffb6388
D (773) memory_layout: Available memory region 0x3ffb6388 - 0x3ffb8000
V (780) memory_layout: Examining memory region 0x3ffb8000 - 0x3ffc0000
V (786) memory_layout: Start of region 0x3ffb8000 - 0x3ffc0000 overlaps reserved 0x3ffb8000 - 0x3ffb9a20
V (796) memory_layout: Region 0x3ffb9a20 - 0x3ffc0000 contains reserved 0x3ffbdb28 - 0x3ffbdb5c
D (805) memory_layout: Available memory region 0x3ffb9a20 - 0x3ffbdb28
V (811) memory_layout: Examining memory region 0x3ffbdb5c - 0x3ffc0000
V (818) memory_layout: End of region 0x3ffbdb5c - 0x3ffc0000 overlaps reserved 0x3ffbdb60 - 0x3ffcc3f0
D (827) memory_layout: Available memory region 0x3ffbdb5c - 0x3ffbdb60
V (834) memory_layout: Examining memory region 0x3ffc0000 - 0x3ffc2000
V (840) memory_layout: Region 0x3ffc0000 - 0x3ffc2000 inside of reserved 0x3ffbdb60 - 0x3ffcc3f0
V (849) memory_layout: Examining memory region 0x3ffc2000 - 0x3ffc4000
V (856) memory_layout: Region 0x3ffc2000 - 0x3ffc4000 inside of reserved 0x3ffbdb60 - 0x3ffcc3f0
V (865) memory_layout: Examining memory region 0x3ffc4000 - 0x3ffc6000
V (871) memory_layout: Region 0x3ffc4000 - 0x3ffc6000 inside of reserved 0x3ffbdb60 - 0x3ffcc3f0
V (880) memory_layout: Examining memory region 0x3ffc6000 - 0x3ffc8000
V (887) memory_layout: Region 0x3ffc6000 - 0x3ffc8000 inside of reserved 0x3ffbdb60 - 0x3ffcc3f0
V (896) memory_layout: Examining memory region 0x3ffc8000 - 0x3ffca000
V (902) memory_layout: Region 0x3ffc8000 - 0x3ffca000 inside of reserved 0x3ffbdb60 - 0x3ffcc3f0
V (911) memory_layout: Examining memory region 0x3ffca000 - 0x3ffcc000
V (918) memory_layout: Region 0x3ffca000 - 0x3ffcc000 inside of reserved 0x3ffbdb60 - 0x3ffcc3f0
V (926) memory_layout: Examining memory region 0x3ffcc000 - 0x3ffce000
V (933) memory_layout: Start of region 0x3ffcc000 - 0x3ffce000 overlaps reserved 0x3ffbdb60 - 0x3ffcc3f0
D (943) memory_layout: Available memory region 0x3ffcc3f0 - 0x3ffce000
V (949) memory_layout: Examining memory region 0x3ffce000 - 0x3ffd0000
D (956) memory_layout: Available memory region 0x3ffce000 - 0x3ffd0000
V (962) memory_layout: Examining memory region 0x3ffd0000 - 0x3ffd2000
D (969) memory_layout: Available memory region 0x3ffd0000 - 0x3ffd2000
V (976) memory_layout: Examining memory region 0x3ffd2000 - 0x3ffd4000
D (982) memory_layout: Available memory region 0x3ffd2000 - 0x3ffd4000
V (989) memory_layout: Examining memory region 0x3ffd4000 - 0x3ffd6000
D (995) memory_layout: Available memory region 0x3ffd4000 - 0x3ffd6000
V (1002) memory_layout: Examining memory region 0x3ffd6000 - 0x3ffd8000
D (1009) memory_layout: Available memory region 0x3ffd6000 - 0x3ffd8000
V (1015) memory_layout: Examining memory region 0x3ffd8000 - 0x3ffda000
D (1022) memory_layout: Available memory region 0x3ffd8000 - 0x3ffda000
V (1029) memory_layout: Examining memory region 0x3ffda000 - 0x3ffdc000
D (1035) memory_layout: Available memory region 0x3ffda000 - 0x3ffdc000
V (1042) memory_layout: Examining memory region 0x3ffdc000 - 0x3ffde000
D (1049) memory_layout: Available memory region 0x3ffdc000 - 0x3ffde000
V (1055) memory_layout: Examining memory region 0x3ffde000 - 0x3ffe0000
D (1062) memory_layout: Available memory region 0x3ffde000 - 0x3ffe0000
V (1069) memory_layout: Examining memory region 0x3ffe0000 - 0x3ffe4000
V (1075) memory_layout: Start of region 0x3ffe0000 - 0x3ffe4000 overlaps reserved 0x3ffe0000 - 0x3ffe0440
D (1085) memory_layout: Available memory region 0x3ffe0440 - 0x3ffe4000
V (1092) memory_layout: Examining memory region 0x3ffe4000 - 0x3ffe8000
V (1098) memory_layout: Start of region 0x3ffe4000 - 0x3ffe8000 overlaps reserved 0x3ffe4000 - 0x3ffe4350
D (1108) memory_layout: Available memory region 0x3ffe4350 - 0x3ffe8000
V (1115) memory_layout: Examining memory region 0x3ffe8000 - 0x3fff0000
D (1121) memory_layout: Available memory region 0x3ffe8000 - 0x3fff0000
V (1128) memory_layout: Examining memory region 0x3fff0000 - 0x3fff8000
D (1135) memory_layout: Available memory region 0x3fff0000 - 0x3fff8000
V (1142) memory_layout: Examining memory region 0x3fff8000 - 0x3fffc000
D (1148) memory_layout: Available memory region 0x3fff8000 - 0x3fffc000
V (1155) memory_layout: Examining memory region 0x3fffc000 - 0x40000000
D (1162) memory_layout: Available memory region 0x3fffc000 - 0x40000000
V (1168) memory_layout: Examining memory region 0x40070000 - 0x40078000
V (1175) memory_layout: Region 0x40070000 - 0x40078000 inside of reserved 0x40070000 - 0x40078000
V (1184) memory_layout: Examining memory region 0x40078000 - 0x40080000
V (1191) memory_layout: Region 0x40078000 - 0x40080000 inside of reserved 0x40078000 - 0x40080000
V (1199) memory_layout: Examining memory region 0x40080000 - 0x40082000
V (1206) memory_layout: Region 0x40080000 - 0x40082000 inside of reserved 0x40080000 - 0x40096b20
V (1215) memory_layout: Examining memory region 0x40082000 - 0x40084000
V (1222) memory_layout: Region 0x40082000 - 0x40084000 inside of reserved 0x40080000 - 0x40096b20
V (1231) memory_layout: Examining memory region 0x40084000 - 0x40086000
V (1237) memory_layout: Region 0x40084000 - 0x40086000 inside of reserved 0x40080000 - 0x40096b20
V (1246) memory_layout: Examining memory region 0x40086000 - 0x40088000
V (1253) memory_layout: Region 0x40086000 - 0x40088000 inside of reserved 0x40080000 - 0x40096b20
V (1262) memory_layout: Examining memory region 0x40088000 - 0x4008a000
V (1269) memory_layout: Region 0x40088000 - 0x4008a000 inside of reserved 0x40080000 - 0x40096b20
V (1278) memory_layout: Examining memory region 0x4008a000 - 0x4008c000
V (1284) memory_layout: Region 0x4008a000 - 0x4008c000 inside of reserved 0x40080000 - 0x40096b20
V (1293) memory_layout: Examining memory region 0x4008c000 - 0x4008e000
V (1300) memory_layout: Region 0x4008c000 - 0x4008e000 inside of reserved 0x40080000 - 0x40096b20
V (1309) memory_layout: Examining memory region 0x4008e000 - 0x40090000
V (1316) memory_layout: Region 0x4008e000 - 0x40090000 inside of reserved 0x40080000 - 0x40096b20
V (1324) memory_layout: Examining memory region 0x40090000 - 0x40092000
V (1331) memory_layout: Region 0x40090000 - 0x40092000 inside of reserved 0x40080000 - 0x40096b20
V (1340) memory_layout: Examining memory region 0x40092000 - 0x40094000
V (1347) memory_layout: Region 0x40092000 - 0x40094000 inside of reserved 0x40080000 - 0x40096b20
V (1356) memory_layout: Examining memory region 0x40094000 - 0x40096000
V (1362) memory_layout: Region 0x40094000 - 0x40096000 inside of reserved 0x40080000 - 0x40096b20
V (1371) memory_layout: Examining memory region 0x40096000 - 0x40098000
V (1378) memory_layout: Start of region 0x40096000 - 0x40098000 overlaps reserved 0x40080000 - 0x40096b20
D (1388) memory_layout: Available memory region 0x40096b20 - 0x40098000
V (1394) memory_layout: Examining memory region 0x40098000 - 0x4009a000
D (1401) memory_layout: Available memory region 0x40098000 - 0x4009a000
V (1408) memory_layout: Examining memory region 0x4009a000 - 0x4009c000
D (1414) memory_layout: Available memory region 0x4009a000 - 0x4009c000
V (1421) memory_layout: Examining memory region 0x4009c000 - 0x4009e000
D (1428) memory_layout: Available memory region 0x4009c000 - 0x4009e000
V (1434) memory_layout: Examining memory region 0x4009e000 - 0x400a0000
D (1441) memory_layout: Available memory region 0x4009e000 - 0x400a0000
I (1448) heap_init: Initializing. RAM available for dynamic allocation:
D (1455) heap_init: New heap initialised at 0x3ffaff10
I (1460) heap_init: At 3FFAFF10 len 000000F0 (0 KiB): DRAM
D (1467) heap_init: New heap initialised at 0x3ffb6388
I (1472) heap_init: At 3FFB6388 len 00001C78 (7 KiB): DRAM
D (1478) heap_init: New heap initialised at 0x3ffb9a20
I (1483) heap_init: At 3FFB9A20 len 00004108 (16 KiB): DRAM
I (1489) heap_init: At 3FFBDB5C len 00000004 (0 KiB): DRAM
D (1495) heap_init: New heap initialised at 0x3ffcc3f0
I (1501) heap_init: At 3FFCC3F0 len 00013C10 (79 KiB): DRAM
I (1507) heap_init: At 3FFE0440 len 00003BC0 (14 KiB): D/IRAM
I (1513) heap_init: At 3FFE4350 len 0001BCB0 (111 KiB): D/IRAM
D (1520) heap_init: New heap initialised at 0x40096b20
I (1525) heap_init: At 40096B20 len 000094E0 (37 KiB): IRAM
I (1531) cpu_start: Pro cpu start user code
D (1543) clk: RTC_SLOW_CLK calibration value: 3365722
V (211) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): checking args
V (211) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): Args okay. Resulting flags 0xE
D (216) intr_alloc: Connected src 46 to int 2 (cpu 0)
V (222) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): checking args
V (227) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): Args okay. Resulting flags 0xC0E
D (235) intr_alloc: Connected src 57 to int 3 (cpu 0)
V (241) esp_dbg_stubs: esp_dbg_stubs_init stubs 3ffc3148
V (246) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): checking args
V (252) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): Args okay. Resulting flags 0x40E
D (260) intr_alloc: Connected src 24 to int 9 (cpu 0)
I (266) cpu_start: Starting scheduler on PRO CPU.
D (271) heap_init: New heap initialised at 0x3ffe0440
D (275) heap_init: New heap initialised at 0x3ffe4350
V (281) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): checking args
V (281) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): Args okay. Resulting flags 0xE
D (281) intr_alloc: Connected src 16 to int 12 (cpu 0)
D (301) nvs: nvs_flash_init_custom partition=nvs start=18 count=14
D (325) nvs: nvs_open_from_partition misc 1
D (325) nvs: nvs_get_str_or_blob log
I (326) wifi: wifi driver task: 3ffd51b4, prio:23, stack:3584, core=0
I (328) wifi: wifi firmware version: addc5bd
I (332) wifi: config NVS flash: enabled
I (336) wifi: config nano formating: disabled
I (340) system_api: Base MAC address is not set, read default base MAC address from BLK0 of EFUSE
I (349) system_api: Base MAC address is not set, read default base MAC address from BLK0 of EFUSE
D (359) nvs: nvs_open_from_partition nvs.net80211 1
D (364) nvs: nvs_get opmode 1
D (367) nvs: nvs_get_str_or_blob sta.ssid
D (371) nvs: nvs_get_str_or_blob sta.mac
D (376) nvs: nvs_get sta.authmode 1
D (379) nvs: nvs_get_str_or_blob sta.pswd
D (383) nvs: nvs_get_str_or_blob sta.pmk
D (387) nvs: nvs_get sta.chan 1
D (390) nvs: nvs_get auto.conn 1
D (393) nvs: nvs_get bssid.set 1
D (396) nvs: nvs_get_str_or_blob sta.bssid
D (401) nvs: nvs_get sta.lis_intval 2
D (404) nvs: nvs_get sta.phym 1
D (408) nvs: nvs_get sta.phybw 1
D (411) nvs: nvs_get_str_or_blob sta.apsw
D (415) nvs: nvs_get_str_or_blob sta.apinfo
D (420) nvs: nvs_get sta.scan_method 1
D (423) nvs: nvs_get sta.sort_method 1
D (427) nvs: nvs_get sta.minrssi 1
D (430) nvs: nvs_get sta.minauth 1
D (434) nvs: nvs_get_str_or_blob ap.ssid
D (438) nvs: nvs_get_str_or_blob ap.mac
D (442) nvs: nvs_get_str_or_blob ap.passwd
D (446) nvs: nvs_get_str_or_blob ap.pmk
D (450) nvs: nvs_get ap.chan 1
D (453) nvs: nvs_get ap.authmode 1
D (456) nvs: nvs_get ap.hidden 1
D (460) nvs: nvs_get ap.max.conn 1
D (463) nvs: nvs_get bcn.interval 2
D (467) nvs: nvs_get ap.phym 1
D (470) nvs: nvs_get ap.phybw 1
D (473) nvs: nvs_get ap.sndchan 1
D (476) nvs: nvs_get lorate 1
D (480) nvs: nvs_set_blob sta.mac 6
D (485) nvs: nvs_set_blob ap.mac 6
I (489) wifi: Init dynamic tx buffer num: 32
I (490) wifi: Init data frame dynamic rx buffer num: 32
I (495) wifi: Init management frame dynamic rx buffer num: 32
I (501) wifi: Init static rx buffer size: 1600
I (505) wifi: Init static rx buffer num: 10
I (509) wifi: Init dynamic rx buffer num: 32
D (514) RTC_MODULE: Wi-Fi takes adc2 lock.
D (517) phy_init: loading PHY init data from partition at offset 0xf000
D (524) phy_init: PHY data partition validated
D (528) nvs: nvs_open_from_partition phy 0
D (532) nvs: nvs_get cal_version 4
V (536) phy_init: phy_get_rf_cal_version: 4000
D (541) nvs: nvs_get_str_or_blob cal_mac
D (545) nvs: nvs_get_str_or_blob cal_data
D (551) nvs: nvs_close 3
I (609) phy: phy_version: 4000, b6198fa, Sep  3 2018, 15:11:06, 0, 0
I (611) wifi: mode : softAP (24:0a:c4:9f:6c:55)
I (612) wifi: Init max length of beacon: 752/752
I (614) wifi: Init max length of beacon: 752/752
D (618) event: SYSTEM_EVENT_AP_START
V (621) event: enter default callback
V (626) tcpip_adapter: check: local, if=1 fn=0x401b3d4c

D (632) tcpip_adapter: dhcp server start:(ip: 192.168.4.1, mask: 255.255.255.0, gw: 192.168.4.1)
V (639) tcpip_adapter: call api in lwip: ret=0x0, give sem
V (645) tcpip_adapter: check: remote, if=1 fn=0x401b3d4c

V (650) event: exit default callback
E (655) HSPI-AT: Cannot get read data address.
I (660) wifi: mode : sta (24:0a:c4:9f:6c:54) + softAP (24:0a:c4:9f:6c:55)
D (666) event: SYSTEM_EVENT_STA_START
V (669) event: enter default callback
V (673) tcpip_adapter: check: local, if=0 fn=0x401b3d4c

V (679) tcpip_adapter: call api in lwip: ret=0x0, give sem
V (684) tcpip_adapter: check: remote, if=0 fn=0x401b3d4c

V (690) event: exit default callback
D (694) nvs: nvs_open_from_partition NVM_004 0
D (698) nvs: nvs_open_from_partition NVM_012 0
D (702) nvs: nvs_open_from_partition NVM_011 0
V (707) tcpip_adapter: check: local, if=0 fn=0x401b5c1c

D (712) tcpip_adapter: dhcp client stop successfully
V (717) tcpip_adapter: call api in lwip: ret=0x0, give sem
V (723) tcpip_adapter: check: remote, if=0 fn=0x401b5c1c

V (729) tcpip_adapter: check: local, if=1 fn=0x401b568c

D (734) tcpip_adapter: dhcp server stop successfully
V (739) tcpip_adapter: call api in lwip: ret=0x0, give sem
V (745) tcpip_adapter: check: remote, if=1 fn=0x401b568c

V (750) tcpip_adapter: check: local, if=2 fn=0x401b5c1c

D (756) tcpip_adapter: dhcp client stop successfully
V (761) tcpip_adapter: call api in lwip: ret=0x0, give sem
V (766) tcpip_adapter: check: remote, if=2 fn=0x401b5c1c

D (772) nvs: nvs_open_from_partition NVM_002 0
D (776) nvs: nvs_open_from_partition NVM_003 0
D (781) nvs: nvs_open_from_partition NVM_001 0
D (785) nvs: nvs_open_from_partition NVM_010 0
D (790) nvs: nvs_open_from_partition NVM_007 0
D (794) nvs: nvs_open_from_partition NVM_006 0
V (799) tcpip_adapter: check: local, if=0 fn=0x401b5ac0

D (804) tcpip_adapter: dhcp client re init
V (809) tcpip_adapter: call api in lwip: ret=0x0, give sem
V (814) tcpip_adapter: check: remote, if=0 fn=0x401b5ac0

V (820) tcpip_adapter: check: local, if=1 fn=0x401b5554

D (825) tcpip_adapter: dhcp server start successfully
V (830) tcpip_adapter: call api in lwip: ret=0x0, give sem
V (836) tcpip_adapter: check: remote, if=1 fn=0x401b5554

V (841) tcpip_adapter: check: local, if=2 fn=0x401b5ac0

D (847) tcpip_adapter: dhcp client re init
V (851) tcpip_adapter: call api in lwip: ret=0x0, give sem
V (857) tcpip_adapter: check: remote, if=2 fn=0x401b5ac0

I (863) wifi: mode : softAP (24:0a:c4:9f:6c:55)
D (867) event: SYSTEM_EVENT_STA_STOP
V (870) event: enter default callback
V (874) tcpip_adapter: check: local, if=0 fn=0x401b41e0

V (879) tcpip_adapter: call api in lwip: ret=0x5002, give sem
V (885) tcpip_adapter: check: remote, if=0 fn=0x401b41e0

V (891) event: exit default callback
D (894) nvs: nvs_open_from_partition NVM_008 0
V (899) tcpip_adapter: check: local, if=0 fn=0x401b52a0

D (904) tcpip_adapter: set dns if=0 type=0 dns=dede43d0
V (909) tcpip_adapter: call api in lwip: ret=0x0, give sem
V (915) tcpip_adapter: check: remote, if=0 fn=0x401b52a0

D (921) nvs: nvs_open_from_partition NVM_009 1
D (925) nvs: nvs_get maxlink 1
D (929) nvs: nvs_open_from_partition NVM_009 0
D (933) nvs: nvs_get auth0 1
D (936) nvs: nvs_open_from_partition NVM_009 0
D (940) nvs: nvs_get auth1 1
D (943) nvs: nvs_open_from_partition NVM_009 0
D (948) nvs: nvs_get auth2 1
D (951) nvs: nvs_open_from_partition NVM_009 0
D (955) nvs: nvs_get auth3 1
D (958) nvs: nvs_open_from_partition NVM_009 0
D (963) nvs: nvs_get auth4 1
D (966) nvs: nvs_open_from_partition NVM_005 1
D (970) nvs: nvs_get enable 1
D (973) nvs: nvs_get type 1
D (976) nvs: nvs_get_str_or_blob r_ip
D (980) nvs: nvs_get r_port 4
D (983) nvs: nvs_get l_port 4
D (986) nvs: nvs_get change_mode 1
D (989) nvs: nvs_get keep_alive 2
D (993) nvs: nvs_open_from_partition NVM_013 0
D (997) nvs: nvs_get apmode 4
D (1001) nvs: nvs_close 11
D (1003) nvs: nvs_open_from_partition NVM_013 1
D (1008) nvs: nvs_set apmode 4 0
D (1012) nvs: nvs_close 12
ESP_ERROR_CHECK failed: esp_err_t 0xffffffff (ESP_FAIL) at 0x400f1e40
file: "/builds/rd/esp-at-core/components/at_core/at_port.c" line 711
func: initialise_wifi
expression: esp_event_loop_init(at_wifi_event_handler_cb, NULL)

Backtrace: 0x40093ae0:0x3ffba9a0 0x40093eb0:0x3ffba9c0 0x400f1e40:0x3ffba9e0 0x400f28e3:0x3ffbaaa0 0x400d4161:0x3ffbaae0 0x400d2408:0x3ffbab00 0x40090f29:0x3ffbab20
@xcguang
Copy link
Collaborator

xcguang commented Oct 8, 2018

Hi,
Please remove esp_at_module_init(CONFIG_LWIP_MAX_SOCKETS - 1, version); in main/interface/hspi/at_hspi_task.c, and we will fix it ASAP.

@TinghuiWang
Copy link
Author

Thanks for your response.
Removing esp_at_module_init does remove the fatal error of initialise_wifi, however, the SPI is still not functioning properly.

I have the following two questions:

  1. SPI pin configuration:
    When HSPI is in slave mode, MOSI is mapped to GPIO12 (HSPIQ), MISO is mapped to GPIO13 (HSPID).
    However, the SCLK and CS signals are not mapped to the same pins as described in ESP32_TRM (v3.8) document.
    SCLK is mapped to GPIO15 in the project, which is labeled as HSPICS0 in ESP32_TRM and ESP-WROOM-32 datasheet.
    CS is mapped to GPIO14 in the project, which is labeled as HSPICLK in ESP32_TRM and ESP-WROOM-32 datasheet.

Which one is correct?

  1. HSPI-AT error message still occurs.

During the log, there is still the following error message:

E (653) HSPI-AT: Cannot get read data address.

@Jacques-Zhao
Copy link

Hi @TinghuiWang 1. SPI pins use iomux map SPI iomux, so you can use any free IO implementation. 2. This Log is normal, we'll get rid of it in the next patch.

@TinghuiWang
Copy link
Author

@yake827 Thank you very much for clearing it up.

@xcguang xcguang closed this as completed Oct 11, 2018
@bgould bgould mentioned this issue Nov 7, 2019
Open
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
None yet
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
3 participants
@TinghuiWang @Jacques-Zhao @xcguang