Hello,
Issue:
I have connected my RAK7268 (FW 1.3.9_RAK b186) to AWS IoT Core and I can see trace logs and a last-up time of the gateway itself in AWS.
Setup:
Gateway is connected via ethernet / basic station setup with AWS.
LoRa® Server:
AWS Iot Core
Details:
Join request from one device (Milesight AM 300, sending every 10 minutes) are shown in the LoRa Packet Logger, but they are not forwarded to the AWS´ LNS. Debug log highlights:
Thu Feb 22 21:32:29 2024 user.notice basicstation[20621]: [LOG:NOTI] Invalid DataRate value : 8
Thu Feb 22 21:32:29 2024 user.notice basicstation[20621]: [LOG:NOTI] Invalid DataRate value : 9
Thu Feb 22 21:32:29 2024 user.notice basicstation[20621]: [LOG:NOTI] Invalid DataRate value : 10
Thu Feb 22 21:32:29 2024 user.notice basicstation[20621]: [LOG:NOTI] Invalid DataRate value : 11
Thu Feb 22 21:32:29 2024 user.notice basicstation[20621]: [LOG:NOTI] Invalid DataRate value : 12
Thu Feb 22 21:32:29 2024 user.notice basicstation[20621]: [LOG:NOTI] Invalid DataRate value : 13
Thu Feb 22 21:32:29 2024 user.notice basicstation[20621]: [LOG:NOTI] Invalid DataRate value : 14
Thu Feb 22 21:32:29 2024 user.notice basicstation[20621]: [LOG:NOTI] Invalid DataRate value : 15
as well as
Thu Feb 22 21:32:29 2024 daemon.err uhttpd[2732]: Device “apcli0” does not exist.
In the time window of receiving a package from the device I see:
Thu Feb 22 21:27:16 2024 user.info basicstation[20621]: [SYN:INFO] MCU/SX130X drift stats: min: +0.0ppm q50: +1.9ppm q80: +5.2ppm max: +9.0ppm - threshold q90: +8.6ppm
Thu Feb 22 21:27:16 2024 user.info basicstation[20621]: [SYN:INFO] Mean MCU drift vs SX130X#0: 2.4ppm
Thu Feb 22 21:27:29 2024 user.debug basicstation[20621]: [LOG:DEBU] execute logger timeout handler.
Thu Feb 22 21:27:43 2024 user.info basicstation[20621]: [RAL:INFO] RX mod=LORA f=868500000 bw=0 sz=23 dr=10 0001002A00C024E1242073427B7024E12404DB16C11D0C
Thu Feb 22 21:27:43 2024 user.debug basicstation[20621]: [LOG:DEBU] rrd_statistic_up-357 uplinkTqByAirtime: dr=2, timeonair=370, tm=1708633663
Thu Feb 22 21:27:43 2024 user.debug basicstation[20621]: [LOG:DEBU] rrd_statistic_up-359 uplinkTqByPkt: dr=2, tm=1708633663
Thu Feb 22 21:27:43 2024 user.debug basicstation[20621]: [LOG:DEBU] rrd_statistic_up-361 ChanBusyByAirtime: chan=7, timeonair=370, tm=1708633663
Thu Feb 22 21:27:45 2024 user.info basicstation[20621]: [SYN:INFO] Time sync qualities: min=133 q90=204 max=217 (previous q90=230)
Thu Feb 22 21:27:49 2024 user.notice data-broker: data-broker timeout, restart it
Thu Feb 22 21:27:54 2024 user.info basicstation[20621]: [SYN:INFO] MCU/SX130X drift stats: min: -0.5ppm q50: -2.4ppm q80: +6.7ppm max: +11.4ppm - threshold q90: +10.5ppm
Thu Feb 22 21:27:54 2024 user.info basicstation[20621]: [SYN:INFO] Mean MCU drift vs SX130X#0: 1.7ppm
Thu Feb 22 21:28:07 2024 user.debug basicstation[20621]: [SYN:VERB] Time sync rejected: quality=228 threshold=204
Thu Feb 22 21:28:09 2024 user.debug basicstation[20621]: [SYN:VERB] Time sync rejected: quality=231 threshold=204
Thu Feb 22 21:28:11 2024 user.debug basicstation[20621]: [SYN:VERB] Time sync rejected: quality=1298 threshold=204
Thu Feb 22 21:28:26 2024 user.debug basicstation[20621]: [SYN:VERB] Time sync rejected: quality=223 threshold=204
After configuring the “Basics Station” mode (which I assume is working as expected), I get the following trace logs:
Thu Feb 22 21:43:32 2024 user.notice breathing_light: set breathing light to ABNORMAL
Thu Feb 22 21:43:33 2024 user.info basicstation[29321]: [SYS:INFO] Logging : /var/etc/station/station.log (maxsize=10000000, rotate=3)
Thu Feb 22 21:43:33 2024 user.info basicstation[29321]: [SYS:INFO] Station Ver : 2.0.6(linux/std) 2023-06-13 07:03:53
Thu Feb 22 21:43:33 2024 user.info basicstation[29321]: [SYS:INFO] Package Ver : (null)
Thu Feb 22 21:43:33 2024 user.info basicstation[29321]: [SYS:INFO] mbedTLS Ver : 2.28.0
Thu Feb 22 21:43:33 2024 user.info basicstation[29321]: [SYS:INFO] proto EUI : ac1f:9ff:fe06:43a (station.conf)
Thu Feb 22 21:43:33 2024 user.info basicstation[29321]: [SYS:INFO] prefix EUI : ::1 (builtin)
Thu Feb 22 21:43:33 2024 user.info basicstation[29321]: [SYS:INFO] Station EUI : ac1f:9ff:fe06:43a
Thu Feb 22 21:43:33 2024 user.info basicstation[29321]: [SYS:INFO] Station home: /var/etc/station/ (--home)
Thu Feb 22 21:43:33 2024 user.info basicstation[29321]: [SYS:INFO] Station bak: /etc/station/bak/ (--bak)
Thu Feb 22 21:43:33 2024 user.info basicstation[29321]: [SYS:INFO] Station temp: /var/run/ (--temp)
Thu Feb 22 21:43:33 2024 user.warn basicstation[29321]: [SYS:WARN] Station in NO-CUPS mode
Thu Feb 22 21:43:33 2024 user.debug basicstation[29321]: [LOG:VERB] initial logger socket success.
Thu Feb 22 21:43:34 2024 user.info basicstation[29321]: [TCE:INFO] Starting TC engine
Thu Feb 22 21:43:34 2024 user.info basicstation[29321]: [AIO:INFO] /var/etc/station/tc.trust: cert. version : 3 serial number : A7:0E:4A:4C:34:82:B7:7F issuer name : C=US, O=Starfield Technologies, Inc., OU=Starfield Class 2 Certification Authority subject name : C=US, ST=Arizona, L=Scottsdale, O=Starfield Technologies, Inc., CN=Starfield Services Root Certificate Authority - G2 issued on : 2009-09-02 00:00:00 expires on : 2034-06-28 17:39:16 signed using : RSA with SHA-256 RSA key size : 2048 bits basic constraints
Thu Feb 22 21:43:34 2024 user.info basicstation[29321]: [AIO:INFO] /var/etc/station/tc.crt: cert. version : 3 serial number : 84:E7:9B:9A:20:18:79:AE:B5:D3:79:8A:E6:5D:E9:FF:69:B0:66:5A issuer name : OU=Amazon Web Services O=Amazon.com Inc. L=Seattle ST=Washington C=US subject name : CN=AWS IoT Certificate issued on : 2024-02-22 19:22:17 expires on : 2049-12-31 23:59:59 signed using : RSA with SHA-256 RSA key size : 2048 bits basic constraints : CA=false key usage : Digital Signature
Thu Feb 22 21:43:34 2024 user.info basicstation[29321]: [TCE:INFO] Connecting to INFOS: wss://A20SJQ5PGPKQ1V.lns.lorawan.eu-central-1.amazonaws.com:443
Thu Feb 22 21:43:37 2024 user.notice breathing_light: set breathing light to NORMAL
Thu Feb 22 21:43:38 2024 user.info basicstation[29321]: [TCE:INFO] Infos: ac1f:09ff:fe06:043a ac1f:09ff:fe06:043a wss://*** (i have redacted that part)
Thu Feb 22 21:43:38 2024 user.debug basicstation[29321]: [AIO:DEBU] [5] ws_close reason=1000
Thu Feb 22 21:43:38 2024 user.debug basicstation[29321]: [AIO:DEBU] [5|WS] Server sent close: reason=1006
Thu Feb 22 21:43:38 2024 user.debug basicstation[29321]: [AIO:DEBU] [5] WS connection shutdown...
Thu Feb 22 21:43:38 2024 user.info basicstation[29321]: [AIO:INFO] /var/etc/station/tc.trust: cert. version : 3 serial number : A7:0E:4A:4C:34:82:B7:7F issuer name : C=US, O=Starfield Technologies, Inc., OU=Starfield Class 2 Certification Authority subject name : C=US, ST=Arizona, L=Scottsdale, O=Starfield Technologies, Inc., CN=Starfield Services Root Certificate Authority - G2 issued on : 2009-09-02 00:00:00 expires on : 2034-06-28 17:39:16 signed using : RSA with SHA-256 RSA key size : 2048 bits basic constraints
Thu Feb 22 21:43:38 2024 user.info basicstation[29321]: [AIO:INFO] /var/etc/station/tc.crt: cert. version : 3 serial number : 84:E7:9B:9A:20:18:79:AE:B5:D3:79:8A:E6:5D:E9:FF:69:B0:66:5A issuer name : OU=Amazon Web Services O=Amazon.com Inc. L=Seattle ST=Washington C=US subject name : CN=AWS IoT Certificate issued on : 2024-02-22 19:22:17 expires on : 2049-12-31 23:59:59 signed using : RSA with SHA-256 RSA key size : 2048 bits basic constraints : CA=false key usage : Digital Signature
Thu Feb 22 21:43:38 2024 user.debug basicstation[29321]: [TCE:VERB] Connecting to MUXS...
Thu Feb 22 21:43:41 2024 user.debug basicstation[29321]: [TCE:VERB] Connected to MUXS.
Thu Feb 22 21:43:41 2024 user.warn basicstation[29321]: [S2E:WARN] Unknown field in router_config - ignored: protocol (0xFD309030)
Thu Feb 22 21:43:41 2024 user.warn basicstation[29321]: [S2E:WARN] Unknown field in router_config - ignored: regionid (0xE6FFB211)
Thu Feb 22 21:43:41 2024 user.debug basicstation[29321]: [SYS:VERB] /etc/station/radio_init.sh: Forked, waiting...
Thu Feb 22 21:43:41 2024 user.debug basicstation[29732]: [SYS:DEBU] execvp argv[0]: </etc/station/radio_init.sh>
Thu Feb 22 21:43:41 2024 user.debug basicstation[29732]: [SYS:DEBU] argv[1]: </dev/spidev32766.1>
Thu Feb 22 21:43:41 2024 user.notice aws: startsvc
Thu Feb 22 21:43:41 2024 user.info basicstation[29321]: [SYS:INFO] Process /etc/station/radio_init.sh (pid=29732) completed
Thu Feb 22 21:43:41 2024 user.info basicstation[29321]: [RAL:INFO] Lora gateway library version: Version: 2.1.0;
Thu Feb 22 21:43:41 2024 user.info basicstation[29321]: [RAL:INFO] [LGW sx1302] full_duplex=0 clksrc=0 lorawan_public=1
Thu Feb 22 21:43:41 2024 user.debug basicstation[29321]: [RAL:DEBU] SX130x txlut table (16 entries)
Thu Feb 22 21:43:41 2024 user.info basicstation[29321]: [RAL:INFO] SX1302 txlut 0: rf_power=-6 pa_gain=0 pwr_idx=9
Thu Feb 22 21:43:41 2024 user.info basicstation[29321]: [RAL:INFO] SX1302 txlut 1: rf_power=-3 pa_gain=0 pwr_idx=12
Thu Feb 22 21:43:41 2024 user.info basicstation[29321]: [RAL:INFO] SX1302 txlut 2: rf_power=0 pa_gain=0 pwr_idx=17
Thu Feb 22 21:43:41 2024 user.info basicstation[29321]: [RAL:INFO] SX1302 txlut 3: rf_power=3 pa_gain=0 pwr_idx=19
Thu Feb 22 21:43:41 2024 user.info basicstation[29321]: [RAL:INFO] SX1302 txlut 4: rf_power=6 pa_gain=0 pwr_idx=21
Thu Feb 22 21:43:41 2024 user.info basicstation[29321]: [RAL:INFO] SX1302 txlut 5: rf_power=10 pa_gain=1 pwr_idx=1
Thu Feb 22 21:43:41 2024 user.info basicstation[29321]: [RAL:INFO] SX1302 txlut 6: rf_power=11 pa_gain=1 pwr_idx=3
Thu Feb 22 21:43:41 2024 user.info basicstation[29321]: [RAL:INFO] SX1302 txlut 7: rf_power=12 pa_gain=1 pwr_idx=4
Thu Feb 22 21:43:41 2024 user.info basicstation[29321]: [RAL:INFO] SX1302 txlut 8: rf_power=13 pa_gain=1 pwr_idx=5
Thu Feb 22 21:43:41 2024 user.info basicstation[29321]: [RAL:INFO] SX1302 txlut 9: rf_power=14 pa_gain=1 pwr_idx=6
Thu Feb 22 21:43:41 2024 user.info basicstation[29321]: [RAL:INFO] SX1302 txlut 10: rf_power=16 pa_gain=1 pwr_idx=8
Thu Feb 22 21:43:41 2024 user.info basicstation[29321]: [RAL:INFO] SX1302 txlut 11: rf_power=20 pa_gain=1 pwr_idx=13
Thu Feb 22 21:43:41 2024 user.info basicstation[29321]: [RAL:INFO] SX1302 txlut 12: rf_power=23 pa_gain=1 pwr_idx=16
Thu Feb 22 21:43:41 2024 user.info basicstation[29321]: [RAL:INFO] SX1302 txlut 13: rf_power=25 pa_gain=1 pwr_idx=18
Thu Feb 22 21:43:41 2024 user.info basicstation[29321]: [RAL:INFO] SX1302 txlut 14: rf_power=26 pa_gain=1 pwr_idx=19
Thu Feb 22 21:43:41 2024 user.info basicstation[29321]: [RAL:INFO] SX1302 txlut 15: rf_power=27 pa_gain=1 pwr_idx=21
Thu Feb 22 21:43:41 2024 user.info basicstation[29321]: [RAL:INFO] RX/TX RF0: 867.5MHz rssi_offset=-215.4 type=5 rssi_tcomp=0.000 0.000 20.410 2162.560 0.000
Thu Feb 22 21:43:41 2024 user.info basicstation[29321]: [RAL:INFO] RX RF1: 868.5MHz rssi_offset=-215.4 type=5 rssi_tcomp=0.000 0.000 20.410 2162.560 0.000
Thu Feb 22 21:43:41 2024 user.info basicstation[29321]: [RAL:INFO] [mSF] 0: 867.1MHz rf=0 freq=-400.0 datarate=0
Thu Feb 22 21:43:41 2024 user.info basicstation[29321]: [RAL:INFO] [mSF] 1: 867.3MHz rf=0 freq=-200.0 datarate=0
Thu Feb 22 21:43:41 2024 user.info basicstation[29321]: [RAL:INFO] [mSF] 2: 867.5MHz rf=0 freq= +0.0 datarate=0
Thu Feb 22 21:43:41 2024 user.info basicstation[29321]: [RAL:INFO] [mSF] 3: 867.7MHz rf=0 freq=+200.0 datarate=0
Thu Feb 22 21:43:41 2024 user.info basicstation[29321]: [RAL:INFO] [mSF] 4: 867.9MHz rf=0 freq=+400.0 datarate=0
Thu Feb 22 21:43:41 2024 user.info basicstation[29321]: [RAL:INFO] [mSF] 5: 868.1MHz rf=1 freq=-400.0 datarate=0
Thu Feb 22 21:43:41 2024 user.info basicstation[29321]: [RAL:INFO] [mSF] 6: 868.3MHz rf=1 freq=-200.0 datarate=0
Thu Feb 22 21:43:41 2024 user.info basicstation[29321]: [RAL:INFO] [mSF] 7: 868.5MHz rf=1 freq= +0.0 datarate=0
Thu Feb 22 21:43:41 2024 user.info basicstation[29321]: [RAL:INFO] [STD] 8: 868.3MHz rf=1 freq=-200.0 datarate=7 bw=5 Explicit header
Thu Feb 22 21:43:41 2024 user.info basicstation[29321]: [RAL:INFO] [FSK] 9: 867.5MHz rf=0 freq= +0.0 datarate=0 bw=0 sync_word=0/0
Thu Feb 22 21:43:41 2024 user.info basicstation[29321]: [RAL:INFO] Station device: spi:/dev/spidev32766.1 (PPS capture disabled)
Thu Feb 22 21:43:41 2024 user.info basicstation[29321]: [HAL:INFO] [lgw_com_open:84] Opening SPI communication interface
Thu Feb 22 21:43:41 2024 user.info basicstation[29321]: [HAL:INFO] [lgw_spi_open:88] Setting SPI speed to 2000000
Thu Feb 22 21:43:41 2024 user.info basicstation[29321]: [HAL:INFO] [lgw_connect:1192] chip version is 0x10 (v1.0)
Thu Feb 22 21:43:44 2024 user.info basicstation[29321]: [HAL:INFO] [timestamp_counter_mode:431] using legacy timestamp
Thu Feb 22 21:43:44 2024 user.info basicstation[29321]: [RAL:INFO] Concentrator started (2s542ms)
Thu Feb 22 21:43:44 2024 user.info basicstation[29321]: [S2E:INFO] Configuring for region: EU868 -- 863.0MHz..870.0MHz
Thu Feb 22 21:43:44 2024 user.debug basicstation[29321]: [LOG:DEBU] Region for EU868
Thu Feb 22 21:43:44 2024 user.debug basicstation[29321]: [LOG:VERB] rrd initial success.
Thu Feb 22 21:43:44 2024 user.info basicstation[29321]: [S2E:INFO] DR0 SF12/BW125
Thu Feb 22 21:43:44 2024 user.info basicstation[29321]: [S2E:INFO] DR1 SF11/BW125
Thu Feb 22 21:43:44 2024 user.info basicstation[29321]: [S2E:INFO] DR2 SF10/BW125
Thu Feb 22 21:43:44 2024 user.info basicstation[29321]: [S2E:INFO] DR3 SF9/BW125
Thu Feb 22 21:43:44 2024 user.info basicstation[29321]: [S2E:INFO] DR4 SF8/BW125
Thu Feb 22 21:43:44 2024 user.info basicstation[29321]: [S2E:INFO] DR5 SF7/BW125
Thu Feb 22 21:43:44 2024 user.info basicstation[29321]: [S2E:INFO] DR6 SF7/BW250
Thu Feb 22 21:43:44 2024 user.info basicstation[29321]: [S2E:INFO] DR7 FSK
Thu Feb 22 21:43:44 2024 user.info basicstation[29321]: [S2E:INFO] DR8 undefined
Thu Feb 22 21:43:44 2024 user.info basicstation[29321]: [S2E:INFO] DR9 undefined
Thu Feb 22 21:43:44 2024 user.info basicstation[29321]: [S2E:INFO] DR10 undefined
Thu Feb 22 21:43:44 2024 user.info basicstation[29321]: [S2E:INFO] DR11 undefined
Thu Feb 22 21:43:44 2024 user.info basicstation[29321]: [S2E:INFO] DR12 undefined
Thu Feb 22 21:43:44 2024 user.info basicstation[29321]: [S2E:INFO] DR13 undefined
Thu Feb 22 21:43:44 2024 user.info basicstation[29321]: [S2E:INFO] DR14 undefined
Thu Feb 22 21:43:44 2024 user.info basicstation[29321]: [S2E:INFO] DR15 undefined
Thu Feb 22 21:43:44 2024 user.info basicstation[29321]: [S2E:INFO] TX power: 16.0 dBm EIRP
Thu Feb 22 21:43:44 2024 user.info basicstation[29321]: [S2E:INFO] 27.0 dBm EIRP for 869.4MHz..869.65MHz
Thu Feb 22 21:43:44 2024 user.info basicstation[29321]: [S2E:INFO] JoinEUI list: 10 entries
Thu Feb 22 21:43:44 2024 user.info basicstation[29321]: [S2E:INFO] NetID filter: FFFFFFFF-FFFFFFFF-FFFFFFFF-FFFFFFFF
Thu Feb 22 21:43:44 2024 user.info basicstation[29321]: [S2E:INFO] Dev/test settings: nocca=0 nodc=0 nodwell=0
I am not really sure what I should try next… AWS Configuration (rules / destinations etc. are setup correct, however, I do not think that the issue is really buried there…)
Please help
BR