Bug #3346
closedosmo-trx-lms: Multi channel support: "R_CTL_LPF range limit reached"
Added by laforge about 6 years ago. Updated over 4 years ago.
0%
Description
When trying to use two channels on a LimeSDR, I'm getting the following:
Wed Jun 13 22:07:07 2018 DMAIN <0000> LMSDevice.cpp:188 [tid=139802759618432] Setting LPFBW chan 0 Wed Jun 13 22:07:07 2018 DLMS <0001> LMSDevice.cpp:76 [tid=139802759618432] MCU algorithm time: 10 ms Wed Jun 13 22:07:08 2018 DLMS <0001> LMSDevice.cpp:76 [tid=139802759618432] MCU algorithm time: 0 ms Wed Jun 13 22:07:08 2018 DLMS <0001> LMSDevice.cpp:76 [tid=139802759618432] MCU Ref. clock: 30.72 MHz Wed Jun 13 22:07:08 2018 DLMS <0001> LMSDevice.cpp:76 [tid=139802759618432] MCU algorithm time: 0 ms Wed Jun 13 22:07:08 2018 DLMS <0001> LMSDevice.cpp:76 [tid=139802759618432] MCU algorithm time: 166 ms Wed Jun 13 22:07:08 2018 DLMS <0001> LMSDevice.cpp:76 [tid=139802759618432] RX LPF configured Wed Jun 13 22:07:08 2018 DLMS <0001> LMSDevice.cpp:76 [tid=139802759618432] INT 75, FRAC 0, DIV_OUTCH_CGEN 18 Wed Jun 13 22:07:08 2018 DLMS <0001> LMSDevice.cpp:76 [tid=139802759618432] VCO 2334.72 MHz, RefClk 30.72 MHz Wed Jun 13 22:07:08 2018 DLMS <0001> LMSDevice.cpp:76 [tid=139802759618432] csw 154; interval [151, 157] Wed Jun 13 22:07:08 2018 DLMS <0001> LMSDevice.cpp:76 [tid=139802759618432] MCU algorithm time: 0 ms Wed Jun 13 22:07:08 2018 DLMS <0001> LMSDevice.cpp:76 [tid=139802759618432] MCU algorithm time: 0 ms Wed Jun 13 22:07:08 2018 DLMS <0001> LMSDevice.cpp:76 [tid=139802759618432] MCU Ref. clock: 30.72 MHz Wed Jun 13 22:07:08 2018 DLMS <0001> LMSDevice.cpp:76 [tid=139802759618432] MCU algorithm time: 0 ms Wed Jun 13 22:07:08 2018 DLMS <0001> LMSDevice.cpp:76 [tid=139802759618432] MCU algorithm time: 71 ms Wed Jun 13 22:07:08 2018 DLMS <0001> LMSDevice.cpp:76 [tid=139802759618432] Filter calibrated. Filter order-4th, filter bandwidth set to 5.2 MHz.Real pole 1st order filter set to 2.5 MHz. Preemphasis filter not active Wed Jun 13 22:07:08 2018 DLMS <0001> LMSDevice.cpp:76 [tid=139802759618432] INT 75, FRAC 0, DIV_OUTCH_CGEN 18 Wed Jun 13 22:07:08 2018 DLMS <0001> LMSDevice.cpp:76 [tid=139802759618432] VCO 2334.72 MHz, RefClk 30.72 MHz Wed Jun 13 22:07:08 2018 DLMS <0001> LMSDevice.cpp:76 [tid=139802759618432] csw 154; interval [151, 157] Wed Jun 13 22:07:08 2018 DLMS <0001> LMSDevice.cpp:76 [tid=139802759618432] TX LPF configured Wed Jun 13 22:07:08 2018 DMAIN <0000> LMSDevice.cpp:193 [tid=139802759618432] Calibrating chan 0 Wed Jun 13 22:07:08 2018 DLMS <0001> LMSDevice.cpp:76 [tid=139802759618432] MCU algorithm time: 0 ms Wed Jun 13 22:07:08 2018 DLMS <0001> LMSDevice.cpp:76 [tid=139802759618432] MCU algorithm time: 0 ms Wed Jun 13 22:07:08 2018 DLMS <0001> LMSDevice.cpp:76 [tid=139802759618432] MCU algorithm time: 0 ms Wed Jun 13 22:07:08 2018 DLMS <0001> LMSDevice.cpp:76 [tid=139802759618432] MCU algorithm time: 110 ms Wed Jun 13 22:07:08 2018 DLMS <0001> LMSDevice.cpp:76 [tid=139802759618432] Rx calibration finished Wed Jun 13 22:07:08 2018 DLMS <0001> LMSDevice.cpp:76 [tid=139802759618432] MCU algorithm time: 0 ms Wed Jun 13 22:07:08 2018 DLMS <0001> LMSDevice.cpp:76 [tid=139802759618432] MCU algorithm time: 0 ms Wed Jun 13 22:07:08 2018 DLMS <0001> LMSDevice.cpp:76 [tid=139802759618432] MCU algorithm time: 0 ms Wed Jun 13 22:07:08 2018 DLMS <0001> LMSDevice.cpp:76 [tid=139802759618432] MCU algorithm time: 243 ms Wed Jun 13 22:07:08 2018 DLMS <0001> LMSDevice.cpp:76 [tid=139802759618432] Tx calibration finished Wed Jun 13 22:07:08 2018 DMAIN <0000> LMSDevice.cpp:188 [tid=139802759618432] Setting LPFBW chan 1 Wed Jun 13 22:07:08 2018 DLMS <0001> LMSDevice.cpp:76 [tid=139802759618432] MCU algorithm time: 0 ms Wed Jun 13 22:07:08 2018 DLMS <0001> LMSDevice.cpp:76 [tid=139802759618432] MCU algorithm time: 0 ms Wed Jun 13 22:07:08 2018 DLMS <0001> LMSDevice.cpp:76 [tid=139802759618432] MCU Ref. clock: 30.72 MHz Wed Jun 13 22:07:08 2018 DLMS <0001> LMSDevice.cpp:76 [tid=139802759618432] MCU algorithm time: 0 ms Wed Jun 13 22:07:09 2018 DLMS <0001> LMSDevice.cpp:76 [tid=139802759618432] MCU algorithm time: 279 ms Wed Jun 13 22:07:09 2018 DLMS <0001> LMSDevice.cpp:76 [tid=139802759618432] Tune Rx Filter: MCU error 12 (Rx R_CTL_LPF range limit reached) Wed Jun 13 22:07:09 2018 DMAIN <0000> LMSDevice.cpp:207 [tid=139802759618432] Error in LMS open, closing: Wed Jun 13 22:07:09 2018 DMAIN <0000> osmo-trx.cpp:447 [tid=139802759618432] Failed to create radio device Shutting down transceiver...
So as one can see, the first RX filter can be tuned as expected, but the second filter for the second channel then fails. I don't understand enough about the LimeSDR to debug this further. Interestingly, google returns exactly zero related hits when searching for that error message, as do the LimeSuite github and the myriadrf forum.
Config file looks like this:
trx bind-ip 127.0.0.1 remote-ip 127.0.0.1 base-port 5700 egprs disable tx-sps 4 rx-sps 4 chan 0 tx-path BAND1 rx-path LNAW chan 1 tx-path BAND2 rx-path LNAH
It doesn't really matter which tx-path / rx-path we are setting in chan 1
, it will fail with the same error.
Related issues
Updated by laforge about 6 years ago
- Related to Feature #2919: Native LimeSDR support added
Updated by laforge about 6 years ago
- Assignee set to roh
Should be fixed by this commit:
https://github.com/myriadrf/LimeSuite/commit/40824fd1e1aaf65c436cd372ff5dbbe2990704f1
roh please test against a recent LimeSuite (including above commit) using the config file snippet I posted above. If it does start up, it appears to be fixed. If it doens't start and spits the "R_CTL_LPF range limit reached" error, the bug still persists.
Updated by laforge over 5 years ago
- Assignee changed from roh to pespin
the same bug can no longer be reproduced. However, osmo-trx-lms has a hard-coded check if channel == 0 and will fail on any other channel, so there's now a hard-coded limitation in osmo-trx-lms and not a problem of LimeSuite anymore.
Updated by pespin over 5 years ago
I submitted several patches to gerrit that remove several wrong conditions and improve the logging when running with several chans.
However, I still get this LMS error message during TRX setup (but it doesn't seem it returns an error code):
Tue Dec 4 14:24:19 2018 DDEV <0001> LMSDevice.cpp:200 [tid=140630265782784] Calibrating chan 1 Tue Dec 4 14:24:19 2018 DLMS <0002> LMSDevice.cpp:83 [tid=140630265782784] Rx calibration: MCU error 5 (Loopback signal weak: not connected/insufficient gain?) Tue Dec 4 14:24:19 2018 DLMS <0002> LMSDevice.cpp:83 [tid=140630265782784] Tx Calibration: MCU error 5 (Loopback signal weak: not connected/insufficient gain?)
Here's the cfg file I use with my limeSDR-USB: (network configured to use 2 TRX and tested with other devices):
log stderr logging filter all 1 logging color 1 logging print category 1 logging timestamp 1 logging print file basename logging level set-all info ! line vty no login ! trx bind-ip 192.168.30.100 remote-ip 192.168.30.1 base-port 5700 egprs disable clock-ref internal tx-sps 4 rx-sps 4 rt-prio 18 chan 0 tx-path BAND1 rx-path LNAW chan 1 tx-path BAND1 rx-path LNAW
Immediatelly after starting osmo-bts-trx, osmo-trx starts failing. It seems it's already reading samples before it is fully configured through the CTRL iface:
Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:222 [tid=140630226585344] starting LMS... Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:330 [tid=140630226585344] chan 0: Setting TX gain to 36.5 dB Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:345 [tid=140630226585344] chan 0: Setting RX gain to 36.5 dB Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:330 [tid=140630226585344] chan 1: Setting TX gain to 36.5 dB Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:345 [tid=140630226585344] chan 1: Setting RX gain to 36.5 dB Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:392 [tid=140630226585344] Initial timestamp 27500 Tue Dec 4 14:24:21 2018 DMAIN <0000> radioInterface.cpp:198 [tid=140630226585344] Radio started Tue Dec 4 14:24:21 2018 DMAIN <0000> Threads.cpp:116 [tid=140630223623936] Thread 140630223623936 (task 26965) set name: TxLower Tue Dec 4 14:24:21 2018 DMAIN <0000> Threads.cpp:116 [tid=140630223529728] Thread 140630223529728 (task 26966) set name: RxLower Tue Dec 4 14:24:21 2018 DMAIN <0000> Threads.cpp:116 [tid=140630223369984] Thread 140630223369984 (task 26967) set name: RxUpper0 Tue Dec 4 14:24:21 2018 DMAIN <0000> Threads.cpp:116 [tid=140630222173952] Thread 140630222173952 (task 26968) set name: TxUpper0 Tue Dec 4 14:24:21 2018 DMAIN <0000> Threads.cpp:116 [tid=140630222046976] Thread 140630222046976 (task 26969) set name: RxUpper1 Tue Dec 4 14:24:21 2018 DMAIN <0000> Threads.cpp:116 [tid=140630221920000] Thread 140630221920000 (task 26970) set name: TxUpper1 Tue Dec 4 14:24:21 2018 DMAIN <0000> Transceiver.cpp:724 [tid=140630226585344] chan 0: command is SETRXGAIN 1 Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:345 [tid=140630226585344] chan 0: Setting RX gain to 1 dB Tue Dec 4 14:24:21 2018 DLMS <0002> LMSDevice.cpp:83 [tid=140630162028288] L Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 1 recv buffer of len 2500 expect 6b6c got 0 (0) diff=ffffffffffff9494 Tue Dec 4 14:24:21 2018 DMAIN <0000> radioInterface.cpp:330 [tid=140630223529728] Receive error 0 Tue Dec 4 14:24:21 2018 DMAIN <0000> Transceiver.cpp:907 [tid=140630223529728] radio Interface receive failed, requesting stop. Tue Dec 4 14:24:21 2018 DMAIN <0000> Transceiver.cpp:724 [tid=140630226585344] chan 0: command is SETPOWER 0 Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:330 [tid=140630226585344] chan 0: Setting TX gain to 73 dB Tue Dec 4 14:24:21 2018 DMAIN <0000> Transceiver.cpp:724 [tid=140630226585344] chan 0: command is SETSLOT 0 4 Tue Dec 4 14:24:21 2018 DMAIN <0000> Transceiver.cpp:724 [tid=140630226585344] chan 0: command is SETSLOT 1 1 Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 6b6c got 7530 (7530) diff=9c4 Tue Dec 4 14:24:21 2018 DMAIN <0000> Transceiver.cpp:724 [tid=140630226585344] chan 0: command is SETSLOT 2 1 Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 1 recv buffer of len 2500 expect 6b6c got 9c4 (9c4) diff=ffffffffffff9e58 Tue Dec 4 14:24:21 2018 DMAIN <0000> radioInterface.cpp:330 [tid=140630223529728] Receive error 0 Tue Dec 4 14:24:21 2018 DMAIN <0000> Transceiver.cpp:907 [tid=140630223529728] radio Interface receive failed, requesting stop. Tue Dec 4 14:24:21 2018 DMAIN <0000> Transceiver.cpp:724 [tid=140630226585344] chan 0: command is SETSLOT 3 1 Tue Dec 4 14:24:21 2018 DMAIN <0000> Transceiver.cpp:724 [tid=140630226585344] chan 0: command is SETSLOT 4 1 Tue Dec 4 14:24:21 2018 DMAIN <0000> Transceiver.cpp:724 [tid=140630226585344] chan 0: command is SETSLOT 5 1 Tue Dec 4 14:24:21 2018 DMAIN <0000> Transceiver.cpp:724 [tid=140630226585344] chan 0: command is SETSLOT 6 13 Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 6b6c got 7ef4 (7ef4) diff=1388 Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 1 recv buffer of len 2500 expect 6b6c got 1388 (1388) diff=ffffffffffffa81c Tue Dec 4 14:24:21 2018 DMAIN <0000> radioInterface.cpp:330 [tid=140630223529728] Receive error 0 Tue Dec 4 14:24:21 2018 DMAIN <0000> Transceiver.cpp:907 [tid=140630223529728] radio Interface receive failed, requesting stop. Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 6b6c got 88b8 (88b8) diff=1d4c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 1 recv buffer of len 2500 expect 6b6c got 1d4c (1d4c) diff=ffffffffffffb1e0 Tue Dec 4 14:24:21 2018 DMAIN <0000> radioInterface.cpp:330 [tid=140630223529728] Receive error 0 Tue Dec 4 14:24:21 2018 DMAIN <0000> Transceiver.cpp:907 [tid=140630223529728] radio Interface receive failed, requesting stop. Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 6b6c got 927c (927c) diff=2710 Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 1 recv buffer of len 2500 expect 6b6c got 2710 (2710) diff=ffffffffffffbba4 Tue Dec 4 14:24:21 2018 DMAIN <0000> radioInterface.cpp:330 [tid=140630223529728] Receive error 0 Tue Dec 4 14:24:21 2018 DMAIN <0000> Transceiver.cpp:907 [tid=140630223529728] radio Interface receive failed, requesting stop. Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 6b6c got 9c40 (9c40) diff=30d4 Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 1 recv buffer of len 2500 expect 6b6c got 30d4 (30d4) diff=ffffffffffffc568 Tue Dec 4 14:24:21 2018 DMAIN <0000> radioInterface.cpp:330 [tid=140630223529728] Receive error 0 Tue Dec 4 14:24:21 2018 DMAIN <0000> Transceiver.cpp:907 [tid=140630223529728] radio Interface receive failed, requesting stop. Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 6b6c got a604 (a604) diff=3a98 Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 1 recv buffer of len 2500 expect 6b6c got 3a98 (3a98) diff=ffffffffffffcf2c Tue Dec 4 14:24:21 2018 DMAIN <0000> radioInterface.cpp:330 [tid=140630223529728] Receive error 0 Tue Dec 4 14:24:21 2018 DMAIN <0000> Transceiver.cpp:907 [tid=140630223529728] radio Interface receive failed, requesting stop. Tue Dec 4 14:24:21 2018 DMAIN <0000> Transceiver.cpp:724 [tid=140630226585344] chan 0: command is SETSLOT 7 13 Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 6b6c got afc8 (afc8) diff=445c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 1 recv buffer of len 2500 expect 6b6c got 445c (445c) diff=ffffffffffffd8f0 Tue Dec 4 14:24:21 2018 DMAIN <0000> radioInterface.cpp:330 [tid=140630223529728] Receive error 0 Tue Dec 4 14:24:21 2018 DMAIN <0000> Transceiver.cpp:907 [tid=140630223529728] radio Interface receive failed, requesting stop. Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 6b6c got b98c (b98c) diff=4e20 Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 1 recv buffer of len 2500 expect 6b6c got 4e20 (4e20) diff=ffffffffffffe2b4 Tue Dec 4 14:24:21 2018 DMAIN <0000> radioInterface.cpp:330 [tid=140630223529728] Receive error 0 Tue Dec 4 14:24:21 2018 DMAIN <0000> Transceiver.cpp:907 [tid=140630223529728] radio Interface receive failed, requesting stop. Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 6b6c got c350 (c350) diff=57e4 Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 1 recv buffer of len 2500 expect 6b6c got 57e4 (57e4) diff=ffffffffffffec78 Tue Dec 4 14:24:21 2018 DMAIN <0000> radioInterface.cpp:330 [tid=140630223529728] Receive error 0 Tue Dec 4 14:24:21 2018 DMAIN <0000> Transceiver.cpp:907 [tid=140630223529728] radio Interface receive failed, requesting stop. Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 6b6c got cd14 (cd14) diff=61a8 Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 1 recv buffer of len 2500 expect 6b6c got 61a8 (61a8) diff=fffffffffffff63c Tue Dec 4 14:24:21 2018 DMAIN <0000> radioInterface.cpp:330 [tid=140630223529728] Receive error 0 Tue Dec 4 14:24:21 2018 DMAIN <0000> Transceiver.cpp:907 [tid=140630223529728] radio Interface receive failed, requesting stop. Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 6b6c got d6d8 (d6d8) diff=6b6c Tue Dec 4 14:24:21 2018 DMAIN <0000> Transceiver.cpp:1038 [tid=140630223529728] ClockInterface: sending IND CLOCK 2665236 Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 7530 got e09c (e09c) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 7ef4 got ea60 (ea60) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 88b8 got f424 (f424) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 927c got fde8 (fde8) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 9c40 got 107ac (107ac) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect a604 got 11170 (11170) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect afc8 got 11b34 (11b34) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect b98c got 124f8 (124f8) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect c350 got 12ebc (12ebc) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect cd14 got 13880 (13880) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect d6d8 got 14244 (14244) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect e09c got 14c08 (14c08) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect ea60 got 155cc (155cc) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect f424 got 15f90 (15f90) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect fde8 got 16954 (16954) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 107ac got 17318 (17318) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 11170 got 17cdc (17cdc) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 11b34 got 186a0 (186a0) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 124f8 got 19064 (19064) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 12ebc got 19a28 (19a28) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 13880 got 1a3ec (1a3ec) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 14244 got 1adb0 (1adb0) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 14c08 got 1b774 (1b774) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 155cc got 1c138 (1c138) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 15f90 got 1cafc (1cafc) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 16954 got 1d4c0 (1d4c0) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 17318 got 1de84 (1de84) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 17cdc got 1e848 (1e848) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 186a0 got 1f20c (1f20c) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 19064 got 1fbd0 (1fbd0) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 19a28 got 20594 (20594) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 1a3ec got 20f58 (20f58) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 1adb0 got 2191c (2191c) diff=6b6c Tue Dec 4 14:24:21 2018 DLMS <0002> LMSDevice.cpp:83 [tid=140630162028288] L Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 1b774 got 222e0 (222e0) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 1c138 got 22ca4 (22ca4) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 1cafc got 23668 (23668) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 1d4c0 got 2402c (2402c) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 1de84 got 249f0 (249f0) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 1e848 got 253b4 (253b4) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 1f20c got 25d78 (25d78) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 1fbd0 got 2673c (2673c) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 20594 got 27100 (27100) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 20f58 got 27ac4 (27ac4) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 2191c got 28488 (28488) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 222e0 got 28e4c (28e4c) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 22ca4 got 29810 (29810) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 23668 got 2a1d4 (2a1d4) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 2402c got 2ab98 (2ab98) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 249f0 got 2b55c (2b55c) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 253b4 got 2bf20 (2bf20) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 25d78 got 2c8e4 (2c8e4) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 2673c got 2d2a8 (2d2a8) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 27100 got 2dc6c (2dc6c) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 27ac4 got 2e630 (2e630) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 28488 got 2eff4 (2eff4) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 28e4c got 2f9b8 (2f9b8) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 29810 got 3037c (3037c) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 2a1d4 got 30d40 (30d40) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 2ab98 got 31704 (31704) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 2b55c got 320c8 (320c8) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 2bf20 got 32a8c (32a8c) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 2c8e4 got 33450 (33450) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 2d2a8 got 33e14 (33e14) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 2dc6c got 347d8 (347d8) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 2e630 got 3519c (3519c) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 2eff4 got 35b60 (35b60) diff=6b6c Tue Dec 4 14:24:21 2018 DLMS <0002> LMSDevice.cpp:83 [tid=140630162028288] L Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 2f9b8 got 36524 (36524) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 3037c got 36ee8 (36ee8) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 30d40 got 378ac (378ac) diff=6b6c Tue Dec 4 14:24:21 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 31704 got 38270 (38270) diff=6b6c Tue Dec 4 14:24:22 2018 DMAIN <0000> Transceiver.cpp:724 [tid=140630226458368] chan 1: command is RXTUNE 1782400 Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:616 [tid=140630226458368] chan 1: Setting Rx Freq to 1.7824e+09 Hz Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 320c8 got 38c34 (38c34) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 32a8c got 395f8 (395f8) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 33450 got 39fbc (39fbc) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 33e14 got 3a980 (3a980) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 347d8 got 3b344 (3b344) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 3519c got 3bd08 (3bd08) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 35b60 got 3c6cc (3c6cc) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 36524 got 3d090 (3d090) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 36ee8 got 3da54 (3da54) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 378ac got 3e418 (3e418) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 38270 got 3eddc (3eddc) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 38c34 got 3f7a0 (3f7a0) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 395f8 got 40164 (40164) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 39fbc got 40b28 (40b28) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 3a980 got 414ec (414ec) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 3b344 got 41eb0 (41eb0) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 3bd08 got 42874 (42874) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 3c6cc got 43238 (43238) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 3d090 got 43bfc (43bfc) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 3da54 got 445c0 (445c0) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 3e418 got 44f84 (44f84) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 3eddc got 45948 (45948) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 3f7a0 got 4630c (4630c) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 40164 got 46cd0 (46cd0) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 40b28 got 47694 (47694) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 414ec got 48058 (48058) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 41eb0 got 48a1c (48a1c) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 42874 got 493e0 (493e0) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 43238 got 49da4 (49da4) diff=6b6c Tue Dec 4 14:24:22 2018 DLMS <0002> LMSDevice.cpp:83 [tid=140630162028288] L Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 43bfc got 4a768 (4a768) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 445c0 got 4b12c (4b12c) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 44f84 got 4baf0 (4baf0) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 45948 got 4c4b4 (4c4b4) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 4630c got 4ce78 (4ce78) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 46cd0 got 4d83c (4d83c) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 47694 got 4e200 (4e200) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 48058 got 4ebc4 (4ebc4) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 48a1c got 4f588 (4f588) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 493e0 got 4ff4c (4ff4c) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 49da4 got 50910 (50910) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 4a768 got 512d4 (512d4) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 4b12c got 51c98 (51c98) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 4baf0 got 5265c (5265c) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 4c4b4 got 53020 (53020) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 4ce78 got 539e4 (539e4) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 4d83c got 543a8 (543a8) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 4e200 got 54d6c (54d6c) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 4ebc4 got 55730 (55730) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 4f588 got 560f4 (560f4) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 4ff4c got 56ab8 (56ab8) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 50910 got 5747c (5747c) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 512d4 got 57e40 (57e40) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 51c98 got 58804 (58804) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 5265c got 591c8 (591c8) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 53020 got 59b8c (59b8c) diff=6b6c Tue Dec 4 14:24:22 2018 DMAIN <0000> Transceiver.cpp:724 [tid=140630226458368] chan 1: command is TXTUNE 1877400 Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:604 [tid=140630226458368] chan 1: Setting Tx Freq to 1.8774e+09 Hz Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 539e4 got 5a550 (5a550) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 543a8 got 5af14 (5af14) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 54d6c got 5b8d8 (5b8d8) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 55730 got 5c29c (5c29c) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 560f4 got 5cc60 (5cc60) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 56ab8 got 5d624 (5d624) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 5747c got 5dfe8 (5dfe8) diff=6b6c Tue Dec 4 14:24:22 2018 DLMS <0002> LMSDevice.cpp:83 [tid=140630162028288] L Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 57e40 got 5e9ac (5e9ac) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 58804 got 5f370 (5f370) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 591c8 got 5fd34 (5fd34) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 59b8c got 606f8 (606f8) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 5a550 got 610bc (610bc) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 5af14 got 61a80 (61a80) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 5b8d8 got 62444 (62444) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 5c29c got 62e08 (62e08) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 5cc60 got 637cc (637cc) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 5d624 got 64190 (64190) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 5dfe8 got 64b54 (64b54) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 5e9ac got 65518 (65518) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 5f370 got 65edc (65edc) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 5fd34 got 668a0 (668a0) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 606f8 got 67264 (67264) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 610bc got 67c28 (67c28) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 61a80 got 685ec (685ec) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 62444 got 68fb0 (68fb0) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 62e08 got 69974 (69974) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 637cc got 6a338 (6a338) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 64190 got 6acfc (6acfc) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 64b54 got 6b6c0 (6b6c0) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 65518 got 6c084 (6c084) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 65edc got 6ca48 (6ca48) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 668a0 got 6d40c (6d40c) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 67264 got 6ddd0 (6ddd0) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 67c28 got 6e794 (6e794) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 685ec got 6f158 (6f158) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 68fb0 got 6fb1c (6fb1c) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 69974 got 704e0 (704e0) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 6a338 got 70ea4 (70ea4) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 6acfc got 71868 (71868) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 6b6c0 got 7222c (7222c) diff=6b6c Tue Dec 4 14:24:22 2018 DLMS <0002> LMSDevice.cpp:83 [tid=140630162028288] L Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 6c084 got 72bf0 (72bf0) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 6ca48 got 735b4 (735b4) diff=6b6c Tue Dec 4 14:24:22 2018 DLMS <0002> LMSDevice.cpp:83 [tid=140630226458368] SetNCOFrequency(index = 0) - Frequency(0.4 MHz) out of range [0-0.270833) MHz Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 6d40c got 73f78 (73f78) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 6ddd0 got 7493c (7493c) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 6e794 got 75300 (75300) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 6f158 got 75cc4 (75cc4) diff=6b6c Tue Dec 4 14:24:22 2018 DLMS <0002> LMSDevice.cpp:83 [tid=140630226458368] SetNCOFrequency(index = 0) - Frequency(0.4 MHz) out of range [0-0.270833) MHz Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 6fb1c got 76688 (76688) diff=6b6c Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 704e0 got 7704c (7704c) diff=6b6c Tue Dec 4 14:24:22 2018 DMAIN <0000> osmo-trx.cpp:449 [tid=140630265782784] Shutting down transceiver... Tue Dec 4 14:24:22 2018 DMAIN <0000> Transceiver.cpp:307 [tid=140630265782784] Stopping the transceiver Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:530 [tid=140630223529728] chan 0 recv buffer of len 2500 expect 70ea4 got 77a10 (77a10) diff=6b6c Tue Dec 4 14:24:22 2018 DMAIN <0000> Transceiver.cpp:320 [tid=140630265782784] Stopping the device Tue Dec 4 14:24:22 2018 DMAIN <0000> Transceiver.cpp:724 [tid=140630226458368] chan 1: command is SETTSC 7 Tue Dec 4 14:24:22 2018 DMAIN <0000> Transceiver.cpp:826 [tid=140630226458368] Changing TSC from 7 to 7 Tue Dec 4 14:24:22 2018 DMAIN <0000> Transceiver.cpp:724 [tid=140630226458368] chan 1: command is SETRXGAIN 1 Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:345 [tid=140630226458368] chan 1: Setting RX gain to 1 dB Tue Dec 4 14:24:22 2018 DMAIN <0000> Transceiver.cpp:724 [tid=140630226458368] chan 1: command is SETPOWER 0 Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:330 [tid=140630226458368] chan 1: Setting TX gain to 73 dB Tue Dec 4 14:24:22 2018 DMAIN <0000> Transceiver.cpp:724 [tid=140630226458368] chan 1: command is SETSLOT 0 1 Tue Dec 4 14:24:22 2018 DMAIN <0000> Transceiver.cpp:724 [tid=140630226458368] chan 1: command is SETSLOT 1 7 Tue Dec 4 14:24:22 2018 DMAIN <0000> Transceiver.cpp:724 [tid=140630226458368] chan 1: command is SETSLOT 2 1 Tue Dec 4 14:24:22 2018 DMAIN <0000> Transceiver.cpp:724 [tid=140630226458368] chan 1: command is SETSLOT 3 1 Tue Dec 4 14:24:22 2018 DMAIN <0000> Transceiver.cpp:724 [tid=140630226458368] chan 1: command is SETSLOT 4 1 Tue Dec 4 14:24:22 2018 DMAIN <0000> Transceiver.cpp:724 [tid=140630226458368] chan 1: command is SETSLOT 5 1 Tue Dec 4 14:24:22 2018 DMAIN <0000> Transceiver.cpp:724 [tid=140630226458368] chan 1: command is SETSLOT 6 13 Tue Dec 4 14:24:22 2018 DMAIN <0000> Transceiver.cpp:724 [tid=140630226458368] chan 1: command is SETSLOT 7 13 Tue Dec 4 14:24:22 2018 DLMS <0002> LMSDevice.cpp:83 [tid=140630153635584] popping from TX, samples popped 230/510 Tue Dec 4 14:24:22 2018 DMAIN <0000> Transceiver.cpp:333 [tid=140630265782784] Transceiver stopped Tue Dec 4 14:24:22 2018 DDEV <0001> LMSDevice.cpp:62 [tid=140630265782784] Closing LMS device
Updated by pespin over 5 years ago
- Subject changed from osmo-trx-lms "R_CTL_LPF range limit reached" to osmo-trx-lms: Multi channel support: "R_CTL_LPF range limit reached"
Updated by pespin about 5 years ago
- Status changed from New to In Progress
I'm retaking this task after all previous improvements in osmo-trx-lms (smpl_buf, rate_ctr, roh's re-arranging of API calls, etc.)
Running with latest LimeSuite (19.04 or around).
Using following cfg in osmo-bts-trx:
phy 0 osmotrx ip local 192.168.30.1 osmotrx ip remote 192.168.30.100 instance 0 osmotrx rx-gain 1 instance 1 osmotrx rx-gain 1 ... trx 0 phy 0 instance 0 trx 1 phy 0 instance 1
And in osmo-trx-lms.cfg (may need to use BAND2 there?):
chan 0 tx-path BAND1 rx-path LNAW chan 1 tx-path BAND1 rx-path LNAW
When BTS tries to set ARFCNs (870 and 872 in DCS1800):
SUMMARY: AddressSanitizer: 12 byte(s) leaked in 1 allocation(s). Tue Jun 4 18:11:28 2019 DLMS <0003> LMSDevice.cpp:92 [tid=139703091786240] RemoteControl Listening on port: 5000 Tue Jun 4 18:11:29 2019 DLMS <0003> LMSDevice.cpp:92 [tid=139703091786240] Reference clock 30.72 MHz Tue Jun 4 18:11:29 2019 DDEV <0002> LMSDevice.cpp:190 [tid=139703091786240] Init LMS device Tue Jun 4 18:11:29 2019 DDEV <0002> LMSDevice.cpp:203 [tid=139703091786240] Setting Internal clock reference Tue Jun 4 18:11:29 2019 DLMS <0003> LMSDevice.cpp:92 [tid=139703091786240] Disabling external reference clock Tue Jun 4 18:11:29 2019 DDEV <0002> LMSDevice.cpp:97 [tid=139703091786240] Sample Rate: Min=100000 Max=6.144e+07 Step=1.97626e-323 Tue Jun 4 18:11:29 2019 DDEV <0002> LMSDevice.cpp:226 [tid=139703091786240] Setting sample rate to 1.08333e+06 4 Tue Jun 4 18:11:29 2019 DDEV <0002> LMSDevice.cpp:232 [tid=139703091786240] Sample Rate: Host=1.08333e+06 RF=3.46667e+07 Tue Jun 4 18:11:29 2019 DMAIN <0000> LMSDevice.cpp:209 [tid=139703091786240] Antennas configured successfully Tue Jun 4 18:11:29 2019 DMAIN <0000> Threads.cpp:116 [tid=139703052617472] Thread 139703052617472 (task 26528) set name: CtrlService0 Tue Jun 4 18:11:29 2019 DMAIN <0000> Threads.cpp:116 [tid=139703052490496] Thread 139703052490496 (task 26529) set name: CtrlService1 Tue Jun 4 18:11:29 2019 DMAIN <0000> osmo-trx.cpp:526 [tid=139703091786240] -- Transceiver active with 2 channel(s) Tue Jun 4 18:11:30 2019 DTRXCTRL <0001> Transceiver.cpp:717 [tid=139703052617472][chan=0] command is 'POWEROFF' Tue Jun 4 18:11:30 2019 DTRXCTRL <0001> Transceiver.cpp:848 [tid=139703052617472][chan=0] response is 'RSP POWEROFF 0' Tue Jun 4 18:11:30 2019 DTRXCTRL <0001> Transceiver.cpp:717 [tid=139703052617472][chan=0] command is 'RXTUNE 1781800' Tue Jun 4 18:11:30 2019 DDEV <0002> LMSDevice.cpp:763 [tid=139703052617472][chan=0] Setting Rx Freq to 1.7818e+09 Hz Tue Jun 4 18:11:30 2019 DTRXCTRL <0001> Transceiver.cpp:717 [tid=139703052490496][chan=1] command is 'RXTUNE 1782200' Tue Jun 4 18:11:30 2019 DDEV <0002> LMSDevice.cpp:763 [tid=139703052490496][chan=1] Setting Rx Freq to 1.7822e+09 Hz Tue Jun 4 18:11:30 2019 DLMS <0003> LMSDevice.cpp:92 [tid=139703052617472] SetFrequencySXR(1781.8 MHz) - cannot deliver frequency Tue Jun 4 18:11:30 2019 DDEV <0002> LMSDevice.cpp:766 [tid=139703052617472][chan=0] Error setting Rx Freq to 1.7818e+09 Hz Tue Jun 4 18:11:30 2019 DTRXCTRL <0001> Transceiver.cpp:796 [tid=139703052617472] RX failed to tune Tue Jun 4 18:11:30 2019 DTRXCTRL <0001> Transceiver.cpp:848 [tid=139703052617472][chan=0] response is 'RSP RXTUNE 1 1781800' Tue Jun 4 18:11:30 2019 DTRXCTRL <0001> Transceiver.cpp:848 [tid=139703052490496][chan=1] response is 'RSP RXTUNE 0 1782200'
Notice how chan=0 and chan=1 calls/returns are interleaved due to each chan running its CTRL socket on a different thread. We actually need to make sure the API is thread-safe.
Updated by pespin almost 5 years ago
I disabled for now multitrx tests in osmo-gsm-tester since this feature doesn't work yet and those test seem to create problems with the other ones, see #4151.
Updated by pespin almost 5 years ago
- Related to Bug #4151: osmo-gsm-tester: osmo-trx-lms process sometimes kept forever in zombie-alike state after killing it added
Updated by pespin over 4 years ago
- Related to Bug #4207: multi-arfcn not working properly added
Updated by pespin over 4 years ago
- Related to Feature #4362: osmo-trx-lms: Support multi-arfcn feature added
Updated by pespin over 4 years ago
According to [1]:
channels A and B uses the same PLL clock so different frequencies can only be achieved by shifting digitally (using NCO). Digital shift is limited by RF bandwidth that is being sampled.
channels A and B are really only useful for MIMO and not for anything else, such as operating independend receivers/transmitters on different frequencies.
So we cannot support multi-channel with osmo-trx-lms. I'm opening a separate ticket regarding multi-arfcn support. Let's do that in #4362