search

aligungr / UERANSIM

Open source 5G UE and RAN (gNodeB) implementation.
GNU General Public License v3.0
793 stars 324 forks source link

Run UERANSIM on arm32v7 got an error #478

Open leegdut opened 2 years ago

leegdut commented 2 years ago

Hi,I just run UERANSIM on my arm32 device and it's very close to being able to connect with open5gs. But there is still an error as follows：

/storage/ue # ./nr-gnb -c new_open5gs-gnb.yaml & [1]- Done ./nr-gnb -c new_open5gs-gnb.yaml /storage/ue # UERANSIM v3.2.4 [2000-08-21 20:14:31.022] [sctp] [info] Trying to establish SCTP connection... ( 70.32.36.53:38412) [2000-08-21 20:14:31.043] [sctp] [info] SCTP connection established (70.32.36.53 :38412) [2000-08-21 20:14:31.043] [sctp] [debug] SCTP association setup ascId[4] [2000-08-21 20:14:31.044] [ngap] [debug] Sending NG Setup Request [2000-08-21 20:14:31.046] [ngap] [debug] NG Setup Response received [2000-08-21 20:14:31.046] [ngap] [info] NG Setup procedure is successful

/storage/ue # ./nr-ue -c new_open5gs-ue.yaml & /storage/ue # UERANSIM v3.2.4 [2000-08-21 20:14:53.718] [nas] [info] UE switches to state [MM-DEREGISTERED/PLM N-SEARCH] [2000-08-21 20:14:53.720] [rrc] [debug] UE[1] new signal detected [2000-08-21 20:14:53.720] [rrc] [debug] New signal detected for cell[1], total [ 1] cells in coverage [2000-08-21 20:14:53.721] [nas] [info] Selected plmn[001/01] [2000-08-21 20:14:53.721] [rrc] [info] Selected cell plmn[001/01] tac[1] categor y[SUITABLE] [2000-08-21 20:14:53.722] [nas] [info] UE switches to state [MM-DEREGISTERED/PS] [2000-08-21 20:14:53.722] [nas] [info] UE switches to state [MM-DEREGISTERED/NOR MAL-SERVICE] [2000-08-21 20:14:53.722] [nas] [debug] Initial registration required due to [MM -DEREG-NORMAL-SERVICE] [2000-08-21 20:14:53.722] [nas] [debug] UAC access attempt is allowed for identi ty[0], category[MO_sig] [2000-08-21 20:14:53.722] [nas] [debug] Sending Initial Registration [2000-08-21 20:14:53.722] [nas] [info] UE switches to state [MM-REGISTER-INITIAT ED] [2000-08-21 20:14:53.722] [rrc] [debug] Sending RRC Setup Request [2000-08-21 20:14:53.723] [rrc] [info] RRC Setup for UE[1] [2000-08-21 20:14:53.724] [rrc] [info] RRC connection established [2000-08-21 20:14:53.724] [rrc] [info] UE switches to state [RRC-CONNECTED] [2000-08-21 20:14:53.724] [ngap] [debug] Initial NAS message received from UE[1] [2000-08-21 20:14:53.725] [nas] [info] UE switches to state [CM-CONNECTED] [2000-08-21 20:14:53.744] [nas] [debug] Authentication Request received [2000-08-21 20:14:53.745] [ngap] [error] NGAP APER encoding failed

/storage/ue # /storage/ue # [2000-08-21 20:14:59.748] [nas] [debug] Authentication Request rec eived [2000-08-21 20:14:59.748] [nas] [error] Sending Authentication Failure with caus e [NGKSI_ALREADY_IN_USE] [2000-08-21 20:14:59.749] [ngap] [error] NGAP APER encoding failed

/storage/ue # [2000-08-21 20:15:05.754] [nas] [debug] Authentication Request rec eived [2000-08-21 20:15:05.754] [nas] [error] Sending Authentication Failure with caus e [NGKSI_ALREADY_IN_USE] [2000-08-21 20:15:05.755] [ngap] [error] NGAP APER encoding failed [2000-08-21 20:15:08.857] [nas] [debug] NAS timer[3510] expired [1] [2000-08-21 20:15:08.857] [nas] [info] UE switches to state [MM-DEREGISTERED/PS] [2000-08-21 20:15:08.857] [nas] [info] UE switches to state [5U2-NOT-UPDATED] [2000-08-21 20:15:08.857] [nas] [info] Performing local release of NAS connectio n [2000-08-21 20:15:08.858] [nas] [info] UE switches to state [MM-DEREGISTERED/ATT EMPTING-REGISTRATION] [2000-08-21 20:15:08.858] [rrc] [info] UE switches to state [RRC-IDLE] [2000-08-21 20:15:08.858] [nas] [info] UE switches to state [CM-IDLE] [2000-08-21 20:15:09.743] [rrc] [debug] UE[2] new signal detected [2000-08-21 20:15:11.202] [rls] [debug] UE[1] signal lost

and the open5gs shows: root@VOLT2:/usr/lwj/open5gs/open5gs# 01/20 12:14:07.176: [amf] INFO: InitialUEMessage (../src/amf/ngap-handler.c:361) 01/20 12:14:07.178: [amf] INFO: [Added] Number of gNB-UEs is now 1 (../src/amf/context.c:2036) 01/20 12:14:07.180: [amf] INFO: RAN_UE_NGAP_ID[3] AMF_UE_NGAP_ID[3] TAC[1] CellID[0x10] (../src/amf/ngap-handler.c:497) 01/20 12:14:07.182: [amf] INFO: [suci-0-001-01-0000-0-0-0000000001] Unknown UE by SUCI (../src/amf/context.c:1388) 01/20 12:14:07.183: [amf] INFO: [Added] Number of AMF-UEs is now 1 (../src/amf/context.c:1187) 01/20 12:14:07.183: [gmm] INFO: Registration request (../src/amf/gmm-sm.c:134) 01/20 12:14:07.183: [gmm] INFO: [suci-0-001-01-0000-0-0-0000000001] SUCI (../src/amf/gmm-handler.c:156) 01/20 12:14:32.407: [amf] INFO: InitialUEMessage (../src/amf/ngap-handler.c:361) 01/20 12:14:32.407: [amf] INFO: [Added] Number of gNB-UEs is now 2 (../src/amf/context.c:2036) 01/20 12:14:32.407: [amf] INFO: RAN_UE_NGAP_ID[4] AMF_UE_NGAP_ID[4] TAC[1] CellID[0x10] (../src/amf/ngap-handler.c:497) 01/20 12:14:32.407: [amf] INFO: [suci-0-001-01-0000-0-0-0000000001] known UE by SUCI (../src/amf/context.c:1386) 01/20 12:14:32.407: [gmm] WARNING: Registration request (../src/amf/gmm-sm.c:573) 01/20 12:14:32.407: [gmm] INFO: [suci-0-001-01-0000-0-0-0000000001] SUCI (../src/amf/gmm-handler.c:156) 01/20 12:14:32.407: [amf] WARNING: GUTI has already been allocated (../src/amf/context.c:1049) 01/20 12:15:02.415: [amf] WARNING: Implicit NG release (../src/amf/amf-sm.c:713) 01/20 12:15:02.415: [amf] WARNING: RAN_UE_NGAP_ID[3] AMF_UE_NGAP_ID[3] (../src/amf/amf-sm.c:714) 01/20 12:15:02.415: [amf] INFO: UE Context Release [Action:1] (../src/amf/ngap-handler.c:1398) 01/20 12:15:02.415: [amf] INFO: RAN_UE_NGAP_ID[3] AMF_UE_NGAP_ID[3] (../src/amf/ngap-handler.c:1399) 01/20 12:15:02.415: [amf] INFO: [Removed] Number of gNB-UEs is now 1 (../src/amf/context.c:2042) 01/20 12:15:02.434: [gmm] WARNING: [suci-0-001-01-0000-0-0-0000000001] Retransmission failed. Stop retransmission (../src/amf/gmm-sm.c:613) 01/20 12:15:02.434: [amf] WARNING: [suci-0-001-01-0000-0-0-0000000001] Authentication reject (../src/amf/nas-path.c:342) 01/20 12:15:32.441: [amf] WARNING: Implicit NG release (../src/amf/amf-sm.c:713) 01/20 12:15:32.443: [amf] WARNING: RAN_UE_NGAP_ID[4] AMF_UE_NGAP_ID[4] (../src/amf/amf-sm.c:714) 01/20 12:15:32.445: [amf] INFO: UE Context Release [Action:3] (../src/amf/ngap-handler.c:1398) 01/20 12:15:32.447: [amf] INFO: RAN_UE_NGAP_ID[4] AMF_UE_NGAP_ID[4] (../src/amf/ngap-handler.c:1399) 01/20 12:15:32.448: [amf] INFO: SUCI[suci-0-001-01-0000-0-0-0000000001] (../src/amf/ngap-handler.c:1402) 01/20 12:15:32.448: [amf] INFO: [Removed] Number of gNB-UEs is now 0 (../src/amf/context.c:2042) 01/20 12:15:32.449: [amf] INFO: [Removed] Number of AMF-UEs is now 0 (../src/amf/context.c:1271)

Do you know what cause the errors? Waiting for your reply. Best Regards.

aligungr commented 2 years ago

Hi

Please try the latest version, it may fix the error. Indeed 3.2.4 is an old version.

BR

leegdut commented 2 years ago

@aligungr Hi,I have tried the latest version, but still have the same error, the log is as follows：

/storage/ue # ./nr-gnb326 -c new_open5gs-gnb.yaml & /storage/ue # UERANSIM v3.2.6 [2021-10-02 04:13:38.379] [sctp] [info] Trying to establish SCTP connection... (70.32.36.53:38412) [2021-10-02 04:13:38.400] [sctp] [info] SCTP connection established (70.32.36.53:38412) [2021-10-02 04:13:38.400] [sctp] [debug] SCTP association setup ascId[5] [2021-10-02 04:13:38.400] [ngap] [debug] Sending NG Setup Request [2021-10-02 04:13:38.403] [ngap] [debug] NG Setup Response received [2021-10-02 04:13:38.403] [ngap] [info] NG Setup procedure is successful

/storage/ue # ./nr-gnb326 -c new_open5gs-gnb.yaml /storage/ue # UERANSIM v3.2.6 [2021-10-02 04:13:54.486] [nas] [info] UE switches to state [MM-DEREGISTERED/PLMN-SEARCH] [2021-10-02 04:13:54.488] [rrc] [debug] UE[1] new signal detected [2021-10-02 04:13:54.488] [rrc] [debug] New signal detected for cell[1], total [1] cells in coverage [2021-10-02 04:13:54.490] [nas] [info] Selected plmn[001/01] [2021-10-02 04:13:54.490] [rrc] [info] Selected cell plmn[001/01] tac[1] category[SUITABLE] [2021-10-02 04:13:54.490] [nas] [info] UE switches to state [MM-DEREGISTERED/PS] [2021-10-02 04:13:54.490] [nas] [info] UE switches to state [MM-DEREGISTERED/NORMAL-SERVICE] [2021-10-02 04:13:54.490] [nas] [debug] Initial registration required due to [MM-DEREG-NORMAL-SERVICE] [2021-10-02 04:13:54.491] [nas] [debug] UAC access attempt is allowed for identity[0], category[MO_sig] [2021-10-02 04:13:54.491] [nas] [debug] Sending Initial Registration [2021-10-02 04:13:54.491] [nas] [info] UE switches to state [MM-REGISTER-INITIATED] [2021-10-02 04:13:54.492] [rrc] [debug] Sending RRC Setup Request [2021-10-02 04:13:54.492] [rrc] [info] RRC Setup for UE[1] [2021-10-02 04:13:54.493] [rrc] [info] RRC connection established [2021-10-02 04:13:54.493] [rrc] [info] UE switches to state [RRC-CONNECTED] [2021-10-02 04:13:54.493] [nas] [info] UE switches to state [CM-CONNECTED] [2021-10-02 04:13:54.494] [ngap] [debug] Initial NAS message received from UE[1] [2021-10-02 04:13:54.517] [nas] [debug] Authentication Request received [2021-10-02 04:13:54.518] [ngap] [error] NGAP APER encoding failed [2021-10-02 04:14:00.519] [nas] [debug] Authentication Request received [2021-10-02 04:14:00.519] [nas] [error] Sending Authentication Failure with cause [NGKSI_ALREADY_IN_USE] [2021-10-02 04:14:00.520] [ngap] [error] NGAP APER encoding failed [2021-10-02 04:14:06.520] [nas] [debug] Authentication Request received [2021-10-02 04:14:06.520] [nas] [error] Sending Authentication Failure with cause [NGKSI_ALREADY_IN_USE] [2021-10-02 04:14:06.520] [ngap] [error] NGAP APER encoding failed

Waiting for your reply. Best Regards.