TTIG connects to Wi-Fi but is always flashing green

KrishnaIyerEaswaran2 · March 22, 2023, 3:41pm

Same question for you. What is this TBMH100XXXXXX code on your gateway?

rladik · March 22, 2023, 3:41pm

Ok, thank you

vicatcu · March 22, 2023, 7:07pm

The field you are asking about has a value of: TBMH100915000233

KrishnaIyerEaswaran2 · March 23, 2023, 7:42am

Ok that’s good. The reason I ask the both of you is that if the code was TBMH100868XXXXXX then it’s an EU868 gateway which would reject a US915 frequency plan. But that’s not the case here.
@vicatcu: I see some activity on your gateway. Are you testing something?

KrishnaIyerEaswaran2 · March 23, 2023, 8:07am

@vicatcu; I’ve enabled debug logging on the servers. Please keep your gateway connected or try to reconnect it so I can get some more logs.

vicatcu · March 23, 2023, 2:25pm

The gateway hasn’t even been plugged in since yesterday afternoon (Eastern Time, NY) so that’s unlikely

descartes · March 23, 2023, 2:28pm

More importantly, have you plugged it back in so Batman can look at the logs?

vicatcu · March 23, 2023, 2:36pm

Understood, its plugged back in now. Seems to be the same LED behavior as before.

descartes · March 23, 2023, 3:03pm

I doubt anyone’s fixed anything because they need to read the logs first …

vicatcu · March 23, 2023, 4:31pm

its solid green now! any chance of knowing what changed?

KrishnaIyerEaswaran2 · March 23, 2023, 4:39pm

No changes on the server. I checked the logs on the server

Your gateway initiated CUPS connections at 15:37, 16:15, 16:45 and 16:58 (CET)
In each case the server responded with an LNS configuration asking your gateway to connect to the nam1 gateway server.

LBS connections are kept alive via Websocket ping pong. Your gateway isn’t responding to server pings.

{
  "name": "gs.gateway.disconnect",
  "time": "2023-03-23T16:32:07.544072806Z",
  "identifiers": [
    {
      "gateway_ids": {
        "gateway_id": "xxx",
        "eui": "58A0CBFFFE8002B8"
      }
    }
  ],
  "data": {
    "@type": "type.googleapis.com/ttn.lorawan.v3.ErrorDetails",
    "namespace": "pkg/gatewayserver/io/ws",
    "name": "missed_too_many_pongs",
    "message_format": "gateway missed too many pongs",
    "correlation_id": "7e8c53df92234141aed963bc63eec666",
    "code": 2
}
}

This does very much sound like a network issue. Tomorrow, I’ll try to check if there’s network latency or something that’s causing this. My current prognosis is that there isn’t anything wrong on the server side.

descartes · March 23, 2023, 4:47pm

LOL

They’ve definitely turned it off & on again, so I guess the next one is the venerable “it’s working for me”!!

It is working for me - the TTN one, the TTI Discovery one and the totally illegal one setup for US915 in the lounge whilst I occasionally test stuff.

@KrishnaIyerEaswaran2, why not turn it off at your end and we can check how many notice. Then turn it back on again to see what still works!

KrishnaIyerEaswaran2 · March 24, 2023, 8:25am

I also did a full clean reclaim of a couple of test gateways and I have no issues connecting with the nam1 cluster. I don’t see any issues on the server side either.
I would recommend trying a different network (maybe 4G), check if port 8887 is blocked by your ISP or in the worst case return your gateway to the vendor so that they can run tests to see if there’s a hardware issue.

semiha · June 30, 2023, 9:25am

Hi,
can’t connect “old” TTIG. The LED is flashing green (fast) and is connected with the WiFi.

Followed the instrucitons for TTIG: Console → Register → Claimed it with EUI+WiFi Pass. I waited more than 30h and also turned the TTIG on off. I also deleted and repeated the steps, but still “disconnected”.

Is it, because the firmware is old:

MFG date2020-04-28 19:31:56
FW Build2018-12-06 09:30:37
FW Version2.0.0
Core Version2.0.0(minihub/debug)
Gateway EUI58-A0-CB-FF-FE-80-33-30.

Is there any possibility for debugging what’s not working?

Thanks,
Semih

joe_4 · January 9, 2024, 2:31pm

First I have to say that I’m not good at using this forum, seems a bit scary, so far I have managed on my own, but now I’m lost…
I had the same problem.
I have two TTIG’s both worked fine, first with V2, now with V3. But now one of them is “not connected”. And I have not manage to get it to work again.
I did all the reset, delete and reclaiming thing (tried several times), but it did not work. I searched here, I googled and did all I could think of, but no success.
Always when I have done something to my gateways, I did the same to both of them.
The EUI for the bade one is" 58A0CBFFFE800C10" (the good one is “58A0CBFFFE800C1E”).
Can someone tell me from the “uart log dump”, and “how it looks” from your side, what has gone wrong, I’m completely lost.
Actually there is not much to do to get it to work. And when it is NOT working. There is not much to do different either.
It seems like it is stuck in a loop, looking for something it can not find.
Here is the log:

dld`�mode : sta(2c:f4:32:50:c6:61)
add if0
1970-01-01 00:00:02.131 [SYS:INFO] FSCK found section marker A0
1970-01-01 00:00:02.138 [SYS:INFO] FSCK section A: 26 records, 6164 bytes used, 1017836 bytes free
1970-01-01 00:00:02.626 [SYS:INFO] FSCK section A followed by erased flash - all clear.
1970-01-01 00:00:02.634 [SYS:INFO] Checking file: [   cups-boot.uri ] OK
1970-01-01 00:00:02.638 [SYS:INFO] Checking file: [   cups-boot.key ] OK
1970-01-01 00:00:02.642 [SYS:INFO] Checking file: [ cups-boot.trust ] OK
1970-01-01 00:00:02.646 [SYS:INFO] Checking file: [       sig-0.key ] OK
1970-01-01 00:00:02.651 [SYS:INFO] Checking file: [    station.conf ] OK
1970-01-01 00:00:02.673 [SYS:INFO] Checking file: [  web/index.html ] OK
1970-01-01 00:00:02.682 [any:INFO] HW pipe bound with fd=0
1970-01-01 00:00:02.684 [any:INFO] AIO registered for HW pipe &aio=0x3ffeea98


1970-01-01 00:00:00.007 [SYS:DEBU] ======= VER ======
1970-01-01 00:00:00.009 [SYS:DEBU] Station Version   2.0.4(minihub/debug)
1970-01-01 00:00:00.011 [SYS:DEBU] Version Commit    f63908e
1970-01-01 00:00:00.014 [SYS:DEBU] Station Build     2020-05-07 16:03:53
1970-01-01 00:00:00.020 [SYS:DEBU] Firmware Version  2.0.4
1970-01-01 00:00:00.025 [SYS:DEBU] FW Flavor ID      semtech0
1970-01-01 00:00:00.031 [SYS:DEBU] Model             minihub
1970-01-01 00:00:00.042 [SYS:DEBU] ======= SYS ======
1970-01-01 00:00:00.044 [SYS:DEBU] CPU Freq          80 / 80000000 / 80000000
1970-01-01 00:00:00.048 [SYS:DEBU] Random Number     -193917573
1970-01-01 00:00:00.053 [SYS:DEBU] Reset cause       0
1970-01-01 00:00:00.058 [SYS:DEBU] Booting USER_BIN  1
1970-01-01 00:00:00.063 [SYS:DEBU] FW start addr     0x00001000
1970-01-01 00:00:00.069 [SYS:DEBU] ESP SDK version   2.0-dev(9ec59b5)
1970-01-01 00:00:00.075 [SYS:DEBU] mbedTLS version   2.6.1
1970-01-01 00:00:00.080 [SYS:DEBU] Free Heap Startup 58280 bytes
1970-01-01 00:00:00.086 [SYS:DEBU] ======= MFG ======
1970-01-01 00:00:00.092 [SYS:DEBU] SN                TBMH100868002061
1970-01-01 00:00:00.103 [SYS:DEBU] MTIME             2019-07-06 11:17:50
1970-01-01 00:00:00.105 [SYS:DEBU] PERSO_HASH        0xfcd3e0c8
1970-01-01 00:00:00.109 [SYS:DEBU] AP_PW             xxxxxxxxxxxxxxxxxx
1970-01-01 00:00:00.114 [SYS:DEBU] AP MAC            58:A0:CB:80:0C:10
1970-01-01 00:00:00.121 [SYS:DEBU] EUI               58-A0-CB-FF-FE-80-0C-10
1970-01-01 00:00:00.127 [SYS:DEBU] STA MAC           2C:F4:32:50:C6:61
1970-01-01 00:00:00.134 [SYS:DEBU] ======= CRD ======
1970-01-01 00:00:00.142 [SYS:DEBU] [cups] auth=3 -> https://rjs.sm.tc:9191
1970-01-01 00:00:00.145 [SYS:DEBU]   type=0  -> /s2/cups.trust
1970-01-01 00:00:00.151 [SYS:DEBU]   type=2  -> /s2/cups.key
1970-01-01 00:00:00.163 [SYS:DEBU] [cups-bak] - not available
1970-01-01 00:00:00.168 [SYS:DEBU] [cups-boot] auth=3 -> https://rjs.sm.tc:9191
1970-01-01 00:00:00.170 [SYS:DEBU]   type=0  -> /s2/cups-boot.trust
1970-01-01 00:00:00.174 [SYS:DEBU]   type=2  -> /s2/cups-boot.key
1970-01-01 00:00:00.181 [SYS:DEBU] [tc] - not available
1970-01-01 00:00:00.186 [SYS:DEBU] [tc-bak] - not available
1970-01-01 00:00:00.191 [SYS:DEBU] [tc-boot] - not available
1970-01-01 00:00:00.196 [SYS:DEBU] ======= MEM ======
data  : 0x3ffe8000 ~ 0x3ffe8d40, len: 3392
rodata: 0x3ffe8d40 ~ 0x3ffe8fd0, len: 656
bss   : 0x3ffe8fd0 ~ 0x3fff00a0, len: 28880
heap  : 0x3fff00a0 ~ 0x40000000, len: 65376
1970-01-01 00:00:00.223 [SYS:DEBU] ==================
1970-01-01 00:00:00.232 [SYS:DEBU] Start WiFi Scan
1970-01-01 00:00:01.225 [SYS:DEBU]   Free Heap: 57720 (min=56816) wifi=0 mh=1 cups=0 tc=0
scandone
1970-01-01 00:00:02.655 [SYS:DEBU] mh_scanDoneCB: status=0
1970-01-01 00:00:02.657 [SYS:DEBU]                SSID |   CH @ RSSI   |  auth  | b/g/n | wps
1970-01-01 00:00:02.659 [SYS:DEBU]  H0401 - Studio de Paris | ch-01@-87 dBm | auth=3 | 1/1/1 | 1
1970-01-01 00:00:02.667 [SYS:DEBU]  Pretty fly for a WiFi | ch-01@-93 dBm | auth=3 | 1/1/1 | 1
1970-01-01 00:00:02.675 [SYS:DEBU]         Omni_3E32B8 | ch-06@-93 dBm | auth=4 | 1/1/1 | 0
1970-01-01 00:00:02.683 [SYS:DEBU]          Zyxel_1F18 | ch-11@-65 dBm | auth=3 | 1/1/1 | 1
1970-01-01 00:00:03.236 [SYS:DEBU] WiFi connecting to 'Zyxel_1F18'
1970-01-01 00:00:03.238 [SYS:INFO] DHCP is not started. Starting it...
scandone
state: 0 -> 2 (b0)
state: 2 -> 3 (0)
state: 3 -> 5 (10)
add 0
aid 15
pm open phy_2,type:2 0 0
cnt

connected with Zyxel_1F18, channel 11
dhcp client start...
1970-01-01 00:00:06.227 [SYS:DEBU]   Free Heap: 56912 (min=55416) wifi=1 mh=3 cups=0 tc=0
ip:192.168.80.142,mask:255.255.255.0,gw:192.168.80.1
1970-01-01 00:00:09.250 [CUP:INFO] Stopping TC in favor of CUPS
1970-01-01 00:00:09.252 [CUP:INFO] Starting a CUPS session in 0 seconds.
1970-01-01 00:00:09.262 [CUP:INFO] Starting a CUPS session now.
1970-01-01 00:00:09.266 [CUP:INFO] Connecting to CUPS ... https://rjs.sm.tc:9191 (try #1)
1970-01-01 00:00:09.278 [any:INFO] /s2/cups.trust:
cert. version     : 1
serial number     : 01
issuer name       : CN=Root CA, OU=TrackCentral (ez5Cj0eN), O=TrackNet.io, C=CH
subject name      : CN=Root CA, OU=TrackCentral (ez5Cj0eN), O=TrackNet.io, C=CH
issued  on        : 2018-11-22 10:23:38
expires on        : 2024-11-20 10:23:38
signed using      : ECDSA with SHA256
EC key size       : 256 bits
1970-01-01 00:00:09.305 [AIO:INFO] cups has no cert configured - running server auth and client auth with token
1970-01-01 00:00:27.686 [AIO:ERRO] [2] HTTP connect failed: UNKNOWN ERROR CODE (0044)
1970-01-01 00:00:27.689 [AIO:DEBU] [2] HTTP connection shutdown...
1970-01-01 00:00:27.701 [CUP:ERRO] CUPS connect failed - URI: https://rjs.sm.tc:9191
1970-01-01 00:00:27.703 [SYS:INFO] sys_inState - Ignoring state transition: 5
1970-01-01 00:00:27.706 [SYS:DEBU]   Free Heap: 57040 (min=38176) wifi=5 mh=7 cups=-1 tc=0
1970-01-01 00:00:27.713 [CUP:INFO] Interaction with CUPS failed - retrying in 1m
1970-01-01 00:00:27.720 [TCE:INFO] Starting TC engine
1970-01-01 00:00:27.726 [TCE:ERRO] No TC URI configured
1970-01-01 00:00:27.737 [TCE:INFO] Router rejected or retry limit reached. Invoking CUPS.
1970-01-01 00:00:27.740 [TCE:INFO] Terminating TC engine
1970-01-01 00:00:27.743 [CUP:INFO] Stopping TC in favor of CUPS
1970-01-01 00:00:27.748 [CUP:INFO] Starting a CUPS session in 60 seconds.
1970-01-01 00:00:32.713 [SYS:DEBU]   Free Heap: 51712 (min=38176) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:00:37.716 [SYS:DEBU]   Free Heap: 51712 (min=38176) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:00:42.719 [SYS:DEBU]   Free Heap: 51712 (min=38176) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:00:47.721 [SYS:DEBU]   Free Heap: 51712 (min=38176) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:00:52.724 [SYS:DEBU]   Free Heap: 51712 (min=38176) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:00:57.727 [SYS:DEBU]   Free Heap: 51712 (min=38176) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:01:02.729 [SYS:DEBU]   Free Heap: 51712 (min=38176) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:01:07.732 [SYS:DEBU]   Free Heap: 51712 (min=38176) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:01:12.737 [SYS:DEBU]   Free Heap: 51712 (min=38176) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:01:17.739 [SYS:DEBU]   Free Heap: 51712 (min=38176) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:01:22.742 [SYS:DEBU]   Free Heap: 51712 (min=38176) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:01:27.745 [SYS:DEBU]   Free Heap: 51712 (min=38176) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:01:27.762 [CUP:INFO] Starting a CUPS session now.
1970-01-01 00:01:27.766 [CUP:INFO] Connecting to CUPS ... https://rjs.sm.tc:9191 (try #2)
1970-01-01 00:01:27.778 [any:INFO] /s2/cups.trust:
cert. version     : 1
serial number     : 01
issuer name       : CN=Root CA, OU=TrackCentral (ez5Cj0eN), O=TrackNet.io, C=CH
subject name      : CN=Root CA, OU=TrackCentral (ez5Cj0eN), O=TrackNet.io, C=CH
issued  on        : 2018-11-22 10:23:38
expires on        : 2024-11-20 10:23:38
signed using      : ECDSA with SHA256
EC key size       : 256 bits
1970-01-01 00:01:27.805 [AIO:INFO] cups has no cert configured - running server auth and client auth with token
1970-01-01 00:01:46.386 [AIO:ERRO] [2] HTTP connect failed: UNKNOWN ERROR CODE (0044)
1970-01-01 00:01:46.388 [AIO:DEBU] [2] HTTP connection shutdown...
1970-01-01 00:01:46.397 [CUP:ERRO] CUPS connect failed - URI: https://rjs.sm.tc:9191
1970-01-01 00:01:46.399 [SYS:INFO] sys_inState - Ignoring state transition: 5
1970-01-01 00:01:46.404 [SYS:DEBU]   Free Heap: 56848 (min=38024) wifi=5 mh=7 cups=-1 tc=-2
1970-01-01 00:01:46.412 [CUP:INFO] Interaction with CUPS failed - retrying in 1m
1970-01-01 00:01:46.419 [TCE:INFO] Starting TC engine
1970-01-01 00:01:46.424 [TCE:ERRO] No TC URI configured
1970-01-01 00:01:46.437 [TCE:INFO] Router rejected or retry limit reached. Invoking CUPS.
1970-01-01 00:01:46.439 [TCE:INFO] Terminating TC engine
1970-01-01 00:01:46.441 [CUP:INFO] Stopping TC in favor of CUPS
1970-01-01 00:01:46.447 [CUP:INFO] Starting a CUPS session in 60 seconds.
1970-01-01 00:01:51.412 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:01:56.414 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:02:01.417 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:02:06.420 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:02:11.423 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:02:16.425 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:02:21.428 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:02:26.431 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:02:31.434 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:02:36.436 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:02:41.439 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:02:46.441 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:02:46.461 [CUP:INFO] Starting a CUPS session now.
1970-01-01 00:02:46.465 [CUP:INFO] Connecting to CUPS ... https://rjs.sm.tc:9191 (try #3)
1970-01-01 00:02:46.477 [any:INFO] /s2/cups.trust:
cert. version     : 1
serial number     : 01
issuer name       : CN=Root CA, OU=TrackCentral (ez5Cj0eN), O=TrackNet.io, C=CH
subject name      : CN=Root CA, OU=TrackCentral (ez5Cj0eN), O=TrackNet.io, C=CH
issued  on        : 2018-11-22 10:23:38
expires on        : 2024-11-20 10:23:38
signed using      : ECDSA with SHA256
EC key size       : 256 bits
1970-01-01 00:02:46.504 [AIO:INFO] cups has no cert configured - running server auth and client auth with token
1970-01-01 00:03:05.146 [AIO:ERRO] [2] HTTP connect failed: UNKNOWN ERROR CODE (0044)
1970-01-01 00:03:05.148 [AIO:DEBU] [2] HTTP connection shutdown...
1970-01-01 00:03:05.157 [CUP:ERRO] CUPS connect failed - URI: https://rjs.sm.tc:9191
1970-01-01 00:03:05.159 [SYS:INFO] sys_inState - Ignoring state transition: 5
1970-01-01 00:03:05.164 [SYS:DEBU]   Free Heap: 56848 (min=38024) wifi=5 mh=7 cups=-1 tc=-2
1970-01-01 00:03:05.173 [CUP:INFO] Interaction with CUPS failed - retrying in 1m
1970-01-01 00:03:05.179 [TCE:INFO] Starting TC engine
1970-01-01 00:03:05.185 [TCE:ERRO] No TC URI configured
1970-01-01 00:03:05.196 [TCE:INFO] Router rejected or retry limit reached. Invoking CUPS.
1970-01-01 00:03:05.198 [TCE:INFO] Terminating TC engine
1970-01-01 00:03:05.201 [CUP:INFO] Stopping TC in favor of CUPS
1970-01-01 00:03:05.207 [CUP:INFO] Starting a CUPS session in 60 seconds.
1970-01-01 00:03:10.173 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:03:15.176 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:03:20.179 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:03:25.182 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:03:30.184 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:03:35.187 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:03:40.190 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:03:45.194 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:03:50.197 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:03:55.199 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:04:00.202 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:04:05.205 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:04:05.222 [CUP:INFO] Starting a CUPS session now.
1970-01-01 00:04:05.226 [CUP:INFO] Connecting to CUPS ... https://rjs.sm.tc:9191 (try #4)
1970-01-01 00:04:05.238 [any:INFO] /s2/cups.trust:
cert. version     : 1
serial number     : 01
issuer name       : CN=Root CA, OU=TrackCentral (ez5Cj0eN), O=TrackNet.io, C=CH
subject name      : CN=Root CA, OU=TrackCentral (ez5Cj0eN), O=TrackNet.io, C=CH
issued  on        : 2018-11-22 10:23:38
expires on        : 2024-11-20 10:23:38
signed using      : ECDSA with SHA256
EC key size       : 256 bits
1970-01-01 00:04:05.265 [AIO:INFO] cups has no cert configured - running server auth and client auth with token
1970-01-01 00:04:23.906 [AIO:ERRO] [2] HTTP connect failed: UNKNOWN ERROR CODE (0044)
1970-01-01 00:04:23.909 [AIO:DEBU] [2] HTTP connection shutdown...
1970-01-01 00:04:23.920 [CUP:ERRO] CUPS connect failed - URI: https://rjs.sm.tc:9191
1970-01-01 00:04:23.922 [SYS:INFO] sys_inState - Ignoring state transition: 5
1970-01-01 00:04:23.925 [SYS:DEBU]   Free Heap: 56848 (min=38024) wifi=5 mh=7 cups=-1 tc=-2
1970-01-01 00:04:23.932 [CUP:INFO] Interaction with CUPS failed - retrying in 1m
1970-01-01 00:04:23.939 [TCE:INFO] Starting TC engine
1970-01-01 00:04:23.945 [TCE:ERRO] No TC URI configured
1970-01-01 00:04:23.957 [TCE:INFO] Router rejected or retry limit reached. Invoking CUPS.
1970-01-01 00:04:23.959 [TCE:INFO] Terminating TC engine
1970-01-01 00:04:23.962 [CUP:INFO] Stopping TC in favor of CUPS
1970-01-01 00:04:23.968 [CUP:INFO] Starting a CUPS session in 60 seconds.
1970-01-01 00:04:28.932 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:04:33.935 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:04:38.938 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:04:43.941 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:04:48.944 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:04:53.946 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:04:58.949 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:05:03.952 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:05:08.954 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:05:13.957 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:05:18.960 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:05:23.963 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:05:23.982 [CUP:INFO] Starting a CUPS session now.
1970-01-01 00:05:23.985 [CUP:INFO] Connecting to CUPS ... https://rjs.sm.tc:9191 (try #5)
1970-01-01 00:05:23.997 [any:INFO] /s2/cups.trust:
cert. version     : 1
serial number     : 01
issuer name       : CN=Root CA, OU=TrackCentral (ez5Cj0eN), O=TrackNet.io, C=CH
subject name      : CN=Root CA, OU=TrackCentral (ez5Cj0eN), O=TrackNet.io, C=CH
issued  on        : 2018-11-22 10:23:38
expires on        : 2024-11-20 10:23:38
signed using      : ECDSA with SHA256
EC key size       : 256 bits
1970-01-01 00:05:24.025 [AIO:INFO] cups has no cert configured - running server auth and client auth with token
1970-01-01 00:05:42.636 [AIO:ERRO] [2] HTTP connect failed: UNKNOWN ERROR CODE (0044)
1970-01-01 00:05:42.638 [AIO:DEBU] [2] HTTP connection shutdown...
1970-01-01 00:05:42.647 [CUP:ERRO] CUPS connect failed - URI: https://rjs.sm.tc:9191
1970-01-01 00:05:42.649 [SYS:INFO] sys_inState - Ignoring state transition: 5
1970-01-01 00:05:42.654 [SYS:DEBU]   Free Heap: 56848 (min=38024) wifi=5 mh=7 cups=-1 tc=-2
1970-01-01 00:05:42.662 [CUP:INFO] Interaction with CUPS failed - retrying in 1m
1970-01-01 00:05:42.669 [TCE:INFO] Starting TC engine
1970-01-01 00:05:42.674 [TCE:ERRO] No TC URI configured
1970-01-01 00:05:42.686 [TCE:INFO] Router rejected or retry limit reached. Invoking CUPS.
1970-01-01 00:05:42.688 [TCE:INFO] Terminating TC engine
1970-01-01 00:05:42.691 [CUP:INFO] Stopping TC in favor of CUPS
1970-01-01 00:05:42.697 [CUP:INFO] Starting a CUPS session in 60 seconds.
1970-01-01 00:05:47.662 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:05:52.664 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:05:57.667 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:06:02.670 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:06:07.672 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:06:12.675 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:06:17.678 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:06:22.681 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:06:27.684 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:06:32.686 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:06:37.689 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:06:42.692 [SYS:DEBU]   Free Heap: 51712 (min=38024) wifi=5 mh=7 cups=0 tc=-2
1970-01-01 00:06:42.711 [CUP:INFO] Starting a CUPS session now.
1970-01-01 00:06:42.715 [CUP:INFO] Connecting to CUPS ... https://rjs.sm.tc:9191 (try #6)
1970-01-01 00:06:42.727 [any:INFO] /s2/cups.trust:
cert. version     : 1
serial number     : 01
issuer name       : CN=Root CA, OU=TrackCentral (ez5Cj0eN), O=TrackNet.io, C=CH
subject name      : CN=Root CA, OU=TrackCentral (ez5Cj0eN), O=TrackNet.io, C=CH
issued  on        : 2018-11-22 10:23:38
expires on        : 2024-11-20 10:23:38
signed using      : ECDSA with SHA256
EC key size       : 256 bits

Jeff-UK · January 9, 2024, 3:51pm

Did not work in what way - did you see an error message in the console? Perhaps relating to GW ID already having been used or similar?

What does TTN tell you has happened/is happening?

descartes · January 9, 2024, 4:18pm

You’ve done the home work, gathered the data, formatted the logs, just the stuff every tech forum asks for, so no need to be scared. It’s those that post one liners that lead to 20 questions that they answer tangentially or not at all that end up with the volunteers getting frustrated.

BTW, most of us don’t crack open our TTIGs so the log is a bit of niche knowledge!

It appears that the date & time aren’t getting updated on the TTIG which means the security certificates will be invalid. Forum search (for the win) indicates this is a situation that has occurred in that past with some routers. Can you try the TTIG with another router or tether to your mobile to get it online & allow any firmware updates. If that shows it working, we can then figure out if the Zyxel is the issue.

[Note to self, crack open TTIG, put on UART, enjoy the datas!]

semiha · January 9, 2024, 4:36pm

Which firmware version does your TTIGs have? Did you checked it?

joe_4 · January 9, 2024, 5:09pm

In the Console, all seems ok, it just say “Disconnected”.

joe_4 · January 9, 2024, 5:10pm

The good TTIG lives on the same router, and both of them has worked for a long time.
I swapped the radio module between the good and the bad one, and the radio hw is ok.
Is seemes to me that something has heppend to the config system.
In the start of the log, I see the bad one try to connect to “https://rjs.sm.tc:9191”.
And it goes i a loop and try doing something to “https://rjs.sm.tc:9191”.
The good one do the same to “https://eu1.cloud.thethings.network:443”, and it gets what it want.
But I see no way or tools I can use to change this behavier for the “bad one”.
And ofcorse I do not deear to reset the good one, who knows what wil happen, I guess this will also start connecting “https://rjs.sm.tc:9191” to get certicicat or other configurations.
Here is how the good one start up:

�lr�mode : sta(2c:f4:32:50:c6:79)
add if0
1970-01-01 00:00:02.148 [SYS:INFO] FSCK found section marker A0
1970-01-01 00:00:02.188 [SYS:INFO] FSCK section A: 503 records, 34620 bytes used, 989380 bytes free
1970-01-01 00:00:02.670 [SYS:INFO] FSCK section A followed by erased flash - all clear.
1970-01-01 00:00:02.770 [SYS:INFO] Checking file: [   cups-boot.uri ] OK
1970-01-01 00:00:02.825 [SYS:INFO] Checking file: [   cups-boot.key ] OK
1970-01-01 00:00:02.881 [SYS:INFO] Checking file: [ cups-boot.trust ] OK
1970-01-01 00:00:02.936 [SYS:INFO] Checking file: [       sig-0.key ] OK
1970-01-01 00:00:02.992 [SYS:INFO] Checking file: [    station.conf ] OK
1970-01-01 00:00:03.051 [SYS:INFO] Checking file: [  web/index.html ] OK
1970-01-01 00:00:03.126 [any:INFO] HW pipe bound with fd=0
1970-01-01 00:00:03.128 [any:INFO] AIO registered for HW pipe &aio=0x3ffeea98


1970-01-01 00:00:00.007 [SYS:DEBU] ======= VER ======
1970-01-01 00:00:00.008 [SYS:DEBU] Station Version   2.0.4(minihub/debug)
1970-01-01 00:00:00.010 [SYS:DEBU] Version Commit    f63908e
1970-01-01 00:00:00.014 [SYS:DEBU] Station Build     2020-05-07 16:03:53
1970-01-01 00:00:00.020 [SYS:DEBU] Firmware Version  2.0.4
1970-01-01 00:00:00.025 [SYS:DEBU] FW Flavor ID      semtech0
1970-01-01 00:00:00.036 [SYS:DEBU] Model             minihub
1970-01-01 00:00:00.038 [SYS:DEBU] ======= SYS ======
1970-01-01 00:00:00.041 [SYS:DEBU] CPU Freq          80 / 80000000 / 80000000
1970-01-01 00:00:00.048 [SYS:DEBU] Random Number     1772019188
1970-01-01 00:00:00.053 [SYS:DEBU] Reset cause       0
1970-01-01 00:00:00.058 [SYS:DEBU] Booting USER_BIN  1
1970-01-01 00:00:00.063 [SYS:DEBU] FW start addr     0x00001000
1970-01-01 00:00:00.069 [SYS:DEBU] ESP SDK version   2.0-dev(9ec59b5)
1970-01-01 00:00:00.075 [SYS:DEBU] mbedTLS version   2.6.1
1970-01-01 00:00:00.080 [SYS:DEBU] Free Heap Startup 58280 bytes
1970-01-01 00:00:00.086 [SYS:DEBU] ======= MFG ======
1970-01-01 00:00:00.097 [SYS:DEBU] SN                TBMH100868002075
1970-01-01 00:00:00.099 [SYS:DEBU] MTIME             2019-07-07 00:35:20
1970-01-01 00:00:00.103 [SYS:DEBU] PERSO_HASH        0xfcd3e0c8
1970-01-01 00:00:00.109 [SYS:DEBU] AP_PW             xxxxxxxxxxxxxxxxxxxxxxxx
1970-01-01 00:00:00.114 [SYS:DEBU] AP MAC            58:A0:CB:80:0C:1E
1970-01-01 00:00:00.121 [SYS:DEBU] EUI               58-A0-CB-FF-FE-80-0C-1E
1970-01-01 00:00:00.127 [SYS:DEBU] STA MAC           2C:F4:32:50:C6:79
1970-01-01 00:00:00.134 [SYS:DEBU] ======= CRD ======
1970-01-01 00:00:00.229 [SYS:DEBU] [cups] auth=3 -> https://eu1.cloud.thethings.network:443
1970-01-01 00:00:00.232 [SYS:DEBU]   type=0  -> /s2/cups.trust
1970-01-01 00:00:00.233 [SYS:DEBU]   type=2  -> /s2/cups.key
1970-01-01 00:00:00.326 [SYS:DEBU] [cups-bak] auth=3 -> https://mh.sm.tc:7007
1970-01-01 00:00:00.328 [SYS:DEBU]   type=0  -> /s2/cups-bak.trust
1970-01-01 00:00:00.337 [SYS:DEBU]   type=2  -> /s2/cups-bak.key
1970-01-01 00:00:00.425 [SYS:DEBU] [cups-boot] auth=3 -> https://rjs.sm.tc:9191
1970-01-01 00:00:00.427 [SYS:DEBU]   type=0  -> /s2/cups-boot.trust
1970-01-01 00:00:00.429 [SYS:DEBU]   type=2  -> /s2/cups-boot.key
1970-01-01 00:00:00.488 [SYS:DEBU] [tc] auth=3 -> wss://eu1.cloud.thethings.network:8887
1970-01-01 00:00:00.490 [SYS:DEBU]   type=0  -> /s2/tc.trust
1970-01-01 00:00:00.492 [SYS:DEBU]   type=2  -> /s2/tc.key
1970-01-01 00:00:00.591 [SYS:DEBU] [tc-bak] auth=3 -> wss://lns.eu.thethings.network:443
1970-01-01 00:00:00.593 [SYS:DEBU]   type=0  -> /s2/tc-bak.trust
1970-01-01 00:00:00.595 [SYS:DEBU]   type=2  -> /s2/tc-bak.key
1970-01-01 00:00:00.614 [SYS:DEBU] [tc-boot] - not available
1970-01-01 00:00:00.615 [SYS:DEBU] ======= MEM ======
data  : 0x3ffe8000 ~ 0x3ffe8d40, len: 3392
rodata: 0x3ffe8d40 ~ 0x3ffe8fd0, len: 656
bss   : 0x3ffe8fd0 ~ 0x3fff00a0, len: 28880
heap  : 0x3fff00a0 ~ 0x40000000, len: 65376
1970-01-01 00:00:00.636 [SYS:DEBU] ==================
1970-01-01 00:00:00.645 [SYS:DEBU] Start WiFi Scan
1970-01-01 00:00:01.637 [SYS:DEBU]   Free Heap: 57624 (min=56816) wifi=0 mh=1 cups=0 tc=0
scandone
1970-01-01 00:00:03.110 [SYS:DEBU] mh_scanDoneCB: status=0
1970-01-01 00:00:03.111 [SYS:DEBU]                SSID |   CH @ RSSI   |  auth  | b/g/n | wps
1970-01-01 00:00:03.114 [SYS:DEBU]  H0401 - Studio de Paris | ch-01@-87 dBm | auth=3 | 1/1/1 | 1
1970-01-01 00:00:03.121 [SYS:DEBU]      Telenor8514obo | ch-01@-94 dBm | auth=3 | 1/1/1 | 1
1970-01-01 00:00:03.129 [SYS:DEBU]     WillYouBeMyWifi | ch-01@-91 dBm | auth=3 | 1/1/1 | 1
1970-01-01 00:00:03.137 [SYS:DEBU]     WillYouBeMyWifi | ch-06@-89 dBm | auth=3 | 1/1/1 | 1
1970-01-01 00:00:03.145 [SYS:DEBU]          Zyxel_1F18 | ch-11@-63 dBm | auth=3 | 1/1/1 | 1
1970-01-01 00:00:03.689 [SYS:DEBU] WiFi connecting to 'Zyxel_1F18'
1970-01-01 00:00:03.691 [SYS:INFO] DHCP is not started. Starting it...
scandone
state: 0 -> 2 (b0)
state: 2 -> 3 (0)
state: 3 -> 5 (10)
add 0
aid 25
pm open phy_2,type:2 0 0
cnt

connected with Zyxel_1F18, channel 11
dhcp client start...
1970-01-01 00:00:06.640 [SYS:DEBU]   Free Heap: 56920 (min=55424) wifi=1 mh=3 cups=0 tc=0
ip:192.168.80.142,mask:255.255.255.0,gw:192.168.80.1
1970-01-01 00:00:09.703 [CUP:INFO] Stopping TC in favor of CUPS
1970-01-01 00:00:09.705 [CUP:INFO] Starting a CUPS session in 0 seconds.
1970-01-01 00:00:09.715 [CUP:INFO] Starting a CUPS session now.
1970-01-01 00:00:09.745 [CUP:INFO] Connecting to CUPS ... https://eu1.cloud.thethings.network:443 (try #1)
1970-01-01 00:00:09.846 [any:INFO] /s2/cups.trust:
cert. version     : 3
serial number     : 82:10:CF:B0:D2:40:E3:59:44:63:E0:BB:63:82:8B:00
issuer name       : C=US, O=Internet Security Research Group, CN=ISRG Root X1
subject name      : C=US, O=Internet Security Research Group, CN=ISRG Root X1
issued  on        : 2015-06-04 11:04:38
expires on        : 2035-06-04 11:04:38
signed using      : RSA with SHA-256
RSA key size      : 4096 bits
basic constraints : CA=true
key usage         : Key Cert Sign, CRL1970-01-01 00:00:09.924 [AIO:INFO] cups has no cert configured - running server auth and cn
1970-01-01 00:00:11.273 [CUP:VERB] Retrieving update-info from CUPS https://eu1.cloud.thethings.network:443...
1970-01-01 00:00:11.643 [SYS:DEBU]   Free Heap: 35672 (min=35552) wifi=5 mh=7 cups=1 tc=0
1970-01-01 00:00:13.470 [AIO:DEBU] [2] HTTP connection shutdown...
1970-01-01 00:00:13.483 [SYS:INFO] sys_inState - Ignoring state transition: 5
1970-01-01 00:00:13.486 [CUP:INFO] Interaction with CUPS done (no updates) - next regular check in 1d
1970-01-01 00:00:13.489 [TCE:INFO] Starting TC engine
1970-01-01 00:00:13.590 [any:INFO] /s2/tc.trust:
cert. version     : 3
serial number     : 82:10:CF:B0:D2:40:E3:59:44:63:E0:BB:63:82:8B:00
issuer name       : C=US, O=Internet Security Research Group, CN=ISRG Root X1
subject name      : C=US, O=Internet Security Research Group, CN=ISRG Root X1
issued  on        : 2015-06-04 11:04:38
expires on        : 2035-06-04 11:04:38
signed using      : RSA with SHA-256
RSA key size      : 4096 bits
basic constraints : CA=true
key usage         : Key Cert Sign, CRL S1970-01-01 00:00:13.664 [AIO:INFO] tc has no cert configured - running server auth and cn
1970-01-01 00:00:13.723 [TCE:INFO] Connecting to INFOS: wss://eu1.cloud.thethings.network:8887
1970-01-01 00:00:15.534 [TCE:INFO] Infos: 58a0:cbff:fe80:c1e muxs-::0 wss://eu1.cloud.thethings.network:8887/traffic/eui-58A0CBFE
1970-01-01 00:00:15.538 [AIO:DEBU] [2] ws_close reason=1000
1970-01-01 00:00:15.542 [AIO:DEBU] ssl_tls.c:3739 MBEDTLS[1]: mbedtls_ssl_read_record_layer() returned -30848 (-0x7880)
1970-01-01 00:00:15.551 [AIO:DEBU] ssl_tls.c:6842 MBEDTLS[1]: mbedtls_ssl_read_record() returned -30848 (-0x7880)
1970-01-01 00:00:15.561 [AIO:ERRO] Recv failed: SSL - The peer notified us that the connection is going to be closed
1970-01-01 00:00:15.571 [AIO:DEBU] [2] WS connection shutdown...
1970-01-01 00:00:15.683 [any:INFO] /s2/tc.trust:
cert. version     : 3
serial number     : 82:10:CF:B0:D2:40:E3:59:44:63:E0:BB:63:82:8B:00
issuer name       : C=US, O=Internet Security Research Group, CN=ISRG Root X1
subject name      : C=US, O=Internet Security Research Group, CN=ISRG Root X1
issued  on        : 2015-06-04 11:04:38
expires on        : 2035-06-04 11:04:38
signed using      : RSA with SHA-256
RSA key size      : 4096 bits
basic constraints : CA=true
key usage         : Key Cert Sign, CRL S1970-01-01 00:00:15.768 [AIO:INFO] tc has no cert configured - running server auth and cn
1970-01-01 00:00:15.828 [TCE:VERB] Connecting to MUXS...
1970-01-01 00:00:17.415 [SYS:DEBU]   Free Heap: 23880 (min=18120) wifi=5 mh=7 cups=8 tc=3
1970-01-01 00:00:17.573 [TCE:VERB] Connected to MUXS.
2024-01-09 10:25:29.840 [RAL:INFO] Lora gateway library version: Version: 5.0.1;
2024-01-09 10:25:29.842 [RAL:VERB] Connecting to device:
2024-01-09 10:25:29.844 [RAL:DEBU] SX130x txlut table (0 entries)
2024-01-09 10:25:29.847 [RAL:VERB] SX1301 rxrfchain 0: enable=1 freq=867.5MHz rssi_offset=-166.000000 type=2 tx_enable=1 tx_notc0
2024-01-09 10:25:29.859 [RAL:VERB] SX1301 rxrfchain 1: enable=1 freq=868.5MHz rssi_offset=-166.000000 type=2 tx_enable=0 tx_notc0
2024-01-09 10:25:29.871 [RAL:VERB] SX1301 ifchain  0: enable=1 rf_chain=1 freq=-400000 bandwidth=0 datarate=0 sync_word=0/0
2024-01-09 10:25:29.882 [RAL:VERB] SX1301 ifchain  1: enable=1 rf_chain=1 freq=-200000 bandwidth=0 datarate=0 sync_word=0/0
2024-01-09 10:25:29.893 [RAL:VERB] SX1301 ifchain  2: enable=1 rf_chain=1 freq=0 bandwidth=0 datarate=0 sync_word=0/0
2024-01-09 10:25:29.903 [RAL:VERB] SX1301 ifchain  3: enable=1 rf_chain=0 freq=-400000 bandwidth=0 datarate=0 sync_word=0/0
2024-01-09 10:25:29.914 [RAL:VERB] SX1301 ifchain  4: enable=1 rf_chain=0 freq=-200000 bandwidth=0 datarate=0 sync_word=0/0
2024-01-09 10:25:29.925 [RAL:VERB] SX1301 ifchain  5: enable=1 rf_chain=0 freq=0 bandwidth=0 datarate=0 sync_word=0/0
2024-01-09 10:25:29.935 [RAL:VERB] SX1301 ifchain  6: enable=1 rf_chain=0 freq=200000 bandwidth=0 datarate=0 sync_word=0/0
2024-01-09 10:25:29.948 [RAL:VERB] SX1301 ifchain  7: enable=1 rf_chain=0 freq=400000 bandwidth=0 datarate=0 sync_word=0/0
2024-01-09 10:25:29.957 [RAL:VERB] SX1301 ifchain  8: enable=1 rf_chain=1 freq=-200000 bandwidth=2 datarate=2 sync_word=0/0
2024-01-09 10:25:29.968 [RAL:VERB] SX1301 ifchain  9: enable=1 rf_chain=1 freq=300000 bandwidth=0 datarate=50000 sync_word=0/0
2024-01-09 10:25:29.979 [RAL:VERB] SX130x LBT not enabled
2024-01-09 10:25:29.984 [RAL:VERB] Station device:  (PPS capture disabled)
INFO: FPGA supported features: [TX filter]  [Spectral Scan]  [LBT]
2024-01-09 10:25:34.407 [RAL:VERB] Concentrator started (4s416ms)
2024-01-09 10:25:34.410 [S2E:INFO] Configuring for region: EU863 -- 863.0MHz..870.0MHz
2024-01-09 10:25:34.414 [S2E:VERB]   DR0  SF12/BW125
2024-01-09 10:25:34.416 [S2E:VERB]   DR1  SF11/BW125
2024-01-09 10:25:34.420 [S2E:VERB]   DR2  SF10/BW125
2024-01-09 10:25:34.425 [S2E:VERB]   DR3  SF9/BW125
2024-01-09 10:25:34.429 [S2E:VERB]   DR4  SF8/BW125
2024-01-09 10:25:34.434 [S2E:VERB]   DR5  SF7/BW125
2024-01-09 10:25:34.440 [S2E:VERB]   DR6  SF7/BW250
2024-01-09 10:25:34.443 [S2E:VERB]   DR7  FSK
2024-01-09 10:25:34.448 [S2E:VERB]   DR8  FSK
2024-01-09 10:25:34.452 [S2E:VERB]   DR9  FSK
2024-01-09 10:25:34.456 [S2E:VERB]   DR10 FSK
2024-01-09 10:25:34.460 [S2E:VERB]   DR11 FSK
2024-01-09 10:25:34.464 [S2E:VERB]   DR12 FSK
2024-01-09 10:25:34.468 [S2E:VERB]   DR13 FSK
2024-01-09 10:25:34.473 [S2E:VERB]   DR14 FSK
2024-01-09 10:25:34.477 [S2E:VERB]   DR15 FSK
2024-01-09 10:25:34.481 [S2E:VERB]   TX power: 16.0 dBm EIRP
2024-01-09 10:25:34.486 [S2E:VERB]             27.0 dBm EIRP for 869.4MHz..869.65MHz
2024-01-09 10:25:34.494 [S2E:VERB]   JoinEui list: 0 entries
2024-01-09 10:25:34.499 [S2E:VERB]   NetID filter: FFFFFFFF-FFFFFFFF-FFFFFFFF-FFFFFFFF
2024-01-09 10:25:34.508 [S2E:VERB]   Dev/test settings: nocca=1 nodc=1 nodwell=1
2024-01-09 10:25:34.514 [S2E:VERB] Beaconing every 2m8s on 869.525MHz(1) @ DR3 (frame layout 2/8/17)
2024-01-09 10:25:34.523 [S2E:INFO] Beaconing suspended for 10s - insufficient GPS data: time position
2024-01-09 10:25:34.564 [SYS:DEBU]   Free Heap: 19520 (min=17928) wifi=5 mh=7 cups=8 tc=4
2024-01-09 10:25:34.587 [S2E:VERB] RX 867.9MHz DR5 SF7/BW125 snr=-4.2 rssi=-117 xtime=0xDA0000003831D4 - updf mhdr=40 DevAddr=00)
2024-01-09 10:25:39.567 [SYS:DEBU]   Free Heap: 19160 (min=17336) wifi=5 mh=7 cups=8 tc=4
2024-01-09 10:25:43.346 [S2E:VERB] RX 868.1MHz DR5 SF7/BW125 snr=0.2 rssi=-113 xtime=0xDA000000BDB98B - updf mhdr=40 DevAddr=014)
2024-01-09 10:25:44.523 [S2E:INFO] Beaconing suspended for 10s - insufficient GPS data: time
2024-01-09 10:25:44.571 [SYS:DEBU]   Free Heap: 19160 (min=17336) wifi=5 mh=7 cups=8 tc=4
2024-01-09 10:25:47.688 [S2E:VERB] RX 867.9MHz DR5 SF7/BW125 snr=2.5 rssi=-113 xtime=0xDA000000FFF89C - updf mhdr=40 DevAddr=014)
2024-01-09 10:25:49.575 [SYS:DEBU]   Free Heap: 19160 (min=17336) wifi=5 mh=7 cups=8 tc=4
2024-01-09 10:25:51.793 [S2E:VERB] RX 868.1MHz DR5 SF7/BW125 snr=-1.0 rssi=-115 xtime=0xDA0000013EBFC3 - updf mhdr=40 DevAddr=00)
2024-01-09 10:25:54.523 [S2E:INFO] Beaconing suspended for 10s - insufficient GPS data: time
2024-01-09 10:25:54.578 [SYS:DEBU]   Free Heap: 19160 (min=17336) wifi=5 mh=7 cups=8 tc=4
2024-01-09 10:25:59.521 [S2E:VERB] RX 867.3MHz DR5 SF7/BW125 snr=-5.8 rssi=-114 xtime=0xDA000001B4969B - updf mhdr=40 DevAddr=00)
2024-01-09 10:25:59.582 [SYS:DEBU]   Free Heap: 17536 (min=17336) wifi=5 mh=7 cups=8 tc=4
2024-01-09 10:26:00.959 [S2E:VERB] RX 867.9MHz DR5 SF7/BW125 snr=5.2 rssi=-111 xtime=0xDA000001CAC664 - updf mhdr=40 DevAddr=01B)
2024-01-09 10:26:04.523 [S2E:INFO] Beaconing suspended for 10s - insufficient GPS data: time
2024-01-09 10:26:04.585 [SYS:DEBU]   Free Heap: 19160 (min=17336) wifi=5 mh=7 cups=8 tc=4
2024-01-09 10:26:09.589 [SYS:DEBU]   Free Heap: 19160 (min=17336) wifi=5 mh=7 cups=8 tc=4
2024-01-09 10:26:13.328 [S2E:VERB] RX 868.1MHz DR5 SF7/BW125 snr=-3.8 rssi=-116 xtime=0xDA000002878333 - updf mhdr=40 DevAddr=00)
2024-01-09 10:26:14.210 [S2E:VERB] RX 867.5MHz DR5 SF7/BW125 snr=-1.0 rssi=-113 xtime=0xDA00000294EC84 - updf mhdr=40 DevAddr=01)
2024-01-09 10:26:14.467 [SYN:INFO] MCU/SX130X drift stats: min: +0.5ppm  q50: +2.9ppm  q80: -47.6ppm  max: -197.9ppm - thresholdm
2024-01-09 10:26:14.473 [SYN:INFO] Mean MCU drift vs SX130X#0: -20.2ppm
2024-01-09 10:26:14.524 [S2E:INFO] Beaconing suspended for 10s - insufficient GPS data: time
2024-01-09 10:26:14.594 [SYS:DEBU]   Free Heap: 19160 (min=17336) wifi=5 mh=7 cups=8 tc=4
2024-01-09 10:26:17.789 [S2E:VERB] RX 867.5MHz DR5 SF7/BW125 snr=-2.5 rssi=-114 xtime=0xDA000002CB8F44 - updf mhdr=40 DevAddr=01)
2024-01-09 10:26:19.599 [SYS:DEBU]   Free Heap: 19160 (min=17336) wifi=5 mh=7 cups=8 tc=4
2024-01-09 10:26:19.967 [S2E:VERB] RX 867.5MHz DR5 SF7/BW125 snr=-0.2 rssi=-114 xtime=0xDA000002ECA264 - updf mhdr=40 DevAddr=00)
2024-01-09 10:26:20.068 [S2E:VERB] RX 868.1MHz DR5 SF7/BW125 snr=-1.2 rssi=-115 xtime=0xDA000002EE0BAB - updf mhdr=40 DevAddr=00)
2024-01-09 10:26:24.524 [S2E:INFO] Beaconing suspended for 10s - insufficient GPS data: time
2024-01-09 10:26:24.603 [SYS:DEBU]   Free Heap: 19160 (min=17336) wifi=5 mh=7 cups=8 tc=4
2024-01-09 10:26:29.606 [SYS:DEBU]   Free Heap: 19160 (min=17336) wifi=5 mh=7 cups=8 tc=4
2024-01-09 10:26:31.610 [S2E:VERB] RX 867.7MHz DR5 SF7/BW125 snr=-3.8 rssi=-117 xtime=0xDA0000039E31EC - updf mhdr=40 DevAddr=00)
2024-01-09 10:26:33.391 [SYN:INFO] Time sync qualities: min=1047 q90=1266 max=1881 (previous q90=2147483647)
2024-01-09 10:26:33.804 [S2E:VERB] RX 868.3MHz DR5 SF7/BW125 snr=4.5 rssi=-107 xtime=0xDA000003BFD5F3 - updf mhdr=40 DevAddr=003)
2024-01-09 10:26:34.524 [S2E:INFO] Beaconing suspended for 10s - insufficient GPS data: time
2024-01-09 10:26:34.581 [S2E:VERB] RX 867.5MHz DR5 SF7/BW125 snr=-6.8 rssi=-117 xtime=0xDA000003CBB4F4 - updf mhdr=40 DevAddr=00)
2024-01-09 10:26:34.610 [SYS:DEBU]   Free Heap: 17536 (min=17336) wifi=5 mh=7 cups=8 tc=4
2024-01-09 10:26:39.614 [SYS:DEBU]   Free Heap: 19160 (min=17336) wifi=5 mh=7 cups=8 tc=4
2024-01-09 10:26:43.347 [S2E:VERB] RX 867.5MHz DR5 SF7/BW125 snr=2.0 rssi=-113 xtime=0xDA000004513E94 - updf mhdr=40 DevAddr=014)
2024-01-09 10:26:44.525 [S2E:INFO] Beaconing suspended for 10s - insufficient GPS data: time
2024-01-09 10:26:44.618 [SYS:DEBU]   Free Heap: 19160 (min=17336) wifi=5 mh=7 cups=8 tc=4
2024-01-09 10:26:47.454 [S2E:VERB] RX 867.7MHz DR5 SF7/BW125 snr=4.2 rssi=-106 xtime=0xDA0000048FF684 - updf mhdr=40 DevAddr=014)
2024-01-09 10:26:49.621 [SYS:DEBU]   Free Heap: 19160 (min=17336) wifi=5 mh=7 cups=8 tc=4
2024-01-09 10:26:51.792 [S2E:VERB] RX 867.7MHz DR5 SF7/BW125 snr=0.5 rssi=-112 xtime=0xDA000004D2468C - updf mhdr=40 DevAddr=006)
2024-01-09 10:26:54.525 [S2E:INFO] Beaconing suspended for 10s - insufficient GPS data: time
2024-01-09 10:26:54.626 [SYS:DEBU]   Free Heap: 19160 (min=17336) wifi=5 mh=7 cups=8 tc=4
2024-01-09 10:26:55.387 [S2E:VERB] RX 868.3MHz DR1 SF11/BW125 snr=-13.2 rssi=-117 xtime=0xDA000005090BC4 - jreq MHdr=00 JoinEui=8
2024-01-09 10:26:56.509 [SYN:INFO] MCU/SX130X drift stats: min: -0.5ppm  q50: +2.4ppm  q80: +6.7ppm  max: +54.7ppm - threshold qm
2024-01-