Problem sending data to a RAK7258 gateway/network server #1020

reibuehl · 2024-09-01T15:43:42Z

reibuehl
Sep 1, 2024

I have compiled the firmware for my LILYGO TTGO LoRa32 V2.1 1.6.1 board. I run a RAK7258 gateway and network server. My device does join the network and receives the correct time via Lora but sending data does not work. After 10 minutes I see src/lorawan.cpp: LORA sendqueue is full in the serial console, but I do not receive any data packets. In the configured MQTT server, I also see the join for the configured application but no rx packet information.
Could you give me some hints where to search?

cyberman54 · 2024-09-01T17:09:41Z

cyberman54
Sep 1, 2024
Maintainer

If the board receives and displays time, then it has joined successfully, thus network is correctly configured.

Please build code with debug level debug and post output of serial console here, for further analysis.

Check that DIO1 of LoRa chip is connected properly.

0 replies

reibuehl · 2024-09-01T18:43:14Z

reibuehl
Sep 1, 2024
Author

Here is the output with debug level debug:

20:25:18.741 > I (393) src/sdcard.cpp: looking for SD-card...
20:25:18.741 > E (423) sdmmc_common: sdmmc_init_ocr: send_op_cond (1) returned 0x107
20:25:18.741 > E (423) vfs_fat_sdmmc: sdmmc_card_init failed (0x107).
20:25:18.741 > I (423) src/sdcard.cpp: No SD-card found (263)
20:25:18.741 > I (427) src/configmanager.cpp: Loading device configuration from NVRAM...
20:25:18.741 > I (435) src/configmanager.cpp: Runtime configuration v3.6.2 loaded
20:25:18.741 > D (440) src/reset.cpp: Timezone set to CET-1CEST,M3.4.0/2,M10.4.0/3
20:25:18.741 > I (446) src/main.cpp: Starting paxcounter_faa5fdb3 v3.6.2 (runmode=0 / restarts=0)
20:25:18.741 > I (453) src/main.cpp: code build date: 1725218613
20:25:18.741 > I (457) src/main.cpp: This is ESP32 chip with 2 CPU cores, WiFi/BT/BLE, silicon revision 1, 4MB embedded Flash
20:25:18.741 > I (467) src/main.cpp: Internal Total heap 223660, internal Free Heap 195900
20:25:18.741 > I (474) src/main.cpp: ChipRevision 1, Cpu Freq 240, SDK Version v4.4.5
20:25:18.741 > I (480) src/main.cpp: Flash Size 4194304, Flash Speed 40000000
20:25:18.741 > I (486) src/main.cpp: Wifi/BT software coexist version 1.2.0
20:25:18.741 > I (491) src/main.cpp: Wifi STA MAC: E8:9F:6D:08:85:6C
20:25:18.741 > I (496) src/main.cpp: IBM LMIC version 1.6.1468577746
20:25:18.741 > I (500) src/main.cpp: Arduino LMIC version 4.1.1.0
20:25:18.741 > I (505) src/lorawan.cpp: DevEUI: 5634129078563412
20:25:18.741 > I (510) C:/Users/reiner/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-i2c.c: Initialising I2C Master: sda=21 scl=22 freq=100000
20:25:18.741 > I (524) src/i2c.cpp: Starting I2C bus scan...
20:25:18.741 > W (527) C:/Users/reiner/.platformio/packages/framework-arduinoespressif32/libraries/Wire/src/Wire.cpp: Bus already started in Master Mode.
20:25:18.741 > I (660) src/i2c.cpp: Device found at 0x3C, type = Unknown
20:25:18.741 > I (660) src/i2c.cpp: 1 I2C device(s) found
20:25:18.741 > W (661) C:/Users/reiner/.platformio/packages/framework-arduinoespressif32/libraries/Wire/src/Wire.cpp: Bus already started in Master Mode.
20:25:18.741 > I (10810) src/main.cpp: Starting LED Controller...
20:25:18.741 > I (10810) src/power.cpp: ADC characterization based on reference voltage stored in eFuse
20:25:18.741 > I (10814) src/main.cpp: Starting libpax...
20:25:18.741 > I (10815) src/main.cpp: WIFISCAN: on
20:25:18.741 > I (10818) src/main.cpp: BLESCAN: off
20:25:18.741 > I (10921) src/main.cpp: Starting rcommand interpreter...
20:25:18.741 > I (10921) src/rcommand.cpp: Rcommand send queue created, size 55 Bytes
20:25:18.741 > I (10922) src/lorawan.cpp: LORA send queue created, size 530 Bytes
20:25:18.741 > I (10944) src/lorawan.cpp: Starting LMIC...
20:25:18.741 > D (10944) src/lorawan.cpp: JOINING
20:25:18.741 > I (10945) src/main.cpp: Starting Interrupt Handler...
20:25:18.741 > I (10945) src/main.cpp: Starting Timers...
20:25:18.741 > I (10980) src/timekeeper.cpp: Starting time pulse...
20:25:18.741 > I (10981) src/timekeeper.cpp: Timepulse: internal (ESP32 hardware timer)
20:25:18.741 > I (11981) src/main.cpp: Features: DISP LED BATT OTA LORA PACKED TIME
20:25:18.741 > I (12010) src/timesync.cpp: [11.639] Timeserver sync request started, seqNo#211
20:25:19.909 > D (15078) src/lorawan.cpp: TXSTART
20:25:24.961 > D (20133) src/lorawan.cpp: RXSTART
20:25:25.046 > I (20218) src/lorawan.cpp: DEVaddr: 0x02A5A815 | Network ID: 0x000001 | Network Type: 0
20:25:25.057 > I (20219) src/lorawan.cpp: RSSI: -5 | SNR: 7
20:25:25.063 > I (20219) src/lorawan.cpp: Radio parameters: SF7 | BW125 | CR 4/5
20:25:25.067 > D (20225) src/lorawan.cpp: JOINED
20:25:25.844 > D (21012) src/lorawan.cpp: TXSTART
20:25:26.877 > D (22050) src/lorawan.cpp: RXSTART
20:25:26.959 > D (22126) src/timesync.cpp: lmicTime.tNetwork = 1725215125
20:25:26.959 > D (22126) src/timesync.cpp: [21.755] seq#211[0]: t2=1725215126
20:25:26.964 > D (22127) src/timesync.cpp: [21.755] seq#211[0]: t3=534
20:25:26.970 > D (22131) src/lorawan.cpp: TXCOMPLETE      
20:25:27.455 > I (22622) src/timekeeper.cpp: [22.250] UTC time: 1725215127.000 sec
20:25:27.461 > D (22622) src/timekeeper.cpp: [22.251] Timesync finished, time was set | timesource=2
20:25:27.466 > D (22625) src/senddata.cpp: sending Payload for Port 9
20:25:30.468 > D (25636) src/lorawan.cpp: TXSTART        1
20:25:31.507 > D (26675) src/lorawan.cpp: RXSTART        1
20:25:31.582 > D (26750) src/lorawan.cpp: TXCOMPLETE     1
20:25:35.093 > D (30261) src/lorawan.cpp: TXSTART        1
20:25:36.135 > D (31303) src/lorawan.cpp: RXSTART        1
20:25:36.197 > D (31370) src/lorawan.cpp: TXCOMPLETE     1
20:25:40.224 > D (35396) src/lorawan.cpp: TXSTART        1
20:25:41.241 > D (36409) src/lorawan.cpp: RXSTART        1
20:25:41.282 > D (36450) src/lorawan.cpp: TXCOMPLETE     1
20:25:41.773 > D (36942) src/lorawan.cpp: TXSTART        1
20:25:46.838 > D (42010) src/cyclic.cpp: Heap: Free:121756, Min:113440, Size:221940, Alloc:106484, StackHWM:2224
20:25:46.851 > D (42011) src/cyclic.cpp: IRQhandler 2224 bytes left | Taskstate = 0
20:25:46.856 > D (42014) src/cyclic.cpp: Rcommand interpreter 2536 bytes left | Taskstate = 2
20:25:46.862 > D (42021) src/cyclic.cpp: LMiCtask 1968 bytes left | Taskstate = 1
20:25:46.867 > D (42027) src/cyclic.cpp: Lorasendtask 2464 bytes left | Taskstate = 2
20:25:46.878 > D (42033) src/cyclic.cpp: LEDloop 432 bytes left | Taskstate = 1
20:26:15.678 > D (70849) src/senddata.cpp: Sending count results: pax=15 / wifi=15 / ble=0
20:26:15.689 > D (70853) src/senddata.cpp: sending Payload for Port 1
20:26:16.844 > D (72009) src/cyclic.cpp: Heap: Free:121756, Min:113440, Size:221940, Alloc:106484, StackHWM:2144
20:26:16.849 > D (72010) src/cyclic.cpp: IRQhandler 2144 bytes left | Taskstate = 0
20:26:16.855 > D (72013) src/cyclic.cpp: Rcommand interpreter 2536 bytes left | Taskstate = 2
20:26:16.861 > D (72020) src/cyclic.cpp: LMiCtask 1968 bytes left | Taskstate = 1
20:26:16.867 > D (72026) src/cyclic.cpp: Lorasendtask 2464 bytes left | Taskstate = 2
20:26:16.878 > D (72032) src/cyclic.cpp: LEDloop 432 bytes left | Taskstate = 1
20:26:46.846 > D (102010) src/cyclic.cpp: Heap: Free:121756, Min:113440, Size:221940, Alloc:106484, StackHWM:2144
20:26:46.852 > D (102011) src/cyclic.cpp: IRQhandler 2144 bytes left | Taskstate = 0
20:26:46.857 > D (102014) src/cyclic.cpp: Rcommand interpreter 2536 bytes left | Taskstate = 2
20:26:46.862 > D (102021) src/cyclic.cpp: LMiCtask 1968 bytes left | Taskstate = 1
20:26:46.874 > D (102027) src/cyclic.cpp: Lorasendtask 2464 bytes left | Taskstate = 2
20:26:46.879 > D (102034) src/cyclic.cpp: LEDloop 432 bytes left | Taskstate = 1
20:27:15.679 > D (130849) src/senddata.cpp: Sending count results: pax=13 / wifi=13 / ble=0
20:27:15.691 > D (130852) src/senddata.cpp: sending Payload for Port 1
20:27:16.846 > D (132009) src/cyclic.cpp: Heap: Free:121756, Min:113440, Size:221940, Alloc:106484, StackHWM:2144
20:27:16.851 > D (132010) src/cyclic.cpp: IRQhandler 2144 bytes left | Taskstate = 0
20:27:16.857 > D (132013) src/cyclic.cpp: Rcommand interpreter 2536 bytes left | Taskstate = 2
20:27:16.862 > D (132020) src/cyclic.cpp: LMiCtask 1968 bytes left | Taskstate = 1
20:27:16.874 > D (132026) src/cyclic.cpp: Lorasendtask 2464 bytes left | Taskstate = 2
20:27:16.879 > D (132033) src/cyclic.cpp: LEDloop 432 bytes left | Taskstate = 1
20:27:46.847 > D (162010) src/cyclic.cpp: Heap: Free:121756, Min:113440, Size:221940, Alloc:106484, StackHWM:2144
20:27:46.852 > D (162011) src/cyclic.cpp: IRQhandler 2144 bytes left | Taskstate = 0
20:27:46.858 > D (162014) src/cyclic.cpp: Rcommand interpreter 2536 bytes left | Taskstate = 2
20:27:46.864 > D (162021) src/cyclic.cpp: LMiCtask 1968 bytes left | Taskstate = 1
20:27:46.875 > D (162027) src/cyclic.cpp: Lorasendtask 2464 bytes left | Taskstate = 2
20:27:46.881 > D (162034) src/cyclic.cpp: LEDloop 432 bytes left | Taskstate = 1
20:28:15.683 > D (190850) src/senddata.cpp: Sending count results: pax=14 / wifi=14 / ble=0
20:28:15.694 > D (190854) src/senddata.cpp: sending Payload for Port 1
20:28:16.842 > D (192009) src/cyclic.cpp: Heap: Free:121756, Min:113440, Size:221940, Alloc:106484, StackHWM:2144
20:28:16.853 > D (192010) src/cyclic.cpp: IRQhandler 2144 bytes left | Taskstate = 0
20:28:16.859 > D (192013) src/cyclic.cpp: Rcommand interpreter 2536 bytes left | Taskstate = 2
20:28:16.865 > D (192021) src/cyclic.cpp: LMiCtask 1968 bytes left | Taskstate = 1
20:28:16.875 > D (192027) src/cyclic.cpp: Lorasendtask 2464 bytes left | Taskstate = 2
20:28:16.881 > D (192033) src/cyclic.cpp: LEDloop 432 bytes left | Taskstate = 1
20:28:46.843 > D (222010) src/cyclic.cpp: Heap: Free:121756, Min:113440, Size:221940, Alloc:106484, StackHWM:2144
20:28:46.855 > D (222011) src/cyclic.cpp: IRQhandler 2144 bytes left | Taskstate = 0
20:28:46.860 > D (222014) src/cyclic.cpp: Rcommand interpreter 2536 bytes left | Taskstate = 2
20:28:46.866 > D (222021) src/cyclic.cpp: LMiCtask 1968 bytes left | Taskstate = 1
20:28:46.876 > D (222027) src/cyclic.cpp: Lorasendtask 2464 bytes left | Taskstate = 2
20:28:46.882 > D (222034) src/cyclic.cpp: LEDloop 432 bytes left | Taskstate = 1
20:29:15.684 > D (250850) src/senddata.cpp: Sending count results: pax=12 / wifi=12 / ble=0
20:29:15.695 > D (250854) src/senddata.cpp: sending Payload for Port 1
20:29:16.844 > D (252010) src/cyclic.cpp: Heap: Free:121756, Min:113440, Size:221940, Alloc:106484, StackHWM:2144
20:29:16.855 > D (252011) src/cyclic.cpp: IRQhandler 2144 bytes left | Taskstate = 0
20:29:16.861 > D (252015) src/cyclic.cpp: Rcommand interpreter 2536 bytes left | Taskstate = 2
20:29:16.867 > D (252022) src/cyclic.cpp: LMiCtask 1968 bytes left | Taskstate = 1
20:29:16.878 > D (252028) src/cyclic.cpp: Lorasendtask 2464 bytes left | Taskstate = 2
20:29:16.883 > D (252034) src/cyclic.cpp: LEDloop 432 bytes left | Taskstate = 1
20:29:46.851 > D (282010) src/cyclic.cpp: Heap: Free:121756, Min:113440, Size:221940, Alloc:106484, StackHWM:2144
20:29:46.857 > D (282011) src/cyclic.cpp: IRQhandler 2144 bytes left | Taskstate = 0
20:29:46.862 > D (282015) src/cyclic.cpp: Rcommand interpreter 2536 bytes left | Taskstate = 2
20:29:46.868 > D (282022) src/cyclic.cpp: LMiCtask 1968 bytes left | Taskstate = 1
20:29:46.879 > D (282028) src/cyclic.cpp: Lorasendtask 2432 bytes left | Taskstate = 2
20:29:46.885 > D (282034) src/cyclic.cpp: LEDloop 416 bytes left | Taskstate = 1
20:30:15.691 > D (310850) src/senddata.cpp: Sending count results: pax=11 / wifi=11 / ble=0
20:30:15.697 > D (310854) src/senddata.cpp: sending Payload for Port 1
20:30:16.846 > D (312010) src/cyclic.cpp: Heap: Free:121756, Min:113440, Size:221940, Alloc:106484, StackHWM:2064
20:30:16.857 > D (312011) src/cyclic.cpp: IRQhandler 2064 bytes left | Taskstate = 0
20:30:16.863 > D (312015) src/cyclic.cpp: Rcommand interpreter 2536 bytes left | Taskstate = 2
20:30:16.868 > D (312022) src/cyclic.cpp: LMiCtask 1968 bytes left | Taskstate = 1
20:30:16.879 > D (312028) src/cyclic.cpp: Lorasendtask 2432 bytes left | Taskstate = 2
20:30:16.884 > D (312034) src/cyclic.cpp: LEDloop 416 bytes left | Taskstate = 1
20:30:46.846 > D (342010) src/cyclic.cpp: Heap: Free:121756, Min:113440, Size:221940, Alloc:106484, StackHWM:2064
20:30:46.858 > D (342011) src/cyclic.cpp: IRQhandler 2064 bytes left | Taskstate = 0
20:30:46.864 > D (342015) src/cyclic.cpp: Rcommand interpreter 2536 bytes left | Taskstate = 2
20:30:46.869 > D (342022) src/cyclic.cpp: LMiCtask 1968 bytes left | Taskstate = 1
20:30:46.880 > D (342028) src/cyclic.cpp: Lorasendtask 2432 bytes left | Taskstate = 2
20:30:46.886 > D (342034) src/cyclic.cpp: LEDloop 416 bytes left | Taskstate = 1
20:31:15.687 > D (370850) src/senddata.cpp: Sending count results: pax=12 / wifi=12 / ble=0
20:31:15.699 > D (370854) src/senddata.cpp: sending Payload for Port 1
20:31:16.848 > D (372010) src/cyclic.cpp: Heap: Free:121756, Min:113440, Size:221940, Alloc:106484, StackHWM:2064
20:31:16.859 > D (372011) src/cyclic.cpp: IRQhandler 2064 bytes left | Taskstate = 0
20:31:16.865 > D (372015) src/cyclic.cpp: Rcommand interpreter 2536 bytes left | Taskstate = 2
20:31:16.870 > D (372022) src/cyclic.cpp: LMiCtask 1968 bytes left | Taskstate = 1
20:31:16.881 > D (372028) src/cyclic.cpp: Lorasendtask 2432 bytes left | Taskstate = 1
20:31:16.887 > D (372034) src/cyclic.cpp: LEDloop 416 bytes left | Taskstate = 1
20:31:46.849 > D (402010) src/cyclic.cpp: Heap: Free:121756, Min:113440, Size:221940, Alloc:106484, StackHWM:2064
20:31:46.860 > D (402011) src/cyclic.cpp: IRQhandler 2064 bytes left | Taskstate = 0
20:31:46.865 > D (402015) src/cyclic.cpp: Rcommand interpreter 2536 bytes left | Taskstate = 2
20:31:46.871 > D (402022) src/cyclic.cpp: LMiCtask 1968 bytes left | Taskstate = 1
20:31:46.881 > D (402028) src/cyclic.cpp: Lorasendtask 2432 bytes left | Taskstate = 2
20:31:46.887 > D (402034) src/cyclic.cpp: LEDloop 416 bytes left | Taskstate = 1
20:32:15.688 > D (430850) src/senddata.cpp: Sending count results: pax=14 / wifi=14 / ble=0
20:32:15.699 > D (430853) src/senddata.cpp: sending Payload for Port 1
20:32:16.849 > D (432010) src/cyclic.cpp: Heap: Free:121756, Min:113440, Size:221940, Alloc:106484, StackHWM:2064
20:32:16.860 > D (432011) src/cyclic.cpp: IRQhandler 2064 bytes left | Taskstate = 0
20:32:16.866 > D (432015) src/cyclic.cpp: Rcommand interpreter 2536 bytes left | Taskstate = 2
20:32:16.871 > D (432022) src/cyclic.cpp: LMiCtask 1968 bytes left | Taskstate = 1
20:32:16.883 > D (432028) src/cyclic.cpp: Lorasendtask 2432 bytes left | Taskstate = 2
20:32:16.888 > D (432034) src/cyclic.cpp: LEDloop 416 bytes left | Taskstate = 1
20:32:46.870 > D (462031) src/cyclic.cpp: Heap: Free:121756, Min:113440, Size:221940, Alloc:106484, StackHWM:2064
20:32:46.882 > D (462031) src/cyclic.cpp: IRQhandler 2064 bytes left | Taskstate = 0
20:32:46.888 > D (462035) src/cyclic.cpp: Rcommand interpreter 2536 bytes left | Taskstate = 2
20:32:46.893 > D (462042) src/cyclic.cpp: LMiCtask 1968 bytes left | Taskstate = 1
20:32:46.904 > D (462048) src/cyclic.cpp: Lorasendtask 2432 bytes left | Taskstate = 2
20:32:46.910 > D (462054) src/cyclic.cpp: LEDloop 416 bytes left | Taskstate = 1
20:33:15.689 > D (490850) src/senddata.cpp: Sending count results: pax=11 / wifi=11 / ble=0
20:33:15.702 > D (490853) src/senddata.cpp: sending Payload for Port 1
20:33:16.850 > D (492010) src/cyclic.cpp: Heap: Free:121756, Min:113440, Size:221940, Alloc:106484, StackHWM:2064
20:33:16.861 > D (492011) src/cyclic.cpp: IRQhandler 2064 bytes left | Taskstate = 0
20:33:16.867 > D (492014) src/cyclic.cpp: Rcommand interpreter 2536 bytes left | Taskstate = 2
20:33:16.872 > D (492021) src/cyclic.cpp: LMiCtask 1968 bytes left | Taskstate = 1
20:33:16.884 > D (492027) src/cyclic.cpp: Lorasendtask 2432 bytes left | Taskstate = 2
20:33:16.889 > D (492034) src/cyclic.cpp: LEDloop 416 bytes left | Taskstate = 1
20:33:46.851 > D (522009) src/cyclic.cpp: Heap: Free:121756, Min:113440, Size:221940, Alloc:106484, StackHWM:2064
20:33:46.862 > D (522010) src/cyclic.cpp: IRQhandler 2064 bytes left | Taskstate = 0
20:33:46.867 > D (522014) src/cyclic.cpp: Rcommand interpreter 2536 bytes left | Taskstate = 2
20:33:46.873 > D (522021) src/cyclic.cpp: LMiCtask 1968 bytes left | Taskstate = 1
20:33:46.884 > D (522027) src/cyclic.cpp: Lorasendtask 2432 bytes left | Taskstate = 2
20:33:46.890 > D (522033) src/cyclic.cpp: LEDloop 416 bytes left | Taskstate = 1
20:34:15.692 > D (550850) src/senddata.cpp: Sending count results: pax=12 / wifi=12 / ble=0
20:34:15.703 > D (550853) src/senddata.cpp: sending Payload for Port 1
20:34:16.852 > D (552010) src/cyclic.cpp: Heap: Free:121756, Min:113440, Size:221940, Alloc:106484, StackHWM:2064
20:34:16.864 > D (552011) src/cyclic.cpp: IRQhandler 2064 bytes left | Taskstate = 0
20:34:16.869 > D (552014) src/cyclic.cpp: Rcommand interpreter 2536 bytes left | Taskstate = 2
20:34:16.875 > D (552021) src/cyclic.cpp: LMiCtask 1968 bytes left | Taskstate = 1
20:34:16.885 > D (552027) src/cyclic.cpp: Lorasendtask 2432 bytes left | Taskstate = 2
20:34:16.891 > D (552034) src/cyclic.cpp: LEDloop 416 bytes left | Taskstate = 1
20:34:46.852 > D (582009) src/cyclic.cpp: Heap: Free:121756, Min:113440, Size:221940, Alloc:106484, StackHWM:2064
20:34:46.864 > D (582010) src/cyclic.cpp: IRQhandler 2064 bytes left | Taskstate = 0
20:34:46.869 > D (582014) src/cyclic.cpp: Rcommand interpreter 2536 bytes left | Taskstate = 2
20:34:46.875 > D (582021) src/cyclic.cpp: LMiCtask 1968 bytes left | Taskstate = 1
20:34:46.886 > D (582027) src/cyclic.cpp: Lorasendtask 2432 bytes left | Taskstate = 2
20:34:46.892 > D (582033) src/cyclic.cpp: LEDloop 416 bytes left | Taskstate = 1
20:35:15.699 > D (610850) src/senddata.cpp: Sending count results: pax=11 / wifi=11 / ble=0
20:35:15.705 > D (610854) src/senddata.cpp: sending Payload for Port 1
20:35:15.710 > W (610854) src/lorawan.cpp: LORA sendqueue is full
20:35:16.853 > D (612010) src/cyclic.cpp: Heap: Free:121756, Min:113440, Size:221940, Alloc:106484, StackHWM:2064
20:35:16.865 > D (612011) src/cyclic.cpp: IRQhandler 2064 bytes left | Taskstate = 0
20:35:16.871 > D (612014) src/cyclic.cpp: Rcommand interpreter 2536 bytes left | Taskstate = 2
20:35:16.876 > D (612021) src/cyclic.cpp: LMiCtask 1968 bytes left | Taskstate = 1
20:35:16.886 > D (612027) src/cyclic.cpp: Lorasendtask 2400 bytes left | Taskstate = 2
20:35:16.892 > D (612034) src/cyclic.cpp: LEDloop 416 bytes left | Taskstate = 1
20:35:46.859 > D (642009) src/cyclic.cpp: Heap: Free:121756, Min:113440, Size:221940, Alloc:106484, StackHWM:2064
20:35:46.865 > D (642010) src/cyclic.cpp: IRQhandler 2064 bytes left | Taskstate = 0
20:35:46.870 > D (642014) src/cyclic.cpp: Rcommand interpreter 2536 bytes left | Taskstate = 2
20:35:46.876 > D (642021) src/cyclic.cpp: LMiCtask 1968 bytes left | Taskstate = 1
20:35:46.888 > D (642027) src/cyclic.cpp: Lorasendtask 2400 bytes left | Taskstate = 2
20:35:46.893 > D (642033) src/cyclic.cpp: LEDloop 416 bytes left | Taskstate = 1
20:36:15.701 > D (670850) src/senddata.cpp: Sending count results: pax=11 / wifi=11 / ble=0
20:36:15.707 > D (670854) src/senddata.cpp: sending Payload for Port 1
20:36:15.712 > W (670854) src/lorawan.cpp: LORA sendqueue is full
20:36:16.861 > D (672010) src/cyclic.cpp: Heap: Free:121756, Min:113440, Size:221940, Alloc:106484, StackHWM:2064
20:36:16.866 > D (672011) src/cyclic.cpp: IRQhandler 2064 bytes left | Taskstate = 0
20:36:16.872 > D (672014) src/cyclic.cpp: Rcommand interpreter 2536 bytes left | Taskstate = 2
20:36:16.878 > D (672021) src/cyclic.cpp: LMiCtask 1968 bytes left | Taskstate = 1
20:36:16.889 > D (672027) src/cyclic.cpp: Lorasendtask 2400 bytes left | Taskstate = 2
20:36:16.895 > D (672034) src/cyclic.cpp: LEDloop 416 bytes left | Taskstate = 1
20:36:46.857 > D (702010) src/cyclic.cpp: Heap: Free:121756, Min:113440, Size:221940, Alloc:106484, StackHWM:2064
20:36:46.868 > D (702011) src/cyclic.cpp: IRQhandler 2064 bytes left | Taskstate = 0
20:36:46.873 > D (702015) src/cyclic.cpp: Rcommand interpreter 2536 bytes left | Taskstate = 2
20:36:46.879 > D (702022) src/cyclic.cpp: LMiCtask 1968 bytes left | Taskstate = 1
20:36:46.889 > D (702028) src/cyclic.cpp: Lorasendtask 2400 bytes left | Taskstate = 2
20:36:46.895 > D (702034) src/cyclic.cpp: LEDloop 416 bytes left | Taskstate = 1
20:37:15.697 > D (730850) src/senddata.cpp: Sending count results: pax=12 / wifi=12 / ble=0
20:37:15.709 > D (730854) src/senddata.cpp: sending Payload for Port 1
20:37:15.714 > W (730854) src/lorawan.cpp: LORA sendqueue is full
20:37:16.858 > D (732010) src/cyclic.cpp: Heap: Free:121756, Min:113440, Size:221940, Alloc:106484, StackHWM:2064
20:37:16.869 > D (732011) src/cyclic.cpp: IRQhandler 2064 bytes left | Taskstate = 0
20:37:16.874 > D (732015) src/cyclic.cpp: Rcommand interpreter 2536 bytes left | Taskstate = 2
20:37:16.880 > D (732022) src/cyclic.cpp: LMiCtask 1968 bytes left | Taskstate = 1
20:37:16.890 > D (732028) src/cyclic.cpp: Lorasendtask 2400 bytes left | Taskstate = 2
20:37:16.896 > D (732034) src/cyclic.cpp: LEDloop 416 bytes left | Taskstate = 1
20:37:46.858 > D (762010) src/cyclic.cpp: Heap: Free:121756, Min:113440, Size:221940, Alloc:106484, StackHWM:2064
20:37:46.870 > D (762011) src/cyclic.cpp: IRQhandler 2064 bytes left | Taskstate = 0
20:37:46.876 > D (762015) src/cyclic.cpp: Rcommand interpreter 2536 bytes left | Taskstate = 2
20:37:46.881 > D (762022) src/cyclic.cpp: LMiCtask 1968 bytes left | Taskstate = 1
20:37:46.891 > D (762028) src/cyclic.cpp: Lorasendtask 2400 bytes left | Taskstate = 2
20:37:46.897 > D (762034) src/cyclic.cpp: LEDloop 416 bytes left | Taskstate = 1
20:38:15.698 > D (790850) src/senddata.cpp: Sending count results: pax=11 / wifi=11 / ble=0
20:38:15.710 > D (790854) src/senddata.cpp: sending Payload for Port 1
20:38:15.715 > W (790854) src/lorawan.cpp: LORA sendqueue is full
20:38:16.859 > D (792010) src/cyclic.cpp: Heap: Free:121756, Min:113440, Size:221940, Alloc:106484, StackHWM:2064
20:38:16.871 > D (792011) src/cyclic.cpp: IRQhandler 2064 bytes left | Taskstate = 0
20:38:16.876 > D (792015) src/cyclic.cpp: Rcommand interpreter 2536 bytes left | Taskstate = 2
20:38:16.882 > D (792022) src/cyclic.cpp: LMiCtask 1968 bytes left | Taskstate = 1
20:38:16.892 > D (792028) src/cyclic.cpp: Lorasendtask 2400 bytes left | Taskstate = 2
20:38:16.898 > D (792034) src/cyclic.cpp: LEDloop 416 bytes left | Taskstate = 1
20:38:46.860 > D (822010) src/cyclic.cpp: Heap: Free:121756, Min:113440, Size:221940, Alloc:106484, StackHWM:2064
20:38:46.871 > D (822011) src/cyclic.cpp: IRQhandler 2064 bytes left | Taskstate = 0
20:38:46.877 > D (822015) src/cyclic.cpp: Rcommand interpreter 2536 bytes left | Taskstate = 2
20:38:46.882 > D (822022) src/cyclic.cpp: LMiCtask 1968 bytes left | Taskstate = 1
20:38:46.893 > D (822028) src/cyclic.cpp: Lorasendtask 2400 bytes left | Taskstate = 2
20:38:46.898 > D (822034) src/cyclic.cpp: LEDloop 416 bytes left | Taskstate = 1
20:39:15.705 > D (850849) src/senddata.cpp: Sending count results: pax=11 / wifi=11 / ble=0
20:39:15.710 > D (850852) src/senddata.cpp: sending Payload for Port 1
20:39:15.715 > W (850853) src/lorawan.cpp: LORA sendqueue is full

0 replies

cyberman54 · 2024-09-01T19:15:39Z

cyberman54
Sep 1, 2024
Maintainer

LMIC seems to be busy for some reason. Please try log level verbose and watch for LMIC error messages.

1 reply

reibuehl Sep 1, 2024
Author

With debug level verbose I noticed that one transmit worked. I received a packet at 21:54:02 on the MQTT server but nothing after that anymore. The logs look like this:

21:53:05.130 > I (396) src/sdcard.cpp: looking for SD-card...
21:53:05.130 > E (426) sdmmc_common: sdmmc_init_ocr: send_op_cond (1) returned 0x107
21:53:05.130 > E (426) vfs_fat_sdmmc: sdmmc_card_init failed (0x107).
21:53:05.130 > I (426) src/sdcard.cpp: No SD-card found (263)
21:53:05.130 > I (430) src/configmanager.cpp: Loading device configuration from NVRAM...
21:53:05.130 > I (438) src/configmanager.cpp: Runtime configuration v3.6.2 loaded
21:53:05.130 > D (443) src/reset.cpp: Timezone set to CET-1CEST,M3.4.0/2,M10.4.0/3
21:53:05.130 > I (449) src/main.cpp: Starting paxcounter_faa5fdb3 v3.6.2 (runmode=0 / restarts=0)
21:53:05.130 > I (456) src/main.cpp: code build date: 1725223875
21:53:05.130 > I (460) src/main.cpp: This is ESP32 chip with 2 CPU cores, WiFi/BT/BLE, silicon revision 1, 4MB embedded Flash
21:53:05.130 > I (470) src/main.cpp: Internal Total heap 223660, internal Free Heap 195900
21:53:05.130 > I (477) src/main.cpp: ChipRevision 1, Cpu Freq 240, SDK Version v4.4.5
21:53:05.130 > I (483) src/main.cpp: Flash Size 4194304, Flash Speed 40000000
21:53:05.130 > I (489) src/main.cpp: Wifi/BT software coexist version 1.2.0
21:53:05.130 > I (494) src/main.cpp: Wifi STA MAC: E8:9F:6D:08:85:6C
21:53:05.130 > I (499) src/main.cpp: IBM LMIC version 1.6.1468577746
21:53:05.130 > I (503) src/main.cpp: Arduino LMIC version 4.1.1.0
21:53:05.130 > I (508) src/lorawan.cpp: DevEUI: 5634129078563412
21:53:05.130 > I (513) C:/Users/reiner/.platformio/packages/framework-arduinoespressif32/cores/esp32/esp32-hal-i2c.c: Initialising I2C Master: sda=21 scl=22 freq=100000
21:53:05.130 > I (527) src/i2c.cpp: Starting I2C bus scan...
21:53:05.130 > W (530) C:/Users/reiner/.platformio/packages/framework-arduinoespressif32/libraries/Wire/src/Wire.cpp: Bus already started in Master Mode.
21:53:05.130 > I (661) src/i2c.cpp: Device found at 0x3C, type = Unknown
21:53:05.130 > I (661) src/i2c.cpp: 1 I2C device(s) found
21:53:05.130 > W (661) C:/Users/reiner/.platformio/packages/framework-arduinoespressif32/libraries/Wire/src/Wire.cpp: Bus already started in Master Mode.
21:53:05.130 > I (10809) src/main.cpp: Starting LED Controller...
21:53:05.130 > I (10809) src/power.cpp: ADC characterization based on reference voltage stored in eFuse
21:53:05.130 > I (10813) src/main.cpp: Starting libpax...
21:53:05.130 > I (10814) src/main.cpp: WIFISCAN: on
21:53:05.130 > I (10817) src/main.cpp: BLESCAN: off
21:53:05.130 > I (10918) src/main.cpp: Starting rcommand interpreter...
21:53:05.130 > I (10918) src/rcommand.cpp: Rcommand send queue created, size 55 Bytes
21:53:05.130 > I (10919) src/lorawan.cpp: LORA send queue created, size 530 Bytes
21:53:05.130 > I (10941) src/lorawan.cpp: Starting LMIC...
21:53:05.130 > D (10942) src/lorawan.cpp: JOINING
21:53:05.130 > I (10943) src/main.cpp: Starting Interrupt Handler...
21:53:05.130 > I (10943) src/main.cpp: Starting Timers...
21:53:05.130 > I (10978) src/timekeeper.cpp: Starting time pulse...
21:53:05.130 > I (10978) src/timekeeper.cpp: Timepulse: internal (ESP32 hardware timer)
21:53:05.130 > I (11979) src/main.cpp: Features: DISP LED BATT OTA LORA PACKED TIME
21:53:05.130 > I (12007) src/timesync.cpp: [11.633] Timeserver sync request started, seqNo#202
21:53:09.294 > D (18071) src/lorawan.cpp: TXSTART
21:53:14.349 > D (23124) src/lorawan.cpp: RXSTART
21:53:14.431 > I (23210) src/lorawan.cpp: DEVaddr: 0x02665EC9 | Network ID: 0x000001 | Network Type: 0
21:53:14.442 > I (23211) src/lorawan.cpp: RSSI: -6 | SNR: 7
21:53:14.448 > I (23211) src/lorawan.cpp: Radio parameters: SF7 | BW125 | CR 4/5
21:53:14.452 > D (23217) src/lorawan.cpp: JOINED
21:53:15.233 > D (24009) src/lorawan.cpp: TXSTART
21:53:16.269 > D (25048) src/lorawan.cpp: RXSTART
21:53:16.343 > D (25123) src/timesync.cpp: lmicTime.tNetwork = 1725220394
21:53:16.349 > D (25123) src/timesync.cpp: [24.749] seq#202[0]: t2=1725220395
21:53:16.355 > D (25124) src/timesync.cpp: [24.750] seq#202[0]: t3=838
21:53:16.360 > D (25128) src/lorawan.cpp: TXCOMPLETE
21:53:16.541 > I (25315) src/timekeeper.cpp: [24.941] UTC time: 1725220396.000 sec
21:53:16.547 > D (25316) src/timekeeper.cpp: [24.942] Timesync finished, time was set | timesource=2
21:53:16.553 > D (25318) src/senddata.cpp: sending Payload for Port 9
21:53:16.559 > V (25324) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:53:17.196 > V (25975) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:53:18.094 > V (26873) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:53:18.611 > V (27391) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:53:19.352 > V (28132) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:53:19.852 > D (28633) src/lorawan.cpp: TXSTART        1
21:53:20.084 > V (28863) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:53:20.834 > V (29608) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:53:20.890 > D (29670) src/lorawan.cpp: RXSTART        1
21:53:20.972 > D (29748) src/lorawan.cpp: TXCOMPLETE     1
21:53:21.471 > V (30250) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:53:22.259 > V (31038) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:53:23.029 > V (31808) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:53:23.847 > V (32621) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:53:24.344 > V (33124) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:53:24.481 > D (33257) src/lorawan.cpp: TXSTART        1
21:53:24.846 > V (33626) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:53:25.519 > D (34299) src/lorawan.cpp: RXSTART        1
21:53:25.685 > V (34465) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:53:26.262 > V (35042) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:53:26.518 > D (35298) src/lorawan.cpp: RXSTART        1
21:53:26.764 > D (35540) src/lorawan.cpp: TXCOMPLETE     1
21:53:26.841 > I (35616) src/lorawan.cpp: 1 byte(s) sent to LORA
21:53:29.618 > D (38393) src/lorawan.cpp: TXSTART
21:53:30.650 > D (39430) src/lorawan.cpp: RXSTART
21:53:31.655 > D (40430) src/lorawan.cpp: RXSTART
21:53:31.892 > D (40673) src/lorawan.cpp: TXCOMPLETE      
21:53:33.227 > D (42007) src/cyclic.cpp: Heap: Free:121752, Min:110140, Size:221932, Alloc:106484, StackHWM:2192
21:53:33.238 > D (42007) src/cyclic.cpp: IRQhandler 2192 bytes left | Taskstate = 0
21:53:33.244 > D (42011) src/cyclic.cpp: Rcommand interpreter 2524 bytes left | Taskstate = 2
21:53:33.250 > D (42018) src/cyclic.cpp: LMiCtask 1968 bytes left | Taskstate = 1
21:53:33.255 > D (42024) src/cyclic.cpp: Lorasendtask 1184 bytes left | Taskstate = 2
21:53:33.267 > D (42030) src/cyclic.cpp: LEDloop 428 bytes left | Taskstate = 1
21:54:02.073 > D (70846) src/senddata.cpp: Sending count results: pax=12 / wifi=12 / ble=0
21:54:02.079 > D (70849) src/senddata.cpp: sending Payload for Port 1
21:54:02.085 > D (70850) src/lorawan.cpp: TXSTART        1
21:54:02.085 > I (70851) src/lorawan.cpp: 2 byte(s) sent to LORA
21:54:03.113 > D (71887) src/lorawan.cpp: RXSTART
21:54:03.174 > D (71954) src/lorawan.cpp: TXCOMPLETE      
21:54:03.233 > D (72006) src/cyclic.cpp: Heap: Free:121752, Min:110140, Size:221932, Alloc:106484, StackHWM:2144
21:54:03.239 > D (72007) src/cyclic.cpp: IRQhandler 2144 bytes left | Taskstate = 0
21:54:03.245 > D (72010) src/cyclic.cpp: Rcommand interpreter 2524 bytes left | Taskstate = 2
21:54:03.250 > D (72017) src/cyclic.cpp: LMiCtask 1968 bytes left | Taskstate = 1
21:54:03.255 > D (72023) src/cyclic.cpp: Lorasendtask 1040 bytes left | Taskstate = 2
21:54:03.267 > D (72029) src/cyclic.cpp: LEDloop 428 bytes left | Taskstate = 1
21:54:06.700 > D (75475) src/lorawan.cpp: TXSTART
21:54:07.716 > D (76490) src/lorawan.cpp: RXSTART
21:54:07.753 > D (76528) src/lorawan.cpp: TXCOMPLETE      
21:54:08.240 > D (77019) src/lorawan.cpp: TXSTART
21:54:33.235 > D (102007) src/cyclic.cpp: Heap: Free:121752, Min:110140, Size:221932, Alloc:106484, StackHWM:2144
21:54:33.240 > D (102007) src/cyclic.cpp: IRQhandler 2144 bytes left | Taskstate = 0
21:54:33.246 > D (102011) src/cyclic.cpp: Rcommand interpreter 2524 bytes left | Taskstate = 2
21:54:33.251 > D (102018) src/cyclic.cpp: LMiCtask 1968 bytes left | Taskstate = 1
21:54:33.262 > D (102024) src/cyclic.cpp: Lorasendtask 1040 bytes left | Taskstate = 2
21:54:33.268 > D (102030) src/cyclic.cpp: LEDloop 428 bytes left | Taskstate = 1
21:55:02.075 > D (130847) src/senddata.cpp: Sending count results: pax=12 / wifi=12 / ble=0
21:55:02.082 > D (130851) src/senddata.cpp: sending Payload for Port 1
21:55:02.087 > V (130851) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:02.753 > V (131530) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:03.234 > D (132006) src/cyclic.cpp: Heap: Free:121752, Min:110140, Size:221932, Alloc:106484, StackHWM:2144
21:55:03.240 > D (132007) src/cyclic.cpp: IRQhandler 2144 bytes left | Taskstate = 0
21:55:03.246 > D (132010) src/cyclic.cpp: Rcommand interpreter 2524 bytes left | Taskstate = 2
21:55:03.251 > D (132017) src/cyclic.cpp: LMiCtask 1968 bytes left | Taskstate = 1
21:55:03.263 > D (132023) src/cyclic.cpp: Lorasendtask 1040 bytes left | Taskstate = 2
21:55:03.268 > D (132030) src/cyclic.cpp: LEDloop 428 bytes left | Taskstate = 1
21:55:03.605 > V (132382) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:04.117 > V (132894) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:05.017 > V (133794) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:05.552 > V (134324) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:06.230 > V (135002) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:06.947 > V (135725) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:07.808 > V (136586) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:08.429 > V (137201) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:08.948 > V (137726) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:09.830 > V (138601) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:10.595 > V (139373) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:11.330 > V (140107) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:11.956 > V (140733) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:12.728 > V (141500) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:13.625 > V (142397) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:14.373 > V (143150) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:15.141 > V (143918) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:15.886 > V (144663) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:16.425 > V (145203) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:17.021 > V (145792) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:17.791 > V (146568) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:18.569 > V (147345) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:19.194 > V (147966) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:19.906 > V (148684) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:20.733 > V (149504) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:21.528 > V (150304) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:22.324 > V (151101) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:23.098 > V (151875) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:23.679 > V (152450) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:24.510 > V (153286) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:25.296 > V (154073) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:25.904 > V (154680) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:26.604 > V (155375) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:27.473 > V (156250) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:28.135 > V (156912) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:28.717 > V (157494) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:29.402 > V (158178) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:30.198 > V (158969) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:30.869 > V (159640) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:31.731 > V (160502) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:32.281 > V (161052) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:33.092 > V (161869) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:33.231 > D (162007) src/cyclic.cpp: Heap: Free:121752, Min:110140, Size:221932, Alloc:106484, StackHWM:2144
21:55:33.242 > D (162007) src/cyclic.cpp: IRQhandler 2144 bytes left | Taskstate = 0
21:55:33.247 > D (162011) src/cyclic.cpp: Rcommand interpreter 2524 bytes left | Taskstate = 2
21:55:33.253 > D (162018) src/cyclic.cpp: LMiCtask 1968 bytes left | Taskstate = 1
21:55:33.264 > D (162024) src/cyclic.cpp: Lorasendtask 1040 bytes left | Taskstate = 2
21:55:33.269 > D (162030) src/cyclic.cpp: LEDloop 428 bytes left | Taskstate = 1
21:55:33.633 > V (162403) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:34.385 > V (163161) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:35.167 > V (163943) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:35.978 > V (164755) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:36.676 > V (165446) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:37.511 > V (166287) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:38.116 > V (166892) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:38.850 > V (167626) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:39.366 > V (168143) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:40.158 > V (168929) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:41.041 > V (169818) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:41.578 > V (170354) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:42.358 > V (171129) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:42.919 > V (171695) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:43.623 > V (172394) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:44.387 > V (173163) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:44.992 > V (173768) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:45.834 > V (174605) src/lorawan.cpp: Message not sent, LMIC busy, will retry later
21:55:46.526 > V (175302) src/lorawan.cpp: Message not sent, LMIC busy, will retry later

cyberman54 · 2024-09-02T06:37:41Z

cyberman54
Sep 2, 2024
Maintainer

As expected, LMIC stack is busy. This typically happens if it sends many messages on high spreading factor (e.g. SF12) and runs in airtime dutycycle limit. Check settings of your network server.

1 reply

reibuehl Sep 2, 2024
Author

These are the network server settings:

Do you see anything that collides with the Paxcounter default settings? I have not changed any of those settings in either the paxcounter source code nor the RAK7258, all is just defaults.

cyberman54 · 2024-09-02T07:35:26Z

cyberman54
Sep 2, 2024
Maintainer

Set RX2 Datarate to SF9, and disable ADR, then try again. If it works, set ADR to on.

5 replies

reibuehl Sep 2, 2024
Author

Many thanks! That was the solution. I now get reliable data every 60 seconds.

reibuehl Sep 2, 2024
Author

Sorry... but it worked until 10:00 and then stopped again. Should I change other values or disable ADR again?

reibuehl Sep 2, 2024
Author

Just switching of ADR did not help.

cyberman54 Sep 2, 2024
Maintainer

Then once again, check logs for LMIC busy error. You may reach duty cycle if you transfer too much data in high SF level. Switch off ADR if your network server drives the node to SF12. Or reduce data traffic by decreasing send cycle.

On LoRaWAN 868 Mhz strong duty cycles apply in EU. Your data amount must be selected according to what is possible.

reibuehl Sep 4, 2024
Author

Based on my understanding of the ESP32-paxcounter code, it sends one packet every 60 seconds (2* SENDCYCLE, SENDCYCLE = 30). The packets I receive have a data length of 4 Byte. That should not be an issue for the duty cycle or am I missing something here?

cyberman54 · 2024-09-04T11:41:11Z

cyberman54
Sep 4, 2024
Maintainer

Again, check your network server settings. MAC payload goes.on top. Could be too much if on SF12.

4 replies

reibuehl Sep 4, 2024
Author

Sorry, I am new to these settings. I have only setup one as I do not have anything else in reach. I am trying to get a Sensor/Actor connected via LoRa because its location is not in reach of my WiFi.

On my network settings I see that all data rates from SF12 to SF7 are allowed. In loraconf_abp.cpp, SF7 is selected which should already be the largest data rate if I understand it correct.

cyberman54 Sep 9, 2024
Maintainer

try disable frame counter validation.

reibuehl Sep 14, 2024
Author

I tried that but it also fails after some time if I re-enable ADR. I have tried switching the gateway to Basics Station mode and connect it to TTN instead of running it in standalone Network Server mode. With TTN Basics Station mode, the error seems to be gone.

cyberman54 Sep 14, 2024
Maintainer

Check your network server settings and compare with TTN.

Check in the gateway's log, if your network server continously sends MAC commands to the node, especially if ADR is enabled. MAC commands also do count down the airtime duty cycle limit.

Provide feedback

Saved searches

Use saved searches to filter your results more quickly

Problem sending data to a RAK7258 gateway/network server #1020

{{title}}

Replies: 6 comments 11 replies

{{title}}

{{title}}

{{title}}

{{editor}}'s edit

{{editor}}'s edit

{{title}}

{{title}}

{{title}}

{{title}}

{{title}}

{{title}}

{{editor}}'s edit

{{editor}}'s edit

{{title}}

{{title}}

{{title}}

{{title}}

{{title}}

{{title}}

{{title}}

{{title}}

Select a reply

Problem sending data to a RAK7258 gateway/network server #1020

reibuehl Sep 1, 2024

Replies: 6 comments · 11 replies

cyberman54 Sep 1, 2024 Maintainer

reibuehl Sep 1, 2024 Author

cyberman54 Sep 1, 2024 Maintainer

reibuehl Sep 1, 2024 Author

cyberman54 Sep 2, 2024 Maintainer

reibuehl Sep 2, 2024 Author

cyberman54 Sep 2, 2024 Maintainer

reibuehl Sep 2, 2024 Author

reibuehl Sep 2, 2024 Author

reibuehl Sep 2, 2024 Author

cyberman54 Sep 2, 2024 Maintainer

reibuehl Sep 4, 2024 Author

cyberman54 Sep 4, 2024 Maintainer

reibuehl Sep 4, 2024 Author

cyberman54 Sep 9, 2024 Maintainer

reibuehl Sep 14, 2024 Author

cyberman54 Sep 14, 2024 Maintainer

reibuehl
Sep 1, 2024

Replies: 6 comments 11 replies

cyberman54
Sep 1, 2024
Maintainer

reibuehl
Sep 1, 2024
Author

cyberman54
Sep 1, 2024
Maintainer

reibuehl Sep 1, 2024
Author

cyberman54
Sep 2, 2024
Maintainer

reibuehl Sep 2, 2024
Author

cyberman54
Sep 2, 2024
Maintainer

reibuehl Sep 2, 2024
Author

reibuehl Sep 2, 2024
Author

reibuehl Sep 2, 2024
Author

cyberman54 Sep 2, 2024
Maintainer

reibuehl Sep 4, 2024
Author

cyberman54
Sep 4, 2024
Maintainer

reibuehl Sep 4, 2024
Author

cyberman54 Sep 9, 2024
Maintainer

reibuehl Sep 14, 2024
Author

cyberman54 Sep 14, 2024
Maintainer