Ethernet Gateway RFM69HW: Lots of !MCO:PRO
-
Dear All,
MCO:PRO issues are sometimes discussed in this forum. They are often caused by a call to send() inside of receive() and easy to solve, but I ran into this issue with no self-written code at all but a plain vanilla ethernet gateway:
#define MY_DEBUG #define MY_RADIO_RFM69 #define MY_IS_RFM69HW #define MY_RFM69_NEW_DRIVER #define MY_RF69_SPI_CS (14) #define MY_GATEWAY_W5100 #define MY_PORT 5003 #define MY_IP_ADDRESS 192,168,2,73 #define MY_MAC_ADDRESS 0xDE, 0xAD, 0xBA, 0xBE, 0x02, 0x73 #define MY_SIGNING_ATSHA204 //!< Hardware signing using ATSHA204A #define MY_SIGNING_ATSHA204_PIN 17 #define MY_SIGNING_REQUEST_SIGNATURES #include <Ethernet.h> #include <MySensors.h> void setup() { } void presentation() { } void loop() { }
Gateway Log:
10:42:01.720 -> 0 MCO:BGN:INIT GW,CP=RPNGAA--,FQ=8,REL=0,VER=2.4.0-alpha ... 10:45:09.137 -> 170602 TSF:MSG:SEND,0-0-123-123,s=255,c=3,t=17,pt=6,l=25,sg=1,ft=0,st=OK:<NONCE> 10:45:09.285 -> 170776 TSF:MSG:READ,123-123-0,s=2,c=0,t=3,pt=0,l=3,sg=1:led 10:45:09.840 -> 171272 TSF:MSG:READ,123-123-0,s=255,c=3,t=26,pt=1,l=1,sg=1:2 10:45:10.041 -> 171489 TSF:MSG:SEND,0-0-123-123,s=255,c=3,t=16,pt=0,l=0,sg=0,ft=0,st=OK: 10:45:10.041 -> 171497 !MCO:PRO:RC=1 10:45:10.041 -> 171499 !MCO:PRO:RC=1 ... many many MCO:PRO's ... 10:45:10.389 -> 171821 !MCO:PRO:RC=1 10:45:10.389 -> 171827 TSF:MSG:READ,123-123-0,s=255,c=3,t=17,pt=6,l=25,sg=0:<NONCE> 10:45:10.543 -> 171956 TSF:MSG:SEND,0-0-123-123,s=255,c=3,t=27,pt=1,l=1,sg=1,ft=0,st=OK:1 10:45:10.744 -> 172136 TSF:MSG:READ,123-123-0,s=1,c=3,t=16,pt=0,l=0,sg=1: 10:45:11.246 -> 172642 TSF:MSG:SEND,0-0-123-123,s=255,c=3,t=17,pt=6,l=25,sg=1,ft=0,st=OK:<NONCE> ...
Sketch Log:
10:32:37.186 -> __ __ ____ 10:32:37.186 -> | \/ |_ _/ ___| ___ _ __ ___ ___ _ __ ___ 10:32:37.186 -> | |\/| | | | \___ \ / _ \ `_ \/ __|/ _ \| `__/ __| 10:32:37.186 -> | | | | |_| |___| | __/ | | \__ \ _ | | \__ \ 10:32:37.186 -> |_| |_|\__, |____/ \___|_| |_|___/\___/|_| |___/ 10:32:37.186 -> |___/ 2.4.0-alpha ... 10:45:09.959 -> 9176 SGN:SGN:SGN 10:45:09.959 -> 9189 TSF:MSG:SEND,123-123-0-0,s=1,c=0,t=36,pt=0,l=9,sg=1,ft=0,st=OK:timestamp 10:45:09.959 -> 9196 SGN:SKP:MSG CMD=3,TYPE=16 10:45:10.478 -> 9711 TSF:MSG:SEND,123-123-0-0,s=2,c=3,t=16,pt=0,l=0,sg=1,ft=0,st=OK: 10:45:10.478 -> 9717 SGN:SGN:NCE REQ,TO=0 10:45:10.806 -> 10048 TSF:MSG:READ,0-0-123,s=255,c=3,t=17,pt=6,l=25,sg=1:<NONCE> 10:45:10.853 -> 10054 SGN:SKP:MSG CMD=3,TYPE=17 ...
After changing some MY_*-defines I found the MCO:PRO-issue also on the node, for example if MY_TRANSPORT_WAIT_READY_MS is set.
My node is a plain Seeduino M328P with RFM69HW attached according to the HowTo. The Gateway is an Arduino Pro Micro, RFM69HW attached to hardware SPI and W5100 also on hardware SPI, but with a hardware extension (https://arduinodiy.wordpress.com/2017/04/12/the-w5100-bug/).
I know this is not a standard scenario, so I also built an Raspberry Pi 4B+ Gateway, for more testing, with the following config:
./configure \ --spi-driver=SPIDEV \ --my-transport=rfm69 \ --my-rfm69-frequency=868 \ --my-is-rfm69hw \ --my-gateway=ethernet \ --my-port=5003 \ --my-signing=software \ --my-signing-request-signatures \ --my-signing-debug \ --extra-cxxflags="-DMY_RFM69_NETWORKID=\(100\) -DMY_RFM69_CSMA_LIMIT_DBM=\(-90\) -DMY_SIGNAL_REPORT_ENABLED"
It runs into the same issue :
pi@raspberrypi:~/MySensors $ sudo ./bin/mysgw Aug 05 11:24:02 INFO Starting gateway... Aug 05 11:24:02 INFO Protocol version - 2.3.2 Aug 05 11:24:02 DEBUG MCO:BGN:INIT GW,CP=RPNGLS--,FQ=NA,REL=255,VER=2.3.2 ... Aug 05 11:24:51 DEBUG SGN:VER:OK Aug 05 11:24:51 DEBUG GWT:RFC:C=0,MSG=123;255;3;0;6;M Aug 05 11:24:51 DEBUG SGN:SKP:MSG CMD=3,TYPE=16 Aug 05 11:24:51 DEBUG TSF:MSG:SEND,0-0-123-123,s=255,c=3,t=16,pt=0,l=0,sg=0,ft=0,st=OK: Aug 05 11:24:51 DEBUG SGN:SGN:NCE REQ,TO=123 Aug 05 11:24:51 DEBUG !MCO:PRO:RC=1 ... many many MCO:PROs ... Aug 05 11:24:52 DEBUG !MCO:PRO:RC=1 Aug 05 11:24:52 DEBUG TSF:MSG:READ,123-123-0,s=255,c=3,t=17,pt=6,l=25,sg=0:<NONCE> Aug 05 11:24:52 DEBUG SGN:SKP:MSG CMD=3,TYPE=17 Aug 05 11:24:52 DEBUG SGN:NCE:FROM=123 Aug 05 11:24:52 DEBUG SGN:BND:NONCE=DC9C963E113AC087BE7F548A7E330E34B09453BB3BA95A8273AAAAAAAAAAAAAA Aug 05 11:24:52 DEBUG SGN:BND:HMAC=5FEB8F6821395B8C16F00A4EE23BE730212E85F94B1CB0D3AFC60512EF8066F5
The issue hurts for it slows down presentation and message sending and I'm trying to track down the (possible) error. But I'm lost in the source code Where should I start?
Thanks in advance,
P.S.
Here's my test cases:
TC# GW Signing WAIT_MS Sketch Results 1 Arduino n 0 hello working fine 2 Arduino only GW 0 hello GW: MCO:PRO rc=1+rc=2 3 Arduino n 1000 hello GW:fine, Node: MCO:PRO rc=1 4 Arduino y 0 hello GW: MCO:PRO rc=1 (presentation+send msg to node), Node:fine 5 Arduino y 1000 hello GW: MCO:PRO rc=1 (presentation+send msg to node), Node:MCO:PRO rc=1 (@presentation) (node logfile unfortunately missing) 6 Arduino y 1000 mini GW+Node: MCO:PRO rc=1 7 Raspberry y 1000 mini GW+Node: MCO:PRO rc=1 8 Raspberry y 1000 hello GW+Node: MCO:PRO rc=1 (presentation+send msg to node) 9 Raspberry y 0 hello GW: MCO:PRO rc=1, Node: according to the logs MCO:PRO, but in my memory fine, have to repeat the test
Sketches:
hello = HelloM328P.ino
mini = MySminimal.ino
https://github.com/hosentraeger/MySensors-MCO-PRO-analyzing
-
@frits I see you're using 2.4.0 alpha. Did you also test with a mysensors release version?
-
@Yveaux , yes, also on 2.3.2. I've recompiled node and gateway with origin/master, got this on the node:
13:24:33.890 -> 13:24:33.890 -> __ __ ____ 13:24:33.890 -> | \/ |_ _/ ___| ___ _ __ ___ ___ _ __ ___ 13:24:33.890 -> | |\/| | | | \___ \ / _ \ `_ \/ __|/ _ \| `__/ __| 13:24:33.890 -> | | | | |_| |___| | __/ | | \__ \ _ | | \__ \ 13:24:33.890 -> |_| |_|\__, |____/ \___|_| |_|___/\___/|_| |___/ 13:24:33.890 -> |___/ 2.3.2 13:24:33.890 -> 13:24:33.890 -> 16 MCO:BGN:INIT NODE,CP=RPNNAA--,FQ=16,REL=255,VER=2.3.2 13:24:33.890 -> 33 SGN:PER:OK 13:24:33.974 -> 50 SGN:INI:BND OK 13:24:33.974 -> 52 TSM:INIT 13:24:33.974 -> 53 TSF:WUR:MS=1000 13:24:33.974 -> 55 TSM:INIT:TSP OK 13:24:33.974 -> 57 TSF:SID:OK,ID=123 13:24:33.974 -> 59 TSM:FPAR 13:24:33.974 -> 60 SGN:SGN:NREQ=255 13:24:33.974 -> 66 ?TSF:MSG:SEND,123-123-255-255,s=255,c=3,t=7,pt=0,l=0,sg=0,ft=0,st=OK: 13:24:34.946 -> 1055 MCO:BGN:STP 13:24:34.946 -> 1056 MCO:BGN:INIT OK,TSP=0 13:24:35.951 -> 2029 TSF:MSG:READ,0-0-255,s=255,c=3,t=20,pt=0,l=0,sg=0: 13:24:35.951 -> 2034 TSF:MSG:BC 13:24:35.951 -> 2073 !TSM:FPAR:NO REPLY 13:24:35.951 -> 2075 TSM:FPAR 13:24:35.951 -> 2076 SGN:SGN:NREQ=255 13:24:36.004 -> 2082 ?TSF:MSG:SEND,123-123-255-255,s=255,c=3,t=7,pt=0,l=0,sg=0,ft=0,st=OK: 13:24:36.693 -> 2783 TSF:MSG:READ,0-0-123,s=255,c=3,t=8,pt=1,l=1,sg=0:0 13:24:36.693 -> 2788 SGN:SKP:MSG CMD=3,TYPE=8 13:24:36.693 -> 2791 TSF:MSG:FPAR OK,ID=0,D=1 13:24:37.981 -> 4090 TSM:FPAR:OK 13:24:37.981 -> 4091 TSM:ID 13:24:37.981 -> 4092 TSM:ID:OK 13:24:37.981 -> 4094 TSM:UPL 13:24:37.981 -> 4096 SGN:SKP:MSG CMD=3,TYPE=24 13:24:37.981 -> 4107 TSF:MSG:SEND,123-123-0-0,s=255,c=3,t=24,pt=1,l=1,sg=0,ft=0,st=OK:1 13:24:38.590 -> 4328 TSF:MSG:READ,0-0-123,s=255,c=3,t=25,pt=1,l=1,sg=0:1 13:24:38.590 -> 4333 SGN:SKP:MSG CMD=3,TYPE=25 13:24:38.590 -> 4335 TSF:MSG:PONG RECV,HP=1 13:24:38.590 -> 4338 TSM:UPL:OK 13:24:38.590 -> 4340 TSM:READY:ID=123,PAR=0,DIS=1 13:24:38.590 -> 4343 SGN:PRE:SGN REQ 13:24:38.590 -> 4344 SGN:PRE:WHI NREQ 13:24:38.590 -> 4346 SGN:SKP:MSG CMD=3,TYPE=15 13:24:38.590 -> 4359 TSF:MSG:SEND,123-123-0-0,s=255,c=3,t=15,pt=6,l=2,sg=0,ft=0,st=OK:0101 13:24:38.590 -> 4366 SGN:PRE:XMT,TO=0 13:24:38.590 -> 4368 SGN:PRE:WAIT GW 13:24:38.590 -> 4370 !MCO:PRO:RC=1 13:24:38.590 -> 4371 !MCO:PRO:RC=1 13:24:38.590 -> 4373 !MCO:PRO:RC=1 13:24:38.590 -> 4375 !MCO:PRO:RC=1 13:24:38.590 -> 4377 !MCO:PRO:RC=1 13:24:38.590 -> 4378 !MCO:PRO:RC=1 ...
... and on the gateway:
13:24:34.269 -> 0 MCO:BGN:INIT GW,CP=RPNGAA--,FQ=8,REL=255,VER=2.3.2 13:24:34.322 -> 38 TSM:INIT 13:24:34.322 -> 40 TSF:WUR:MS=0 13:24:34.322 -> 43 TSM:INIT:TSP OK 13:24:34.322 -> 45 TSM:INIT:GW MODE 13:24:34.322 -> 47 TSM:READY:ID=0,PAR=0,DIS=0 13:24:34.322 -> 49 MCO:REG:NOT NEEDED 13:24:34.871 -> 614 GWT:TIN:IP=192.168.2.73 13:24:35.875 -> 1617 MCO:BGN:STP 13:24:35.875 -> 1619 MCO:BGN:INIT OK,TSP=1 13:24:35.875 -> 1622 TSM:READY:NWD REQ 13:24:35.929 -> 1630 ?TSF:MSG:SEND,0-0-255-255,s=255,c=3,t=20,pt=0,l=0,sg=0,ft=0,st=OK: 13:24:35.976 -> 1683 TSF:MSG:READ,123-123-255,s=255,c=3,t=7,pt=0,l=0,sg=0: 13:24:35.976 -> 1689 TSF:MSG:BC 13:24:35.976 -> 1691 TSF:MSG:FPAR REQ,ID=123 13:24:35.976 -> 1695 TSF:CKU:OK,FCTRL 13:24:35.976 -> 1697 TSF:MSG:GWL OK 13:24:36.679 -> 2383 TSF:MSG:SEND,0-0-123-123,s=255,c=3,t=8,pt=1,l=1,sg=0,ft=0,st=OK:0 13:24:37.983 -> 3704 TSF:MSG:READ,123-123-0,s=255,c=3,t=24,pt=1,l=1,sg=0:1 13:24:37.983 -> 3710 TSF:MSG:PINGED,ID=123,HP=1 13:24:38.184 -> 3926 TSF:MSG:SEND,0-0-123-123,s=255,c=3,t=25,pt=1,l=1,sg=0,ft=0,st=OK:1 13:24:38.237 -> 3956 TSF:MSG:READ,123-123-0,s=255,c=3,t=15,pt=6,l=2,sg=0:0101 13:24:38.438 -> 4173 TSF:MSG:SEND,0-0-123-123,s=255,c=3,t=15,pt=6,l=2,sg=0,ft=0,st=OK:0101 13:24:38.485 -> 4196 TSF:MSG:READ,123-123-0,s=255,c=3,t=16,pt=0,l=0,sg=0: 13:24:38.817 -> 4489 TSF:MSG:SEND,0-0-123-123,s=255,c=3,t=17,pt=6,l=25,sg=0,ft=0,st=OK:<NONCE> 13:24:38.986 -> 4665 TSF:MSG:READ,123-123-0,s=255,c=0,t=17,pt=0,l=5,sg=1:2.3.2 13:24:39.541 -> 5160 TSF:MSG:READ,123-123-0,s=255,c=3,t=16,pt=0,l=0,sg=1: 13:24:39.842 -> 5453 TSF:MSG:SEND,0-0-123-123,s=255,c=3,t=17,pt=6,l=25,sg=1,ft=0,st=OK:<NONCE> 13:24:40.043 -> 5629 TSF:MSG:READ,123-123-0,s=255,c=3,t=6,pt=1,l=1,sg=1:0 13:24:42.052 -> 7622 TSF:MSG:READ,123-123-0,s=255,c=3,t=26,pt=1,l=1,sg=1:2 13:24:42.252 -> 7839 TSF:MSG:SEND,0-0-123-123,s=255,c=3,t=16,pt=0,l=0,sg=0,ft=0,st=OK: 13:24:42.299 -> 7847 !MCO:PRO:RC=1 13:24:42.299 -> 7849 !MCO:PRO:RC=1 13:24:42.299 -> 7852 !MCO:PRO:RC=1 13:24:42.299 -> 7856 !MCO:PRO:RC=1 13:24:42.299 -> 7858 !MCO:PRO:RC=1 13:24:42.299 -> 7860 !MCO:PRO:RC=1 13:24:42.299 -> 7862 !MCO:PRO:RC=1 13:24:42.299 -> 7864 !MCO:PRO:RC=1 13:24:42.299 -> 7866 !MCO:PRO:RC=1 13:24:42.299 -> 7868 !MCO:PRO:RC=1 13:24:42.299 -> 7870 !MCO:PRO:RC=1 13:24:42.299 -> 7872 !MCO:PRO:RC=1 13:24:42.299 -> 7874 !MCO:PRO:RC=1 13:24:42.299 -> 7876 !MCO:PRO:RC=1 13:24:42.299 -> 7878 !MCO:PRO:RC=1 13:24:42.299 -> 7880 !MCO:PRO:RC=1 13:24:42.299 -> 7882 !MCO:PRO:RC=1 13:24:42.299 -> 7884 !MCO:PRO:RC=1 13:24:42.299 -> 7886 !MCO:PRO:RC=1 13:24:42.299 -> 7888 !MCO:PRO:RC=1 13:24:42.299 -> 7890 !MCO:PRO:RC=1 13:24:42.299 -> 7892 !MCO:PRO:RC=1 13:24:42.353 -> 7897 !MCO:PRO:RC=1 13:24:42.353 -> 7899 !MCO:PRO:RC=1 13:24:42.353 -> 7901 !MCO:PRO:RC=1 13:24:42.353 -> 7903 !MCO:PRO:RC=1 13:24:42.353 -> 7905 !MCO:PRO:RC=1 13:24:42.353 -> 7907 !MCO:PRO:RC=1 13:24:42.353 -> 7909 !MCO:PRO:RC=1 13:24:42.353 -> 7911 !MCO:PRO:RC=1 13:24:42.353 -> 7913 !MCO:PRO:RC=1 13:24:42.353 -> 7915 !MCO:PRO:RC=1 13:24:42.353 -> 7917 !MCO:PRO:RC=1 13:24:42.353 -> 7919 !MCO:PRO:RC=1 13:24:42.353 -> 7921 !MCO:PRO:RC=1 13:24:42.353 -> 7923 !MCO:PRO:RC=1 13:24:42.353 -> 7925 !MCO:PRO:RC=1 13:24:42.353 -> 7927 !MCO:PRO:RC=1 13:24:42.353 -> 7929 !MCO:PRO:RC=1 13:24:42.353 -> 7931 !MCO:PRO:RC=1 13:24:42.353 -> 7936 !MCO:PRO:RC=1 13:24:42.353 -> 7938 !MCO:PRO:RC=1 13:24:42.353 -> 7940 !MCO:PRO:RC=1 13:24:42.353 -> 7942 !MCO:PRO:RC=1 13:24:42.353 -> 7944 !MCO:PRO:RC=1 13:24:42.353 -> 7946 !MCO:PRO:RC=1 13:24:42.353 -> 7948 !MCO:PRO:RC=1 13:24:42.399 -> 7950 !MCO:PRO:RC=1 13:24:42.399 -> 7952 !MCO:PRO:RC=1 13:24:42.399 -> 7954 !MCO:PRO:RC=1 13:24:42.399 -> 7956 !MCO:PRO:RC=1 13:24:42.399 -> 7958 !MCO:PRO:RC=1 13:24:42.399 -> 7960 !MCO:PRO:RC=1 13:24:42.399 -> 7962 !MCO:PRO:RC=1 13:24:42.399 -> 7964 !MCO:PRO:RC=1 13:24:42.399 -> 7966 !MCO:PRO:RC=1 13:24:42.399 -> 7968 !MCO:PRO:RC=1 13:24:42.399 -> 7970 !MCO:PRO:RC=1 13:24:42.399 -> 7974 !MCO:PRO:RC=1 13:24:42.399 -> 7976 !MCO:PRO:RC=1 13:24:42.399 -> 7979 !MCO:PRO:RC=1 13:24:42.399 -> 7981 !MCO:PRO:RC=1 13:24:42.399 -> 7983 !MCO:PRO:RC=1 13:24:42.399 -> 7985 !MCO:PRO:RC=1 13:24:42.399 -> 7987 !MCO:PRO:RC=1 13:24:42.399 -> 7989 !MCO:PRO:RC=1 13:24:42.399 -> 7991 !MCO:PRO:RC=1 13:24:42.399 -> 7993 !MCO:PRO:RC=1 13:24:42.399 -> 7995 !MCO:PRO:RC=1 13:24:42.453 -> 7997 !MCO:PRO:RC=1 13:24:42.453 -> 7999 !MCO:PRO:RC=1 13:24:42.453 -> 8001 !MCO:PRO:RC=1 13:24:42.453 -> 8003 !MCO:PRO:RC=1 13:24:42.453 -> 8005 !MCO:PRO:RC=1 13:24:42.453 -> 8007 !MCO:PRO:RC=1 13:24:42.453 -> 8009 !MCO:PRO:RC=1 13:24:42.453 -> 8013 !MCO:PRO:RC=1 13:24:42.453 -> 8015 !MCO:PRO:RC=1 13:24:42.453 -> 8017 !MCO:PRO:RC=1 13:24:42.453 -> 8019 !MCO:PRO:RC=1 13:24:42.453 -> 8022 !MCO:PRO:RC=1 13:24:42.453 -> 8024 !MCO:PRO:RC=1 13:24:42.453 -> 8026 !MCO:PRO:RC=1 13:24:42.453 -> 8028 !MCO:PRO:RC=1 13:24:42.453 -> 8030 !MCO:PRO:RC=1 13:24:42.453 -> 8032 !MCO:PRO:RC=1 13:24:42.453 -> 8034 !MCO:PRO:RC=1 13:24:42.453 -> 8036 !MCO:PRO:RC=1 13:24:42.453 -> 8038 !MCO:PRO:RC=1 13:24:42.453 -> 8040 !MCO:PRO:RC=1 13:24:42.453 -> 8042 !MCO:PRO:RC=1 13:24:42.453 -> 8044 !MCO:PRO:RC=1 13:24:42.453 -> 8046 !MCO:PRO:RC=1 13:24:42.453 -> 8048 !MCO:PRO:RC=1 13:24:42.500 -> 8052 !MCO:PRO:RC=1 13:24:42.500 -> 8054 !MCO:PRO:RC=1 13:24:42.500 -> 8056 !MCO:PRO:RC=1 13:24:42.500 -> 8058 !MCO:PRO:RC=1 13:24:42.500 -> 8060 !MCO:PRO:RC=1 13:24:42.500 -> 8062 !MCO:PRO:RC=1 13:24:42.500 -> 8065 !MCO:PRO:RC=1 13:24:42.500 -> 8067 !MCO:PRO:RC=1 13:24:42.500 -> 8069 !MCO:PRO:RC=1 13:24:42.500 -> 8071 !MCO:PRO:RC=1 13:24:42.500 -> 8073 !MCO:PRO:RC=1 13:24:42.500 -> 8075 !MCO:PRO:RC=1 13:24:42.500 -> 8077 !MCO:PRO:RC=1 13:24:42.500 -> 8079 !MCO:PRO:RC=1 13:24:42.500 -> 8081 !MCO:PRO:RC=1 13:24:42.500 -> 8083 !MCO:PRO:RC=1 13:24:42.500 -> 8085 !MCO:PRO:RC=1 13:24:42.500 -> 8087 !MCO:PRO:RC=1 13:24:42.500 -> 8089 !MCO:PRO:RC=1 13:24:42.500 -> 8093 !MCO:PRO:RC=1 13:24:42.500 -> 8095 !MCO:PRO:RC=1 13:24:42.500 -> 8097 !MCO:PRO:RC=1 13:24:42.554 -> 8099 !MCO:PRO:RC=1 13:24:42.554 -> 8101 !MCO:PRO:RC=1 13:24:42.554 -> 8103 !MCO:PRO:RC=1 13:24:42.554 -> 8105 !MCO:PRO:RC=1 13:24:42.554 -> 8108 !MCO:PRO:RC=1 13:24:42.554 -> 8110 !MCO:PRO:RC=1 13:24:42.554 -> 8112 !MCO:PRO:RC=1 13:24:42.554 -> 8114 !MCO:PRO:RC=1 13:24:42.554 -> 8116 !MCO:PRO:RC=1 13:24:42.554 -> 8118 !MCO:PRO:RC=1 13:24:42.554 -> 8120 !MCO:PRO:RC=1 13:24:42.554 -> 8122 !MCO:PRO:RC=1 13:24:42.554 -> 8124 !MCO:PRO:RC=1 13:24:42.554 -> 8126 !MCO:PRO:RC=1 13:24:42.554 -> 8128 !MCO:PRO:RC=1 13:24:42.554 -> 8132 !MCO:PRO:RC=1 13:24:42.554 -> 8134 !MCO:PRO:RC=1 13:24:42.554 -> 8136 !MCO:PRO:RC=1 13:24:42.554 -> 8138 !MCO:PRO:RC=1 13:24:42.554 -> 8140 !MCO:PRO:RC=1 13:24:42.554 -> 8142 !MCO:PRO:RC=1 13:24:42.554 -> 8144 !MCO:PRO:RC=1 13:24:42.554 -> 8146 !MCO:PRO:RC=1 13:24:42.554 -> 8148 !MCO:PRO:RC=1 13:24:42.600 -> 8151 !MCO:PRO:RC=1 13:24:42.600 -> 8153 !MCO:PRO:RC=1 13:24:42.600 -> 8155 !MCO:PRO:RC=1 13:24:42.600 -> 8157 !MCO:PRO:RC=1 13:24:42.600 -> 8159 !MCO:PRO:RC=1 13:24:42.600 -> 8161 !MCO:PRO:RC=1 13:24:42.600 -> 8163 !MCO:PRO:RC=1 13:24:42.600 -> 8165 !MCO:PRO:RC=1 13:24:42.600 -> 8167 !MCO:PRO:RC=1 13:24:42.600 -> 8171 !MCO:PRO:RC=1 13:24:42.600 -> 8173 !MCO:PRO:RC=1 13:24:42.600 -> 8179 TSF:MSG:READ,123-123-0,s=255,c=3,t=17,pt=6,l=25,sg=0:<NONCE> 13:24:42.754 -> 8306 TSF:MSG:SEND,0-0-123-123,s=255,c=3,t=27,pt=1,l=1,sg=1,ft=0,st=OK:1