[srslte-users] Failed to get Release 10(?) bcch_dlsch messages.
Ismael Gomez
ismael.gomez at softwareradiosystems.com
Mon May 30 22:05:03 UTC 2016
Hi Enes,
Thanks for providing these files. I could access the symbols in the core
dump.
Nonetheless, I created a branch for printing some info whenever there is a
DCI grant with 0 TBS. Can you try to run it and send the logs and screen
output please? The branch is name is "test_enes"
Thanks
On Mon, 30 May 2016 at 20:52 Enes ÜNAL <aenesunal at gmail.com> wrote:
> I suppress the segfault and here is the ue.log:
>
> 21:49:53.534 [MAC ] Info [00000] Resetting MAC
> 21:49:53.536 [MAC ] Info [00000] Waiting PHY to synchronize with cell
> 21:49:54.868 [RLC ] Info BCCH BCH message received.
> 0000: 61 24 00
> 21:49:54.868 [RRC ] Info BCCH BCH message received.
> 0000: 61 24 00
> 21:49:54.868 [RRC ] Info BCCH BCH message Stack latency: 8 us
> 21:49:54.868 [RRC ] Info MIB received BW=10 MHz
> 21:49:59.372 [PHY ] Info [00000] SYNC: Cell found. Synchronizing...
> 21:49:59.375 [PHY ] Info [00000] SYNC: PSS/SSS not found...
> 21:49:59.377 [PHY ] Info [00000] SYNC: PSS/SSS not found...
> 21:49:59.379 [PHY ] Info [00000] SYNC: PSS/SSS not found...
> 21:49:59.384 [RRC ] Info Detected 1 out-of-sync from PHY. Starting T310
> timer
> 21:49:59.386 [PHY ] Info [00000] SYNC: Decoding MIB...
> 21:49:59.387 [PHY ] Info [00000] SYNC: DONE, TTI=7440, sfn_offset=0
> 21:49:59.396 [RRC ] Info Detected 1 in-sync from PHY. Stopping T310
> timer
> 21:49:59.431 [MAC ] Info [00000] SCHED: Searching for DL grant for
> SI-RNTI window_st=7505, window_len=1
> 21:49:59.436 [MAC ] Info [07491] BSR: QUEUE status: 0 (0), 0 (0), 0
> (0), 0 (0), 0 (0), 0 (0),
> 21:49:59.452 [PHY ] Info [07505] PDCCH: DL DCI 1C cce_index=12,
> n_data_bits=13, partial_time=1069 us
> 21:49:59.452 [PHY ] Info [07505] PDSCH: l_crb= 4, harq=0, tbs=0, mcs=0,
> rv=1, crc=OK, snr=-4.9 dB, n_iter=0, dec_time= 90 us
> 21:49:59.452 [RLC ] Info BCCH DLSCH message received.
> 21:49:59.452 [MAC ] Info [07506] DL 8: newTX tbs=0, rv=1, ack=OK,
> ndi=0 (0), tti=7505 (0)
> 21:49:59.541 [MAC ] Info [07596] SCHED: Searching for DL grant for
> SI-RNTI window_st=7605, window_len=1
> 21:49:59.551 [PHY ] Info [07605] PDCCH: DL DCI 1C cce_index= 4,
> n_data_bits=13, partial_time= 544 us
> 21:49:59.551 [PHY ] Info [07605] PDSCH: l_crb= 4, harq=0, tbs=0, mcs=0,
> rv=0, crc=OK, snr=-4.9 dB, n_iter=0, dec_time= 46 us
> 21:49:59.551 [RLC ] Info BCCH DLSCH message received.
> 21:49:59.552 [MAC ] Info [07606] DL 8: newTX tbs=0, rv=0, ack=OK,
> ndi=0 (0), tti=7605 (0)
> 21:49:59.651 [MAC ] Info [07706] SCHED: Searching for DL grant for
> SI-RNTI window_st=7725, window_len=1
> 21:49:59.672 [PHY ] Info [07725] PDCCH: DL DCI 1C cce_index= 4,
> n_data_bits=13, partial_time= 817 us
> 21:49:59.672 [PHY ] Info [07725] PDSCH: l_crb= 4, harq=0, tbs=0, mcs=0,
> rv=3, crc=OK, snr=-4.9 dB, n_iter=0, dec_time= 74 us
> 21:49:59.672 [RLC ] Info BCCH DLSCH message received.
> 21:49:59.672 [MAC ] Info [07726] DL 8: newTX tbs=0, rv=3, ack=OK,
> ndi=0 (0), tti=7725 (0)
> 21:49:59.761 [MAC ] Info [07816] SCHED: Searching for DL grant for
> SI-RNTI window_st=7825, window_len=1
> 21:49:59.771 [PHY ] Info [07825] PDCCH: DL DCI 1C cce_index=12,
> n_data_bits=13, partial_time= 579 us
> 21:49:59.771 [PHY ] Info [07825] PDSCH: l_crb= 4, harq=0, tbs=0, mcs=0,
> rv=1, crc=OK, snr=-4.9 dB, n_iter=0, dec_time= 44 us
> 21:49:59.772 [RLC ] Info BCCH DLSCH message received.
> 21:49:59.772 [MAC ] Info [07826] DL 8: newTX tbs=0, rv=1, ack=OK,
> ndi=0 (0), tti=7825 (0)
>
>
> 30 May 2016 Pzt, 20:55 tarihinde, Ismael Gomez <
> ismael.gomez at softwareradiosystems.com> şunu yazdı:
>
>> Can you send the dumped core from srsUE and the ue.log file please? Set
>> the logging to info for all layers please. Release 10 should be backwards
>> compatible with Release 8 so that shouldn't be a problem at all.
>>
>> On Mon, 30 May 2016 at 19:48 Enes ÜNAL <aenesunal at gmail.com> wrote:
>>
>>>
>>> Hello,
>>>
>>> I'm living in Turkey, and there are 3 different operators here. By using
>>> srsUE, I successfully got SIB1, SIB2 messages for 2 operator. However, as I
>>> discovered the third operator is using LTE Release-10
>>> while 2 of them using Release-9.
>>> srsUE is
>>> failed
>>> to
>>> get SIB messages for this
>>> particular
>>> operator.
>>> For every dl_frequencies. Currently the operator have 2 different
>>> center frequencies in 2 different band LTE-800 & LTE-1800.
>>>
>>> You can find tt.cap and tt_sync.cap capture files
>>> in the bottom of this e-mail
>>> generated by followings respectively.
>>>
>>> #################################################################
>>> "./usrp_capture -f 796000000 -o tt.cap"
>>> #################################################################
>>> linux; GNU C++ version 5.3.1 20151219; Boost_105800;
>>> UHD_003.009.002-0-unknown
>>>
>>> Opening RF device...
>>> -- Detected Device: B200mini
>>> -- Operating over USB 3.
>>> -- Initialize CODEC control...
>>> -- Initialize Radio control...
>>> -- Performing register loopback test... pass
>>> -- Performing CODEC loopback test... pass
>>> -- Asking for clock rate 16.000000 MHz...
>>> -- Actually got clock rate 16.000000 MHz.
>>> -- Performing timer loopback test... pass
>>> -- Setting master clock rate selection to 'automatic'.
>>> -- Asking for clock rate 32.000000 MHz...
>>> -- Actually got clock rate 32.000000 MHz.
>>> -- Performing timer loopback test... pass
>>> -- Asking for clock rate 16.000000 MHz...
>>> -- Actually got clock rate 16.000000 MHz.
>>> -- Performing timer loopback test... pass
>>> -- Asking for clock rate 30.720000 MHz...
>>> -- Actually got clock rate 30.720000 MHz.
>>> -- Performing timer loopback test... pass
>>> Set RX freq: 796.00 MHz
>>> Set RX gain: 40.00 dB
>>> Correctly RX rate: 0.96 MHz
>>> ^COk - wrote 777600 samples
>>>
>>> #################################################################
>>> "./usrp_capture_sync -l 279 -f 796000000 -o tt_sync.cap".
>>> #################################################################
>>>
>>> linux; GNU C++ version 5.3.1 20151219; Boost_105800;
>>> UHD_003.009.002-0-unknown
>>>
>>> Opening RF device...
>>> -- Detected Device: B200mini
>>> -- Operating over USB 3.
>>> -- Initialize CODEC control...
>>> -- Initialize Radio control...
>>> -- Performing register loopback test... pass
>>> -- Performing CODEC loopback test... pass
>>> -- Asking for clock rate 16.000000 MHz...
>>> -- Actually got clock rate 16.000000 MHz.
>>> -- Performing timer loopback test... pass
>>> -- Setting master clock rate selection to 'automatic'.
>>> -- Asking for clock rate 32.000000 MHz...
>>> -- Actually got clock rate 32.000000 MHz.
>>> -- Performing timer loopback test... pass
>>> -- Asking for clock rate 16.000000 MHz...
>>> -- Actually got clock rate 16.000000 MHz.
>>> -- Performing timer loopback test... pass
>>> -- Asking for clock rate 30.720000 MHz...
>>> -- Actually got clock rate 30.720000 MHz.
>>> -- Performing timer loopback test... pass
>>> Set RX freq: 796.000000 MHz
>>> Set RX gain: 60.0 dB
>>> -- Asking for clock rate 7.680000 MHz...
>>> -- Actually got clock rate 7.680000 MHz.
>>> -- Performing timer loopback test... pass
>>> Setting sampling rate 1.92 MHz
>>> Using Volk machine: avx2_64_mmx_orc
>>> Ok - wrote 648 subframesubframes.....
>>>
>>> #################################################################
>>> Below you can also find the decoded MIB generated by "pdsch_ue -f
>>> 796000000"
>>> #################################################################
>>>
>>> linux; GNU C++ version 5.3.1 20151219; Boost_105800;
>>> UHD_003.009.002-0-unknown
>>>
>>> Opening RF device...
>>> -- Detected Device: B200mini
>>> -- Operating over USB 3.
>>> -- Initialize CODEC control...
>>> -- Initialize Radio control...
>>> -- Performing register loopback test... pass
>>> -- Performing CODEC loopback test... pass
>>> -- Asking for clock rate 16.000000 MHz...
>>> -- Actually got clock rate 16.000000 MHz.
>>> -- Performing timer loopback test... pass
>>> -- Setting master clock rate selection to 'automatic'.
>>> -- Asking for clock rate 32.000000 MHz...
>>> -- Actually got clock rate 32.000000 MHz.
>>> -- Performing timer loopback test... pass
>>> -- Asking for clock rate 16.000000 MHz...
>>> -- Actually got clock rate 16.000000 MHz.
>>> -- Performing timer loopback test... pass
>>> Starting AGC thread...
>>> -- Asking for clock rate 30.720000 MHz...
>>> -- Actually got clock rate 30.720000 MHz.
>>> -- Performing timer loopback test... pass
>>> Tunning receiver to 796.000 MHz
>>> Searching for cell...
>>> Using Volk machine: avx2_64_mmx_orc
>>> *Found Cell_id: 279 CP: Normal , DetectRatio=100% PSR=17.98,
>>> Power=-12.1 dBm
>>> Found Cell_id: 0 CP: Normal , DetectRatio= 0% PSR=0.00, Power=-inf
>>> dBm
>>> Found Cell_id: 0 CP: Normal , DetectRatio= 0% PSR=0.00, Power=-inf
>>> dBm
>>> Decoding PBCH for cell 279 (N_id_2=0)
>>> -- Asking for clock rate 11.520000 MHz...
>>> -- Actually got clock rate 11.520000 MHz.
>>> -- Performing timer loopback test... pass
>>> Setting sampling rate 11.52 MHz
>>> - Cell ID: 279 5.9, FrameCnt: 0, State: 1
>>> - Nof ports: 2
>>> - CP: Normal
>>> - PRB: 50
>>> - PHICH Length: Normal
>>> - PHICH Resources: 1/6
>>> - SFN: 1020
>>> Decoded MIB. SFN: 1020, offset: 1
>>> CFO: -0.17 kHz, SNR: -nan dB, PDCCH-Miss: -nan%, PDSCH-BLER: inf%
>>> CFO: +0.32 kHz, SNR: -nan dB, PDCCH-Miss: 100.00%, PDSCH-BLER: 100.00%
>>>
>>> #################################################################
>>> When I run srsUE with 796MHz DL freq, I got:
>>> #################################################################
>>>
>>> linux; GNU C++ version 5.3.1 20151219; Boost_105800;
>>> UHD_003.009.002-0-unknown
>>>
>>> --- Software Radio Systems LTE UE ---
>>>
>>> Reading configuration file ue.conf...
>>> Using srsLTE version 001.002.000
>>> -- Detected Device: B200mini
>>> -- Operating over USB 3.
>>> -- Initialize CODEC control...
>>> -- Initialize Radio control...
>>> -- Performing register loopback test... pass
>>> -- Performing CODEC loopback test... pass
>>> -- Asking for clock rate 16.000000 MHz...
>>> -- Actually got clock rate 16.000000 MHz.
>>> -- Performing timer loopback test... pass
>>> -- Setting master clock rate selection to 'automatic'.
>>> -- Asking for clock rate 32.000000 MHz...
>>> -- Actually got clock rate 32.000000 MHz.
>>> -- Performing timer loopback test... pass
>>> -- Asking for clock rate 16.000000 MHz...
>>> -- Actually got clock rate 16.000000 MHz.
>>> -- Performing timer loopback test... pass
>>> Setting frequency: DL=796.0 Mhz, UL=837.0 MHz
>>> Searching for cell...
>>> Using Volk machine: avx2_64_mmx_orc
>>> Found CELL ID: 279 CP: Normal , CFO: -0.1 KHz.
>>> Trying to decode MIB...
>>> - Cell ID: 279
>>> - Nof ports: 2
>>> - CP: Normal
>>> - PRB: 50
>>> - PHICH Length: Normal
>>> - PHICH Resources: 1/6
>>> - SFN: 0
>>> MIB received BW=10 MHz
>>> Initializating cell configuration...
>>> Setting Sampling frequency 11.52 MHz
>>> Segmentation fault (core dumped)
>>>
>>> #################################################################
>>>
>>> I debugged UE, and what I found is quite interesting. In the
>>> phch_worker.cc:373 (commit 9482eee); while filling MAC grant structure,
>>> every time grant->n_bytes is filling as 0 (zero).
>>>
>>> What may cause this problem? Is there any missing part in the UE?
>>>
>>> Thanks in advance,
>>> Best,
>>> Enes.
>>>
>>> -------------------------
>>> tt.cap : https://drive.google.com/open?id=0B96xxEajM94mYklNdmFfMzI3R00
>>> tt_sync.cap :
>>> https://drive.google.com/open?id=0B96xxEajM94mTWVzeFg3T3RzVG8
>>>
>>> _______________________________________________
>>> srslte-users mailing list
>>> srslte-users at lists.softwareradiosystems.com
>>> http://www.softwareradiosystems.com/mailman/listinfo/srslte-users
>>>
>>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <https://lists.srsran.com/pipermail/srsran-users/attachments/20160530/54bb3299/attachment.htm>
More information about the srsran-users
mailing list