firmware
firmware copied to clipboard
Published
20 hours ago •
meshtastic
meshtastic
[Bug]: T-beam v1.1 cannot setup CN470 directly
Category
Other
Hardware
T-Beam
Firmware Version
2.3.8
Description
After freshly flashed and reset a T-beam v1.1 board (the 433/470 MHz variant with SX1268 chip), directly setting region to CN470 would fail, with critical fault # 3 showing on screen. Error logs are attached down below.
Some probably important messages:
- It reports critical error 7 before rebooting;
- After booting, it fails to init either RF95, SX1262 or SX1268, then reporting error 3;
- It also reports error 4 in NodeInfoModule and DeviceTelemetryModule.
However, if I set it to EU433 first (which works fine), then set it back to CN470, it instead works. None of the above error messages showed up, and in both cases (setting to EU433 or CN470), log reports RF95 init success.
Relevant log output
INFO | ??:??:?? 626 [Router] Client is setting the config
INFO | ??:??:?? 626 [Router] Setting config: LoRa
INFO | ??:??:?? 626 [Router] Wanted region 4, using CN
INFO | ??:??:?? 626 [Router] Saving changes to disk
DEBUG | ??:??:?? 626 [Router] Expanding short PSK #1
INFO | ??:??:?? 626 [Router] Wanted region 4, using CN
DEBUG | ??:??:?? 626 [Router] (bw=250, sf=11, cr=4/5) packet symLen=8 ms, payloadSize=0, time 231 ms
DEBUG | ??:??:?? 626 [Router] (bw=250, sf=11, cr=4/5) packet symLen=8 ms, payloadSize=253, time 2115 ms
INFO | ??:??:?? 626 [Router] Radio freq=478.875, config.lora.frequency_offset=0.000
INFO | ??:??:?? 626 [Router] Set radio: region=CN, name=LongFast, config=0, ch=35, power=19
INFO | ??:??:?? 626 [Router] Radio myRegion->freqStart -> myRegion->freqEnd: 470.000000 -> 510.000000 (40.000000 mhz)
INFO | ??:??:?? 626 [Router] Radio myRegion->numChannels: 160 x 250.000kHz
INFO | ??:??:?? 626 [Router] Radio channel_num: 36
INFO | ??:??:?? 626 [Router] Radio frequency: 478.875000
INFO | ??:??:?? 626 [Router] Slot time: 42 msec
ERROR | ??:??:?? 626 [Router] NOTE! Recording critical error 7 at src/mesh/RF95Interface.cpp:154
INFO | ??:??:?? 626 [Router] Saving /prefs/config.proto
INFO | ??:??:?? 627 [Router] Saving /prefs/module.proto
INFO | ??:??:?? 627 [Router] Rebooting in 7 seconds
DEBUG | ??:??:?? 627 [Router] Module 'Admin' considered
DEBUG | ??:??:?? 627 [Router] Module 'routing' wantsPacket=1
INFO | ??:??:?? 627 [Router] Received routing from=0x0, id=0x78875a0b, portnum=6, payloadlen=17
DEBUG | ??:??:?? 627 [Router] Routing sniffing (id=0x78875a0b fr=0x00 to=0xec, WantAck=1, HopLim=3 Ch=0x0 Portnum=6 priority=70)
DEBUG | ??:??:?? 627 [Router] Enqueued local (id=0x19b41c2c fr=0xec to=0xec, WantAck=0, HopLim=3 Ch=0x0 Portnum=5 requestId=78875a0b priority=120)
DEBUG | ??:??:?? 627 [Router] Module 'routing' considered
DEBUG | ??:??:?? 627 [Router] Rx someone rebroadcasting for us (id=0x19b41c2c fr=0xec to=0xec, WantAck=0, HopLim=3 Ch=0x0 Portnum=5 requestId=78875a0b priority=120)
DEBUG | ??:??:?? 627 [Router] didn't find pending packet
DEBUG | ??:??:?? 627 [Router] Add packet record (id=0x19b41c2c fr=0xec to=0xec, WantAck=0, HopLim=3 Ch=0x0 Portnum=5 requestId=78875a0b priority=120)
DEBUG | ??:??:?? 627 [Router] handleReceived(REMOTE) (id=0x19b41c2c fr=0xec to=0xec, WantAck=0, HopLim=3 Ch=0x0 Portnum=5 requestId=78875a0b priority=120)
DEBUG | ??:??:?? 627 [Router] Module 'canned' wantsPacket=1
DEBUG | ??:??:?? 627 [Router] showing standard frames
DEBUG | ??:??:?? 627 [Router] Showing 0 module frames
DEBUG | ??:??:?? 627 [Router] Total frame count: 103
DEBUG | ??:??:?? 627 [Router] Added modules. numframes: 0
DEBUG | ??:??:?? 627 [Router] Finished building frames. numframes: 4
DEBUG | ??:??:?? 627 [Router] Module 'canned' considered
DEBUG | ??:??:?? 627 [Router] Module 'routing' wantsPacket=1
INFO | ??:??:?? 627 [Router] Received routing from=0xa3f991ec, id=0x19b41c2c, portnum=5, payloadlen=2
DEBUG | ??:??:?? 627 [Router] Routing sniffing (id=0x19b41c2c fr=0xec to=0xec, WantAck=0, HopLim=3 Ch=0x0 Portnum=5 requestId=78875a0b priority=120)
DEBUG | ??:??:?? 627 [Router] Received an ack for 0x78875a0b, stopping retransmissions
DEBUG | ??:??:?? 627 [Router] Delivering rx packet (id=0x19b41c2c fr=0xec to=0xec, WantAck=0, HopLim=3 Ch=0x0 Portnum=5 requestId=78875a0b priority=120)
DEBUG | ??:??:?? 627 [Router] Update DB node 0xa3f991ec, rx_time=0
DEBUG | ??:??:?? 627 [Router] Forwarding to phone (id=0x19b41c2c fr=0xec to=0xec, WantAck=0, HopLim=3 Ch=0x0 Portnum=5 requestId=78875a0b priority=120)
DEBUG | ??:??:?? 627 [Router] Module 'routing' considered
INFO | ??:??:?? 627 [Screen] Turning on screen
DEBUG | ??:??:?? 627 [Screen] Screen: Critical error 7!
DEBUG | ??:??:?? 627 [Screen] showing reboot screen
DEBUG | ??:??:?? 627 (Client not yet interested in packets)
INFO | ??:??:?? 634 Rebooting
ets Jul 29 2019 12:21:46
rst:0xc (SW_CPU_RESET),boot:0x13 (SPI_FAST_FLASH_BOOT)
configsip: 0, SPIWP:0xee
clk_drv:0x00,q_drv:0x00,d_drv:0x00,cs0_drv:0x00,hd_drv:0x00,wp_drv:0x00
mode:DIO, clock div:2
load:0x3fff0030,len:1184
load:0x40078000,len:13192
load:0x40080400,len:3028
entry 0x400805e4
E (847) esp_core_dump_flash: No core dump��ѥѥ���found!
E (847) esp_core_dump_flash: No core dump partition found!
[ 12][D][esp32-hal-cpu.c:244] setCpuFrequencyMhz(): PLL: 480 / 2 = 240 Mhz, APB: 80000000 Hz
[ 464][I][esp32-hal-psram.c:96] psramInit(): PSRAM enabled
��@INFO | ??:??:?? 0
//\ E S H T /\ S T / C
INFO | ??:??:?? 0 Booted, wake cause 0 (boot count 1), reset_reason=reset
DEBUG | ??:??:?? 0 Filesystem files (479232/1048576 Bytes):
DEBUG | ??:??:?? 0 /prefs/channels.proto (57 Bytes)
DEBUG | ??:??:?? 0 /prefs/config.proto (87 Bytes)
DEBUG | ??:??:?? 0 /prefs/db.proto (368 Bytes)
DEBUG | ??:??:?? 0 /prefs/module.proto (105 Bytes)
DEBUG | ??:??:?? 0 /static/.gitkeep (0 Bytes)
DEBUG | ??:??:?? 0 /static/Logo_Black.svg.gz (592 Bytes)
DEBUG | ??:??:?? 0 /static/Logo_White.svg.gz (600 Bytes)
DEBUG | ??:??:?? 0 /static/apple-touch-icon.png.gz (3162 Bytes)
DEBUG | ??:??:?? 0 /static/favicon.ico.gz (2221 Bytes)
DEBUG | ??:??:?? 0 /static/icon.svg.gz (842 Bytes)
DEBUG | ??:??:?? 0 /static/index-9602d760.css.gz (17494 Bytes)
DEBUG | ??:??:?? 0 /static/index-a445ed47.js.gz (399957 Bytes)
DEBUG | ??:??:?? 0 /static/index-fc2e9253.js.gz (347 Bytes)
DEBUG | ??:??:?? 0 /static/index.html.gz (547 Bytes)
DEBUG | ??:??:?? 0 /static/robots.txt.gz (42 Bytes)
DEBUG | ??:??:?? 0 /static/site.webmanifest.gz (196 Bytes)
[ 994][I][esp32-hal-i2c.c:75] i2cInit(): Initialising I2C Master: sda=21 scl=22 freq=100000
[ 995][I][XPowersCommon.tpp:248] begin(): SDA:21 SCL:22
[ 999][W][Wire.cpp:301] begin(): Bus already started in Master Mode.
WARN | ??:??:?? 1 Failed to find AXP2101 power management
[ 1018][I][XPowersAXP2101.tpp:230] ~XPowersAXP2101(): ~XPowersAXP2101
[ 1018][I][XPowersCommon.tpp:248] begin(): SDA:21 SCL:22
[ 1022][I][esp32-hal-i2c.c:75] i2cInit(): Initialising I2C Master: sda=21 scl=22 freq=100000
INFO | ??:??:?? 1 AXP192 PMU init succeeded, using AXP192 PMU
[ 1048][D][XPowersAXP192.tpp:2010] setInterruptImpl(): setInterruptImpl DISABLE - 0xffffffffff
DEBUG | ??:??:?? 1 =======================================================================
DEBUG | ??:??:?? 1 DC1 : + Voltage:3300 mV
DEBUG | ??:??:?? 1 DC2 : - Voltage:1800 mV
DEBUG | ??:??:?? 1 DC3 : + Voltage:3300 mV
DEBUG | ??:??:?? 1 LDO2 : + Voltage:3300 mV
DEBUG | ??:??:?? 1 LDO3 : + Voltage:3300 mV
DEBUG | ??:??:?? 1 =======================================================================
DEBUG | ??:??:?? 1 Battery: usbPower=1, isCharging=0, batMv=4142, batPct=99
INFO | ??:??:?? 1 Scanning for i2c devices...
[ 1103][W][Wire.cpp:301] begin(): Bus already started in Master Mode.
DEBUG | ??:??:?? 1 Scanning for i2c devices on port 1
DEBUG | ??:??:?? 1 I2C device found at address 0x34
INFO | ??:??:?? 1 axp192/axp2101 PMU found
DEBUG | ??:??:?? 1 I2C device found at address 0x3c
INFO | ??:??:?? 1 ssd1306 display found
INFO | ??:??:?? 1 ssd1306 display found
DEBUG | ??:??:?? 1 0x7 subtype probed in 2 tries
INFO | ??:??:?? 1 2 I2C devices found
DEBUG | ??:??:?? 1 acc_info = 0
INFO | ??:??:?? 1 Meshtastic hwvendor=4, swver=2.3.8.d490a33
DEBUG | ??:??:?? 1 Setting random seed 3482936810
DEBUG | ??:??:?? 1 Total heap: 192944
DEBUG | ??:??:?? 1 Free heap: 158644
DEBUG | ??:??:?? 1 Total PSRAM: 4192107
DEBUG | ??:??:?? 1 Free PSRAM: 4191847
DEBUG | ??:??:?? 1 NVS: UsedEntries 93, FreeEntries 537, AllEntries 630, NameSpaces 3
DEBUG | ??:??:?? 1 Setup Preferences in Flash Storage
DEBUG | ??:??:?? 1 Number of Device Reboots: 2
DEBUG | ??:??:?? 1 OTA firmware version 0.2.1.2fbe7fc
INFO | ??:??:?? 1 Initializing NodeDB
INFO | ??:??:?? 1 Loading /prefs/db.proto
INFO | ??:??:?? 1 Loaded /prefs/db.proto successfully
INFO | ??:??:?? 1 Loaded saved devicestate version 22, with nodecount: 2
INFO | ??:??:?? 1 Loading /prefs/config.proto
INFO | ??:??:?? 1 Loaded /prefs/config.proto successfully
INFO | ??:??:?? 1 Loaded saved config version 22
INFO | ??:??:?? 1 Loading /prefs/module.proto
INFO | ??:??:?? 1 Loaded /prefs/module.proto successfully
INFO | ??:??:?? 1 Loaded saved moduleConfig version 22
INFO | ??:??:?? 1 Loading /prefs/channels.proto
INFO | ??:??:?? 1 Loaded /prefs/channels.proto successfully
INFO | ??:??:?? 1 Loaded saved channelFile version 22
[ 1542][E][vfs_api.cpp:105] open(): /littlefs/oem/oem.proto does not exist, no permits for creation
INFO | ??:??:?? 1 File /oem/oem.proto not found
DEBUG | ??:??:?? 1 cleanupMeshDB purged 0 entries
DEBUG | ??:??:?? 1 Using nodenum 0xa3f991ec
DEBUG | ??:??:?? 1 Number of Device Reboots: 2
DEBUG | ??:??:?? 1 Expanding short PSK #1
INFO | ??:??:?? 1 Wanted region 4, using CN
INFO | ??:??:?? 1 Saving /prefs/db.proto
DEBUG | ??:??:?? 1 Using GPIO38 for button
DEBUG | ??:??:?? 1 SPI.begin(SCK=5, MISO=19, MOSI=27, NSS=18)
DEBUG | ??:??:?? 1 Set Timezone to GMT0
DEBUG | ??:??:?? 1 Read RTC time as 637
INFO | ??:??:?? 1 Setting GPS power=1
DEBUG | ??:??:?? 1 WANT GPS=1
INFO | ??:??:?? 1 Setting GPS power=1
DEBUG | ??:??:?? 1 Using GPIO34 for GPS RX
DEBUG | ??:??:?? 1 Using GPIO12 for GPS TX
DEBUG | ??:??:?? 1 NeighborInfoModule is disabled
INFO | ??:??:?? 1 External Notification Module Disabled
INFO | ??:??:?? 1 Turning on screen
DEBUG | ??:??:?? 2 Module wants a UI Frame
DEBUG | ??:??:?? 2 RF95Interface(cs=18, irq=26, rst=23, busy=33)
INFO | ??:??:?? 2 Starting meshradio init...
DEBUG | ??:??:?? 2 (bw=250, sf=11, cr=4/5) packet symLen=8 ms, payloadSize=0, time 231 ms
DEBUG | ??:??:?? 2 (bw=250, sf=11, cr=4/5) packet symLen=8 ms, payloadSize=253, time 2115 ms
INFO | ??:??:?? 2 Radio freq=478.875, config.lora.frequency_offset=0.000
INFO | ??:??:?? 2 Set radio: region=CN, name=LongFast, config=0, ch=35, power=19
INFO | ??:??:?? 2 Radio myRegion->freqStart -> myRegion->freqEnd: 470.000000 -> 510.000000 (40.000000 mhz)
INFO | ??:??:?? 2 Radio myRegion->numChannels: 160 x 250.000kHz
INFO | ??:??:?? 2 Radio channel_num: 36
INFO | ??:??:?? 2 Radio frequency: 478.875000
INFO | ??:??:?? 2 Slot time: 42 msec
INFO | ??:??:?? 2 Set radio: final power level=19
DEBUG | ??:??:?? 2 Current limit set to 100.000000
DEBUG | ??:??:?? 2 Current limit set result 0
INFO | ??:??:?? 2 RF95 init result -13
INFO | ??:??:?? 2 Frequency set to 478.875000
INFO | ??:??:?? 2 Bandwidth set to 250.000000
INFO | ??:??:?? 2 Power output set to 19
WARN | ??:??:?? 2 Failed to find RF95 radio
DEBUG | ??:??:?? 2 SX126xInterface(cs=18, irq=33, rst=23, busy=32)
DEBUG | ??:??:?? 2 SX126X_DIO3_TCXO_VOLTAGE defined, using DIO3 as TCXO reference voltage at 1.800000 V
INFO | ??:??:?? 2 Starting meshradio init...
DEBUG | ??:??:?? 2 (bw=250, sf=11, cr=4/5) packet symLen=8 ms, payloadSize=0, time 231 ms
DEBUG | ??:??:?? 2 (bw=250, sf=11, cr=4/5) packet symLen=8 ms, payloadSize=253, time 2115 ms
INFO | ??:??:?? 2 Radio freq=478.875, config.lora.frequency_offset=0.000
INFO | ??:??:?? 2 Set radio: region=CN, name=LongFast, config=0, ch=35, power=19
INFO | ??:??:?? 2 Radio myRegion->freqStart -> myRegion->freqEnd: 470.000000 -> 510.000000 (40.000000 mhz)
INFO | ??:??:?? 2 Radio myRegion->numChannels: 160 x 250.000kHz
INFO | ??:??:?? 2 Radio channel_num: 36
INFO | ??:??:?? 2 Radio frequency: 478.875000
INFO | ??:??:?? 2 Slot time: 42 msec
INFO | ??:??:?? 2 Set radio: final power level=19
INFO | ??:??:?? 28 SX126x init result -2
WARN | ??:??:?? 28 Failed to find SX1262 radio
DEBUG | ??:??:?? 28 SX126xInterface(cs=18, irq=33, rst=23, busy=32)
DEBUG | ??:??:?? 28 SX126X_DIO3_TCXO_VOLTAGE defined, using DIO3 as TCXO reference voltage at 1.800000 V
INFO | ??:??:?? 28 Starting meshradio init...
DEBUG | ??:??:?? 28 (bw=250, sf=11, cr=4/5) packet symLen=8 ms, payloadSize=0, time 231 ms
DEBUG | ??:??:?? 28 (bw=250, sf=11, cr=4/5) packet symLen=8 ms, payloadSize=253, time 2115 ms
INFO | ??:??:?? 28 Radio freq=478.875, config.lora.frequency_offset=0.000
INFO | ??:??:?? 28 Set radio: region=CN, name=LongFast, config=0, ch=35, power=19
INFO | ??:??:?? 28 Radio myRegion->freqStart -> myRegion->freqEnd: 470.000000 -> 510.000000 (40.000000 mhz)
INFO | ??:??:?? 28 Radio myRegion->numChannels: 160 x 250.000kHz
INFO | ??:??:?? 28 Radio channel_num: 36
INFO | ??:??:?? 28 Radio frequency: 478.875000
INFO | ??:??:?? 28 Slot time: 42 msec
INFO | ??:??:?? 28 Set radio: final power level=19
INFO | ??:??:?? 55 SX126x init result -2
WARN | ??:??:?? 55 Failed to find SX1268 radio
INFO | ??:??:?? 55 Not using WIFI
ERROR | ??:??:?? 55 NOTE! Recording critical error 3 at src/main.cpp:y`Xj
INFO | ??:??:?? 55 PowerFSM init, USB power=1
DEBUG | ??:??:?? 55 Enter state: BOOT
[ 55112][D][esp32-hal-cpu.c:244] setCpuFrequencyMhz(): PLL: 320 / 4 = 80 Mhz, APB: 80000000 Hz
DEBUG | ??:??:?? 55 [Power] Battery: usbPower=1, isCharging=0, batMv=4141, batPct=99
INFO | ??:??:?? 55 [Screen] Done with boot screen...
DEBUG | ??:??:?? 55 [Screen] Screen: Started...
DEBUG | ??:??:?? 55 [Screen] Screen: Critical error 3!
DEBUG | ??:??:?? 55 [Screen] showing standard frames
DEBUG | ??:??:?? 55 [Screen] Showing 0 module frames
DEBUG | ??:??:?? 55 [Screen] Total frame count: 103
DEBUG | ??:??:?? 55 [Screen] Added modules. numframes: 0
DEBUG | ??:??:?? 55 [Screen] Finished building frames. numframes: 4
DEBUG | ??:??:?? 55 [GPS] Probing for GPS at 9600
INFO | ??:??:?? 57 [GPS] Found a UBlox Module using baudrate 9600
DEBUG | ??:??:?? 57 [GPS] Module Info :
DEBUG | ??:??:?? 57 [GPS] Soft version: 7.03 (45969)
DEBUG | ??:??:?? 57 [GPS] Hard version: 00040007
DEBUG | ??:??:?? 57 [GPS] Extensions:0
INFO | ??:??:?? 59 [GPS] GNSS module configuration saved!
INFO | ??:??:?? 59 [NodeInfoModule] Sending our nodeinfo to mesh (wantReplies=1)
INFO | ??:??:?? 59 [NodeInfoModule] sending owner !a3f991ec/Meshtastic 91ec/91ec
DEBUG | ??:??:?? 59 [NodeInfoModule] Initial packet id 1714302537, numPacketId 4294967295
DEBUG | ??:??:?? 59 [NodeInfoModule] Update DB node 0xa3f991ec, rx_time=0
ERROR | ??:??:?? 59 [NodeInfoModule] Error=4, returning NAK and dropping packet.
ERROR | ??:??:?? 59 [NodeInfoModule] Alloc an err=4,to=0xa3f991ec,idFrom=0x662e2e4b,id=0x662e2e4c
DEBUG | ??:??:?? 59 [NodeInfoModule] Enqueued local (id=0x662e2e4c fr=0xec to=0xec, WantAck=0, HopLim=3 Ch=0x0 Portnum=5 requestId=662e2e4b priority=120)
INFO | ??:??:?? 59 [DeviceTelemetryModule] (Sending): air_util_tx=0.000000, channel_utilization=0.000000, battery_level=99, voltage=4.141000, uptime=59
DEBUG | ??:??:?? 59 [DeviceTelemetryModule] updateTelemetry LOCAL
DEBUG | ??:??:?? 59 [DeviceTelemetryModule] Node status update: 2 online, 2 total
DEBUG | ??:??:?? 59 [DeviceTelemetryModule] showing standard frames
DEBUG | ??:??:?? 59 [DeviceTelemetryModule] Showing 0 module frames
DEBUG | ??:??:?? 59 [DeviceTelemetryModule] Total frame count: 103
DEBUG | ??:??:?? 59 [DeviceTelemetryModule] Added modules. numframes: 0
DEBUG | ??:??:?? 59 [DeviceTelemetryModule] Finished building frames. numframes: 4
INFO | ??:??:?? 59 [DeviceTelemetryModule] Sending packet to mesh
DEBUG | ??:??:?? 59 [DeviceTelemetryModule] Update DB node 0xa3f991ec, rx_time=0
ERROR | ??:??:?? 59 [DeviceTelemetryModule] Error=4, returning NAK and dropping packet.
ERROR | ??:??:?? 59 [DeviceTelemetryModule] Alloc an err=4,to=0xa3f991ec,idFrom=0x662e2e4d,id=0x662e2e4e
DEBUG | ??:??:?? 59 [DeviceTelemetryModule] Enqueued local (id=0x662e2e4e fr=0xec to=0xec, WantAck=0, HopLim=3 Ch=0x0 Portnum=5 requestId=662e2e4d priority=120)
