Re: [Openbts-discuss] Unable to Connect/Register with OpenBTS-UMTS

[Bokath, C. <Chu...@gt...>]

Hi Tom. 

I have provided the INFO logging statements per your request.  My receive antenna gain is set to 60, my Tx Gain is 69.75dB. I have an omni with an addition 10db gain.  The phone just times out without accessing or any additional processing. 

INFO 140271611385600 18:46:58.6 UMTSRadioModem.cpp:684:detectRACHPreamble: Insert AICH SNR=10.1238 TOA=66.5469 at 8:3262 and 9:3262, last transmit: 14:3258, now: 0:3260rcvTime: 0:3251
INFO 140271221262080 18:46:59.2 Ggsn.cpp:123:miniGgsnReadServiceLoop: ggsn: polling 0 at  18:46:59.2
INFO 140271221262080 18:46:59.2 Ggsn.cpp:118:miniGgsnReadServiceLoop: ggsn: polling at  18:46:59.2
INFO 140271611385600 18:47:00.0 UMTSRadioModem.cpp:684:detectRACHPreamble: Insert AICH SNR=13.4889 TOA=84.9531 at 8:3398 and 9:3398, last transmit: 14:3395, now: 0:3396rcvTime: 0:3387
INFO 140271611385600 18:47:00.3 UMTSRadioModem.cpp:684:detectRACHPreamble: Insert AICH SNR=10.2794 TOA=51.9219 at 14:3428 and 0:3429, last transmit: 14:3425, now: 0:3426rcvTime: 6:3417
INFO 140271221262080 18:47:02.2 Ggsn.cpp:123:miniGgsnReadServiceLoop: ggsn: polling 0 at  18:47:02.2
INFO 140271221262080 18:47:02.2 Ggsn.cpp:118:miniGgsnReadServiceLoop: ggsn: polling at  18:47:02.2
INFO 140271611385600 18:47:02.9 UMTSRadioModem.cpp:684:detectRACHPreamble: Insert AICH SNR=10.9309 TOA=21.0469 at 2:3688 and 3:3688, last transmit: 14:3684, now: 0:3685rcvTime: 9:3676
INFO 140271221262080 18:47:05.2 Ggsn.cpp:123:miniGgsnReadServiceLoop: ggsn: polling 0 at  18:47:05.2
INFO 140271221262080 18:47:05.2 Ggsn.cpp:118:miniGgsnReadServiceLoop: ggsn: polling at  18:47:05.2
INFO 140271611385600 18:47:05.7 UMTSRadioModem.cpp:684:detectRACHPreamble: Insert AICH SNR=10.9717 TOA=11.6406 at 11:3961 and 12:3961, last transmit: 14:3959, now: 0:3960rcvTime: 12:3951
INFO 140271611385600 18:47:06.0 UMTSRadioModem.cpp:684:detectRACHPreamble: Insert AICH SNR=10.9094 TOA=28.3906 at 8:3998 and 9:3998, last transmit: 2:3995, now: 0:3996rcvTime: 0:3987
INFO 140271611385600 18:47:06.2 UMTSRadioModem.cpp:684:detectRACHPreamble: Insert AICH SNR=10.2673 TOA=15.8906 at 8:4022 and 9:4022, last transmit: 14:4019, now: 0:4020rcvTime: 0:4011
INFO 140271611385600 18:47:08.0 UMTSRadioModem.cpp:684:detectRACHPreamble: Insert AICH SNR=10.5762 TOA=67.6406 at 11:97 and 12:97, last transmit: 14:95, now: 0:96rcvTime: 12:87
INFO 140271221262080 18:47:08.2 Ggsn.cpp:123:miniGgsnReadServiceLoop: ggsn: polling 0 at  18:47:08.2
INFO 140271221262080 18:47:08.2 Ggsn.cpp:118:miniGgsnReadServiceLoop: ggsn: polling at  18:47:08.2
INFO 140271221262080 18:47:11.2 Ggsn.cpp:123:miniGgsnReadServiceLoop: ggsn: polling 0 at  18:47:11.2
INFO 140271221262080 18:47:11.2 Ggsn.cpp:118:miniGgsnReadServiceLoop: ggsn: polling at  18:47:11.2
INFO 140271611385600 18:47:13.0 UMTSRadioModem.cpp:684:detectRACHPreamble: Insert AICH SNR=17.9119 TOA=6.01562 at 11:601 and 12:601, last transmit: 14:598, now: 0:599rcvTime: 3:590
INFO 140271611385600 18:47:13.2 UMTSRadioModem.cpp:684:detectRACHPreamble: Insert AICH SNR=11.6927 TOA=87.0781 at 11:617 and 12:617, last transmit: 14:615, now: 0:616rcvTime: 12:607
INFO 140271221262080 18:47:14.2 Ggsn.cpp:123:miniGgsnReadServiceLoop: ggsn: polling 0 at  18:47:14.2
INFO 140271221262080 18:47:14.2 Ggsn.cpp:118:miniGgsnReadServiceLoop: ggsn: polling at  18:47:14.2
INFO 140271221262080 18:47:17.2 Ggsn.cpp:123:miniGgsnReadServiceLoop: ggsn: polling 0 at  18:47:17.2
INFO 140271221262080 18:47:17.2 Ggsn.cpp:118:miniGgsnReadServiceLoop: ggsn: polling at  18:47:17.2
INFO 140271221262080 18:47:20.2 Ggsn.cpp:123:miniGgsnReadServiceLoop: ggsn: polling 0 at  18:47:20.2
INFO 140271221262080 18:47:20.2 Ggsn.cpp:118:miniGgsnReadServiceLoop: ggsn: polling at  18:47:20.2
INFO 140271611385600 18:47:21.0 UMTSRadioModem.cpp:684:detectRACHPreamble: Insert AICH SNR=10.7605 TOA=54.9531 at 11:1401 and 12:1401, last transmit: 14:1399, now: 0:1400rcvTime: 12:1391
INFO 140271221262080 18:47:23.2 Ggsn.cpp:123:miniGgsnReadServiceLoop: ggsn: polling 0 at  18:47:23.2
INFO 140271221262080 18:47:23.2 Ggsn.cpp:118:miniGgsnReadServiceLoop: ggsn: polling at  18:47:23.2
INFO 140271611385600 18:47:23.5 UMTSRadioModem.cpp:684:detectRACHPreamble: Insert AICH SNR=11.4259 TOA=4.01562 at 2:1648 and 3:1648, last transmit: 14:1644, now: 0:1645rcvTime: 9:1636
INFO 140271611385600 18:47:25.3 UMTSRadioModem.cpp:684:detectRACHPreamble: Insert AICH SNR=10.623 TOA=95.2031 at 2:1832 and 3:1832, last transmit: 14:1828, now: 0:1829rcvTime: 9:1820
INFO 140271221262080 18:47:26.2 Ggsn.cpp:123:miniGgsnReadServiceLoop: ggsn: polling 0 at  18:47:26.2
INFO 140271221262080 18:47:26.2 Ggsn.cpp:118:miniGgsnReadServiceLoop: ggsn: polling at  18:47:26.2
INFO 140271611385600 18:47:27.0 UMTSRadioModem.cpp:684:detectRACHPreamble: Insert AICH SNR=10.6303 TOA=14.3281 at 11:2001 and 12:2001, last transmit: 14:1999, now: 0:2000rcvTime: 12:1991
INFO 140271221262080 18:47:29.2 Ggsn.cpp:123:miniGgsnReadServiceLoop: ggsn: polling 0 at  18:47:29.2
INFO 140271221262080 18:47:29.2 Ggsn.cpp:118:miniGgsnReadServiceLoop: ggsn: polling at  18:47:29.2
INFO 140271611385600 18:47:31.1 UMTSRadioModem.cpp:684:detectRACHPreamble: Insert AICH SNR=11.0548 TOA=48.3594 at 2:2416 and 3:2416, last transmit: 14:2412, now: 0:2413rcvTime: 9:2404
INFO 140271221262080 18:47:32.2 Ggsn.cpp:123:miniGgsnReadServiceLoop: ggsn: polling 0 at  18:47:32.2
INFO 140271221262080 18:47:32.2 Ggsn.cpp:118:miniGgsnReadServiceLoop: ggsn: polling at  18:47:32.2
INFO 140271221262080 18:47:35.2 Ggsn.cpp:123:miniGgsnReadServiceLoop: ggsn: polling 0 at  18:47:35.2
INFO 140271221262080 18:47:35.2 Ggsn.cpp:118:miniGgsnReadServiceLoop: ggsn: polling at  18:47:35.2
INFO 140271611385600 18:47:35.7 UMTSRadioModem.cpp:684:detectRACHPreamble: Insert AICH SNR=10.1959 TOA=69.2969 at 14:2876 and 0:2877, last transmit: 14:2873, now: 0:2874rcvTime: 6:2865
INFO 140271611385600 18:47:37.7 UMTSRadioModem.cpp:684:detectRACHPreamble: Insert AICH SNR=11.9805 TOA=78.2031 at 8:3070 and 9:3070, last transmit: 14:3066, now: 0:3068rcvTime: 0:3059
INFO 140271221262080 18:47:38.2 Ggsn.cpp:123:miniGgsnReadServiceLoop: ggsn: polling 0 at  18:47:38.2
INFO 140271221262080 18:47:38.2 Ggsn.cpp:118:miniGgsnReadServiceLoop: ggsn: polling at  18:47:38.2
INFO 140271611385600 18:47:39.9 UMTSRadioModem.cpp:684:detectRACHPreamble: Insert AICH SNR=10.2179 TOA=34.7344 at 11:3289 and 12:3289, last transmit: 14:3286, now: 0:3287rcvTime: 3:3278
INFO 140271611385600 18:47:41.0 UMTSRadioModem.cpp:684:detectRACHPreamble: Insert AICH SNR=11.5583 TOA=91.8906 at 8:3406 and 9:3406, last transmit: 11:3403, now: 0:3404rcvTime: 0:3395
INFO 140271221262080 18:47:41.2 Ggsn.cpp:123:miniGgsnReadServiceLoop: ggsn: polling 0 at  18:47:41.2
INFO 140271221262080 18:47:41.2 Ggsn.cpp:118:miniGgsnReadServiceLoop: ggsn: polling at  18:47:41.2
INFO 140271611385600 18:47:42.4 UMTSRadioModem.cpp:684:detectRACHPreamble: Insert AICH SNR=10.4218 TOA=11.0156 at 11:3537 and 12:3537, last transmit: 14:3535, now: 0:3536rcvTime: 12:3527
INFO 140271221262080 18:47:44.3 Ggsn.cpp:123:miniGgsnReadServiceLoop: ggsn: polling 0 at  18:47:44.2
INFO 140271221262080 18:47:44.3 Ggsn.cpp:118:miniGgsnReadServiceLoop: ggsn: polling at  18:47:44.3
INFO 140271221262080 18:47:47.3 Ggsn.cpp:123:miniGgsnReadServiceLoop: ggsn: polling 0 at  18:47:47.3
INFO 140271221262080 18:47:47.3 Ggsn.cpp:118:miniGgsnReadServiceLoop: ggsn: polling at  18:47:47.3
INFO 140271611385600 18:47:50.0 UMTSRadioModem.cpp:684:detectRACHPreamble: Insert AICH SNR=13.9947 TOA=91.8906 at 8:206 and 9:206, last transmit: 2:203, now: 0:204rcvTime: 0:195

-----Original Message-----
From: Tom Tsou [mailto:to...@ts...] 
Sent: Monday, December 22, 2014 4:16 PM
To: Bokath, Chuck
Cc: ope...@li...
Subject: Re: [Openbts-discuss] Unable to Connect/Register with OpenBTS-UMTS

On Sun, Dec 21, 2014 at 9:49 AM, Bokath, Chuck <Chu...@gt...> wrote:
> I am trying to connect for the first time on OpenBTS-UMTS. When I 
> search for networks, I can see my network. When I attempt to connect 
> to my network, my phone says “Registering on <CARRIER>” then goes away 
> without registering or any errors. On the network side, when I turn on 
> detail logging, It seems that the L1 layer of the network does in fact 
> see the registration request from the modem – it detects energy and 
> write/reads data. When I start the android debugger, The phone see’s 
> the network at -75dbm.  Physically, I am running Ubuntu 14.10, intel 
> i5, b200 with UHD_003.008.000-50-gb228b755 using HTC One and Samsung 
> S3

RSSI looks good on the handset side.

> DEBUG 139656691037952 10:34:03.2 sigProcLib.cpp:1060:energyDetect: 
> detected
> energy: 1643.02
>
> DEBUG 139656691037952 10:34:03.2 UMTSRadioModem.cpp:486:estimateChannel:
> TOA: 34.3906chan:

Energy numbers seem low. In most cases, more meaningful and easier to read logging can be done at INFO level. The most useful value in early attachment for recognizing real bursts vs. noise is probably the TOA value in detectRACHPreamble (not shown in this log), which should be close to zero.

What is your receive antenna setup and rxgain value?

  -TT