Raspberry Pi rf24 mqtt gateway not working

[Jens Jensen]

Hi folks, I'm looking for help in troubleshooting why my raspberry pi gateway is not working (seems like not acking?).
I have tried different rpi (rpi1 b+ vs pi zero), different radio modules (all of them are chinese modules, but they all have marked nrf24l01+ chip on them, not cob etc). Tried using irq vs not. Modules have cap (10uF, 4.7uF, etc) on vcc to gnd at module. On pi i have tried powering module w/ separate 3.3v power supply, etc.
I have tried changing rf power levels, data rates, channels, etc, to no avail. I have tried 2.3.1 (master branch, vs development, etc), also even tried 2.3.0 tag.

The most important thing here is that all of this works when I use esp8266-mqtt-rf24 gateway (nodemcu) - the rpi gateways do not seem to work with rf24 mysensors for some reason.

See below for debug output examples (with rf24 debug on, from rpi gateway and sample node).

gateway:

./configure --my-transport=rf24 --my-gateway=mqtt --my-controller-ip-address=192.168.1.8 --my-mqtt-publish-topic-prefix=mysensors-out --my-mqtt-subscribe-topic-prefix=mysensors-in --my-mqtt-client-id=mygateway-pi --extra-cxxflags="-DMY_DEBUG_VERBOSE_RF24"


pi@pihome ~/build/MySensors $ sudo bin/mysgw 
Jan 20 12:48:06 INFO  Starting gateway...
Jan 20 12:48:06 INFO  Protocol version - 2.3.2-alpha
Jan 20 12:48:06 DEBUG MCO:BGN:INIT GW,CP=RNNGL---,REL=1,VER=2.3.2-alpha
Jan 20 12:48:06 DEBUG TSF:LRT:OK
Jan 20 12:48:06 DEBUG TSM:INIT
Jan 20 12:48:06 DEBUG TSF:WUR:MS=0
Jan 20 12:48:06 DEBUG RF24:INIT
Jan 20 12:48:06 DEBUG RF24:INIT:PIN,CE=22,CS=24
Jan 20 12:48:06 DEBUG RF24:SBY
Jan 20 12:48:06 DEBUG RF24:WBR:REG=0,VAL=14
Jan 20 12:48:06 DEBUG RF24:WBR:REG=3,VAL=3
Jan 20 12:48:06 DEBUG RF24:WBR:REG=4,VAL=95
Jan 20 12:48:06 DEBUG RF24:WBR:REG=5,VAL=76
Jan 20 12:48:06 DEBUG RF24:WBR:REG=6,VAL=37
Jan 20 12:48:06 DEBUG RF24:WBR:REG=29,VAL=4
Jan 20 12:48:06 DEBUG RF24:RBR:REG=29,VAL=4
Jan 20 12:48:06 DEBUG RF24:RBR:REG=6,VAL=37
Jan 20 12:48:06 DEBUG RF24:RBR:REG=5,VAL=76
Jan 20 12:48:06 DEBUG RF24:WBR:REG=2,VAL=2
Jan 20 12:48:06 DEBUG RF24:WBR:REG=1,VAL=0
Jan 20 12:48:06 DEBUG RF24:WBR:REG=28,VAL=3
Jan 20 12:48:06 DEBUG RF24:FRX
Jan 20 12:48:06 DEBUG RF24:FTX
Jan 20 12:48:06 DEBUG RF24:WBR:REG=7,VAL=112
Jan 20 12:48:06 DEBUG TSM:INIT:TSP OK
Jan 20 12:48:06 DEBUG TSM:INIT:GW MODE
Jan 20 12:48:06 DEBUG RF24:WBR:REG=2,VAL=3
Jan 20 12:48:06 DEBUG RF24:WBR:REG=1,VAL=1
Jan 20 12:48:06 DEBUG RF24:STL
Jan 20 12:48:06 DEBUG RF24:WBR:REG=0,VAL=15
Jan 20 12:48:06 DEBUG RF24:WBR:REG=10,VAL=0
Jan 20 12:48:06 DEBUG TSM:READY:ID=0,PAR=0,DIS=0
Jan 20 12:48:06 DEBUG MCO:REG:NOT NEEDED
Jan 20 12:48:06 DEBUG RF24:RBR:REG=23,VAL=17
Jan 20 12:48:06 DEBUG MCO:BGN:STP
Jan 20 12:48:06 DEBUG RF24:RBR:REG=6,VAL=37
Jan 20 12:48:06 DEBUG RF24:RBR:REG=5,VAL=76
Jan 20 12:48:06 DEBUG MCO:BGN:INIT OK,TSP=1
Jan 20 12:48:06 DEBUG GWT:RMQ:CONNECTING...
Jan 20 12:48:06 DEBUG connected to 192.168.1.8
Jan 20 12:48:06 DEBUG GWT:RMQ:OK
Jan 20 12:48:06 DEBUG GWT:TPS:TOPIC=mysensors-out/0/255/0/0/18,MSG SENT
Jan 20 12:48:06 DEBUG TSM:READY:NWD REQ
Jan 20 12:48:06 DEBUG RF24:SPL
Jan 20 12:48:06 DEBUG RF24:WBR:REG=0,VAL=14
Jan 20 12:48:06 DEBUG RF24:OWP:RCPT=255
Jan 20 12:48:06 DEBUG RF24:WBR:REG=10,VAL=255
Jan 20 12:48:06 DEBUG RF24:WBR:REG=16,VAL=255
Jan 20 12:48:06 DEBUG RF24:TXM:TO=255,LEN=7
Jan 20 12:48:06 DEBUG RF24:FTX
Jan 20 12:48:08 DEBUG RF24:WBR:REG=7,VAL=48
Jan 20 12:48:08 DEBUG RF24:STL
Jan 20 12:48:08 DEBUG RF24:WBR:REG=0,VAL=15
Jan 20 12:48:08 DEBUG RF24:WBR:REG=10,VAL=0
Jan 20 12:48:08 DEBUG TSF:MSG:SEND,0-0-255-255,s=255,c=3,t=20,pt=0,l=0,sg=0,ft=0,st=OK:
Jan 20 12:48:08 DEBUG RF24:RBR:REG=23,VAL=1
Jan 20 12:48:08 DEBUG RF24:RBR:REG=23,VAL=1
Jan 20 12:48:08 DEBUG RF24:RBR:REG=23,VAL=1
... snipped, idle waiting for uno node to start ...
Jan 20 12:48:24 DEBUG RF24:RBR:REG=23,VAL=1
Jan 20 12:48:24 DEBUG RF24:RBR:REG=23,VAL=1
Jan 20 12:48:24 DEBUG RF24:RBR:REG=23,VAL=1
Jan 20 12:48:24 DEBUG RF24:RBR:REG=23,VAL=0
Jan 20 12:48:24 DEBUG RF24:RXM:LEN=7
Jan 20 12:48:24 DEBUG RF24:WBR:REG=7,VAL=64
Jan 20 12:48:24 DEBUG TSF:MSG:READ,102-102-255,s=255,c=3,t=7,pt=0,l=0,sg=0:
Jan 20 12:48:24 DEBUG TSF:MSG:BC
Jan 20 12:48:24 DEBUG TSF:MSG:FPAR REQ,ID=102
Jan 20 12:48:24 DEBUG TSF:PNG:SEND,TO=0
Jan 20 12:48:24 DEBUG TSF:CKU:OK
Jan 20 12:48:24 DEBUG TSF:MSG:GWL OK
Jan 20 12:48:25 DEBUG RF24:SPL
Jan 20 12:48:25 DEBUG RF24:WBR:REG=0,VAL=14
Jan 20 12:48:25 DEBUG RF24:OWP:RCPT=102
Jan 20 12:48:25 DEBUG RF24:WBR:REG=10,VAL=102
Jan 20 12:48:25 DEBUG RF24:WBR:REG=16,VAL=102
Jan 20 12:48:25 DEBUG RF24:TXM:TO=102,LEN=8
Jan 20 12:48:25 DEBUG RF24:FTX
Jan 20 12:48:26 DEBUG RF24:WBR:REG=7,VAL=48
Jan 20 12:48:26 DEBUG RF24:STL
Jan 20 12:48:26 DEBUG RF24:WBR:REG=0,VAL=15
Jan 20 12:48:26 DEBUG RF24:WBR:REG=10,VAL=0
Jan 20 12:48:26 DEBUG !TSF:MSG:SEND,0-0-102-102,s=255,c=3,t=8,pt=1,l=1,sg=0,ft=0,st=NACK:0
Jan 20 12:48:26 DEBUG RF24:RBR:REG=23,VAL=1
Jan 20 12:48:26 DEBUG RF24:RBR:REG=23,VAL=1
Jan 20 12:48:26 DEBUG RF24:RBR:REG=23,VAL=1
... snipped repeating ...
Jan 20 12:48:27 DEBUG RF24:RBR:REG=23,VAL=1
Jan 20 12:48:27 DEBUG RF24:RBR:REG=23,VAL=1
Jan 20 12:48:27 DEBUG RF24:RBR:REG=23,VAL=1
Jan 20 12:48:27 DEBUG RF24:RBR:REG=23,VAL=0
Jan 20 12:48:27 DEBUG RF24:RXM:LEN=7
Jan 20 12:48:27 DEBUG RF24:WBR:REG=7,VAL=64
Jan 20 12:48:27 DEBUG TSF:MSG:READ,102-102-255,s=255,c=3,t=7,pt=0,l=0,sg=0:
Jan 20 12:48:27 DEBUG TSF:MSG:BC
Jan 20 12:48:27 DEBUG TSF:MSG:FPAR REQ,ID=102
Jan 20 12:48:27 DEBUG TSF:CKU:OK,FCTRL
Jan 20 12:48:27 DEBUG TSF:MSG:GWL OK
Jan 20 12:48:27 DEBUG RF24:SPL
Jan 20 12:48:27 DEBUG RF24:WBR:REG=0,VAL=14
Jan 20 12:48:27 DEBUG RF24:OWP:RCPT=102
Jan 20 12:48:27 DEBUG RF24:WBR:REG=10,VAL=102
Jan 20 12:48:27 DEBUG RF24:WBR:REG=16,VAL=102
Jan 20 12:48:27 DEBUG RF24:TXM:TO=102,LEN=8
Jan 20 12:48:27 DEBUG RF24:FTX
Jan 20 12:48:29 DEBUG RF24:WBR:REG=7,VAL=48
Jan 20 12:48:29 DEBUG RF24:STL
Jan 20 12:48:29 DEBUG RF24:WBR:REG=0,VAL=15
Jan 20 12:48:29 DEBUG RF24:WBR:REG=10,VAL=0
Jan 20 12:48:29 DEBUG !TSF:MSG:SEND,0-0-102-102,s=255,c=3,t=8,pt=1,l=1,sg=0,ft=0,st=NACK:0
Jan 20 12:48:29 DEBUG RF24:RBR:REG=23,VAL=1
Jan 20 12:48:29 DEBUG RF24:RBR:REG=23,VAL=1
Jan 20 12:48:29 DEBUG RF24:RBR:REG=23,VAL=1
... snipped repeating ...
Jan 20 12:48:29 DEBUG RF24:RBR:REG=23,VAL=1
Jan 20 12:48:29 DEBUG RF24:RBR:REG=23,VAL=1
Jan 20 12:48:29 DEBUG RF24:RBR:REG=23,VAL=1
Jan 20 12:48:29 DEBUG RF24:RBR:REG=23,VAL=0
Jan 20 12:48:29 DEBUG RF24:RXM:LEN=7
Jan 20 12:48:29 DEBUG RF24:WBR:REG=7,VAL=64
Jan 20 12:48:29 DEBUG TSF:MSG:READ,102-102-255,s=255,c=3,t=7,pt=0,l=0,sg=0:
Jan 20 12:48:29 DEBUG TSF:MSG:BC
Jan 20 12:48:29 DEBUG TSF:MSG:FPAR REQ,ID=102
Jan 20 12:48:29 DEBUG TSF:CKU:OK,FCTRL
Jan 20 12:48:29 DEBUG TSF:MSG:GWL OK
Jan 20 12:48:29 DEBUG RF24:SPL
Jan 20 12:48:29 DEBUG RF24:WBR:REG=0,VAL=14
Jan 20 12:48:29 DEBUG RF24:OWP:RCPT=102
Jan 20 12:48:29 DEBUG RF24:WBR:REG=10,VAL=102
Jan 20 12:48:29 DEBUG RF24:WBR:REG=16,VAL=102
Jan 20 12:48:29 DEBUG RF24:TXM:TO=102,LEN=8
Jan 20 12:48:29 DEBUG RF24:FTX
Jan 20 12:48:31 DEBUG RF24:WBR:REG=7,VAL=48
Jan 20 12:48:31 DEBUG RF24:STL
Jan 20 12:48:31 DEBUG RF24:WBR:REG=0,VAL=15
Jan 20 12:48:31 DEBUG RF24:WBR:REG=10,VAL=0
Jan 20 12:48:31 DEBUG !TSF:MSG:SEND,0-0-102-102,s=255,c=3,t=8,pt=1,l=1,sg=0,ft=0,st=NACK:0
Jan 20 12:48:31 DEBUG RF24:RBR:REG=23,VAL=1
Jan 20 12:48:31 DEBUG RF24:RBR:REG=23,VAL=1
Jan 20 12:48:31 DEBUG RF24:RBR:REG=23,VAL=1
... snipped, repeating while idle ...

MockMySensors sketch on arduino uno with door, armed sensor mocked

> Executing task in folder mysensors-uno-test1: platformio device monitor <

--- Miniterm on /dev/cu.wchusbserial14b30  9600,8,N,1 ---
--- Quit: Ctrl+C | Menu: Ctrl+T | Help: Ctrl+T followed by Ctrl+H ---

 __  __       ____
|  \/  |_   _/ ___|  ___ _ __  ___  ___  _ __ ___
| |\/| | | | \___ \ / _ \ `_ \/ __|/ _ \| `__/ __|
| |  | | |_| |___| |  __/ | | \__ \  _  | |  \__ \
|_|  |_|\__, |____/ \___|_| |_|___/\___/|_|  |___/
        |___/                      2.3.1

209 MCO:BGN:INIT NODE,CP=RNNNA---,REL=255,VER=2.3.1
331 TSM:INIT
345 TSF:WUR:MS=0
362 RF24:INIT
377 RF24:INIT:PIN,CE=9,CS=10
407 RF24:SBY
421 RF24:WBR:REG=0,VAL=14
453 RF24:WBR:REG=3,VAL=3
479 RF24:WBR:REG=4,VAL=95
506 RF24:WBR:REG=5,VAL=76
533 RF24:WBR:REG=6,VAL=37
561 RF24:WBR:REG=29,VAL=4
587 RF24:RBR:REG=29,VAL=4
615 RF24:RBR:REG=6,VAL=37
643 RF24:RBR:REG=5,VAL=76
669 RF24:WBR:REG=2,VAL=2
696 RF24:WBR:REG=1,VAL=0
721 RF24:WBR:REG=28,VAL=3
749 RF24:FRX
762 RF24:FTX
777 RF24:WBR:REG=7,VAL=112
804 TSM:INIT:TSP OK
826 TSM:INIT:STATID=102
850 RF24:WBR:REG=2,VAL=3
877 RF24:WBR:REG=1,VAL=1
903 RF24:STL
917 RF24:WBR:REG=0,VAL=15
944 RF24:WBR:REG=10,VAL=102
973 TSF:SID:OK,ID=102
996 TSM:FPAR
1010 RF24:SPL
1025 RF24:WBR:REG=0,VAL=14
1053 RF24:OWP:RCPT=255
1077 RF24:WBR:REG=10,VAL=255
1107 RF24:WBR:REG=16,VAL=255
1138 RF24:TXM:TO=255,LEN=7
1166 RF24:FTX
1216 RF24:WBR:REG=7,VAL=48
1244 !RF24:TXM:MAX_RT
1267 RF24:FTX
1282 RF24:STL
1296 RF24:WBR:REG=0,VAL=15
1325 RF24:WBR:REG=10,VAL=102
1355 TSF:MSG:SEND,102-102-255-255,s=255,c=3,t=7,pt=0,l=0,sg=0,ft=0,st=OK:
1432 RF24:RBR:REG=23,VAL=17
1462 RF24:RBR:REG=23,VAL=17
1490 RF24:RBR:REG=23,VAL=17
1520 RF24:RBR:REG=23,VAL=17
1550 RF24:RBR:REG=23,VAL=17
1579 RF24:RBR:REG=23,VAL=17
1608 RF24:RBR:REG=23,VAL=17
1638 RF24:RBR:REG=23,VAL=17
1667 RF24:RBR:REG=23,VAL=17
1696 RF24:RBR:REG=23,VAL=17
1726 RF24:RBR:REG=23,VAL=17
1755 RF24:RBR:REG=23,VAL=17
1784 RF24:RBR:REG=23,VAL=17
1814 RF24:RBR:REG=23,VAL=17
1843 RF24:RBR:REG=23,VAL=17
1872 RF24:RBR:REG=23,VAL=17
1902 RF24:RBR:REG=23,VAL=17
1931 RF24:RBR:REG=23,VAL=17
1960 RF24:RBR:REG=23,VAL=17
1990 RF24:RBR:REG=23,VAL=17
2019 RF24:RBR:REG=23,VAL=17
2049 RF24:RBR:REG=23,VAL=17
2077 RF24:RBR:REG=23,VAL=17
2107 RF24:RBR:REG=23,VAL=17
2137 RF24:RBR:REG=23,VAL=17
2165 RF24:RBR:REG=23,VAL=17
2195 RF24:RBR:REG=23,VAL=17
2225 RF24:RBR:REG=23,VAL=17
2253 RF24:RBR:REG=23,VAL=17
2283 RF24:RBR:REG=23,VAL=17
2313 RF24:RBR:REG=23,VAL=17
2341 RF24:RBR:REG=23,VAL=17
2371 RF24:RBR:REG=23,VAL=17
2401 RF24:RBR:REG=23,VAL=17
2429 RF24:RBR:REG=23,VAL=17
2459 RF24:RBR:REG=23,VAL=17
2489 RF24:RBR:REG=23,VAL=17
2518 RF24:RBR:REG=23,VAL=17
2547 RF24:RBR:REG=23,VAL=17
2577 RF24:RBR:REG=23,VAL=17
2606 RF24:RBR:REG=23,VAL=17
2635 RF24:RBR:REG=23,VAL=17
2665 RF24:RBR:REG=23,VAL=17
2694 RF24:RBR:REG=23,VAL=17
2723 RF24:RBR:REG=23,VAL=17
2753 RF24:RBR:REG=23,VAL=17
2782 RF24:RBR:REG=23,VAL=17
2811 RF24:RBR:REG=23,VAL=17
2840 RF24:RBR:REG=23,VAL=17
2870 RF24:RBR:REG=23,VAL=17
2899 RF24:RBR:REG=23,VAL=17
2928 RF24:RBR:REG=23,VAL=17
2958 RF24:RBR:REG=23,VAL=17
2988 RF24:RBR:REG=23,VAL=17
3016 RF24:RBR:REG=23,VAL=17
3046 RF24:RBR:REG=23,VAL=17
3076 RF24:RBR:REG=23,VAL=17
3104 RF24:RBR:REG=23,VAL=17
3134 RF24:RBR:REG=23,VAL=17
3164 RF24:RBR:REG=23,VAL=17
3192 RF24:RBR:REG=23,VAL=17
3222 RF24:RBR:REG=23,VAL=17
3252 RF24:RBR:REG=23,VAL=17
3280 RF24:RBR:REG=23,VAL=17
3310 RF24:RBR:REG=23,VAL=17
3340 RF24:RBR:REG=23,VAL=17
3368 RF24:RBR:REG=23,VAL=17
3398 RF24:RBR:REG=23,VAL=17
3428 RF24:RBR:REG=23,VAL=17
3457 !TSM:FPAR:NO REPLY
3482 TSM:FPAR
3496 RF24:SPL
3512 RF24:WBR:REG=0,VAL=14
3539 RF24:OWP:RCPT=255
3564 RF24:WBR:REG=10,VAL=255
3595 RF24:WBR:REG=16,VAL=255
3624 RF24:TXM:TO=255,LEN=7
3653 RF24:FTX
3702 RF24:WBR:REG=7,VAL=48
3731 !RF24:TXM:MAX_RT
3753 RF24:FTX
3769 RF24:STL
3783 RF24:WBR:REG=0,VAL=15
3812 RF24:WBR:REG=10,VAL=102
3842 TSF:MSG:SEND,102-102-255-255,s=255,c=3,t=7,pt=0,l=0,sg=0,ft=0,st=OK:
3919 RF24:RBR:REG=23,VAL=17
3948 RF24:RBR:REG=23,VAL=17
3978 RF24:RBR:REG=23,VAL=17
4007 RF24:RBR:REG=23,VAL=17
4036 RF24:RBR:REG=23,VAL=17
4066 RF24:RBR:REG=23,VAL=17
4096 RF24:RBR:REG=23,VAL=17
4124 RF24:RBR:REG=23,VAL=17
4154 RF24:RBR:REG=23,VAL=17
4183 RF24:RBR:REG=23,VAL=17
4212 RF24:RBR:REG=23,VAL=17
4242 RF24:RBR:REG=23,VAL=17
4271 RF24:RBR:REG=23,VAL=17
4300 RF24:RBR:REG=23,VAL=17
4330 RF24:RBR:REG=23,VAL=17
4359 RF24:RBR:REG=23,VAL=17
4388 RF24:RBR:REG=23,VAL=17
4418 RF24:RBR:REG=23,VAL=17
4447 RF24:RBR:REG=23,VAL=17
4476 RF24:RBR:REG=23,VAL=17
4506 RF24:RBR:REG=23,VAL=17
4535 RF24:RBR:REG=23,VAL=17
4564 RF24:RBR:REG=23,VAL=17
4594 RF24:RBR:REG=23,VAL=17
4623 RF24:RBR:REG=23,VAL=17
4653 RF24:RBR:REG=23,VAL=17
4682 RF24:RBR:REG=23,VAL=17
4711 RF24:RBR:REG=23,VAL=17
4741 RF24:RBR:REG=23,VAL=17
4770 RF24:RBR:REG=23,VAL=17
4799 RF24:RBR:REG=23,VAL=17
4829 RF24:RBR:REG=23,VAL=17
4857 RF24:RBR:REG=23,VAL=17
4887 RF24:RBR:REG=23,VAL=17
4917 RF24:RBR:REG=23,VAL=17
4945 RF24:RBR:REG=23,VAL=17
4975 RF24:RBR:REG=23,VAL=17
5005 RF24:RBR:REG=23,VAL=17
5033 RF24:RBR:REG=23,VAL=17
5063 RF24:RBR:REG=23,VAL=17
5093 RF24:RBR:REG=23,VAL=17
5122 RF24:RBR:REG=23,VAL=17
5151 RF24:RBR:REG=23,VAL=17
5181 RF24:RBR:REG=23,VAL=17
5210 RF24:RBR:REG=23,VAL=17
5239 RF24:RBR:REG=23,VAL=17
5269 RF24:RBR:REG=23,VAL=17
5298 RF24:RBR:REG=23,VAL=17
5327 RF24:RBR:REG=23,VAL=17
5357 RF24:RBR:REG=23,VAL=17
5386 RF24:RBR:REG=23,VAL=17
5415 RF24:RBR:REG=23,VAL=17
5445 RF24:RBR:REG=23,VAL=17
5474 RF24:RBR:REG=23,VAL=17
5504 RF24:RBR:REG=23,VAL=17
5533 RF24:RBR:REG=23,VAL=17
5562 RF24:RBR:REG=23,VAL=17
5592 RF24:RBR:REG=23,VAL=17
5620 RF24:RBR:REG=23,VAL=17
5650 RF24:RBR:REG=23,VAL=17
5680 RF24:RBR:REG=23,VAL=17
5708 RF24:RBR:REG=23,VAL=17
5738 RF24:RBR:REG=23,VAL=17
5768 RF24:RBR:REG=23,VAL=17
5796 RF24:RBR:REG=23,VAL=17
5826 RF24:RBR:REG=23,VAL=17
5856 RF24:RBR:REG=23,VAL=17
5884 RF24:RBR:REG=23,VAL=17
5914 RF24:RBR:REG=23,VAL=17
5944 !TSM:FPAR:NO REPLY
5968 TSM:FPAR
5984 RF24:SPL
5998 RF24:WBR:REG=0,VAL=14
6027 RF24:OWP:RCPT=255
6050 RF24:WBR:REG=10,VAL=255
6081 RF24:WBR:REG=16,VAL=255
6112 RF24:TXM:TO=255,LEN=7
6139 RF24:FTX
6189 RF24:WBR:REG=7,VAL=48
6217 !RF24:TXM:MAX_RT
6241 RF24:FTX
6255 RF24:STL
6269 RF24:WBR:REG=0,VAL=15
6298 RF24:WBR:REG=10,VAL=102
6329 TSF:MSG:SEND,102-102-255-255,s=255,c=3,t=7,pt=0,l=0,sg=0,ft=0,st=OK:
6406 RF24:RBR:REG=23,VAL=17
6435 RF24:RBR:REG=23,VAL=17
6464 RF24:RBR:REG=23,VAL=17
6494 RF24:RBR:REG=23,VAL=17
6523 RF24:RBR:REG=23,VAL=17
6552 RF24:RBR:REG=23,VAL=17
6582 RF24:RBR:REG=23,VAL=17
6611 RF24:RBR:REG=23,VAL=17
6640 RF24:RBR:REG=23,VAL=17
6670 RF24:RBR:REG=23,VAL=17
6700 RF24:RBR:REG=23,VAL=17
6728 RF24:RBR:REG=23,VAL=17
6758 RF24:RBR:REG=23,VAL=17
6788 RF24:RBR:REG=23,VAL=17
6816 RF24:RBR:REG=23,VAL=17
6846 RF24:RBR:REG=23,VAL=17
6875 RF24:RBR:REG=23,VAL=17
6904 RF24:RBR:REG=23,VAL=17
6934 RF24:RBR:REG=23,VAL=17
6963 RF24:RBR:REG=23,VAL=17
6992 RF24:RBR:REG=23,VAL=17
7022 RF24:RBR:REG=23,VAL=17
7051 RF24:RBR:REG=23,VAL=17
7080 RF24:RBR:REG=23,VAL=17
7110 RF24:RBR:REG=23,VAL=17
7139 RF24:RBR:REG=23,VAL=17
7169 RF24:RBR:REG=23,VAL=17
7198 RF24:RBR:REG=23,VAL=17
7227 RF24:RBR:REG=23,VAL=17
7257 RF24:RBR:REG=23,VAL=17
7286 RF24:RBR:REG=23,VAL=17
7315 RF24:RBR:REG=23,VAL=17
7345 RF24:RBR:REG=23,VAL=17
7374 RF24:RBR:REG=23,VAL=17
7403 RF24:RBR:REG=23,VAL=17
7433 RF24:RBR:REG=23,VAL=17
7462 RF24:RBR:REG=23,VAL=17
7491 RF24:RBR:REG=23,VAL=17
7521 RF24:RBR:REG=23,VAL=17
7550 RF24:RBR:REG=23,VAL=17
7579 RF24:RBR:REG=23,VAL=17
7609 RF24:RBR:REG=23,VAL=17
7638 RF24:RBR:REG=23,VAL=17
7667 RF24:RBR:REG=23,VAL=17
7697 RF24:RBR:REG=23,VAL=17
7726 RF24:RBR:REG=23,VAL=17
7755 RF24:RBR:REG=23,VAL=17
7785 RF24:RBR:REG=23,VAL=17
7814 RF24:RBR:REG=23,VAL=17
7843 RF24:RBR:REG=23,VAL=17
7873 RF24:RBR:REG=23,VAL=17
7902 RF24:RBR:REG=23,VAL=17
7931 RF24:RBR:REG=23,VAL=17
7961 RF24:RBR:REG=23,VAL=17
7990 RF24:RBR:REG=23,VAL=17
8019 RF24:RBR:REG=23,VAL=17
8049 RF24:RBR:REG=23,VAL=17
8078 RF24:RBR:REG=23,VAL=17
8108 RF24:RBR:REG=23,VAL=17
8137 RF24:RBR:REG=23,VAL=17
8166 RF24:RBR:REG=23,VAL=17
8196 RF24:RBR:REG=23,VAL=17
8225 RF24:RBR:REG=23,VAL=17
8254 RF24:RBR:REG=23,VAL=17
8284 RF24:RBR:REG=23,VAL=17
8313 RF24:RBR:REG=23,VAL=17
8342 RF24:RBR:REG=23,VAL=17
8372 RF24:RBR:REG=23,VAL=17
8400 RF24:RBR:REG=23,VAL=17
8430 !TSM:FPAR:NO REPLY
8456 TSM:FPAR
8470 RF24:SPL
8485 RF24:WBR:REG=0,VAL=14
8513 RF24:OWP:RCPT=255
8538 RF24:WBR:REG=10,VAL=255
8567 RF24:WBR:REG=16,VAL=255
8598 RF24:TXM:TO=255,LEN=7
8627 RF24:FTX
8676 RF24:WBR:REG=7,VAL=48
8705 !RF24:TXM:MAX_RT
8727 RF24:FTX
8741 RF24:STL
8757 RF24:WBR:REG=0,VAL=15
8785 RF24:WBR:REG=10,VAL=102
8815 TSF:MSG:SEND,102-102-255-255,s=255,c=3,t=7,pt=0,l=0,sg=0,ft=0,st=OK:
8893 RF24:RBR:REG=23,VAL=17
8922 RF24:RBR:REG=23,VAL=17
8951 RF24:RBR:REG=23,VAL=17
8981 RF24:RBR:REG=23,VAL=17
9010 RF24:RBR:REG=23,VAL=17
9039 RF24:RBR:REG=23,VAL=17
9068 RF24:RBR:REG=23,VAL=17
9098 RF24:RBR:REG=23,VAL=17
9127 RF24:RBR:REG=23,VAL=17
9156 RF24:RBR:REG=23,VAL=17
9186 RF24:RBR:REG=23,VAL=17
9216 RF24:RBR:REG=23,VAL=17
9244 RF24:RBR:REG=23,VAL=17
9274 RF24:RBR:REG=23,VAL=17
9304 RF24:RBR:REG=23,VAL=17
9332 RF24:RBR:REG=23,VAL=17
9362 RF24:RBR:REG=23,VAL=17
9392 RF24:RBR:REG=23,VAL=17
9420 RF24:RBR:REG=23,VAL=17
9450 RF24:RBR:REG=23,VAL=17
9480 RF24:RBR:REG=23,VAL=17
9508 RF24:RBR:REG=23,VAL=17
9538 RF24:RBR:REG=23,VAL=17
9568 RF24:RBR:REG=23,VAL=17
9596 RF24:RBR:REG=23,VAL=17
9626 RF24:RBR:REG=23,VAL=17
9656 RF24:RBR:REG=23,VAL=17
9684 RF24:RBR:REG=23,VAL=17
9714 RF24:RBR:REG=23,VAL=17
9743 RF24:RBR:REG=23,VAL=17
9773 RF24:RBR:REG=23,VAL=17
9802 RF24:RBR:REG=23,VAL=17
9831 RF24:RBR:REG=23,VAL=17
9861 RF24:RBR:REG=23,VAL=17
9890 RF24:RBR:REG=23,VAL=17
9919 RF24:RBR:REG=23,VAL=17
9949 RF24:RBR:REG=23,VAL=17
9978 RF24:RBR:REG=23,VAL=17
10007 RF24:RBR:REG=23,VAL=17
10038 RF24:RBR:REG=23,VAL=17
10068 RF24:RBR:REG=23,VAL=17
10098 RF24:RBR:REG=23,VAL=17
10129 RF24:RBR:REG=23,VAL=17
10160 RF24:RBR:REG=23,VAL=17
10190 RF24:RBR:REG=23,VAL=17
10220 RF24:RBR:REG=23,VAL=17
10251 RF24:RBR:REG=23,VAL=17
10281 RF24:RBR:REG=23,VAL=17
10311 RF24:RBR:REG=23,VAL=17
10342 RF24:RBR:REG=23,VAL=17
10373 RF24:RBR:REG=23,VAL=17
10403 RF24:RBR:REG=23,VAL=17
10433 RF24:RBR:REG=23,VAL=17
10464 RF24:RBR:REG=23,VAL=17
10494 RF24:RBR:REG=23,VAL=17
10524 RF24:RBR:REG=23,VAL=17
10555 RF24:RBR:REG=23,VAL=17
10586 RF24:RBR:REG=23,VAL=17
10616 RF24:RBR:REG=23,VAL=17
10646 RF24:RBR:REG=23,VAL=17
10677 RF24:RBR:REG=23,VAL=17
10707 RF24:RBR:REG=23,VAL=17
10737 RF24:RBR:REG=23,VAL=17
10768 RF24:RBR:REG=23,VAL=17
10799 RF24:RBR:REG=23,VAL=17
10828 RF24:RBR:REG=23,VAL=17
10859 RF24:RBR:REG=23,VAL=17
10890 RF24:RBR:REG=23,VAL=17
10920 !TSM:FPAR:FAIL
10942 TSM:FAIL:CNT=1
10964 TSM:FAIL:DIS
10984 TSF:TDI:TSL
11003 RF24:SLP
11019 RF24:WBR:REG=0,VAL=12
...

[Jens Jensen]

Ok, this was super silly resolution.

I had wrong CE pin selected, and confusion bit me again on the pin vs gpio thing of the header/brcm gpio mapping.

On my rf24 module, I had (from previous implementations) wired up CE to GPIO 22 (pin 15), and IRQ to GPIO 25 (pin 22). So default CE line for rpi/rf24/mysgw is "22" (pin, NOT gpio

The frustration was that my module was being recognized, which gave false appearance of complete wiring correctness, but I think it never transitioned to TX.
Not sure if it would be possible to sanity check RF24 driver to verify if CE line is working in module wiring or not.

Anyhow, moral of the story is to check and double-check the wiring!!!