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.

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

esp32S3 as OTBR, " OPENTHREAD: Failed to get LL address, error: Invalid If index" (IDFGH-14237) #15033

Open
3 tasks done
githubworksonline opened this issue Dec 15, 2024 · 7 comments
Assignees
Labels
Status: Opened Issue is new Type: Bug bugs in IDF

Comments

@githubworksonline
Copy link

Answers checklist.

  • I have read the documentation ESP-IDF Programming Guide and the issue is not addressed there.
  • I have updated my IDF branch (master or release) to the latest version and checked that the issue is present there.
  • I have searched the issue tracker for a similar issue and not found a similar issue.

IDF version.

TAG: 5.3.2

Espressif SoC revision.

Chip rev: v0.1

Operating System used.

Windows

How did you build your project?

Command line with Make

If you are using Windows, please specify command line type.

None

Development Kit.

esp32s3 chip

Power Supply used.

USB

What is the expected behavior?

i do not understand openthread, it is my fist run this example. after 10minutes, nothing happened.

What is the actual behavior?

i want it run as "https://docs.espressif.com/projects/esp-thread-br/en/latest/codelab/index.html"

Steps to reproduce.

only idf5.3.2 otbr example on esp32S3 and ncp example on esp32H2.

Debug Logs.

factoryreset

I (1017808) wifi:state: run -> init (0x0)
I (1017808) wifi:pm stop, total sleep time: 975447964 us / 1014050981 us

I (1017808) wifi:<ba-del>idx:0, tid:0
I (1017808) wifi:new:<8,0>, old:<8,1>, ap:<255,255>, sta:<8,1>, prof:1, snd_ch_cfg:0x0
 [0;32mI (1017828) example_connect: Wi-Fi disconnected 8, trying to reconnect... [0m
I (1017868) wifi:flush txq
I (1017868) wifi:stop sw txq
I (1017868) wifi:lmac stop hw txq
ESP-ROM:esp32s3-20210327
Build:Mar 27 2021
rst:0xc (RTC_SW_CPU_RST),boot:0x8 (SPI_FAST_FLASH_BOOT)
Saved PC:0x40375c30
SPIWP:0xee
mode:DIO, clock div:1
load:0x3fce2810,len:0x1870
load:0x403c8700,len:0x4
load:0x403c8704,len:0xce8
load:0x403cb700,len:0x2ed8
entry 0x403c8918
 [0;32mI (31) boot: ESP-IDF v5.3.2 2nd stage bootloader [0m
 [0;32mI (31) boot: compile time Dec 15 2024 13:41:06 [0m
 [0;32mI (31) boot: Multicore bootloader [0m
 [0;32mI (34) boot: chip revision: v0.1 [0m
 [0;32mI (38) boot: efuse block revision: v1.2 [0m
 [0;32mI (43) boot.esp32s3: Boot SPI Speed : 80MHz [0m
 [0;32mI (47) boot.esp32s3: SPI Mode       : DIO [0m
 [0;32mI (52) boot.esp32s3: SPI Flash Size : 8MB [0m
 [0;32mI (57) boot: Enabling RNG early entropy source... [0m
 [0;32mI (62) boot: Partition Table: [0m
 [0;32mI (66) boot: ## Label            Usage          Type ST Offset   Length [0m
 [0;32mI (73) boot:  0 nvs              WiFi data        01 02 00009000 00006000 [0m
 [0;32mI (81) boot:  1 phy_init         RF data          01 01 0000f000 00001000 [0m
 [0;32mI (88) boot:  2 factory          factory app      00 00 00010000 001c2000 [0m
 [0;32mI (96) boot: End of partition table [0m
 [0;32mI (100) esp_image: segment 0: paddr=00010020 vaddr=3c120020 size=496dch (300764) map [0m
 [0;32mI (161) esp_image: segment 1: paddr=00059704 vaddr=3fc9ba00 size=050a4h ( 20644) load [0m
 [0;32mI (166) esp_image: segment 2: paddr=0005e7b0 vaddr=40374000 size=01868h (  6248) load [0m
 [0;32mI (168) esp_image: segment 3: paddr=00060020 vaddr=42000020 size=1191d0h (1151440) map [0m
 [0;32mI (379) esp_image: segment 4: paddr=001791f8 vaddr=40375868 size=16170h ( 90480) load [0m
 [0;32mI (408) boot: Loaded app from partition at offset 0x10000 [0m
 [0;32mI (408) boot: Disabling RNG early entropy source... [0m
 [0;32mI (420) cpu_start: Multicore app [0m
 [0;32mI (430) cpu_start: Pro cpu start user code [0m
 [0;32mI (430) cpu_start: cpu freq: 160000000 Hz [0m
 [0;32mI (430) app_init: Application information: [0m
 [0;32mI (433) app_init: Project name:     otbr [0m
 [0;32mI (438) app_init: App version:      78b930f-dirty [0m
 [0;32mI (443) app_init: Compile time:     Dec 15 2024 13:38:28 [0m
 [0;32mI (449) app_init: ELF file SHA256:  93dc03328... [0m
 [0;32mI (454) app_init: ESP-IDF:          v5.3.2 [0m
 [0;32mI (459) efuse_init: Min chip rev:     v0.0 [0m
 [0;32mI (464) efuse_init: Max chip rev:     v0.99  [0m
 [0;32mI (469) efuse_init: Chip rev:         v0.1 [0m
 [0;32mI (474) heap_init: Initializing. RAM available for dynamic allocation: [0m
 [0;32mI (481) heap_init: At 3FCAEED8 len 0003A838 (234 KiB): RAM [0m
 [0;32mI (487) heap_init: At 3FCE9710 len 00005724 (21 KiB): RAM [0m
 [0;32mI (493) heap_init: At 3FCF0000 len 00008000 (32 KiB): DRAM [0m
 [0;32mI (499) heap_init: At 600FE100 len 00001EE8 (7 KiB): RTCRAM [0m
 [0;32mI (507) spi_flash: detected chip: gd [0m
 [0;32mI (510) spi_flash: flash io: dio [0m
 [0;32mI (514) sleep: Configure to isolate all GPIO pins in sleep state [0m
 [0;32mI (521) sleep: Enable automatic switching of GPIO sleep configuration [0m
 [0;32mI (528) main_task: Started on CPU0 [0m
 [0;32mI (558) main_task: Calling app_main() [0m
 [0;32mI (568) uart: ESP_INTR_FLAG_IRAM flag not set while CONFIG_UART_ISR_IN_IRAM is enabled, flag updated [0m
 [0;32mI (568) uart: ESP_INTR_FLAG_IRAM flag not set while CONFIG_UART_ISR_IN_IRAM is enabled, flag updated [0m
 [0;32mI (568) esp_ot_br: use the Wi-Fi config from NVS [0m
 [0;32mI (578) OPENTHREAD: spinel UART interface initialization completed [0m
 [0;32mI (588) pp: pp rom version: e7ae62f [0m
 [0;32mI (568) main_task: Returned from app_main() [0m
 [0;32mI(598) OPENTHREAD: [0;32mI (598) net80211: net80211 rom version: e7ae62f [0m
[I] P-SpinelDrive-: co-processor reset: RESET_POWER_ON [0m
I (618) wifi:wifi driver task: 3fcb2264, prio:23, stack:6656, core=0
 [0;31mE(618) OPENTHREAD:[C] P-SpinelDrive-: Software reset co-processor successfully [0m
I (628) wifi:wifi firmware version: b0fd6006b
I (638) wifi:wifi certification version: v7.0
I (638) wifi:config NVS flash: enabled
I (638) wifi:config nano formating: disabled
I (648) wifi:Init data frame dynamic rx buffer num: 32
I (648) wifi:Init static rx mgmt buffer num: 5
I (648) wifi:Init management short buffer num: 32
I (658) wifi:Init dynamic tx buffer num: 32
I (668) wifi:Init static tx FG buffer num: 2
I (668) wifi:Init static rx buffer size: 1600
I (678) wifi:Init static rx buffer num: 10
I (678) wifi:Init dynamic rx buffer num: 32
 [0;32mI (678) wifi_init: rx ba win: 6 [0m
 [0;32mI (678) wifi_init: accept mbox: 6 [0m
 [0;32mI (688) wifi_init: tcpip mbox: 32 [0m
 [0;32mI (688) wifi_init: udp mbox: 6 [0m
 [0;32mI(688) OPENTHREAD:[I] CslTxScheduler: Bus TX Time: 0 usec, Latency: 0 usec. Calculated CSL Frame Request Ahead: 20000 usec [0m
 [0;32mI (698) wifi_init: tcp mbox: 6 [0m
 [0;32mI (708) wifi_init: tcp tx win: 5760 [0m
 [0;32mI(718) OPENTHREAD:[I] ChildSupervsn-: Timeout: 0 -> 190 [0m
 [0;32mI (718) wifi_init: tcp rx win: 5760 [0m
 [0;32mI (728) wifi_init: tcp mss: 1440 [0m
 [0;32mI (728) OPENTHREAD: OpenThread attached to netif [0m
>  [0;32mI (728) wifi_init: WiFi IRAM OP enabled [0m
 [5n [0;32mI (748) wifi_init: WiFi RX IRAM OP enabled [0m
 [0;32mI (748) phy_init: phy_version 680,a6008b2,Jun  4 2024,16:41:10 [0m
I (788) wifi:mode : sta (f4:12:fa:43:67:ec)
I (788) wifi:enable tsf
I (788) wifi:Set ps type: 2, coexist: 0

 [0;32mI (788) ot_ext_cli: Start example_connect [0m
 [0;32mI (798) example_connect: Connecting to NNNNNNNNNNN... [0m
W (808) wifi:Password length matches WPA2 standards, authmode threshold changes from OPEN to WPA2
 [0;32mI (808) example_connect: Waiting for IP(s) [0m
> I (3688) wifi:new:<8,1>, old:<1,0>, ap:<255,255>, sta:<8,1>, prof:1, snd_ch_cfg:0x0
I (3698) wifi:state: init -> auth (0xb0)
I (3698) wifi:state: auth -> assoc (0x0)
I (3708) wifi:state: assoc -> run (0x10)
I (3738) wifi:connected with NNNNNNNNNNN, aid = 8, channel 8, 40U, bssid = QQ:WW:EE:RR:TT:YY
I (3738) wifi:security: WPA2-PSK, phy: bgn, rssi: -17
I (3738) wifi:pm start, type: 2

I (3748) wifi:dp: 1, bi: 102400, li: 3, scale listen interval from 307200 us to 307200 us
I (3748) wifi:set rx beacon pti, rx_bcn_pti: 0, bcn_timeout: 25000, mt_pti: 0, mt_time: 10000
I (3758) wifi:<ba-add>idx:0 (ifx:0, QQ:WW:EE:RR:TT:YY), tid:0, ssn:2, winSize:64
I (3798) wifi:AP's beacon interval = 102400 us, DTIM period = 1
 [0;32mI (5568) example_connect: Got IPv6 event: Interface "example_netif_sta" address: fe80:0000:0000:0000:AASS:DDFF:GGHH:JJKK, type: ESP_IP6_ADDR_IS_LINK_LOCAL [0m
 [0;32mI (6768) esp_netif_handlers: example_netif_sta ip: 192.168.100.9, mask: 255.255.255.0, gw: 192.168.100.1 [0m
 [0;32mI (6768) example_connect: Got IPv4 event: Interface "example_netif_sta" address: 192.168.100.9 [0m
 [0;32mI(6788) OPENTHREAD:[N] RoutingManager: No valid /48 BR ULA prefix found in settings, generating new one [0m
 [0;32mI(6798) OPENTHREAD:[N] RoutingManager: BR ULA prefix: fd16:7835:7d60::/48 (generated) [0m
 [0;32mI(6798) OPENTHREAD:[N] RoutingManager: Local on-link prefix: fdde:ad00:beef:cafe::/64 [0m
 [0;31mE (6828) OPENTHREAD: Failed to leave multicast group [0m
 [0;32mI (6838) OPENTHREAD: Platform UDP bound to port 49153 [0m
 [0;32mI(6848) OPENTHREAD:[N] Mle-----------: Role disabled -> detached [0m
 [0;32mI (6858) OPENTHREAD: Platform UDP bound to port 61631 [0m
 [0;32mI (6858) OT_STATE: netif up [0m
I (6868) OPENTHREAD: NAT64 ready
 [0;32mI(7338) OPENTHREAD:[N] Mle-----------: Attach attempt 1, AnyPartition reattaching with Active Dataset [0m
 [0;32mI (7568) example_connect: Got IPv6 event: Interface "example_netif_sta" address: (hidded), type: ESP_IP6_ADDR_IS_GLOBAL [0m
 [0;32mI(8188) OPENTHREAD:[N] Mle-----------: RLOC16 fffe -> dc01 [0m
 [0;32mI(8198) OPENTHREAD:[N] Mle-----------: Role detached -> child [0m
 [0;32mI (8208) OPENTHREAD: Platform UDP bound to port 49154 [0m
 [0;32mI (8228) OPENTHREAD: Platform UDP bound to port 49155 [0m
I (8248) OPENTHREAD: NAT64 ready
I (8248) OPENTHREAD: NAT64 ready
 [0;31mE (8588) OPENTHREAD: Failed to get LL address, error: Invalid If index [0m
 [0;33mW(8848) OPENTHREAD:[W] DuaManager----: Failed to perform next registration: NotFound [0m
 [0;32mI (9618) OPENTHREAD: Platform UDP bound to port 53536 [0m
I (9618) OPENTHREAD: NAT64 ready
 [0;31mE (12608) OPENTHREAD: Failed to get LL address, error: Invalid If index [0m
 [0;31mE (16628) OPENTHREAD: Failed to get LL address, error: Invalid If index [0m
 [0;31mE (17658) OPENTHREAD: Failed to get LL address, error: Invalid If index [0m
 [0;31mE (35248) OPENTHREAD: Failed to get LL address, error: Invalid If index [0m

More Information.

No response

@githubworksonline githubworksonline added the Type: Bug bugs in IDF label Dec 15, 2024
@github-actions github-actions bot changed the title esp32S3 as OTBR, " OPENTHREAD: Failed to get LL address, error: Invalid If index" esp32S3 as OTBR, " OPENTHREAD: Failed to get LL address, error: Invalid If index" (IDFGH-14237) Dec 15, 2024
@espressif-bot espressif-bot added the Status: Opened Issue is new label Dec 15, 2024
@zwx1995esp
Copy link
Collaborator

Hi @githubworksonline ,Thanks for issuing this, I will investigate it later. For now, please use the recommanded code base shown in the docs: https://docs.espressif.com/projects/esp-thread-br/en/latest/dev-guide/build_and_run.html#set-up-the-repositories

@Kris-Morrison
Copy link

Hi @githubworksonline ,Thanks for issuing this, I will investigate it later. For now, please use the recommanded code base shown in the docs: https://docs.espressif.com/projects/esp-thread-br/en/latest/dev-guide/build_and_run.html#set-up-the-repositories

Yeah, I just followed the recommended code base - 5.3.2 and got same error "OPENTHREAD: Failed to get LL address, error: Invalid If index"

@GASEN1216
Copy link

I had the same error, also using esp32S3 as OTBR

@giangnv1993
Copy link

I had the same error, also using esp32S3 as OTBR

Hi, I had the same issue. Did you can control from chip tool to end device ( ex: light, light_switch)?

@zwx1995esp
Copy link
Collaborator

Hi @giangnv1993 @GASEN1216 @Kris-Morrison @githubworksonline Thanks for issuing this, we have fixed this issue in our internal branch and will sync to github very soon, I will let you know if the fix becomes available in release/v5.3 branch on GitHub.

@gparvind
Copy link

@zwx1995esp could you please share what was the issue and fix?

@zwx1995esp
Copy link
Collaborator

@zwx1995esp could you please share what was the issue and fix?

Sure, it is a software issue. Our BR lib is a pre-built static binary library. Some structs used in BR lib is different between the branch v5.3.2 and the built branch master. This discrepancy leads to an ABI issue, as the data types are misaligned between the library and the code on branch v5.3.2.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
Status: Opened Issue is new Type: Bug bugs in IDF
Projects
None yet
Development

No branches or pull requests

7 participants