ERROR: sx1250 Image Calibration Error on RAK7391

Hi - I am getting an error on a new RAK7391 with the RAK5146 configured by Rak. I opened a support ticket several days ago but have not heard anything. Can anyone help confirm if this is a hardware failure?


BasicStation ™ Packet Forwarder Container v2.8.4
(c) Xose Pérez 2022-2024

Based on:

  • basicstation v2.0.6
  • sx1302_hal v2.1.0
  • picoGW_hal v0.2.3

Protocol

Mode: STATIC
Protocol: LNS
LNS Server: wss://nam1.cloud.thethings.network:8887
Gateway EUI: 2CCF67FFFEB91D65
EUI Source: file

Radio

Model: RAK5146
Concentrator: SX1303
Design: CORECELL
Interface: SPI
Radio Device: /dev/spidev0.0
SPI Speed: 8000000
GPIO chip: gpiochip0
Reset GPIO: 17
Enable GPIO: 0

Killing process group 1
2025-05-24 18:43:43.744 [SYS:INFO] Logging : stderr (maxsize=10000000, rotate=3)
2025-05-24 18:43:43.745 [SYS:INFO] Station Ver : 2.0.6(corecell/stdn) 2024-08-27 09:53:19
2025-05-24 18:43:43.745 [SYS:INFO] Package Ver : (null)
2025-05-24 18:43:43.745 [SYS:INFO] mbedTLS Ver : 2.28.0
2025-05-24 18:43:43.745 [SYS:INFO] proto EUI : 2ccf:67ff:feb9:1d65 (station.conf)
2025-05-24 18:43:43.745 [SYS:INFO] prefix EUI : ::1 (builtin)
2025-05-24 18:43:43.745 [SYS:INFO] Station EUI : 2ccf:67ff:feb9:1d65
2025-05-24 18:43:43.745 [SYS:INFO] Station home: ./ (builtin)
2025-05-24 18:43:43.745 [SYS:INFO] Station temp: /var/tmp/ (builtin)
2025-05-24 18:43:43.745 [SYS:INFO] GPS device: ./
2025-05-24 18:43:43.745 [SYS:WARN] Station in NO-CUPS mode
2025-05-24 18:43:43.746 [RAL:DEBU] execvp argv[0]: </proc/self/exe>
2025-05-24 18:43:43.746 [RAL:DEBU] argv[1]: <-S>
2025-05-24 18:43:43.746 [RAL:DEBU] argv[2]: <(null)>
2025-05-24 18:43:43.748 [S00:INFO] Logging : stderr (maxsize=10000000, rotate=3)
2025-05-24 18:43:43.748 [S00:INFO] Station Ver : 2.0.6(corecell/stdn) 2024-08-27 09:53:19
2025-05-24 18:43:43.748 [S00:INFO] Package Ver : (null)
2025-05-24 18:43:43.748 [S00:INFO] mbedTLS Ver : 2.28.0
2025-05-24 18:43:43.748 [S00:INFO] proto EUI : 2ccf:67ff:feb9:1d65 (station.conf)
2025-05-24 18:43:43.748 [S00:INFO] prefix EUI : ::1 (builtin)
2025-05-24 18:43:43.748 [S00:INFO] Station EUI : 2ccf:67ff:feb9:1d65
2025-05-24 18:43:43.748 [S00:INFO] Station home: ./ (builtin)
2025-05-24 18:43:43.748 [S00:INFO] Station temp: /var/tmp/ (builtin)
2025-05-24 18:43:43.748 [S00:INFO] Station slave: 0
2025-05-24 18:43:43.748 [S00:WARN] Station in NO-CUPS mode
2025-05-24 18:43:43.748 [S00:INFO] Slave LGW (0) - started.
2025-05-24 18:43:43.746 [RAL:INFO] Master has started slave: pid=41 idx=0 (attempt 1)
2025-05-24 18:43:43.946 [GPS:ERRO] Failed to open TTY ‘./’: Is a directory
2025-05-24 18:43:43.946 [GPS:CRIT] Initial open of GPS FIFO ‘./’ failed - GPS disabled!
2025-05-24 18:43:43.946 [TCE:INFO] Starting TC engine
2025-05-24 18:43:44.003 [AIO:INFO] ./tc.trust:
cert. version : 3
serial number : 04:00:00:00:00:01:15:4B:5A:C3:94
issuer name : C=BE, O=GlobalSign nv-sa, OU=Root CA, CN=GlobalSign Root CA
subject name : C=BE, O=GlobalSign nv-sa, OU=Root CA, CN=GlobalSign Root CA
issued on : 1998-09-01 12:00:00
expires on : 2028-01-28 12:00:00
signed using : RSA with SHA1
RSA key size : 2048 bits
basic constraints : CA=true
key usage : Key Cert Sign, CRL Sign
2025-05-24 18:43:44.004 [TCE:INFO] Connecting to INFOS: wss://nam1.cloud.thethings.network:8887
2025-05-24 18:43:44.591 [TCE:INFO] Infos: 2ccf:67ff:feb9:1d65 muxs-::0 wss://nam1.cloud.thethings.network:8887/traffic/eui-2CCF67FFFEB91D65
2025-05-24 18:43:44.591 [AIO:DEBU] [4] ws_close reason=1000
2025-05-24 18:43:44.591 [AIO:DEBU] Echoing close - reason=1000
2025-05-24 18:43:44.591 [AIO:ERRO] Recv failed: SSL - The peer notified us that the connection is going to be closed
2025-05-24 18:43:44.591 [AIO:DEBU] [4] WS connection shutdown…
2025-05-24 18:43:44.648 [AIO:INFO] ./tc.trust:
cert. version : 3
serial number : 04:00:00:00:00:01:15:4B:5A:C3:94
issuer name : C=BE, O=GlobalSign nv-sa, OU=Root CA, CN=GlobalSign Root CA
subject name : C=BE, O=GlobalSign nv-sa, OU=Root CA, CN=GlobalSign Root CA
issued on : 1998-09-01 12:00:00
expires on : 2028-01-28 12:00:00
signed using : RSA with SHA1
RSA key size : 2048 bits
basic constraints : CA=true
key usage : Key Cert Sign, CRL Sign
2025-05-24 18:43:44.648 [TCE:VERB] Connecting to MUXS…
2025-05-24 18:43:45.109 [S00:VERB] /app/config/reset.sh: Forked, waiting…
2025-05-24 18:43:45.109 [S00:DEBU] execvp argv[0]: </app/config/reset.sh>
2025-05-24 18:43:45.109 [S00:DEBU] argv[1]: </dev/spidev0.0>
2025-05-24 18:43:45.109 [S00:DEBU] argv[2]: <0>
Concentrator reset through gpiochip0:17 (using libgpiod)
2025-05-24 18:43:45.066 [TCE:VERB] Connected to MUXS.
2025-05-24 18:43:45.082 [RAL:INFO] Region plan hwspec ‘sx1301/1’ mapped to 1 slaves ‘sx1301/1’
2025-05-24 18:43:45.082 [RAL:INFO] Master sending 645 bytes of JSON sx1301conf to slave (0)
2025-05-24 18:43:45.082 [S2E:INFO] Configuring for region: US915 – 923.0MHz…928.0MHz
2025-05-24 18:43:45.082 [S2E:INFO] DR0 SF10/BW125
2025-05-24 18:43:45.082 [S2E:INFO] DR1 SF9/BW125
2025-05-24 18:43:45.082 [S2E:INFO] DR2 SF8/BW125
2025-05-24 18:43:45.082 [S2E:INFO] DR3 SF7/BW125
2025-05-24 18:43:45.082 [S2E:INFO] DR4 SF8/BW500
2025-05-24 18:43:45.082 [S2E:INFO] DR5 FSK
2025-05-24 18:43:45.082 [S2E:INFO] DR6 FSK
2025-05-24 18:43:45.082 [S2E:INFO] DR7 FSK
2025-05-24 18:43:45.082 [S2E:INFO] DR8 SF12/BW500
2025-05-24 18:43:45.082 [S2E:INFO] DR9 SF11/BW500
2025-05-24 18:43:45.082 [S2E:INFO] DR10 SF10/BW500
2025-05-24 18:43:45.082 [S2E:INFO] DR11 SF9/BW500
2025-05-24 18:43:45.082 [S2E:INFO] DR12 SF8/BW500
2025-05-24 18:43:45.082 [S2E:INFO] DR13 SF7/BW500
2025-05-24 18:43:45.082 [S2E:INFO] DR14 FSK
2025-05-24 18:43:45.082 [S2E:INFO] DR15 FSK
2025-05-24 18:43:45.082 [S2E:INFO] TX power: 26.0 dBm EIRP
2025-05-24 18:43:45.082 [S2E:INFO] JoinEui list: 0 entries
2025-05-24 18:43:45.082 [S2E:INFO] NetID filter: FFFFFFFF-FFFFFFFF-FFFFFFFF-FFFFFFFF
2025-05-24 18:43:45.082 [S2E:INFO] Dev/test settings: nocca=1 nodc=1 nodwell=1
2025-05-24 18:43:45.082 [S2E:INFO] Beaconing every 2m8s on 923.3MHz(8) @ DR8 (frame layout 5/11/23)
2025-05-24 18:43:45.082 [S2E:INFO] Beaconing suspend - missing GPS data: time
2025-05-24 18:43:45.424 [S00:INFO] Process /app/config/reset.sh (pid=42) completed
2025-05-24 18:43:45.424 [S00:INFO] Lora gateway library version: Version: 2.1.0;
2025-05-24 18:43:45.424 [S00:INFO] [LGW sx1302] full_duplex=0 clksrc=0 lorawan_public=1
2025-05-24 18:43:45.424 [S00:DEBU] SX130x txlut table (16 entries)
2025-05-24 18:43:45.424 [S00:INFO] SX1302 txlut 0: rf_power=12 pa_gain=0 pwr_idx=15
2025-05-24 18:43:45.424 [S00:INFO] SX1302 txlut 1: rf_power=13 pa_gain=0 pwr_idx=16
2025-05-24 18:43:45.424 [S00:INFO] SX1302 txlut 2: rf_power=14 pa_gain=0 pwr_idx=17
2025-05-24 18:43:45.424 [S00:INFO] SX1302 txlut 3: rf_power=15 pa_gain=0 pwr_idx=19
2025-05-24 18:43:45.424 [S00:INFO] SX1302 txlut 4: rf_power=16 pa_gain=0 pwr_idx=20
2025-05-24 18:43:45.424 [S00:INFO] SX1302 txlut 5: rf_power=17 pa_gain=0 pwr_idx=22
2025-05-24 18:43:45.424 [S00:INFO] SX1302 txlut 6: rf_power=18 pa_gain=1 pwr_idx=1
2025-05-24 18:43:45.424 [S00:INFO] SX1302 txlut 7: rf_power=19 pa_gain=1 pwr_idx=2
2025-05-24 18:43:45.424 [S00:INFO] SX1302 txlut 8: rf_power=20 pa_gain=1 pwr_idx=3
2025-05-24 18:43:45.424 [S00:INFO] SX1302 txlut 9: rf_power=21 pa_gain=1 pwr_idx=4
2025-05-24 18:43:45.424 [S00:INFO] SX1302 txlut 10: rf_power=22 pa_gain=1 pwr_idx=5
2025-05-24 18:43:45.424 [S00:INFO] SX1302 txlut 11: rf_power=23 pa_gain=1 pwr_idx=6
2025-05-24 18:43:45.424 [S00:INFO] SX1302 txlut 12: rf_power=24 pa_gain=1 pwr_idx=7
2025-05-24 18:43:45.424 [S00:INFO] SX1302 txlut 13: rf_power=25 pa_gain=1 pwr_idx=9
2025-05-24 18:43:45.424 [S00:INFO] SX1302 txlut 14: rf_power=26 pa_gain=1 pwr_idx=11
2025-05-24 18:43:45.424 [S00:INFO] SX1302 txlut 15: rf_power=27 pa_gain=1 pwr_idx=14
2025-05-24 18:43:45.424 [S00:INFO] RX/TX RF0: 902.7MHz rssi_offset=-215.4 type=5 rssi_tcomp=0.000 0.000 20.410 2162.560 0.000
2025-05-24 18:43:45.424 [S00:INFO] RX RF1: 903.4MHz rssi_offset=-215.4 type=5 rssi_tcomp=0.000 0.000 20.410 2162.560 0.000
2025-05-24 18:43:45.424 [S00:INFO] [mSF] 0: 902.3MHz rf=0 freq=-400.0 datarate=0
2025-05-24 18:43:45.424 [S00:INFO] [mSF] 1: 902.5MHz rf=0 freq=-200.0 datarate=0
2025-05-24 18:43:45.424 [S00:INFO] [mSF] 2: 902.7MHz rf=0 freq= +0.0 datarate=0
2025-05-24 18:43:45.424 [S00:INFO] [mSF] 3: 902.9MHz rf=0 freq=+200.0 datarate=0
2025-05-24 18:43:45.424 [S00:INFO] [mSF] 4: 903.1MHz rf=1 freq=-300.0 datarate=0
2025-05-24 18:43:45.424 [S00:INFO] [mSF] 5: 903.3MHz rf=1 freq=-100.0 datarate=0
2025-05-24 18:43:45.424 [S00:INFO] [mSF] 6: 903.5MHz rf=1 freq=+100.0 datarate=0
2025-05-24 18:43:45.424 [S00:INFO] [mSF] 7: 903.7MHz rf=1 freq=+300.0 datarate=0
2025-05-24 18:43:45.424 [S00:INFO] [STD] 8: 903.0MHz rf=0 freq=+300.0 datarate=8 bw=6 Explicit header
2025-05-24 18:43:45.425 [S00:INFO] channel 9 disabled
2025-05-24 18:43:45.425 [S00:INFO] Station device: spi:/dev/spidev0.0 (PPS capture disabled)
2025-05-24 18:43:45.425 [S00:INFO] [lgw_com_open:84] Opening SPI communication interface
2025-05-24 18:43:45.425 [S00:INFO] [lgw_spi_open:88] Setting SPI speed to 8000000
2025-05-24 18:43:45.425 [S00:INFO] [lgw_connect:1192] chip version is 0xFF (v15.15)
2025-05-24 18:43:46.479 [S00:ERRO] [sx1302_radio_calibrate:561] radio calibration failed
2025-05-24 18:43:46.479 [S00:ERRO] [lgw_start:880] radio calibration failed
ERROR: sx1250 Image Calibration Error
2025-05-24 18:43:46.479 [S00:ERRO] Concentrator start failed: lgw_start
2025-05-24 18:43:46.479 [S00:CRIT] Slave radio start up failed with status 0x08
2025-05-24 18:43:46.453 [RAL:ERRO] Slave (0) - EOF
2025-05-24 18:43:46.453 [any:CRIT] Slave pid=41 idx=0: Fatal exit

rak@rakpios:~ $ hexdump -C /dev/spidev0.0
00000000 ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff |…|
*
^C