8 Sep
2016
8 Sep
'16
12:56 p.m.
Dear Tom and List,
I am in the process of updating the wiki for USRP radios, therefor I am recompiling
everything Osmocom related with the latest master branches.
I managed to setup the system, the CS services are working just fine (only fullrate and
SMS is tested yet), but the GPRS service seems to be not working. I am using my well
tested setup on 1800MHz (ARFCN 885), with duplex filters.
On the Osmo-BTS end I get this message:
<0007> l1sap.c:957 RACH for packet access
<0007> l1sap.c:957 RACH for packet access
<0007> l1sap.c:957 RACH for packet access
<0007> l1sap.c:957 RACH for packet access
<0007> l1sap.c:957 RACH for packet access
<0007> l1sap.c:957 RACH for packet access
<0007> l1sap.c:957 RACH for packet access
<0007> l1sap.c:957 RACH for packet access
<0007> l1sap.c:957 RACH for packet access
<0007> l1sap.c:957 RACH for packet access
<0007> l1sap.c:957 RACH for packet access
<0007> l1sap.c:957 RACH for packet access
<0007> l1sap.c:957 RACH for packet access
<0007> l1sap.c:957 RACH for packet access
<0007> l1sap.c:957 RACH for packet access
Osmo-PCU in the same time shows the following (repeatedly):
Thu Sep 8 12:48:30 2016 DRLCMAC <0002> tbf.cpp:819 TBF(TFI=0 TLLI=0x00000000 DIR=UL
STATE=WAIT ASSIGN) timer 3169 expired.
Thu Sep 8 12:48:30 2016 DRLCMAC <0002> tbf.cpp:874 TBF(TFI=0 TLLI=0x00000000 DIR=UL
STATE=WAIT ASSIGN) T3169 timeout during transsmission
Thu Sep 8 12:48:30 2016 DRLCMAC <0002> tbf.cpp:893 - Assignment was on CCCH
Thu Sep 8 12:48:30 2016 DRLCMAC <0002> tbf.cpp:899 - No uplink data received yet
Thu Sep 8 12:48:30 2016 DRLCMAC <0002> tbf.cpp:879 TBF(TFI=0 TLLI=0x00000000 DIR=UL
STATE=WAIT ASSIGN) will be freed due to timeout
Thu Sep 8 12:48:30 2016 DRLCMAC <0002> tbf.cpp:334 TBF(TFI=0 TLLI=0x00000000 DIR=UL
STATE=WAIT ASSIGN) free
Thu Sep 8 12:48:30 2016 DRLCMAC <0002> bts.cpp:1501 PDCH(TS 6, TRX 0): Detaching
TBF(TFI=0 TLLI=0x00000000 DIR=UL STATE=WAIT ASSIGN), 0 TBFs, USFs = 00, TFIs = 00000000.
Thu Sep 8 12:48:30 2016 DRLCMAC <0002> gprs_ms.cpp:323 Detaching TBF from MS
object, TLLI = 0x00000000, TBF = TBF(TFI=0 TLLI=0x00000000 DIR=UL STATE=WAIT ASSIGN)
Thu Sep 8 12:48:30 2016 DRLCMAC <0002> gprs_ms.cpp:140 Destroying MS object, TLLI =
0x00000000
Thu Sep 8 12:48:30 2016 DRLCMAC <0002> tbf.cpp:355 ********** TBF ends here
**********
Thu Sep 8 12:48:31 2016 DRLCMAC <0002> bts.cpp:486 MS requests UL TBF on RACH, so
we provide one:
Thu Sep 8 12:48:31 2016 DRLCMAC <0002> tbf.cpp:672 ********** TBF starts here
**********
Thu Sep 8 12:48:31 2016 DRLCMAC <0002> tbf.cpp:674 Allocating UL TBF: MS_CLASS=0/0
Thu Sep 8 12:48:31 2016 DRLCMAC <0002> gprs_ms.cpp:114 Creating MS object, TLLI =
0x00000000
Thu Sep 8 12:48:31 2016 DRLCMAC <0002> bts.cpp:413 Searching for first unallocated
TFI: TRX=0
Thu Sep 8 12:48:31 2016 DRLCMAC <0002> bts.cpp:423 Found TFI=0.
Thu Sep 8 12:48:31 2016 DRLCMAC <0002> gprs_rlcmac_ts_alloc.cpp:525 Slot Allocation
(Algorithm B) for unknown class (assuming 12)
Thu Sep 8 12:48:31 2016 DRLCMAC <0002> gprs_rlcmac_ts_alloc.cpp:560 - Rx=4 Tx=4 Sum
Rx+Tx=5 Tta=2 Ttb=1 Tra=2 Trb=1 Type=1
Thu Sep 8 12:48:31 2016 DRLCMAC <0002> gprs_rlcmac_ts_alloc.cpp:157 - Skipping TS
0, because not enabled
Thu Sep 8 12:48:31 2016 DRLCMAC <0002> gprs_rlcmac_ts_alloc.cpp:157 - Skipping TS
1, because not enabled
Thu Sep 8 12:48:31 2016 DRLCMAC <0002> gprs_rlcmac_ts_alloc.cpp:157 - Skipping TS
2, because not enabled
Thu Sep 8 12:48:31 2016 DRLCMAC <0002> gprs_rlcmac_ts_alloc.cpp:157 - Skipping TS
3, because not enabled
Thu Sep 8 12:48:31 2016 DRLCMAC <0002> gprs_rlcmac_ts_alloc.cpp:579 - Possible
DL/UL slots: (TS=0)"....CCCC"(TS=7)
Thu Sep 8 12:48:31 2016 DRLCMAC <0002> gprs_rlcmac_ts_alloc.cpp:940 - Selected UL
slots: (TS=0)"......U."(TS=7), single
Thu Sep 8 12:48:31 2016 DRLCMAC <0002> gprs_rlcmac_ts_alloc.cpp:966 Using single
slot at TS 6 for UL
Thu Sep 8 12:48:31 2016 DRLCMAC <0002> gprs_rlcmac_ts_alloc.cpp:990 - Reserved
DL/UL slots: (TS=0)"......C."(TS=7)
Thu Sep 8 12:48:31 2016 DRLCMAC <0002> gprs_rlcmac_ts_alloc.cpp:1017 - Assigning UL
TS 6
Thu Sep 8 12:48:31 2016 DRLCMAC <0002> bts.cpp:1481 PDCH(TS 6, TRX 0): Attaching
TBF(TFI=0 TLLI=0x00000000 DIR=UL STATE=NULL), 1 TBFs, USFs = 01, TFIs = 00000001.
Thu Sep 8 12:48:31 2016 DRLCMAC <0002> tbf.cpp:385 - Setting Control TS 6
Thu Sep 8 12:48:31 2016 DRLCMAC <0002> gprs_ms.cpp:267 Attaching TBF to MS object,
TLLI = 0x00000000, TBF = TBF(TFI=0 TLLI=0x00000000 DIR=UL STATE=NULL)
Thu Sep 8 12:48:31 2016 DRLCMAC <0002> tbf.cpp:625 Allocated TBF(TFI=0
TLLI=0x00000000 DIR=UL STATE=NULL): trx = 0, ul_slots = 40, dl_slots = 00
Thu Sep 8 12:48:31 2016 DRLCMAC <0002> bts.cpp:291 TBF(TFI=0 TLLI=0x00000000 DIR=UL
STATE=NULL) changes state from NULL to FLOW
Thu Sep 8 12:48:31 2016 DRLCMAC <0002> tbf.cpp:409 TBF(TFI=0 TLLI=0x00000000 DIR=UL
STATE=FLOW) starting timer 3169.
Thu Sep 8 12:48:31 2016 DRLCMAC <0002> bts.cpp:530 TBF(TFI=0 TLLI=0x00000000 DIR=UL
STATE=FLOW) [UPLINK] START
Thu Sep 8 12:48:31 2016 DRLCMAC <0002> bts.cpp:534 TBF(TFI=0 TLLI=0x00000000 DIR=UL
STATE=FLOW) RX: [PCU <- BTS] RACH qbit-ta=0 ra=0x78, Fn=1011875 (27,35,7)
Thu Sep 8 12:48:31 2016 DRLCMAC <0002> bts.cpp:536 TBF(TFI=0 TLLI=0x00000000 DIR=UL
STATE=FLOW) TX: START Immediate Assignment Uplink (AGCH)
Thu Sep 8 12:48:31 2016 DRLCMAC <0002> bts.cpp:549 - TRX=0 (885) TS=6 TA=0 TSC=7
TFI=0 USF=0
Thu Sep 8 12:48:31 2016 DRLCMAC <0002> bts.cpp:291 TBF(TFI=0 TLLI=0x00000000 DIR=UL
STATE=FLOW) changes state from FLOW to WAIT ASSIGN
Thu Sep 8 12:48:33 2016 DBSSGP <0009> gprs_bssgp_pcu.cpp:792 Sending flow control
info on BVCI 2
Thu Sep 8 12:48:33 2016 DBSSGP <0009> gprs_bssgp_pcu.cpp:705 Computed BVC leak rate
= 10000, num_pdch = 4, cs = CS-4
Thu Sep 8 12:48:33 2016 DBSSGP <0009> gprs_bssgp_pcu.cpp:729 Computed MS default
leak rate = 10000, ms_num_pdch = 4, cs = CS-4
Thu Sep 8 12:48:33 2016 DBSSGP <0009> gprs_bssgp_pcu.cpp:758 Sending FLOW CONTROL
BVC, Bmax = 100000, R = 10000, Bmax_MS = 100000, R_MS = 10000, avg_dly = 0
Thu Sep 8 12:48:33 2016 DBSSGP <0009> gprs_bssgp_pcu.cpp:385 rx BVCI_PTP
gprs_bssgp_rx_ptp
Thu Sep 8 12:48:33 2016 DBSSGP <0009> gprs_bssgp_pcu.cpp:245 rx
BSSGP_PDUT_FLOW_CONTROL_BVC_ACK
Thu Sep 8 12:48:36 2016 DRLCMAC <0002> tbf.cpp:819 TBF(TFI=0 TLLI=0x00000000 DIR=UL
STATE=WAIT ASSIGN) timer 3169 expired.
Thu Sep 8 12:48:36 2016 DRLCMAC <0002> tbf.cpp:874 TBF(TFI=0 TLLI=0x00000000 DIR=UL
STATE=WAIT ASSIGN) T3169 timeout during transsmission
Thu Sep 8 12:48:36 2016 DRLCMAC <0002> tbf.cpp:893 - Assignment was on CCCH
Thu Sep 8 12:48:36 2016 DRLCMAC <0002> tbf.cpp:899 - No uplink data received yet
Thu Sep 8 12:48:36 2016 DRLCMAC <0002> tbf.cpp:879 TBF(TFI=0 TLLI=0x00000000 DIR=UL
STATE=WAIT ASSIGN) will be freed due to timeout
Thu Sep 8 12:48:36 2016 DRLCMAC <0002> tbf.cpp:334 TBF(TFI=0 TLLI=0x00000000 DIR=UL
STATE=WAIT ASSIGN) free
Thu Sep 8 12:48:36 2016 DRLCMAC <0002> bts.cpp:1501 PDCH(TS 6, TRX 0): Detaching
TBF(TFI=0 TLLI=0x00000000 DIR=UL STATE=WAIT ASSIGN), 0 TBFs, USFs = 00, TFIs = 00000000.
Thu Sep 8 12:48:36 2016 DRLCMAC <0002> gprs_ms.cpp:323 Detaching TBF from MS
object, TLLI = 0x00000000, TBF = TBF(TFI=0 TLLI=0x00000000 DIR=UL STATE=WAIT ASSIGN)
Thu Sep 8 12:48:36 2016 DRLCMAC <0002> gprs_ms.cpp:140 Destroying MS object, TLLI =
0x00000000
Thu Sep 8 12:48:36 2016 DRLCMAC <0002> tbf.cpp:355 ********** TBF ends here
**********
Thu Sep 8 12:48:36 2016 DRLCMAC <0002> bts.cpp:486 MS requests UL TBF on RACH, so
we provide one:
Thu Sep 8 12:48:36 2016 DRLCMAC <0002> tbf.cpp:672 ********** TBF starts here
**********
Thu Sep 8 12:48:36 2016 DRLCMAC <0002> tbf.cpp:674 Allocating UL TBF: MS_CLASS=0/0
Thu Sep 8 12:48:36 2016 DRLCMAC <0002> gprs_ms.cpp:114 Creating MS object, TLLI =
0x00000000
Thu Sep 8 12:48:36 2016 DRLCMAC <0002> bts.cpp:413 Searching for first unallocated
TFI: TRX=0
Thu Sep 8 12:48:36 2016 DRLCMAC <0002> bts.cpp:423 Found TFI=0.
Thu Sep 8 12:48:36 2016 DRLCMAC <0002> gprs_rlcmac_ts_alloc.cpp:525 Slot Allocation
(Algorithm B) for unknown class (assuming 12)
Thu Sep 8 12:48:36 2016 DRLCMAC <0002> gprs_rlcmac_ts_alloc.cpp:560 - Rx=4 Tx=4 Sum
Rx+Tx=5 Tta=2 Ttb=1 Tra=2 Trb=1 Type=1
Thu Sep 8 12:48:36 2016 DRLCMAC <0002> gprs_rlcmac_ts_alloc.cpp:157 - Skipping TS
0, because not enabled
Thu Sep 8 12:48:36 2016 DRLCMAC <0002> gprs_rlcmac_ts_alloc.cpp:157 - Skipping TS
1, because not enabled
Thu Sep 8 12:48:36 2016 DRLCMAC <0002> gprs_rlcmac_ts_alloc.cpp:157 - Skipping TS
2, because not enabled
Thu Sep 8 12:48:36 2016 DRLCMAC <0002> gprs_rlcmac_ts_alloc.cpp:157 - Skipping TS
3, because not enabled
Thu Sep 8 12:48:36 2016 DRLCMAC <0002> gprs_rlcmac_ts_alloc.cpp:579 - Possible
DL/UL slots: (TS=0)"....CCCC"(TS=7)
Thu Sep 8 12:48:36 2016 DRLCMAC <0002> gprs_rlcmac_ts_alloc.cpp:940 - Selected UL
slots: (TS=0)"......U."(TS=7), single
Thu Sep 8 12:48:36 2016 DRLCMAC <0002> gprs_rlcmac_ts_alloc.cpp:966 Using single
slot at TS 6 for UL
Thu Sep 8 12:48:36 2016 DRLCMAC <0002> gprs_rlcmac_ts_alloc.cpp:990 - Reserved
DL/UL slots: (TS=0)"......C."(TS=7)
Thu Sep 8 12:48:36 2016 DRLCMAC <0002> gprs_rlcmac_ts_alloc.cpp:1017 - Assigning UL
TS 6
Thu Sep 8 12:48:36 2016 DRLCMAC <0002> bts.cpp:1481 PDCH(TS 6, TRX 0): Attaching
TBF(TFI=0 TLLI=0x00000000 DIR=UL STATE=NULL), 1 TBFs, USFs = 01, TFIs = 00000001.
Thu Sep 8 12:48:36 2016 DRLCMAC <0002> tbf.cpp:385 - Setting Control TS 6
Thu Sep 8 12:48:36 2016 DRLCMAC <0002> gprs_ms.cpp:267 Attaching TBF to MS object,
TLLI = 0x00000000, TBF = TBF(TFI=0 TLLI=0x00000000 DIR=UL STATE=NULL)
Thu Sep 8 12:48:36 2016 DRLCMAC <0002> tbf.cpp:625 Allocated TBF(TFI=0
TLLI=0x00000000 DIR=UL STATE=NULL): trx = 0, ul_slots = 40, dl_slots = 00
Thu Sep 8 12:48:36 2016 DRLCMAC <0002> bts.cpp:291 TBF(TFI=0 TLLI=0x00000000 DIR=UL
STATE=NULL) changes state from NULL to FLOW
Thu Sep 8 12:48:36 2016 DRLCMAC <0002> tbf.cpp:409 TBF(TFI=0 TLLI=0x00000000 DIR=UL
STATE=FLOW) starting timer 3169.
Thu Sep 8 12:48:36 2016 DRLCMAC <0002> bts.cpp:530 TBF(TFI=0 TLLI=0x00000000 DIR=UL
STATE=FLOW) [UPLINK] START
Thu Sep 8 12:48:36 2016 DRLCMAC <0002> bts.cpp:534 TBF(TFI=0 TLLI=0x00000000 DIR=UL
STATE=FLOW) RX: [PCU <- BTS] RACH qbit-ta=0 ra=0x79, Fn=1013049 (27,36,11)
Thu Sep 8 12:48:36 2016 DRLCMAC <0002> bts.cpp:536 TBF(TFI=0 TLLI=0x00000000 DIR=UL
STATE=FLOW) TX: START Immediate Assignment Uplink (AGCH)
Thu Sep 8 12:48:36 2016 DRLCMAC <0002> bts.cpp:549 - TRX=0 (885) TS=6 TA=0 TSC=7
TFI=0 USF=0
Thu Sep 8 12:48:36 2016 DRLCMAC <0002> bts.cpp:291 TBF(TFI=0 TLLI=0x00000000 DIR=UL
STATE=FLOW) changes state from FLOW to WAIT ASSIGN
Thu Sep 8 12:48:41 2016 DRLCMAC <0002> tbf.cpp:819 TBF(TFI=0 TLLI=0x00000000 DIR=UL
STATE=WAIT ASSIGN) timer 3169 expired.
Thu Sep 8 12:48:41 2016 DRLCMAC <0002> tbf.cpp:874 TBF(TFI=0 TLLI=0x00000000 DIR=UL
STATE=WAIT ASSIGN) T3169 timeout during transsmission
The SGSN and GGSN logs are empty.
The RX gain is on 5dB, the UHD version is 3.10.0-release. Only GPRS is allowed so far on 4
PDCHs.
Osmo-TRX is started with default set:
Config Settings
Log Level............... NOTICE
Device args.............
TRX Base Port........... 5700
TRX Address............. 127.0.0.1
Channels................ 1
Tx Samples-per-Symbol... 4
Rx Samples-per-Symbol... 1
EDGE support............ Disabled
Reference............... Internal
C0 Filler Table......... Disabled
Multi-Carrier........... Disabled
Diversity............... Disabled
Tuning offset........... 0
RSSI to dBm offset...... 0
Swap channels........... 0
The CS call and SMS are both working fine, the audio quality is quite good.
Can someone give me a hint where this goes wrong? From what I see the PRACH is failing to
succeed.
Regards,
Csaba