meshtastic / firmware

Meshtastic device firmware
https://meshtastic.org
GNU General Public License v3.0
3.55k stars 884 forks source link

[Bug]: T1000E BusyRX all the time #5209

Closed DomoArigatoMrGato closed 1 week ago

DomoArigatoMrGato commented 1 week ago

Category

Hardware Compatibility

Hardware

Seeed Card Tracker T1000-E

Firmware Version

2.4.0 + 2.5.6

Description

I'm experiencing an issue with my T1000E, this was an issue with the default 2.4.0 firmware the device came with as well.

The device seems to always be busy with RX, there are only 2 reachable nodes in my area. I can send messages to my other T-Beam node from my T1000E on channel 0, and my T-Beam node sees my T1000E, but my T1000E does not see my T-Beam nor the messages sent by my T-Beam. Every message I send to channel 0 from my T1000E is only sent after preamble is ignored and it does not receive a message acknowledgment.

I have followed instructions on flashing the device firmware to 2.5.6, including loading the erase flash firmware, then loading the Meshtastic firmware.

Relevant log output

T1000E Logs

1730401276 hopStart=6 priority=100)
DEBUG | 14:01:16 148 txGood=2,txRelay=0,rxGood=0,rxBad=0
INFO  | 14:01:16 148 Telling client we have new packets 9
INFO  | 14:01:16 148 BLE notify fromNum
INFO  | 14:01:16 148 getFromRadio=STATE_SEND_PACKETS
WARN  | 14:01:16 148 [RadioIf] Can not send yet, busyRx
WARN  | 14:01:16 148 [RadioIf] Can not send yet, busyRx
WARN  | 14:01:16 148 [RadioIf] Can not send yet, busyRx
WARN  | 14:01:16 149 [RadioIf] Can not send yet, busyRx
DEBUG | 14:01:17 149 [RadioIf] Ignore false preamble detection.
DEBUG | 14:01:17 149 [RadioIf] Starting low level send (id=0xb6f8c601 fr=0x4d to=0xff, WantAck=0, HopLim=6 Ch=0x8 encrypted rxtime=1730401276 hopStart=6 priority=100)
DEBUG | 14:01:17 149 [RadioIf] Packet transmitted : 428ms
DEBUG | 14:01:17 149 [RadioIf] Completed sending (id=0xb6f8c601 fr=0x4d to=0xff, WantAck=0, HopLim=6 Ch=0x8 encrypted rxtime=1730401276 hopStart=6 priority=100)
DEBUG | 14:01:24 156 [Router] Sending reliable retransmission fr=0x0,to=0xffffffff,id=0xb6f8c601, tries left=2
DEBUG | 14:01:24 156 [Router] Found existing packet record for fr=0x0,to=0xffffffff,id=0xb6f8c601
DEBUG | 14:01:24 156 [Router] Add packet record (id=0xb6f8c601 fr=0x00 to=0xff, WantAck=1, HopLim=6 Ch=0x0 Portnum=1 rxtime=1730401276)
DEBUG | 14:01:24 156 [Router] Expanding short PSK #1
DEBUG | 14:01:24 156 [Router] Using AES128 key!
DEBUG | 14:01:24 156 [Router] enqueuing for send (id=0xb6f8c601 fr=0x4d to=0xff, WantAck=0, HopLim=6 Ch=0x8 encrypted rxtime=1730401276 hopStart=6 priority=100)
DEBUG | 14:01:24 156 [Router] txGood=3,txRelay=0,rxGood=0,rxBad=0
DEBUG | 14:01:24 156 [Router] Setting next retransmission in 7940 msecs:  (id=0xb6f8c601 fr=0x00 to=0xff, WantAck=1, HopLim=6 Ch=0x0 Portnum=1 rxtime=1730401276)
WARN  | 14:01:24 156 [RadioIf] Can not send yet, busyRx
WARN  | 14:01:24 156 [RadioIf] Can not send yet, busyRx
WARN  | 14:01:24 157 [RadioIf] Can not send yet, busyRx
WARN  | 14:01:24 157 [RadioIf] Can not send yet, busyRx
DEBUG | 14:01:25 157 [RadioIf] Ignore false preamble detection.
DEBUG | 14:01:25 157 [RadioIf] Starting low level send (id=0xb6f8c601 fr=0x4d to=0xff, WantAck=0, HopLim=6 Ch=0x8 encrypted rxtime=1730401276 hopStart=6 priority=100)
DEBUG | 14:01:25 157 [RadioIf] Packet transmitted : 428ms
DEBUG | 14:01:25 157 [RadioIf] Completed sending (id=0xb6f8c601 fr=0x4d to=0xff, WantAck=0, HopLim=6 Ch=0x8 encrypted rxtime=1730401276 hopStart=6 priority=100)
DEBUG | 14:01:32 164 [Router] Sending reliable retransmission fr=0x0,to=0xffffffff,id=0xb6f8c601, tries left=1
DEBUG | 14:01:32 164 [Router] Found existing packet record for fr=0x0,to=0xffffffff,id=0xb6f8c601
DEBUG | 14:01:32 164 [Router] Add packet record (id=0xb6f8c601 fr=0x00 to=0xff, WantAck=1, HopLim=6 Ch=0x0 Portnum=1 rxtime=1730401276)
DEBUG | 14:01:32 164 [Router] Expanding short PSK #1
DEBUG | 14:01:32 164 [Router] Using AES128 key!
DEBUG | 14:01:32 164 [Router] enqueuing for send (id=0xb6f8c601 fr=0x4d to=0xff, WantAck=0, HopLim=6 Ch=0x8 encrypted rxtime=1730401276 hopStart=6 priority=100)
DEBUG | 14:01:32 164 [Router] txGood=4,txRelay=0,rxGood=0,rxBad=0
DEBUG | 14:01:32 164 [Router] Setting next retransmission in 7940 msecs:  (id=0xb6f8c601 fr=0x00 to=0xff, WantAck=1, HopLim=6 Ch=0x0 Portnum=1 rxtime=1730401276)
DEBUG | 14:01:32 164 [RadioIf] Starting low level send (id=0xb6f8c601 fr=0x4d to=0xff, WantAck=0, HopLim=6 Ch=0x8 encrypted rxtime=1730401276 hopStart=6 priority=100)
DEBUG | 14:01:32 164 [RadioIf] Packet transmitted : 428ms
DEBUG | 14:01:33 165 [RadioIf] Completed sending (id=0xb6f8c601 fr=0x4d to=0xff, WantAck=0, HopLim=6 Ch=0x8 encrypted rxtime=1730401276 hopStart=6 priority=100)
DEBUG | 14:01:33 165 [Power] Battery: usbPower=1, isCharging=1, batMv=4209, batPct=100
GUVWAF commented 1 week ago

"Can not send yet, busyRx" due to false preamble detection is normal and happens every now and then. It's a known issue that the T1000-E cannot receive packets from the old SX127x radios, and this is being tracked in #4775.