srsRAN_4G
srsRAN_4G copied to clipboard
5G SA COTS UE Disconnecting after a few minutes "Removed user rnti=0x4601"
Issue Description
Following the 5G SA COTS UE Application Note, after running srsENB with sudo ./srsenb enb.conf the UE successfully connects to the open5gs net and gets an assigned IP and access to the internet. But after a few seconds or minutes the UE disconnects from the network.
Setup Details
- Operation System: Ubuntu 20.04
- srsRAN (srsRAN-agpl_next)
- RF: USRP B210 (UHD driver)
- Asus ZenBook intel Core i7
- UE: Galaxy S21 FE 5G Sysmocom USIM
- Third Party 5G Core: Open5GS
Expected Behavior
The UE should be connected to the enb indefinitely
Actual Behaviour
After a few seconds or minutes the UE disconnects from the network, the ping from PC to UE stop having a reply and the UE stops having acces to the internet.
srsenb Output:
==== eNodeB started ===
Type <t> to view trace
Setting manual TX/RX offset to 100 samples
Setting frequency: DL=1847.5 Mhz, UL=1752.5 MHz for cc_idx=0 nof_prb=52
RACH: slot=6251, cc=0, preamble=1, offset=3, temp_crnti=0x4601
RACH: slot=5291, cc=0, preamble=2, offset=1477, temp_crnti=0x4602
Disconnecting rnti=0x4602.
RACH: slot=5451, cc=0, preamble=6, offset=1477, temp_crnti=0x4603
Disconnecting rnti=0x4603.
RACH: slot=5611, cc=0, preamble=4, offset=1477, temp_crnti=0x4604
Disconnecting rnti=0x4604.
RACH: slot=5771, cc=0, preamble=1, offset=1477, temp_crnti=0x4605
Disconnecting rnti=0x4605.
RACH: slot=5931, cc=0, preamble=7, offset=1477, temp_crnti=0x4606
Disconnecting rnti=0x4606.
RACH: slot=6091, cc=0, preamble=4, offset=1477, temp_crnti=0x4607
Disconnecting rnti=0x4607.
RACH: slot=6251, cc=0, preamble=2, offset=1475, temp_crnti=0x4608
Disconnecting rnti=0x4608.
RACH: slot=6731, cc=0, preamble=6, offset=3, temp_crnti=0x4609
User 0x4609 requesting RRC Reestablishment as 0x4601. Cause: otherFailure
Disconnecting rnti=0x4601.
RACH: slot=6891, cc=0, preamble=3, offset=3, temp_crnti=0x460a
Disconnecting rnti=0x460a.
RACH: slot=7371, cc=0, preamble=4, offset=3, temp_crnti=0x460b
User 0x460b requesting RRC Reestablishment as 0x4609. Cause: reconfigurationFailure
Disconnecting rnti=0x4609.
RACH: slot=7531, cc=0, preamble=4, offset=3, temp_crnti=0x460c
Disconnecting rnti=0x460c.
RACH: slot=7691, cc=0, preamble=1, offset=3, temp_crnti=0x460d
Disconnecting rnti=0x460d.
RACH: slot=7851, cc=0, preamble=6, offset=3, temp_crnti=0x460e
Disconnecting rnti=0x460e.
RACH: slot=8011, cc=0, preamble=2, offset=5, temp_crnti=0x460f
Disconnecting rnti=0x460f.
RACH: slot=8171, cc=0, preamble=2, offset=3, temp_crnti=0x4610
Disconnecting rnti=0x4610.
RACH: slot=8331, cc=0, preamble=2, offset=3, temp_crnti=0x4611
Disconnecting rnti=0x4611.
RACH: slot=8491, cc=0, preamble=0, offset=3, temp_crnti=0x4612
Disconnecting rnti=0x4612.
RACH: slot=8651, cc=0, preamble=1, offset=3, temp_crnti=0x4613
Disconnecting rnti=0x4613.
RACH: slot=9131, cc=0, preamble=5, offset=5, temp_crnti=0x4614
User 0x4614 requesting RRC Reestablishment as 0x460b. Cause: otherFailure
Disconnecting rnti=0x460b.
RACH: slot=9291, cc=0, preamble=3, offset=3, temp_crnti=0x4615
Disconnecting rnti=0x4615.
RACH: slot=9451, cc=0, preamble=4, offset=3, temp_crnti=0x4616
Disconnecting rnti=0x4616.
RACH: slot=9611, cc=0, preamble=4, offset=3, temp_crnti=0x4617
Disconnecting rnti=0x4617.
RACH: slot=9771, cc=0, preamble=2, offset=3, temp_crnti=0x4618
Disconnecting rnti=0x4618.
RACH: slot=9931, cc=0, preamble=2, offset=3, temp_crnti=0x4619
Disconnecting rnti=0x4619.
RACH: slot=10091, cc=0, preamble=5, offset=3, temp_crnti=0x461a
Disconnecting rnti=0x461a.
RACH: slot=11, cc=0, preamble=7, offset=3, temp_crnti=0x461b
Disconnecting rnti=0x461b.
RACH: slot=171, cc=0, preamble=4, offset=3, temp_crnti=0x461c
Disconnecting rnti=0x461c.
RACH: slot=491, cc=0, preamble=5, offset=3, temp_crnti=0x461d
User 0x461d requesting RRC Reestablishment as 0x4614. Cause: otherFailure
Disconnecting rnti=0x4614.
RACH: slot=651, cc=0, preamble=4, offset=3, temp_crnti=0x461e
Disconnecting rnti=0x461e.
RACH: slot=811, cc=0, preamble=1, offset=3, temp_crnti=0x461f
Disconnecting rnti=0x461f.
RACH: slot=971, cc=0, preamble=7, offset=3, temp_crnti=0x4620
Disconnecting rnti=0x4620.
RACH: slot=1131, cc=0, preamble=1, offset=3, temp_crnti=0x4621
Disconnecting rnti=0x4621.
RACH: slot=1291, cc=0, preamble=1, offset=3, temp_crnti=0x4622
Disconnecting rnti=0x4622.
RACH: slot=1451, cc=0, preamble=5, offset=3, temp_crnti=0x4623
Disconnecting rnti=0x4623.
RACH: slot=1611, cc=0, preamble=3, offset=3, temp_crnti=0x4624
Disconnecting rnti=0x4624.
RACH: slot=1771, cc=0, preamble=0, offset=3, temp_crnti=0x4625
Disconnecting rnti=0x4625.
RACH: slot=2091, cc=0, preamble=6, offset=3, temp_crnti=0x4626
User 0x4626 requesting RRC Reestablishment as 0x461d. Cause: otherFailure
Disconnecting rnti=0x461d.
RACH: slot=2251, cc=0, preamble=4, offset=3, temp_crnti=0x4627
Disconnecting rnti=0x4627.
RACH: slot=2411, cc=0, preamble=7, offset=3, temp_crnti=0x4628
Disconnecting rnti=0x4628.
RACH: slot=2571, cc=0, preamble=1, offset=3, temp_crnti=0x4629
Disconnecting rnti=0x4629.
RACH: slot=2731, cc=0, preamble=4, offset=5, temp_crnti=0x462a
Disconnecting rnti=0x462a.
RACH: slot=2891, cc=0, preamble=3, offset=5, temp_crnti=0x462b
Disconnecting rnti=0x462b.
RACH: slot=3051, cc=0, preamble=1, offset=5, temp_crnti=0x462c
Disconnecting rnti=0x462c.
RACH: slot=3211, cc=0, preamble=5, offset=5, temp_crnti=0x462d
Disconnecting rnti=0x462d.
RACH: slot=3371, cc=0, preamble=3, offset=5, temp_crnti=0x462e
Disconnecting rnti=0x462e.
After failure, If I activate airplane mode in the UE and deactivate it again, the UE reconnects without any problems with the network and stays connected for a few minutes with another IP, until it disconnects again and so on.
Sometimes it is connected for 20 minutes and others for just a few seconds...
I use a large RRC inactivity timer in the enb.conf rrc_inactivity_timer = 1073741823
Steps to reproduce the problem
To reproduce this issue follow the guide https://docs.srsran.com/projects/4g/en/latest/app_notes/source/5g_sa_COTS/source/index.html Copy the config files, execute srsenb sudo ./srsenb enb.conf and try to connect the UE to the open5GS net.
srsRAN Config files: enb.conf.txt rr.conf.txt rb.conf.txt sib.conf.txt
Open5GS config files: amf.yaml.txt upf.yaml.txt
Additional Information
enb.log at the moment of disconnection (When the srsenb output shows RACH: slot=5291, cc=0, preamble=2, offset=1477, temp_crnti=0x4602)
:
2022-06-30T11:14:54.711416 [PHY1-NR] [I] [ 7676] PDSCH: cc=0 si-rnti=0xffff prb=(1,8) symb=(2,13) CW0: mod=QPSK tbs=80 R=0.380 rv=0 tti_tx=7680
2022-06-30T11:14:54.716369 [PHY0-NR] [I] [ 7681] PUCCH: f=2 prb=50:1 symb=2:2 rnti=0x4601 cqi=0 epre=+10.0 snr=-5.6 cfo=+5448.8 delay=-3.9 valid=y
2022-06-30T11:14:54.723472 [PHY1-NR] [I] [ 7688] PUCCH: f=1 prb=51:1 symb=0:14 cs=8 occ=0 rnti=0x4601 sr=1 epre=+8.2 snr=-10.9 cfo=-614.0 delay=-2.1 valid=n
2022-06-30T11:14:54.726484 [PHY-NR ] [I] [ 0] PRACH: cc=0, 0/1, preamble=5, offset=1.9 us, peak2avg=401.2, max_offset=1000.0 us
2022-06-30T11:14:54.726614 [MAC-NR ] [I] [ 7691] SCHED: rnti=0x4602, new lcid configuration: [{lcid=0, mode=bi-dir, prio=1, lcg=0}]
2022-06-30T11:14:54.726677 [RLC-NR ] [I] Added LTE radio bearer with LCID 0 in Transparent Mode
2022-06-30T11:14:54.726682 [RRC-NR ] [I] Added new user rnti=0x4602
2022-06-30T11:14:54.726682 [MAC-NR ] [I] [ 7691] RACH: slot=7691, cc=0, preamble=5, offset=3, temp_crnti=0x4602
2022-06-30T11:14:54.726690 [MAC-NR ] [I] [ 7691] rach_tprof: {mean, max, min}={192.1, 204, 179} usec, nof_samples=2
2022-06-30T11:14:54.727302 [MAC-NR ] [I] [ 7692] SCHED: New user rnti=0x4602, cc=0
2022-06-30T11:14:54.727303 [MAC-NR ] [I] [ 7692] SCHED: New PRACH slot=7691, preamble=5, ra-rnti=0xf, temp_crnti=0x4602, ta_cmd=3, msg3_size=7
2022-06-30T11:14:54.727336 [MAC-NR ] [I] [ 7692] SCHED: RAR, cc=0, ra-rnti=0xf, prbs=[1, 5), pdsch_slot=7696, msg3_slot=7702, nof_grants=1
2022-06-30T11:14:54.727342 [MAC-NR ] [I] [ 7692] Setting RAR Grant tc-rnti=0x4602 dci=RAR ss=rar hop=0 f_alloc=0x68 t_alloc=0x0 mcs=0 tpc=1 csi=0
2022-06-30T11:14:54.727345 [MAC-NR ] [I] [ 7692] DL RAPID: 5, Temp C-RNTI: 0x4602, TA: 3, UL Grant: [00 d0 00 40 ]
2022-06-30T11:14:54.727378 [PHY1-NR] [I] [ 7692] PDCCH: cc=0 ra-rnti=0x000f dci=1_0 ss=common1 L=2 cce=0 f_alloc=0x90 t_alloc=0x0 vrb_to_prb_map=0 mcs=5 tb_scaling=0 reserved=0x0 tti_tx=7696
2022-06-30T11:14:54.727409 [PHY1-NR] [I] [ 7692] PDSCH: cc=0 ra-rnti=0xf prb=(1,4) symb=(1,13) CW0: mod=QPSK tbs=44 R=0.383 rv=0 tti_tx=7696
2022-06-30T11:14:54.731433 [PHY1-NR] [I] [ 7696] PDCCH: cc=0 si-rnti=0xffff dci=1_0 ss=common0 L=2 cce=0 f_alloc=0x150 t_alloc=0x0 vrb_to_prb_map=0 mcs=5 rv=0 sii=0 coreset0_bw=48 reserved=0x0 tti_tx=7700
2022-06-30T11:14:54.731472 [PHY1-NR] [I] [ 7696] PDSCH: cc=0 si-rnti=0xffff prb=(1,8) symb=(2,13) CW0: mod=QPSK tbs=80 R=0.380 rv=0 tti_tx=7700
2022-06-30T11:14:54.737508 [PHY1-NR] [I] [ 7702] PUSCH: tc-rnti=0x4602 prb=(0,2) symb=(0,13) CW0: mod=QPSK tbs=11 R=0.131 rv=0 CRC=OK iter=1.0 evm=0.28 t_us=29 epre=+41.5 snr=+11.7 cfo=-6.8 delay=+0.0
2022-06-30T11:14:54.737555 [MAC-NR ] [I] [ 7702] Rx PDU: rnti=0x4602, UL CCCH48: len=6 LBSR: bitmap=0x0 PAD: len=0
2022-06-30T11:14:54.737565 [RRC-NR ] [I] rnti=0x4602, SRB0 - Rx UL-CCCH.rrcReestablishmentRequest (6 B)
The new user "Added new user rnti=0x4602" is always added after a PRACH
On another try I see the message Removed user rnti=0x4601 at enb.log
2022-06-30T12:03:52.476777 [GTPU ] [I] Modifying bearer rnti. Old rnti: 0x4601, new rnti: 0x4602
2022-06-30T12:03:52.476795 [STCK ] [I] Bearers: Removed rnti=0x4601 from EPS bearer manager
2022-06-30T12:03:52.476908 [RRC-NR ] [I] Removed user rnti=0x4601
2022-06-30T12:03:52.477528 [MAC-NR ] [I] [ 7223] SCHED: rnti=0x4602, new lcid configuration: [{lcid=1, mode=bi-dir, prio=1, lcg=0}]
2022-06-30T12:03:52.478367 [MAC-NR ] [I] [ 7223] SCHED: Removed user rnti=0x4601
2022-06-30T12:03:52.478386 [MAC-NR ] [I] [ 7223] SCHED: DL tx, cc=0, rnti=0x4602, pid=0, cs=0, f=1_0, prbs=[1, 49), nrtx=0, dai=0, lcids=[62, 1], tbs=960, bs=16, pdsch_slot=7227, ack_slot=7231
2022-06-30T12:03:52.478393 [RLC-NR ] [I] SRB1: Started t-PollRetransmit. POLL_SN=0
2022-06-30T12:03:52.478394 [RLC-NR ] [I] SRB1: [Data PDU, P=1, SI=full, SN_SIZE=12 bits, SN=0, SO=0]
2022-06-30T12:03:52.478396 [RLC-NR ] [I] SRB1: No data available to be sent
2022-06-30T12:03:52.478398 [MAC-NR ] [I] [ 7223] 0x4602 DL CON_RES: id=48c02fa56934 LCID=1 len=10 PAD: len=940
2022-06-30T12:03:52.478425 [PHY1-NR] [I] [ 7223] PDCCH: cc=0 c-rnti=0x4602 dci=1_0 ss=common3 L=2 cce=0 f_alloc=0x5f t_alloc=0x0 vrb_to_prb_map=0 mcs=10 ndi=1 rv=0 harq_id=0 dai=0 pucch_tpc=1 pucch_res=>
2022-06-30T12:03:52.478580 [PHY1-NR] [I] [ 7223] PDSCH: cc=0 c-rnti=0x4602 prb=(1,48) symb=(1,13) CW0: mod=16QAM tbs=960 R=0.334 rv=0 tti_tx=7227
2022-06-30T12:03:52.485601 [PHY1-NR] [I] [ 7231] PUCCH: f=1 prb=51:1 symb=0:14 cs=0 occ=0 rnti=0x4602 ack=1 epre=+43.6 snr=+13.4 cfo=-547.1 delay=+4.0 valid=y
2022-06-30T12:03:52.490462 [PHY0-NR] [I] [ 7236] PDCCH: cc=0 si-rnti=0xffff dci=1_0 ss=common0 L=2 cce=0 f_alloc=0x150 t_alloc=0x0 vrb_to_prb_map=0 mcs=5 rv=0 sii=0 coreset0_bw=48 reserved=0x0 tti_tx=7>
2022-06-30T12:03:52.490490 [PHY0-NR] [I] [ 7236] PDSCH: cc=0 si-rnti=0xffff prb=(1,8) symb=(2,13) CW0: mod=QPSK tbs=80 R=0.380 rv=0 tti_tx=7240
Hi @cristina-posada, did you manage to clarify this? Thanks
Hi @avalori1 No, sadly not yet. I have installed the latest versions of srsRAN and open5gs recently this week and the problem still exists for me.
Hi @cristina-posada,
I'm trying to figure out why I'm having similar issues.
Was your Sysmocom SJA2 purchased before or after September 2021 (is it SJA2v1 or SJA2v2)?
Thank you
Hi
Did you have the same issue with the new srsRAN repository https://github.com/srsran/srsRAN_Project? If so, can you open an issue there?
Thanks
Hi @igoforth, @frankist. In my case, I don't have the same issue with the new repository https://github.com/srsran/srsRAN_Project. I tested it a few weeks ago and the UE was connected for hours.
I don't know when the card I'm using was purchased, I don't know if it's version SJA2v1 or SJA2v2 but I'll find out and let you know!
Thanks
Hi
Did you have the same issue with the new srsRAN repository https://github.com/srsran/srsRAN_Project? If so, can you open an issue there?
Thanks
@frankist @cristina-posada Thank you for the response.
In the case of my UE with srsRAN Project, it disconnects after 2-5 minutes. I have a feeling that's because Project's gNB does not yet support RRC Mobility, Paging and Reestablishment. I'm looking for idle state transition capabilities.
Thanks